builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-085 starttime: 1502944891.43 results: success (0) revision: 932388b8c22c9775264e543697ce918415db9e23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.429246) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.429744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.430057) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.455785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.459127) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 21:41:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-08-16 21:41:32 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146726 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.638770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.639100) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018368 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:31.693814) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 21:41:31.694153) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 932388b8c22c9775264e543697ce918415db9e23 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 932388b8c22c9775264e543697ce918415db9e23 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 21:41:32,223 truncating revision to first 12 chars 2017-08-16 21:41:32,223 Setting DEBUG logging. 2017-08-16 21:41:32,223 attempt 1/10 2017-08-16 21:41:32,223 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/932388b8c22c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 21:41:33,372 unpacking tar archive at: mozilla-central-932388b8c22c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.512904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 21:41:33.224502) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.224782) ========= script_repo_revision: 932388b8c22c9775264e543697ce918415db9e23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.228190) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.228472) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 21:41:33.240268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-16 21:41:33.240543) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:41:33 INFO - MultiFileLogger online at 20170816 21:41:33 in /builds/slave/test 21:41:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:41:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:41:33 INFO - {'append_to_log': False, 21:41:33 INFO - 'base_work_dir': '/builds/slave/test', 21:41:33 INFO - 'blob_upload_branch': 'Firefox', 21:41:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:41:33 INFO - 'branch': 'Firefox', 21:41:33 INFO - 'buildbot_json_path': 'buildprops.json', 21:41:33 INFO - 'code_coverage': False, 21:41:33 INFO - 'config_files': ('talos/linux_config.py',), 21:41:33 INFO - 'default_actions': ('clobber', 21:41:33 INFO - 'read-buildbot-config', 21:41:33 INFO - 'download-and-extract', 21:41:33 INFO - 'populate-webroot', 21:41:33 INFO - 'create-virtualenv', 21:41:33 INFO - 'install', 21:41:33 INFO - 'setup-mitmproxy', 21:41:33 INFO - 'run-tests'), 21:41:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:41:33 INFO - 'disable_ccov_upload': False, 21:41:33 INFO - 'download_minidump_stackwalk': True, 21:41:33 INFO - 'download_symbols': 'ondemand', 21:41:33 INFO - 'enable_stylo': False, 21:41:33 INFO - 'enable_webrender': False, 21:41:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:41:33 INFO - 'tooltool.py': '/tools/tooltool.py', 21:41:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:41:33 INFO - '/tools/misc-python/virtualenv.py')}, 21:41:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:41:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:41:33 INFO - 'gecko_profile': False, 21:41:33 INFO - 'gecko_profile_interval': 0, 21:41:33 INFO - 'installer_path': 'installer.exe', 21:41:33 INFO - 'log_level': 'info', 21:41:33 INFO - 'log_name': 'talos', 21:41:33 INFO - 'log_to_console': True, 21:41:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:41:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:41:33 INFO - 'opt_config_files': (), 21:41:33 INFO - 'pip_index': False, 21:41:33 INFO - 'suite': 'dromaeojs-e10s', 21:41:33 INFO - 'system_bits': '32', 21:41:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:41:33 INFO - 'title': 'talos-linux64-ix-085', 21:41:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:41:33 INFO - 'use_talos_json': True, 21:41:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:41:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:41:33 INFO - 'work_dir': 'build'} 21:41:33 INFO - [mozharness: 2017-08-17 04:41:33.871008Z] Running clobber step. 21:41:33 INFO - Running pre-action listener: _resource_record_pre_action 21:41:33 INFO - Running main action method: clobber 21:41:33 INFO - rmtree: /builds/slave/test/build 21:41:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:41:34 INFO - Running post-action listener: _resource_record_post_action 21:41:34 INFO - [mozharness: 2017-08-17 04:41:34.912843Z] Finished clobber step (success) 21:41:34 INFO - [mozharness: 2017-08-17 04:41:34.912947Z] Running read-buildbot-config step. 21:41:34 INFO - Running pre-action listener: _resource_record_pre_action 21:41:34 INFO - Running main action method: read_buildbot_config 21:41:34 INFO - Using buildbot properties: 21:41:34 INFO - { 21:41:34 INFO - "project": "", 21:41:34 INFO - "product": "firefox", 21:41:34 INFO - "who": "philringnalda@gmail.com", 21:41:34 INFO - "installer_path": "public/build/target.tar.bz2", 21:41:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 21:41:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 21:41:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 21:41:34 INFO - "stage_platform": "linux64-stylosequential", 21:41:34 INFO - "basedir": "/builds/slave/test", 21:41:34 INFO - "buildnumber": 153, 21:41:34 INFO - "platform": "ubuntu64_hw_styloseq", 21:41:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:41:34 INFO - "slavebuilddir": "test", 21:41:34 INFO - "taskId": "cI8_JPJqSj68qAc9aWFMMQ", 21:41:34 INFO - "branch": "mozilla-central", 21:41:34 INFO - "script_repo_revision": "production", 21:41:34 INFO - "revision": "932388b8c22c9775264e543697ce918415db9e23", 21:41:34 INFO - "slavename": "talos-linux64-ix-085", 21:41:34 INFO - "repo_path": "mozilla-central" 21:41:34 INFO - } 21:41:34 INFO - Finding installer, test and symbols from parent task. 21:41:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cI8_JPJqSj68qAc9aWFMMQ'}, attempt #1 21:41:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cI8_JPJqSj68qAc9aWFMMQ'}, attempt #1 21:41:35 INFO - Task dependencies: GAdvR_fzSk6gV6tKKcdXVg 21:41:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg'}, attempt #1 21:41:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:41:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json 21:41:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip 21:41:36 INFO - Running post-action listener: _resource_record_post_action 21:41:36 INFO - [mozharness: 2017-08-17 04:41:36.261935Z] Finished read-buildbot-config step (success) 21:41:36 INFO - [mozharness: 2017-08-17 04:41:36.262158Z] Running download-and-extract step. 21:41:36 INFO - Running pre-action listener: _resource_record_pre_action 21:41:36 INFO - Running main action method: download_and_extract 21:41:36 INFO - mkdir: /builds/slave/test/build/tests 21:41:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:36 INFO - trying https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json 21:41:36 INFO - Downloading https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:41:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:41:36 INFO - Downloaded 989 bytes. 21:41:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:41:36 INFO - Using the following test package requirements: 21:41:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:41:36 INFO - u'common': [u'target.common.tests.zip'], 21:41:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:41:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:41:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:41:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:41:36 INFO - u'mozbase': [u'target.common.tests.zip'], 21:41:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:41:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:41:36 INFO - u'web-platform': [u'target.common.tests.zip', 21:41:36 INFO - u'target.web-platform.tests.tar.gz'], 21:41:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:41:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:41:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip 21:41:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:36 INFO - Fetch https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip into memory 21:41:37 INFO - Content-Length response header: 53999257 21:41:37 INFO - Bytes received: 53999257 21:41:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:41:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip 21:41:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:41:48 INFO - Fetch https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.common.tests.zip into memory 21:41:49 INFO - Content-Length response header: 53999257 21:41:49 INFO - Bytes received: 53999257 21:42:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.talos.tests.zip 21:42:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:42:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.talos.tests.zip into memory 21:42:02 INFO - Content-Length response header: 14496161 21:42:02 INFO - Bytes received: 14496161 21:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:02 INFO - trying https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:42:02 INFO - Downloading https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:42:03 INFO - Downloaded 61823178 bytes. 21:42:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:42:03 INFO - mkdir: /builds/slave/test/properties 21:42:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:42:03 INFO - Writing to file /builds/slave/test/properties/build_url 21:42:03 INFO - Contents: 21:42:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 21:42:03 INFO - Running post-action listener: _resource_record_post_action 21:42:03 INFO - Running post-action listener: set_extra_try_arguments 21:42:03 INFO - [mozharness: 2017-08-17 04:42:03.798572Z] Finished download-and-extract step (success) 21:42:03 INFO - [mozharness: 2017-08-17 04:42:03.798671Z] Running populate-webroot step. 21:42:03 INFO - Running pre-action listener: _resource_record_pre_action 21:42:03 INFO - Running main action method: populate_webroot 21:42:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:42:03 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:42:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:42:03 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:42:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:03 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:42:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'tests': ['damp', 'tps']}, 21:42:03 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['damp', 'tps']}, 21:42:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:42:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:42:03 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:42:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:42:03 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 21:42:03 INFO - 'other-e10s': {'tests': ['a11yr', 21:42:03 INFO - 'ts_paint', 21:42:03 INFO - 'tpaint', 21:42:03 INFO - 'sessionrestore', 21:42:03 INFO - 'sessionrestore_many_windows', 21:42:03 INFO - 'sessionrestore_no_auto_restore', 21:42:03 INFO - 'tabpaint']}, 21:42:03 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['a11yr', 21:42:03 INFO - 'ts_paint', 21:42:03 INFO - 'tpaint', 21:42:03 INFO - 'sessionrestore', 21:42:03 INFO - 'sessionrestore_many_windows', 21:42:03 INFO - 'sessionrestore_no_auto_restore', 21:42:03 INFO - 'tabpaint']}, 21:42:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 21:42:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 21:42:03 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['bloom_basic_singleton']}, 21:42:03 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['bloom_basic']}, 21:42:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:42:03 INFO - 'tsvgr_opacity', 21:42:03 INFO - 'tart', 21:42:03 INFO - 'tscrollx', 21:42:03 INFO - 'tsvg_static']}, 21:42:03 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['tsvgx', 21:42:03 INFO - 'tsvgr_opacity', 21:42:03 INFO - 'tart', 21:42:03 INFO - 'tscrollx', 21:42:03 INFO - 'tsvg_static']}, 21:42:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:42:03 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'talos_options': ['--stylo'], 21:42:03 INFO - 'tests': ['tp5o']}, 21:42:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:42:03 INFO - 'talos_options': ['--mitmproxy', 21:42:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:42:03 INFO - '--firstNonBlankPaint'], 21:42:03 INFO - 'tests': ['tp6_google', 21:42:03 INFO - 'tp6_youtube', 21:42:03 INFO - 'tp6_amazon', 21:42:03 INFO - 'tp6_facebook']}, 21:42:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:42:03 INFO - 'talos_options': ['--stylo', 21:42:03 INFO - '--mitmproxy', 21:42:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:42:03 INFO - '--firstNonBlankPaint'], 21:42:03 INFO - 'tests': ['tp6_google', 21:42:03 INFO - 'tp6_youtube', 21:42:03 INFO - 'tp6_amazon', 21:42:03 INFO - 'tp6_facebook']}, 21:42:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 21:42:03 INFO - 'talos_options': ['--stylo', 21:42:03 INFO - '--stylo-threads=1', 21:42:03 INFO - '--mitmproxy', 21:42:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 21:42:03 INFO - '--firstNonBlankPaint'], 21:42:03 INFO - 'tests': ['tp6_google', 21:42:03 INFO - 'tp6_youtube', 21:42:03 INFO - 'tp6_amazon', 21:42:03 INFO - 'tp6_facebook']}, 21:42:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'talos_options': ['--xperf_path', 21:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:03 INFO - 'tests': ['tp5n']}, 21:42:03 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 21:42:03 INFO - 'talos_options': ['--stylo', 21:42:03 INFO - '--xperf_path', 21:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:42:03 INFO - 'tests': ['tp5n']}}} 21:42:03 INFO - Running post-action listener: _resource_record_post_action 21:42:03 INFO - [mozharness: 2017-08-17 04:42:03.812935Z] Finished populate-webroot step (success) 21:42:03 INFO - [mozharness: 2017-08-17 04:42:03.813027Z] Running create-virtualenv step. 21:42:03 INFO - Running pre-action listener: _resource_record_pre_action 21:42:03 INFO - Running main action method: create_virtualenv 21:42:03 INFO - Creating virtualenv /builds/slave/test/build/venv 21:42:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:42:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:42:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 21:42:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:42:03 INFO - Using real prefix '/usr' 21:42:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:42:04 INFO - Installing distribute.............................................................................................................................................................................................done. 21:42:06 INFO - Installing pip.................done. 21:42:06 INFO - Return code: 0 21:42:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:42:06 INFO - Reading from file tmpfile_stdout 21:42:06 INFO - Output received: 21:42:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:42:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:42:06 INFO - Using env: {'DISPLAY': ':0', 21:42:06 INFO - 'HOME': '/home/cltbld', 21:42:06 INFO - 'LANG': 'en_US.UTF-8', 21:42:06 INFO - 'LANGUAGE': 'en_US:en', 21:42:06 INFO - 'LOGNAME': 'cltbld', 21:42:06 INFO - 'MAIL': '/var/mail/cltbld', 21:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:06 INFO - 'MOZ_NO_REMOTE': '1', 21:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:06 INFO - 'NO_EM_RESTART': '1', 21:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:06 INFO - 'PWD': '/builds/slave/test', 21:42:06 INFO - 'SHELL': '/bin/bash', 21:42:06 INFO - 'SHLVL': '1', 21:42:06 INFO - 'TERM': 'linux', 21:42:06 INFO - 'TMOUT': '86400', 21:42:06 INFO - 'USER': 'cltbld', 21:42:06 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:06 INFO - '_': '/tools/buildbot/bin/python'} 21:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:42:06 INFO - Cleaning up... 21:42:06 INFO - Return code: 0 21:42:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:42:06 INFO - Using env: {'DISPLAY': ':0', 21:42:06 INFO - 'HOME': '/home/cltbld', 21:42:06 INFO - 'LANG': 'en_US.UTF-8', 21:42:06 INFO - 'LANGUAGE': 'en_US:en', 21:42:06 INFO - 'LOGNAME': 'cltbld', 21:42:06 INFO - 'MAIL': '/var/mail/cltbld', 21:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:06 INFO - 'MOZ_NO_REMOTE': '1', 21:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:06 INFO - 'NO_EM_RESTART': '1', 21:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:06 INFO - 'PWD': '/builds/slave/test', 21:42:06 INFO - 'SHELL': '/bin/bash', 21:42:06 INFO - 'SHLVL': '1', 21:42:06 INFO - 'TERM': 'linux', 21:42:06 INFO - 'TMOUT': '86400', 21:42:06 INFO - 'USER': 'cltbld', 21:42:06 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:06 INFO - '_': '/tools/buildbot/bin/python'} 21:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:07 INFO - Downloading/unpacking psutil>=3.1.1 21:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:08 INFO - Installing collected packages: psutil 21:42:08 INFO - Running setup.py install for psutil 21:42:08 INFO - building 'psutil._psutil_linux' extension 21:42:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:42:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:42:08 INFO - building 'psutil._psutil_posix' extension 21:42:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:42:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:42:08 INFO - Successfully installed psutil 21:42:08 INFO - Cleaning up... 21:42:08 INFO - Return code: 0 21:42:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:42:08 INFO - Using env: {'DISPLAY': ':0', 21:42:08 INFO - 'HOME': '/home/cltbld', 21:42:08 INFO - 'LANG': 'en_US.UTF-8', 21:42:08 INFO - 'LANGUAGE': 'en_US:en', 21:42:08 INFO - 'LOGNAME': 'cltbld', 21:42:08 INFO - 'MAIL': '/var/mail/cltbld', 21:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:08 INFO - 'MOZ_NO_REMOTE': '1', 21:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:08 INFO - 'NO_EM_RESTART': '1', 21:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:08 INFO - 'PWD': '/builds/slave/test', 21:42:08 INFO - 'SHELL': '/bin/bash', 21:42:08 INFO - 'SHLVL': '1', 21:42:08 INFO - 'TERM': 'linux', 21:42:08 INFO - 'TMOUT': '86400', 21:42:08 INFO - 'USER': 'cltbld', 21:42:08 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:08 INFO - '_': '/tools/buildbot/bin/python'} 21:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:42:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:42:10 INFO - Installing collected packages: mozsystemmonitor 21:42:10 INFO - Running setup.py install for mozsystemmonitor 21:42:10 INFO - Successfully installed mozsystemmonitor 21:42:10 INFO - Cleaning up... 21:42:10 INFO - Return code: 0 21:42:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:42:10 INFO - Using env: {'DISPLAY': ':0', 21:42:10 INFO - 'HOME': '/home/cltbld', 21:42:10 INFO - 'LANG': 'en_US.UTF-8', 21:42:10 INFO - 'LANGUAGE': 'en_US:en', 21:42:10 INFO - 'LOGNAME': 'cltbld', 21:42:10 INFO - 'MAIL': '/var/mail/cltbld', 21:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:10 INFO - 'MOZ_NO_REMOTE': '1', 21:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:10 INFO - 'NO_EM_RESTART': '1', 21:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:10 INFO - 'PWD': '/builds/slave/test', 21:42:10 INFO - 'SHELL': '/bin/bash', 21:42:10 INFO - 'SHLVL': '1', 21:42:10 INFO - 'TERM': 'linux', 21:42:10 INFO - 'TMOUT': '86400', 21:42:10 INFO - 'USER': 'cltbld', 21:42:10 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:10 INFO - '_': '/tools/buildbot/bin/python'} 21:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:10 INFO - Downloading/unpacking jsonschema==2.5.1 21:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:42:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:11 INFO - Downloading functools32-3.2.3-2.tar.gz 21:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:42:11 INFO - warning: no files found matching '*.txt' 21:42:11 INFO - no previously-included directories found matching 'build' 21:42:11 INFO - no previously-included directories found matching 'dist' 21:42:11 INFO - no previously-included directories found matching '.git*' 21:42:11 INFO - Installing collected packages: jsonschema, functools32 21:42:11 INFO - Running setup.py install for functools32 21:42:11 INFO - warning: no files found matching '*.txt' 21:42:11 INFO - no previously-included directories found matching 'build' 21:42:11 INFO - no previously-included directories found matching 'dist' 21:42:11 INFO - no previously-included directories found matching '.git*' 21:42:11 INFO - Successfully installed jsonschema functools32 21:42:11 INFO - Cleaning up... 21:42:11 INFO - Return code: 0 21:42:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:42:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:42:11 INFO - Using env: {'DISPLAY': ':0', 21:42:11 INFO - 'HOME': '/home/cltbld', 21:42:11 INFO - 'LANG': 'en_US.UTF-8', 21:42:11 INFO - 'LANGUAGE': 'en_US:en', 21:42:11 INFO - 'LOGNAME': 'cltbld', 21:42:11 INFO - 'MAIL': '/var/mail/cltbld', 21:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:11 INFO - 'MOZ_NO_REMOTE': '1', 21:42:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:11 INFO - 'NO_EM_RESTART': '1', 21:42:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:11 INFO - 'PWD': '/builds/slave/test', 21:42:11 INFO - 'SHELL': '/bin/bash', 21:42:11 INFO - 'SHLVL': '1', 21:42:11 INFO - 'TERM': 'linux', 21:42:11 INFO - 'TMOUT': '86400', 21:42:11 INFO - 'USER': 'cltbld', 21:42:11 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:11 INFO - '_': '/tools/buildbot/bin/python'} 21:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:42:12 INFO - Cleaning up... 21:42:12 INFO - Return code: 0 21:42:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:42:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:42:12 INFO - Using env: {'DISPLAY': ':0', 21:42:12 INFO - 'HOME': '/home/cltbld', 21:42:12 INFO - 'LANG': 'en_US.UTF-8', 21:42:12 INFO - 'LANGUAGE': 'en_US:en', 21:42:12 INFO - 'LOGNAME': 'cltbld', 21:42:12 INFO - 'MAIL': '/var/mail/cltbld', 21:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:12 INFO - 'MOZ_NO_REMOTE': '1', 21:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:12 INFO - 'NO_EM_RESTART': '1', 21:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:12 INFO - 'PWD': '/builds/slave/test', 21:42:12 INFO - 'SHELL': '/bin/bash', 21:42:12 INFO - 'SHLVL': '1', 21:42:12 INFO - 'TERM': 'linux', 21:42:12 INFO - 'TMOUT': '86400', 21:42:12 INFO - 'USER': 'cltbld', 21:42:12 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:12 INFO - '_': '/tools/buildbot/bin/python'} 21:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:12 INFO - Downloading/unpacking blobuploader==1.2.4 21:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:13 INFO - Downloading blobuploader-1.2.4.tar.gz 21:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:42:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:42:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:14 INFO - Downloading docopt-0.6.1.tar.gz 21:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:42:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:42:14 INFO - Running setup.py install for blobuploader 21:42:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:42:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:42:14 INFO - Running setup.py install for requests 21:42:14 INFO - Running setup.py install for docopt 21:42:14 INFO - Successfully installed blobuploader requests docopt 21:42:14 INFO - Cleaning up... 21:42:14 INFO - Return code: 0 21:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:42:14 INFO - Using env: {'DISPLAY': ':0', 21:42:14 INFO - 'HOME': '/home/cltbld', 21:42:14 INFO - 'LANG': 'en_US.UTF-8', 21:42:14 INFO - 'LANGUAGE': 'en_US:en', 21:42:14 INFO - 'LOGNAME': 'cltbld', 21:42:14 INFO - 'MAIL': '/var/mail/cltbld', 21:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:14 INFO - 'MOZ_NO_REMOTE': '1', 21:42:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:14 INFO - 'NO_EM_RESTART': '1', 21:42:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:14 INFO - 'PWD': '/builds/slave/test', 21:42:14 INFO - 'SHELL': '/bin/bash', 21:42:14 INFO - 'SHLVL': '1', 21:42:14 INFO - 'TERM': 'linux', 21:42:14 INFO - 'TMOUT': '86400', 21:42:14 INFO - 'USER': 'cltbld', 21:42:14 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:14 INFO - '_': '/tools/buildbot/bin/python'} 21:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:14 INFO - Running setup.py (path:/tmp/pip-ga_Ptj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:15 INFO - Running setup.py (path:/tmp/pip-ZrMZna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:15 INFO - Running setup.py (path:/tmp/pip-cgjMMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:15 INFO - Running setup.py (path:/tmp/pip-it9dZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:15 INFO - Running setup.py (path:/tmp/pip-YzGVRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:15 INFO - Running setup.py (path:/tmp/pip-3cSdLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:15 INFO - Running setup.py (path:/tmp/pip-I3aQav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:15 INFO - Running setup.py (path:/tmp/pip-kT00rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:15 INFO - Running setup.py (path:/tmp/pip-ySFzni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:15 INFO - Running setup.py (path:/tmp/pip-nFkFjg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:15 INFO - Running setup.py (path:/tmp/pip-HH_9zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:15 INFO - Running setup.py (path:/tmp/pip-ie96o0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:15 INFO - Running setup.py (path:/tmp/pip-uVbNEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:15 INFO - Running setup.py (path:/tmp/pip-THiMPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:15 INFO - Running setup.py (path:/tmp/pip-d6PlQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:16 INFO - Running setup.py (path:/tmp/pip-Gvvoqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:16 INFO - Running setup.py (path:/tmp/pip-bVj0D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:42:16 INFO - Running setup.py install for manifestparser 21:42:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Running setup.py install for mozcrash 21:42:16 INFO - Running setup.py install for mozdebug 21:42:16 INFO - Running setup.py install for mozdevice 21:42:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Running setup.py install for mozfile 21:42:16 INFO - Running setup.py install for mozhttpd 21:42:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Running setup.py install for mozinfo 21:42:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Running setup.py install for mozInstall 21:42:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:42:16 INFO - Running setup.py install for mozleak 21:42:17 INFO - Running setup.py install for mozlog 21:42:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Running setup.py install for moznetwork 21:42:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Running setup.py install for mozprocess 21:42:17 INFO - Running setup.py install for mozprofile 21:42:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Running setup.py install for mozrunner 21:42:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Running setup.py install for mozscreenshot 21:42:17 INFO - Running setup.py install for moztest 21:42:17 INFO - Running setup.py install for mozversion 21:42:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:42:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:42:17 INFO - Cleaning up... 21:42:17 INFO - Return code: 0 21:42:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:42:17 INFO - Using env: {'DISPLAY': ':0', 21:42:17 INFO - 'HOME': '/home/cltbld', 21:42:17 INFO - 'LANG': 'en_US.UTF-8', 21:42:17 INFO - 'LANGUAGE': 'en_US:en', 21:42:17 INFO - 'LOGNAME': 'cltbld', 21:42:17 INFO - 'MAIL': '/var/mail/cltbld', 21:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:17 INFO - 'MOZ_NO_REMOTE': '1', 21:42:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:17 INFO - 'NO_EM_RESTART': '1', 21:42:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:17 INFO - 'PWD': '/builds/slave/test', 21:42:17 INFO - 'SHELL': '/bin/bash', 21:42:17 INFO - 'SHLVL': '1', 21:42:17 INFO - 'TERM': 'linux', 21:42:17 INFO - 'TMOUT': '86400', 21:42:17 INFO - 'USER': 'cltbld', 21:42:17 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:17 INFO - '_': '/tools/buildbot/bin/python'} 21:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:42:18 INFO - Running setup.py (path:/tmp/pip-tWWBIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:42:18 INFO - Running setup.py (path:/tmp/pip-HwrZhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:42:18 INFO - Running setup.py (path:/tmp/pip-TNpGRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:42:18 INFO - Running setup.py (path:/tmp/pip-vlRcHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:42:18 INFO - Running setup.py (path:/tmp/pip-ipQF4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:42:18 INFO - Running setup.py (path:/tmp/pip-ckOf8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:42:18 INFO - Running setup.py (path:/tmp/pip-za6uiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:42:18 INFO - Running setup.py (path:/tmp/pip-ojZKwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:42:18 INFO - Running setup.py (path:/tmp/pip-ErMb8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:42:18 INFO - Running setup.py (path:/tmp/pip-XecADu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:42:18 INFO - Running setup.py (path:/tmp/pip-2m569t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:42:18 INFO - Running setup.py (path:/tmp/pip-8EvYdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:42:19 INFO - Running setup.py (path:/tmp/pip-JLV7vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:42:19 INFO - Running setup.py (path:/tmp/pip-Jb2OGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:19 INFO - Running setup.py (path:/tmp/pip-JIpmb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:42:19 INFO - Running setup.py (path:/tmp/pip-BX08V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:42:19 INFO - Running setup.py (path:/tmp/pip-QRXkEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:42:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:20 INFO - Downloading blessings-1.6.tar.gz 21:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:42:20 INFO - Installing collected packages: blessings 21:42:20 INFO - Running setup.py install for blessings 21:42:20 INFO - Successfully installed blessings 21:42:20 INFO - Cleaning up... 21:42:20 INFO - Return code: 0 21:42:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:42:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:20 INFO - Reading from file tmpfile_stdout 21:42:20 INFO - Current package versions: 21:42:20 INFO - argparse == 1.2.1 21:42:20 INFO - blessings == 1.6 21:42:20 INFO - blobuploader == 1.2.4 21:42:20 INFO - docopt == 0.6.1 21:42:20 INFO - functools32 == 3.2.3-2 21:42:20 INFO - jsonschema == 2.5.1 21:42:20 INFO - manifestparser == 1.1 21:42:20 INFO - mozInstall == 1.13 21:42:20 INFO - mozcrash == 1.0 21:42:20 INFO - mozdebug == 0.1 21:42:20 INFO - mozdevice == 0.51 21:42:20 INFO - mozfile == 1.2 21:42:20 INFO - mozhttpd == 0.7 21:42:20 INFO - mozinfo == 0.10 21:42:20 INFO - mozleak == 0.1 21:42:20 INFO - mozlog == 3.5 21:42:20 INFO - moznetwork == 0.27 21:42:20 INFO - mozprocess == 0.25 21:42:20 INFO - mozprofile == 0.28 21:42:20 INFO - mozrunner == 6.13 21:42:20 INFO - mozscreenshot == 0.1 21:42:20 INFO - mozsystemmonitor == 0.3 21:42:20 INFO - moztest == 0.8 21:42:20 INFO - mozversion == 1.4 21:42:20 INFO - psutil == 3.1.1 21:42:20 INFO - requests == 1.2.3 21:42:20 INFO - wsgiref == 0.1.2 21:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:42:20 INFO - Using env: {'DISPLAY': ':0', 21:42:20 INFO - 'HOME': '/home/cltbld', 21:42:20 INFO - 'LANG': 'en_US.UTF-8', 21:42:20 INFO - 'LANGUAGE': 'en_US:en', 21:42:20 INFO - 'LOGNAME': 'cltbld', 21:42:20 INFO - 'MAIL': '/var/mail/cltbld', 21:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:20 INFO - 'MOZ_NO_REMOTE': '1', 21:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:20 INFO - 'NO_EM_RESTART': '1', 21:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:20 INFO - 'PWD': '/builds/slave/test', 21:42:20 INFO - 'SHELL': '/bin/bash', 21:42:20 INFO - 'SHLVL': '1', 21:42:20 INFO - 'TERM': 'linux', 21:42:20 INFO - 'TMOUT': '86400', 21:42:20 INFO - 'USER': 'cltbld', 21:42:20 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:20 INFO - '_': '/tools/buildbot/bin/python'} 21:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:42:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 21:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:42:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 21:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:42:22 INFO - Installing collected packages: simplejson 21:42:22 INFO - Running setup.py install for simplejson 21:42:22 INFO - building 'simplejson._speedups' extension 21:42:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 21:42:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 21:42:23 INFO - Successfully installed simplejson 21:42:23 INFO - Cleaning up... 21:42:23 INFO - Return code: 0 21:42:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:42:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1460ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:42:23 INFO - Using env: {'DISPLAY': ':0', 21:42:23 INFO - 'HOME': '/home/cltbld', 21:42:23 INFO - 'LANG': 'en_US.UTF-8', 21:42:23 INFO - 'LANGUAGE': 'en_US:en', 21:42:23 INFO - 'LOGNAME': 'cltbld', 21:42:23 INFO - 'MAIL': '/var/mail/cltbld', 21:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:23 INFO - 'MOZ_NO_REMOTE': '1', 21:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:23 INFO - 'NO_EM_RESTART': '1', 21:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:23 INFO - 'PWD': '/builds/slave/test', 21:42:23 INFO - 'SHELL': '/bin/bash', 21:42:23 INFO - 'SHLVL': '1', 21:42:23 INFO - 'TERM': 'linux', 21:42:23 INFO - 'TMOUT': '86400', 21:42:23 INFO - 'USER': 'cltbld', 21:42:23 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:23 INFO - '_': '/tools/buildbot/bin/python'} 21:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:42:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:42:23 INFO - Cleaning up... 21:42:23 INFO - Return code: 0 21:42:23 INFO - Running post-action listener: _resource_record_post_action 21:42:23 INFO - Running post-action listener: _start_resource_monitoring 21:42:23 INFO - Starting resource monitoring. 21:42:23 INFO - [mozharness: 2017-08-17 04:42:23.658737Z] Finished create-virtualenv step (success) 21:42:23 INFO - [mozharness: 2017-08-17 04:42:23.659209Z] Running install step. 21:42:23 INFO - Running pre-action listener: _resource_record_pre_action 21:42:23 INFO - Running main action method: install 21:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:42:23 INFO - Reading from file tmpfile_stdout 21:42:23 INFO - Detecting whether we're running mozinstall >=1.0... 21:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:42:24 INFO - Reading from file tmpfile_stdout 21:42:24 INFO - Output received: 21:42:24 INFO - Usage: mozinstall [options] installer 21:42:24 INFO - Options: 21:42:24 INFO - -h, --help show this help message and exit 21:42:24 INFO - -d DEST, --destination=DEST 21:42:24 INFO - Directory to install application into. [default: 21:42:24 INFO - "/builds/slave/test"] 21:42:24 INFO - --app=APP Application being installed. [default: firefox] 21:42:24 INFO - mkdir: /builds/slave/test/build/application 21:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:42:42 INFO - Reading from file tmpfile_stdout 21:42:42 INFO - Output received: 21:42:42 INFO - /builds/slave/test/build/application/firefox/firefox 21:42:42 INFO - Running post-action listener: _resource_record_post_action 21:42:42 INFO - [mozharness: 2017-08-17 04:42:42.170986Z] Finished install step (success) 21:42:42 INFO - [mozharness: 2017-08-17 04:42:42.171332Z] Running setup-mitmproxy step. 21:42:42 INFO - Running pre-action listener: _resource_record_pre_action 21:42:42 INFO - Running main action method: setup_mitmproxy 21:42:42 INFO - Skipping: mitmproxy is not required 21:42:42 INFO - Running post-action listener: _resource_record_post_action 21:42:42 INFO - [mozharness: 2017-08-17 04:42:42.172964Z] Finished setup-mitmproxy step (success) 21:42:42 INFO - [mozharness: 2017-08-17 04:42:42.173280Z] Running run-tests step. 21:42:42 INFO - Running pre-action listener: _resource_record_pre_action 21:42:42 INFO - Running pre-action listener: _set_gcov_prefix 21:42:42 INFO - Running main action method: run_tests 21:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:42:42 INFO - Python 2.7.3 21:42:42 INFO - Return code: 0 21:42:42 INFO - grabbing minidump binary from tooltool 21:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:42:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145e0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x145efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x145f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:42:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:42:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:42:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:42:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:42:42 INFO - Return code: 0 21:42:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:42:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:42:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:42:42 INFO - ENV: RUST_BACKTRACE is now full 21:42:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:42:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:42:42 INFO - Using env: {'DISPLAY': ':0', 21:42:42 INFO - 'HOME': '/home/cltbld', 21:42:42 INFO - 'LANG': 'en_US.UTF-8', 21:42:42 INFO - 'LANGUAGE': 'en_US:en', 21:42:42 INFO - 'LOGNAME': 'cltbld', 21:42:42 INFO - 'MAIL': '/var/mail/cltbld', 21:42:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:42:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:42:42 INFO - 'MOZ_NO_REMOTE': '1', 21:42:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:42:42 INFO - 'NO_EM_RESTART': '1', 21:42:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:42:42 INFO - 'PWD': '/builds/slave/test', 21:42:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:42:42 INFO - 'RUST_BACKTRACE': 'full', 21:42:42 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 21:42:42 INFO - 'SHELL': '/bin/bash', 21:42:42 INFO - 'SHLVL': '1', 21:42:42 INFO - 'STYLO_FORCE_ENABLED': '1', 21:42:42 INFO - 'TERM': 'linux', 21:42:42 INFO - 'TMOUT': '86400', 21:42:42 INFO - 'USER': 'cltbld', 21:42:42 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004', 21:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:42:42 INFO - '_': '/tools/buildbot/bin/python'} 21:42:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:42:42 INFO - mozversion application_buildid: 20170817035831 21:42:42 INFO - mozversion application_changeset: 932388b8c22c9775264e543697ce918415db9e23 21:42:42 INFO - mozversion application_display_name: Nightly 21:42:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:42:42 INFO - mozversion application_name: Firefox 21:42:42 INFO - mozversion application_remotingname: firefox 21:42:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:42:42 INFO - mozversion application_vendor: Mozilla 21:42:42 INFO - mozversion application_version: 57.0a1 21:42:42 INFO - mozversion platform_buildid: 20170817035831 21:42:42 INFO - mozversion platform_changeset: 932388b8c22c9775264e543697ce918415db9e23 21:42:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:42:42 INFO - mozversion platform_version: 57.0a1 21:42:42 INFO - using testdate: 1502944962 21:42:42 INFO - actual date: 1502944962 21:42:42 INFO - starting webserver on 'localhost:37133' 21:42:42 INFO - SUITE-START | Running 2 tests 21:42:42 INFO - TEST-START | dromaeo_css 21:42:42 INFO - Initialising browser for dromaeo_css test... 21:42:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37133/getInfo.html -profile /tmp/tmpa0oT63/profile 21:42:42 INFO - TEST-INFO | started process 12165 (/builds/slave/test/build/application/firefox/firefox http://localhost:37133/getInfo.html) 21:42:48 INFO - TEST-INFO | 12165: exit 0 21:42:48 INFO - Browser initialized. 21:42:48 INFO - Running cycle 1/1 for dromaeo_css test... 21:42:48 INFO - TEST-INFO | started process 12358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpa0oT63/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:49 INFO - PID 12358 | 21:42:49 INFO - PID 12358 | (/builds/slave/test/build/application/firefox/firefox:12412): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 21:42:49 INFO - PID 12358 | 21:43:00 INFO - PID 12358 | RSS: Main: 166580224 21:43:00 INFO - PID 12358 | 21:45:58 INFO - PID 12358 | Cycle 1(1): loaded http://localhost:37133/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37133/tests/dromaeo/cssquery-ext.html) 21:46:00 INFO - PID 12358 | RSS: Main: 174538752 21:46:00 INFO - PID 12358 | 21:49:02 INFO - PID 12358 | Cycle 1(1): loaded http://localhost:37133/tests/dromaeo/cssquery-ext.html (next: http://localhost:37133/tests/dromaeo/cssquery-jquery.html) 21:49:02 INFO - PID 12358 | RSS: Main: 171462656 21:49:02 INFO - PID 12358 | 21:52:04 INFO - PID 12358 | Cycle 1(1): loaded http://localhost:37133/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37133/tests/dromaeo/cssquery-mootools.html) 21:52:05 INFO - PID 12358 | RSS: Main: 173842432 21:52:05 INFO - PID 12358 | 21:55:06 INFO - PID 12358 | Cycle 1(1): loaded http://localhost:37133/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37133/tests/dromaeo/cssquery-prototype.html) 21:55:07 INFO - PID 12358 | RSS: Main: 171978752 21:55:07 INFO - PID 12358 | 21:58:11 INFO - PID 12358 | Cycle 1(1): loaded http://localhost:37133/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37133/tests/dromaeo/cssquery-yui.html) 21:58:11 INFO - PID 12358 | RSS: Main: 175534080 21:58:11 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | Cycle 1(1): loaded http://localhost:37133/tests/dromaeo/cssquery-yui.html (next: http://localhost:37133/tests/dromaeo/cssquery-dojo.html) 22:01:13 INFO - PID 12358 | RSS: Main: 176070656 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | __start_tp_report 22:01:13 INFO - PID 12358 | _x_x_mozilla_page_load 22:01:13 INFO - PID 12358 | _x_x_mozilla_page_load_details 22:01:13 INFO - PID 12358 | |i|pagename|runs| 22:01:13 INFO - PID 12358 | |0;dojo.html;3185.2036990752313;3205.583274174358;3219.533167690685;3232.143481977275;3241.9837900810494;6272.905906411407;6331.55679102463;6338.207724034496;6378.138951241587;6431.6784160792;6221.222347206599;6306.148669929569;6311.084892690568;6324.241091069078;6324.2727086385075;5700.942990570104;5754.02181629123;5755.366909639936;5756.395578464264;5769.682667453289;5827.796027139051;5864.530837533009;5882.088276317178;5915.467607915287;5927.585069045169;5757.596968212227;5823.330317013555;5824.708764561755;5863.442972917566;5916.083007133901;5654.773809047633;5718.027935250976;5769.24999750034;5820.185174075633;5832.941670583282;5721;5739.3399759027825;5787.942120578825;5817.912731309034;5828.504577110951;6046.304674962392;6196.814095577095;6212.627242365473;6241.032639940817;6304.747810087591;6679.56582822115;6727.058211850345;6752.696128674222;6756.560823546503;6821.522493425462;6865.9313406865795;6869.896951545731;6873.621950792704;6877.243503214642;6887.449004079712;6308.3060863304545;6364.204474440695;6399.552031357807;6400.295967443578;6406.263279722798;6959.8956015659805;6974.930250697529;6980.197277313073;6983.196932352743;7080.468964827659;6407.103005579223;6494.805155845333;6593.142891424084;6661.700223489955;6665.800025999228;6727.360900714424;6759.188897332253;6764.4926630502905;6780.627065511346;6862.965685171642;6746.224184218878;6837;6841.179058512911;6842.076319696876;6846.863062738717;6791.252962174157;6797.354251346114;6799.32006799326;6894.827629309308;6899.517033807585;5382.515573598395;5437.157240627709;5464.3442786865835;5491.917621235684;5492.505674489315;4686.062787442525;4715.764211789466;4719.693219940693;4724.267738500538;4738.64460165489;5722.570807189478;5742.913856292159;5795.333536643256;5799.101139323411;5808.5062769665055;6738.561993470409;6827.863442731117;6829.317068293131;6831.760888368884;6835.384815366641;5742.138679198154;5747.770089196469;5791.768329266866;5820.621659592113;5839.678817664984;5787.363390027093;5911.201987731602;5919.733611987471;5938.406159384113;5994.460498555151;6595.769148079794;6596.60420374779;6600.207975043026;6608.537402381787;6612.966935165294;6795.864082718417;6851.828704282433;6855.177378714586;6858.3827455529245;6887.621180835102;6548.869022619616;6597.703103360264;6620.205575330991;6671.199456065303;6682.365175308338;6542.182227221598;6600.669966501751;6667.633280169443;6675.332466753286;6764.3573860483175;6840.6921688525135;6854.074699915647;6859.897101543381;6872.553284036521;6878.312168783082;6528.608283503005;6674.032265321598;6676.399124078856;6681.732730690913;6681.899771503334;6520.250171230369;6543.247526534509;6553.148090748363;6606.405423511907;6627.502937279627;6397.552171348148;6454.935450645434;6481.902771458526;6496.155499784998;6557.344265573404;6576.145101136822;6615.900761488678;6633.502487313567;6635.336466353326;6637.937929931188;6332.335104813928;6358.904616430665;6393.936060639334;6433.774817881352;6435.06691529735 22:01:13 INFO - PID 12358 | |1;ext.html;709.9361057504826;770.283636218317;785.0148064179458;785.2971590426566;1136.3749937534353;30508.84745576272;30978.53532197019;41644.16711665765;42536.361954570704;42597.78701106498;42433.15133697332;42904;42925.57074429255;42956.3556546652;43040.56959430405;7434.442416818733;7516.511426757271;7718.53688778675;7723.343515801163;7728.7681369559;7565.394768418513;7680.231976802303;7682.884756728654;7683.1548529661695;7683.308502234798;7621.237876212362;7647.388208943299;7675.424343174284;7697.114831794332;7701.9614901925415;7603.733869314575;7648.541087534738;7651.655675494589;7651.770446886602;7664.540127592362;7477.327040566375;7551.546907185587;7552.69789208431;7556.206598307153;7562.243775622449;37669.05827354338;37928;37961.24077518434;37977;38018.23963520714;3536.1159710072484;3568.0366301098816;3581.158427769472;3583.910402239939;3586.6234045425117;30900.0729978101;31017.534736978963;31017.534736978963;31041.37917241665;31043.84478077595;4610.077984403133;4630.328602352673;4630.444346678387;4649.418822647169;4693.48371679115;186929;189349;191034;191341.04329478403;191580;49055.75472122688;49102.50897491051;49263;49267.753661231465;49510;50936.74531627318;51326.74336628368;51329;51387.48612513902;51555.7422212894;12989.28558929249;16519.752203716955;16836.74744878828;16837.494875153767;16846;10849.24055316136;13759.518416855562;14044.508442204473;14053.367598458093;14057.578272651837;14402.351894164787;14463;14501.202433866029;14529.200893950934;14588.124712517283;5617.8595535111135;5778.566607504454;5807.5644326675665;5861.765529378862;5940.227770389908;974.3715303629119;1006.225206590921;1011.838105903052;1018.9082982531608;1023.2530252915413;22826.885865570897;22902.969366378555;23011.769882300963;23083;23363;963.2534785541261;967.4969016111583;971.3637567393368;984;989.6288891665625;10519.008330503233;10543;10632.46837658114;10683.358998460117;10829.187810914213;233218;234400;236732;236812;236882;52787.73606132022;52949;53298.73350633222;53353.46646533562;53356.19965700518;1382.2743059893637;1465.2014652014464;1486.7100915321626;1489.560579629012;1499.7825315329435;19316.32392866243;19436.514087147934;19518.609627807647;19660.80339196647;19999.400017999484;50585;51877.22184167316;51991.480085198666;52057.219141713664;52123.739381302854;206312;213781;217112;219627;220007;36801;36989;37009;37656.05859853526;37681.81159094187;46890;47513.28730068982;47701.76149119232;48016;48288.275675864184;35283.29433411266;35352.46971295381;35453.645463545035;35638.64361356457;35884.28231435305;34401.13997150091;35025.64974350326;35285.823570881985;35305.29389412146;35439.645603543635;37303;38252.42621360626;38374.80812595919;38479;38799.806000970944;33425.83287083549;33756;33907.321853562295;34042.82978585091;34650;23494.76505234926;24512.632310515;24707.382315442257;24982.62526062147;25353 22:01:13 INFO - PID 12358 | |2;jquery.html;543.3262754184809;564.2072887592931;569.2485918587461;570.8858228354328;586.2291087220306;21823.345299641016;22641.207557735503;22667;22678.88660556699;22727.659085113715;26009.73990260097;26527.602085968676;26684.599731004;26764.19707408776;26792;6379.904301435494;6535.836604084889;6538.313477084909;6544.181977252843;6544.672766361687;6330.588511746745;6497.480201583886;6551.1483507144;6619.338066193391;6968.616726080064;6806.863862722743;6818;6820.420264277543;6850.246472888003;6877.243503214642;6829.556078854858;6872.484563657721;6876.724931002754;6885.896711549331;6894.827629309258;6765.086713293692;6796.830079248059;6799.320067993211;6811.352921472501;6828;25089.372765680822;25552.105676301428;28221;32161.517577236362;32306.192345191324;1922.404054743034;1983.8016198380192;1991.601679664073;1999.3701983875033;2001.4395969128668;19619.80380196194;20215.090320935593;20947;21669.566608667737;21761.238356657443;2483.8261321707487;2485.763852434016;2560.167945417728;2608.960865587018;2620.331815387083;138629.30685346609;145765;146364;146629;146693;20230.69653955192;20237.595248094956;20939.371818845153;22026.779732202795;22617.51207367188;45259.32111018337;45615.31577026347;45945.77027114843;45990.540094599295;46036.3094553582;11597.88402115968;11830.645080647595;11850.585229516926;11865.703357416134;11918.284902905853;9520.333576649706;9622.37454565451;9748.366356186825;9811.116999470081;9886.703398898044;8857.867131993025;9217.124373184537;9226.215771659485;11354;11911.10666700001;2555.195113539229;2622.9966688142354;2689.9193024209303;2717.402171522262;2826.547752359613;925.7407925780792;973.2894986659778;977.203579083045;978.8335982882927;987.7876256604865;19916.70124948127;20044.899775501322;20188;20404.591908162052;20546.69179962302;1045.8849526552074;1055.6885718712997;1059.427908929185;1068.0227591753614;1075.693427373195;11160.10719142483;11405.828912566318;11411.543538258542;11628.302301861915;11675.416229188506;463191;480297;484294;487031;487576;118281;121669;121811.39094304472;121979.39010304892;122813;1200.6698158006618;1233.9136260461682;1234.2594443334108;1250.4123062160952;1253.053944272087;18133.727994080364;18185.18166682476;18193.909030454764;18293;18642.533936651693;56420;56894.43105569057;57270.713646431504;57678;58210.70894645499;69027.96458053234;69771.3022869785;70069;70398;71906.28093718996;12358.50565977351;12410.937945310216;14660.56018319452;14954.775678365051;15035;23380.18169364064;23458.296251112493;23650.645240321064;23905.64141537913;23963;17804.3768468103;17912.462626121236;18032.819671803114;18464;18652.90673546678;17206.741898871278;17439.56401089983;17477;17612;17824.55438614045;18969.620607587494;19236.615267694287;19601.70597441068;19656.410307690792;19698.50753731168;14275.500357487437;14966;14989.400423983354;15022.399104035716;15099.698006040038;18945.90527047411;18995.145218465477;19225.711614325515;19232.423027309203;19254.903725481283 22:01:13 INFO - PID 12358 | |3;mootools.html;1389.1942673249514;1446.2913172545457;1454.4909281751382;1454.9345279462423;1465.838757736649;14246.928765356171;14574.198419086946;14878.851211487881;14880.404783808635;14888.553343399702;13096.869031309685;13288.335583220849;13440.865591344083;13454.394552245149;13466.192028478274;2589.6115582662565;2670.359113812681;2733.876975536096;2734.6171535984977;2739.260399692092;2794.4690508803264;2804.4531316393313;2830;2838.3329917469378;2838.815476993989;2760.268528839859;2791.427757309757;2794.3572978215025;2819;2828.250513613894;2549.6557964674903;2586.7671909528044;2672.986635066822;2696.0968075694664;2714.864256787153;2536.1884197056947;2588.4952434275324;2589.741025897414;2597.2597809624167;2612.6211699303494;14208.289585520683;14422.639434014234;14501.347439365254;14502.70994580113;14566;7772.65023073963;8042.839143217103;8061.153578874251;8075.919240807634;8090.838183236302;5274.340707411574;5339.652922560022;5436.238926550286;5505.587080968903;5511.283533140666;1881.9341323053764;1886.141805478504;1890.4895678166956;1928.0456174193864;1928.0841600239773;23963.041478340845;24212;24218;24668.629970550457;24786;6514.739410423625;6516.609003459807;6603.570767900071;6649.601023938482;6762.492813039042;16744.330226790793;16755.41356052532;16756.497305080866;16782.58043548921;16789.6642067158;7845.764627061198;7891.565963871927;7938.444308898437;7955;7989.121196668362;7211.89182162268;7230.710771569184;7359.190489046201;7395.7041718330665;7410.11078670563;4966.726830024311;4999.125153098194;5020.874478138003;5038.974805125951;5053.469385714447;1480.7556753135611;1482.6145202247494;1492.9776053359208;1501.3469140923733;1502.721996430664;910.4855756497558;938.558877327655;940.1773448232797;943.1228957069853;944.9338546301831;7631.465797394129;7685.42359323053;7701.730439434593;7746.225377462209;7811.101723301779;717.2612209424301;724.699249811333;725.804032911111;738.8189893476133;739.4454159380465;5000.499950004971;5218.165093585008;5337.5463085637375;5355.625106242525;5415.458454154632;19780.021997800104;20267.391978240677;20349.898250508653;20559.691604625943;20568.485787855425;18940.90529547371;19715.704264436044;20082.598348032956;20109.698354524695;20159.899200503904;9273.67542136022;9639.662611808553;9771.80456390854;10442.477876106164;10693.358398496115;8453.87319190225;8679.479231246145;8708.17272359125;8755.212030917248;8860.955695221483;16682;17059.573510662332;17148.485545433658;17617.64764704673;17883.73174402359;17110.230039647995;17774;17891.642167156846;17900.28398864031;17953.192106355506;13379.598612041655;13586.45654173822;13678.589642310746;13679.042467027213;13680.110792798436;13597.52408665692;13680.384382702603;13768.724625507633;13804.516841910887;13832.446702131801;11213.719657008314;11217.49521271561;11260.718482038015;11410.201285909907;11492.770144596894;11069.612563560237;11081.889181108409;11206.215564910379;11209.215354925076;11399.373034483184;9514.762130946505;9586.424814511152;9612.855807163038;9660.178884794872;9677.274204434836;7315.853682926205;7376.7786966391095;7441.404687625085;7456.254374562501;7504.249575042452;7067.116610423697;7218.133823941161;7219.422446204396;7221.494495385273;7232.566046037255 22:01:13 INFO - PID 12358 | |4;prototype.html;510.40027967138604;512.8948565544063;528.8281308574713;533.4233961289551;536.7369988705533;6237.251529816423;6325.078451360163;6370.267419246788;6372.139761132245;6386.521010924176;6133.785317513888;6190.907136392958;6197.459041792866;6201.441870231678;6220.382700497869;5124.538791508754;5131.332926719521;5148.176291793314;5160.329157209558;5171.482851714817;4769.713817170964;4916.926246106311;5085.23721441783;5130.666506677054;5139.743012849362;4929.630277729167;4946.9752651236695;4956.430010548779;4967.950320496803;4996.32549605804;4919.60643148549;4926.1625523660705;4945.678530895516;4967.875803104916;4975.527324904128;4407.647388208936;4419.535948725402;4428.31361139024;4489.079738653568;4507.504174540798;6031.306399763996;6058.485028772559;6060.454584081075;6105.816825495198;6113.724882380304;5719.113537401668;5744.684042377709;5745.942540574582;5775.8556036099435;5823.737931793037;6422.582532135443;6446.613203207822;6457.450211949145;6477.935220647781;6490.610563366213;4855.174620314555;4858.6356023298395;4883.218685010382;4893.804247830082;4898.289747986522;6678.298778628271;6695.631740254284;6761.222459417131;6905.930940690579;7014.508984371096;4840.854774356775;4990.451050384455;4997.3253610762085;5005.549500544896;5025;5041.193409054534;5100.209467532539;5114.795408183631;5120.897582048338;5135.6918584885025;5692.14617807324;5717.771289148471;5724;5726.255586773693;5778.711064446761;6595.967020164869;6644.568103073285;6675.7997260082275;6682.532222744361;6692.297308782508;1741.947741567755;1750.9824901751074;1757.5957529768225;1786.7141257398753;1798.8291112344307;1183.6329039958862;1217.8477690288714;1223.62067758995;1231.5073970411906;1248.7502499500135;5663;5674.602777805597;5677.772889084473;5730.226419433407;5762.827115186551;6640.402363787282;6666.899996500057;6726.293739157416;6741.966290168518;6827.453803695693;5733.627314224562;5748.5688573357165;5762.423757624288;5814.622049566765;5820.097884827858;3564.8395822188063;3577.4633804929467;3619.94570081449;3620.3664358737115;3631.473436351714;6568.737250510022;6601.207855057328;6629.46964242869;6652.234992975773;6657.23441804189;6903.896441553381;6948.513604047668;6966;6973.546719463218;6976.93023069773;6540.967295163494;6589.341065893373;6590.242122155918;6618.437432818168;6643.541889500915;6155.6614386209185;6829.180498340231;6829.931700683128;6839.931600684128;6843.349881761224;6678.332166783282;6679.4990375721045;6698.899516507354;6710.571023124714;6737.124173857367;6413.775517856852;6599.60402375859;6604.7027883746305;6611.834704132435;6611.950065690032;5042.117629414764;5071.112555302733;5074.16276314404;5082.288479612783;5084.1102807009365;6582.243042050034;6624.56940298879;6753.797386078426;6805.251422343637;6862.519623626298;6587.374199451045;6589.341065893564;6590.176227971504;6614.5039122067;6624.337566243337;6519.250286217146;6532.314107018695;6560.507961902972;6574.243961944438;6605.702743376463;6393.442622950857;6415.839604009937;6423.678816059271;6484.902726459201;6531.575447595891;6571.835704107244;6599.340065993362;6602.570832895846;6627.966860165861;6635.8009259722285;6311.589746666452;6354.301026887131;6390.977443609;6393.328700486382;6406.231252249573 22:01:13 INFO - PID 12358 | |5;yui.html;899.7390756680559;903.1600611431368;920.769807548113;924.7780532672157;929.1498279074647;19134.42596722097;20071.59856802865;20079.397618071445;20113.698294525577;20160.395188144343;17969.550761230978;18001.279948802032;18251.81748182518;22488.662670059963;22538.774612253874;1050.1965996013057;1073.0396295315688;1073.581303291717;1074.425182527348;1074.5970261152067;1019.2457581389755;1061.5753698520575;1062.1821197677823;1065.3554599467327;1065.9626913058044;1105.5743538737604;1109.4009235013084;1110.5779803674593;1112.6495154026495;1113.582406597526;1105.6461932181705;1105.9944700276487;1106.1537923488538;1106.4578356605286;1106.4965440724452;800.8918795962587;801.7193982106274;802.9156938521429;803.2489622203259;803.8914746509205;19851;20067.698984515246;20294.188232470682;20330.28843990468;20392.796072039237;22600.66099008516;22760.20339288117;22960.77039229603;22973.425664358525;23250.76749232503;16092.517224483285;16277.186140692918;16387.754183687255;16589.087600181985;16725.498235052968;3610.5667319921513;3617.981910090459;3621.3481573316794;3664.578573464059;3666.4133738601963;130402;130480;130926;134076.32961835127;134810;17460.650786984188;17534.82465175332;17541.736873946902;17564.91217543904;17952.102394880203;31066.68933310683;31707.682923170934;31878.521822172686;31931.680683193335;32510.349793004007;8404.20160084791;8631.136886311444;8634.611442485104;8654.697085601974;8858.247049000907;4294.592013758688;4327.891802704895;4392.1874453226255;4404.471463424409;4406.801693923717;5223.582113430916;5307.8142265021315;5319.946800532022;5328.120860058125;5329.573634109262;1016.2378216337746;1017.6183931025865;1044.060345688871;1044.185535282481;1046.0428707732492;695.8399568099366;707.6178863413802;716.3660160757767;717.9748708795167;722.8626560953402;11420.828687569694;11513.481893314822;12307.56923507673;12464.563740269046;12611.684707882192;690.5787469643514;696.8188271049462;700.6881937537848;703.855709579535;705.1538154214962;6211.3167551569295;6601.141851559267;6712.127423434922;6760.08738820253;6796.286389929085;111331;112493.43753281345;113362.43318783518;113495.43252283685;114117;76770.16149192517;97694.51152744191;100124.49937750411;100379;102322;86145;88440;88620.5568972151;89116;92238;12657.93671031639;12884.935575322063;13492.730145397234;13498.52755153565;13546.458141674222;40091.59908400878;40473.39289910595;40913.38629920613;41571.58428415798;41603.16793664049;72302.27697722956;73491;74052.2594774067;74272;76791.61604191943;19362.51593710112;19502.512437188616;19513.804861951197;19770.40688779339;19773.802261977195;20799.584008320053;22142.335729928127;22214.666779998635;22351.217707380165;22356.77643223612;17658.20538075764;18402.171902264163;18576;19146;19658.705119423506;20299.188032478534;21181.152753889673;21395.037223324678;21815.345539633836;22088.88955555212;20917.163313467292;21056.684149738074;21223.469413264793;21364.392346457564;21520.461988450414;13993.580192594238;14085.647858803612;14154.858451415354;14169;14174.858251417767;13987.796284913074;14354.775009873487;14366.209858457885;15182.924085379502;15564.066156030674 22:01:13 INFO - PID 12358 | __end_tp_report 22:01:13 INFO - PID 12358 | __start_cc_report 22:01:13 INFO - PID 12358 | _x_x_mozilla_cycle_collect,369 22:01:13 INFO - PID 12358 | __end_cc_report 22:01:13 INFO - PID 12358 | __startTimestamp1502946073813__endTimestamp 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | ------- Summary: start ------- 22:01:13 INFO - PID 12358 | Number of tests: 6 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | [#0] dojo.html Cycles:165 Average:6236.89 Median:6454.94 stddev:741.78 (11.5%) stddev-sans-first:704.36 22:01:13 INFO - PID 12358 | Values: 3185.2 3205.6 3219.5 3232.1 3242.0 6272.9 6331.6 6338.2 6378.1 6431.7 6221.2 6306.1 6311.1 6324.2 6324.3 5700.9 5754.0 5755.4 5756.4 5769.7 5827.8 5864.5 5882.1 5915.5 5927.6 5757.6 5823.3 5824.7 5863.4 5916.1 5654.8 5718.0 5769.2 5820.2 5832.9 5721.0 5739.3 5787.9 5817.9 5828.5 6046.3 6196.8 6212.6 6241.0 6304.7 6679.6 6727.1 6752.7 6756.6 6821.5 6865.9 6869.9 6873.6 6877.2 6887.4 6308.3 6364.2 6399.6 6400.3 6406.3 6959.9 6974.9 6980.2 6983.2 7080.5 6407.1 6494.8 6593.1 6661.7 6665.8 6727.4 6759.2 6764.5 6780.6 6863.0 6746.2 6837.0 6841.2 6842.1 6846.9 6791.3 6797.4 6799.3 6894.8 6899.5 5382.5 5437.2 5464.3 5491.9 5492.5 4686.1 4715.8 4719.7 4724.3 4738.6 5722.6 5742.9 5795.3 5799.1 5808.5 6738.6 6827.9 6829.3 6831.8 6835.4 5742.1 5747.8 5791.8 5820.6 5839.7 5787.4 5911.2 5919.7 5938.4 5994.5 6595.8 6596.6 6600.2 6608.5 6613.0 6795.9 6851.8 6855.2 6858.4 6887.6 6548.9 6597.7 6620.2 6671.2 6682.4 6542.2 6600.7 6667.6 6675.3 6764.4 6840.7 6854.1 6859.9 6872.6 6878.3 6528.6 6674.0 6676.4 6681.7 6681.9 6520.3 6543.2 6553.1 6606.4 6627.5 6397.6 6454.9 6481.9 6496.2 6557.3 6576.1 6615.9 6633.5 6635.3 6637.9 6332.3 6358.9 6393.9 6433.8 6435.1 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | [#1] ext.html Cycles:180 Average:38937.60 Median:37479.53 stddev:55712.74 (148.6%) stddev-sans-first:55795.09 22:01:13 INFO - PID 12358 | Values: 709.9 770.3 785.0 785.3 1136.4 30508.8 30978.5 41644.2 42536.4 42597.8 42433.2 42904.0 42925.6 42956.4 43040.6 7434.4 7516.5 7718.5 7723.3 7728.8 7565.4 7680.2 7682.9 7683.2 7683.3 7621.2 7647.4 7675.4 7697.1 7702.0 7603.7 7648.5 7651.7 7651.8 7664.5 7477.3 7551.5 7552.7 7556.2 7562.2 37669.1 37928.0 37961.2 37977.0 38018.2 3536.1 3568.0 3581.2 3583.9 3586.6 30900.1 31017.5 31017.5 31041.4 31043.8 4610.1 4630.3 4630.4 4649.4 4693.5 186929.0 189349.0 191034.0 191341.0 191580.0 49055.8 49102.5 49263.0 49267.8 49510.0 50936.7 51326.7 51329.0 51387.5 51555.7 12989.3 16519.8 16836.7 16837.5 16846.0 10849.2 13759.5 14044.5 14053.4 14057.6 14402.4 14463.0 14501.2 14529.2 14588.1 5617.9 5778.6 5807.6 5861.8 5940.2 974.4 1006.2 1011.8 1018.9 1023.3 22826.9 22903.0 23011.8 23083.0 23363.0 963.3 967.5 971.4 984.0 989.6 10519.0 10543.0 10632.5 10683.4 10829.2 233218.0 234400.0 236732.0 236812.0 236882.0 52787.7 52949.0 53298.7 53353.5 53356.2 1382.3 1465.2 1486.7 1489.6 1499.8 19316.3 19436.5 19518.6 19660.8 19999.4 50585.0 51877.2 51991.5 52057.2 52123.7 206312.0 213781.0 217112.0 219627.0 220007.0 36801.0 36989.0 37009.0 37656.1 37681.8 46890.0 47513.3 47701.8 48016.0 48288.3 35283.3 35352.5 35453.6 35638.6 35884.3 34401.1 35025.6 35285.8 35305.3 35439.6 37303.0 38252.4 38374.8 38479.0 38799.8 33425.8 33756.0 33907.3 34042.8 34650.0 23494.8 24512.6 24707.4 24982.6 25353.0 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | [#2] jquery.html Cycles:180 Average:35906.21 Median:22703.27 stddev:81413.00 (358.6%) stddev-sans-first:81598.09 22:01:13 INFO - PID 12358 | Values: 543.3 564.2 569.2 570.9 586.2 21823.3 22641.2 22667.0 22678.9 22727.7 26009.7 26527.6 26684.6 26764.2 26792.0 6379.9 6535.8 6538.3 6544.2 6544.7 6330.6 6497.5 6551.1 6619.3 6968.6 6806.9 6818.0 6820.4 6850.2 6877.2 6829.6 6872.5 6876.7 6885.9 6894.8 6765.1 6796.8 6799.3 6811.4 6828.0 25089.4 25552.1 28221.0 32161.5 32306.2 1922.4 1983.8 1991.6 1999.4 2001.4 19619.8 20215.1 20947.0 21669.6 21761.2 2483.8 2485.8 2560.2 2609.0 2620.3 138629.3 145765.0 146364.0 146629.0 146693.0 20230.7 20237.6 20939.4 22026.8 22617.5 45259.3 45615.3 45945.8 45990.5 46036.3 11597.9 11830.6 11850.6 11865.7 11918.3 9520.3 9622.4 9748.4 9811.1 9886.7 8857.9 9217.1 9226.2 11354.0 11911.1 2555.2 2623.0 2689.9 2717.4 2826.5 925.7 973.3 977.2 978.8 987.8 19916.7 20044.9 20188.0 20404.6 20546.7 1045.9 1055.7 1059.4 1068.0 1075.7 11160.1 11405.8 11411.5 11628.3 11675.4 463191.0 480297.0 484294.0 487031.0 487576.0 118281.0 121669.0 121811.4 121979.4 122813.0 1200.7 1233.9 1234.3 1250.4 1253.1 18133.7 18185.2 18193.9 18293.0 18642.5 56420.0 56894.4 57270.7 57678.0 58210.7 69028.0 69771.3 70069.0 70398.0 71906.3 12358.5 12410.9 14660.6 14954.8 15035.0 23380.2 23458.3 23650.6 23905.6 23963.0 17804.4 17912.5 18032.8 18464.0 18652.9 17206.7 17439.6 17477.0 17612.0 17824.6 18969.6 19236.6 19601.7 19656.4 19698.5 14275.5 14966.0 14989.4 15022.4 15099.7 18945.9 18995.1 19225.7 19232.4 19254.9 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | [#3] mootools.html Cycles:180 Average:9021.49 Median:2671.67 stddev:6206.46 (232.3%) stddev-sans-first:6197.37 22:01:13 INFO - PID 12358 | Values: 1389.2 1446.3 1454.5 1454.9 1465.8 14246.9 14574.2 14878.9 14880.4 14888.6 13096.9 13288.3 13440.9 13454.4 13466.2 2589.6 2670.4 2733.9 2734.6 2739.3 2794.5 2804.5 2830.0 2838.3 2838.8 2760.3 2791.4 2794.4 2819.0 2828.3 2549.7 2586.8 2673.0 2696.1 2714.9 2536.2 2588.5 2589.7 2597.3 2612.6 14208.3 14422.6 14501.3 14502.7 14566.0 7772.7 8042.8 8061.2 8075.9 8090.8 5274.3 5339.7 5436.2 5505.6 5511.3 1881.9 1886.1 1890.5 1928.0 1928.1 23963.0 24212.0 24218.0 24668.6 24786.0 6514.7 6516.6 6603.6 6649.6 6762.5 16744.3 16755.4 16756.5 16782.6 16789.7 7845.8 7891.6 7938.4 7955.0 7989.1 7211.9 7230.7 7359.2 7395.7 7410.1 4966.7 4999.1 5020.9 5039.0 5053.5 1480.8 1482.6 1493.0 1501.3 1502.7 910.5 938.6 940.2 943.1 944.9 7631.5 7685.4 7701.7 7746.2 7811.1 717.3 724.7 725.8 738.8 739.4 5000.5 5218.2 5337.5 5355.6 5415.5 19780.0 20267.4 20349.9 20559.7 20568.5 18940.9 19715.7 20082.6 20109.7 20159.9 9273.7 9639.7 9771.8 10442.5 10693.4 8453.9 8679.5 8708.2 8755.2 8861.0 16682.0 17059.6 17148.5 17617.6 17883.7 17110.2 17774.0 17891.6 17900.3 17953.2 13379.6 13586.5 13678.6 13679.0 13680.1 13597.5 13680.4 13768.7 13804.5 13832.4 11213.7 11217.5 11260.7 11410.2 11492.8 11069.6 11081.9 11206.2 11209.2 11399.4 9514.8 9586.4 9612.9 9660.2 9677.3 7315.9 7376.8 7441.4 7456.3 7504.2 7067.1 7218.1 7219.4 7221.5 7232.6 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | [#4] prototype.html Cycles:180 Average:5536.75 Median:6144.72 stddev:1552.81 (25.3%) stddev-sans-first:1510.64 22:01:13 INFO - PID 12358 | Values: 510.4 512.9 528.8 533.4 536.7 6237.3 6325.1 6370.3 6372.1 6386.5 6133.8 6190.9 6197.5 6201.4 6220.4 5124.5 5131.3 5148.2 5160.3 5171.5 4769.7 4916.9 5085.2 5130.7 5139.7 4929.6 4947.0 4956.4 4968.0 4996.3 4919.6 4926.2 4945.7 4967.9 4975.5 4407.6 4419.5 4428.3 4489.1 4507.5 6031.3 6058.5 6060.5 6105.8 6113.7 5719.1 5744.7 5745.9 5775.9 5823.7 6422.6 6446.6 6457.5 6477.9 6490.6 4855.2 4858.6 4883.2 4893.8 4898.3 6678.3 6695.6 6761.2 6905.9 7014.5 4840.9 4990.5 4997.3 5005.5 5025.0 5041.2 5100.2 5114.8 5120.9 5135.7 5692.1 5717.8 5724.0 5726.3 5778.7 6596.0 6644.6 6675.8 6682.5 6692.3 1741.9 1751.0 1757.6 1786.7 1798.8 1183.6 1217.8 1223.6 1231.5 1248.8 5663.0 5674.6 5677.8 5730.2 5762.8 6640.4 6666.9 6726.3 6742.0 6827.5 5733.6 5748.6 5762.4 5814.6 5820.1 3564.8 3577.5 3619.9 3620.4 3631.5 6568.7 6601.2 6629.5 6652.2 6657.2 6903.9 6948.5 6966.0 6973.5 6976.9 6541.0 6589.3 6590.2 6618.4 6643.5 6155.7 6829.2 6829.9 6839.9 6843.3 6678.3 6679.5 6698.9 6710.6 6737.1 6413.8 6599.6 6604.7 6611.8 6612.0 5042.1 5071.1 5074.2 5082.3 5084.1 6582.2 6624.6 6753.8 6805.3 6862.5 6587.4 6589.3 6590.2 6614.5 6624.3 6519.3 6532.3 6560.5 6574.2 6605.7 6393.4 6415.8 6423.7 6484.9 6531.6 6571.8 6599.3 6602.6 6628.0 6635.8 6311.6 6354.3 6391.0 6393.3 6406.2 22:01:13 INFO - PID 12358 | 22:01:13 INFO - PID 12358 | [#5] yui.html Cycles:180 Average:24645.78 Median:20361.54 stddev:33012.70 (162.1%) stddev-sans-first:33057.16 22:01:13 INFO - PID 12358 | Values: 899.7 903.2 920.8 924.8 929.1 19134.4 20071.6 20079.4 20113.7 20160.4 17969.6 18001.3 18251.8 22488.7 22538.8 1050.2 1073.0 1073.6 1074.4 1074.6 1019.2 1061.6 1062.2 1065.4 1066.0 1105.6 1109.4 1110.6 1112.6 1113.6 1105.6 1106.0 1106.2 1106.5 1106.5 800.9 801.7 802.9 803.2 803.9 19851.0 20067.7 20294.2 20330.3 20392.8 22600.7 22760.2 22960.8 22973.4 23250.8 16092.5 16277.2 16387.8 16589.1 16725.5 3610.6 3618.0 3621.3 3664.6 3666.4 130402.0 130480.0 130926.0 134076.3 134810.0 17460.7 17534.8 17541.7 17564.9 17952.1 31066.7 31707.7 31878.5 31931.7 32510.3 8404.2 8631.1 8634.6 8654.7 8858.2 4294.6 4327.9 4392.2 4404.5 4406.8 5223.6 5307.8 5319.9 5328.1 5329.6 1016.2 1017.6 1044.1 1044.2 1046.0 695.8 707.6 716.4 718.0 722.9 11420.8 11513.5 12307.6 12464.6 12611.7 690.6 696.8 700.7 703.9 705.2 6211.3 6601.1 6712.1 6760.1 6796.3 111331.0 112493.4 113362.4 113495.4 114117.0 76770.2 97694.5 100124.5 100379.0 102322.0 86145.0 88440.0 88620.6 89116.0 92238.0 12657.9 12884.9 13492.7 13498.5 13546.5 40091.6 40473.4 40913.4 41571.6 41603.2 72302.3 73491.0 74052.3 74272.0 76791.6 19362.5 19502.5 19513.8 19770.4 19773.8 20799.6 22142.3 22214.7 22351.2 22356.8 17658.2 18402.2 18576.0 19146.0 19658.7 20299.2 21181.2 21395.0 21815.3 22088.9 20917.2 21056.7 21223.5 21364.4 21520.5 13993.6 14085.6 14154.9 14169.0 14174.9 13987.8 14354.8 14366.2 15182.9 15564.1 22:01:13 INFO - PID 12358 | -------- Summary: end -------- 22:01:13 INFO - PID 12358 | 22:01:14 INFO - TEST-INFO | 12358: exit 0 22:01:14 INFO - TEST-OK | dromaeo_css | took 1112048ms 22:01:14 INFO - TEST-START | kraken 22:01:14 INFO - Initialising browser for kraken test... 22:01:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37133/getInfo.html -profile /tmp/tmpkcnqP0/profile 22:01:14 INFO - TEST-INFO | started process 12732 (/builds/slave/test/build/application/firefox/firefox http://localhost:37133/getInfo.html) 22:01:20 INFO - TEST-INFO | 12732: exit 0 22:01:20 INFO - Browser initialized. 22:01:20 INFO - Running cycle 1/1 for kraken test... 22:01:20 INFO - TEST-INFO | started process 12924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkcnqP0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:21 INFO - PID 12924 | 22:01:21 INFO - PID 12924 | (/builds/slave/test/build/application/firefox/firefox:12978): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 22:01:21 INFO - PID 12924 | 22:01:31 INFO - PID 12924 | RSS: Main: 166457344 22:01:31 INFO - PID 12924 | 22:01:34 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37133/tests/kraken/driver.html?testName=audio-beat-detection) 22:01:35 INFO - PID 12924 | RSS: Main: 172662784 22:01:35 INFO - PID 12924 | 22:01:38 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37133/tests/kraken/driver.html?testName=audio-dft) 22:01:38 INFO - PID 12924 | RSS: Main: 172761088 22:01:38 INFO - PID 12924 | 22:01:41 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37133/tests/kraken/driver.html?testName=audio-fft) 22:01:42 INFO - PID 12924 | RSS: Main: 168202240 22:01:42 INFO - PID 12924 | 22:01:44 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37133/tests/kraken/driver.html?testName=audio-oscillator) 22:01:45 INFO - PID 12924 | RSS: Main: 168165376 22:01:45 INFO - PID 12924 | 22:01:47 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37133/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:01:48 INFO - PID 12924 | RSS: Main: 168603648 22:01:48 INFO - PID 12924 | 22:01:51 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37133/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:51 INFO - PID 12924 | RSS: Main: 171479040 22:01:51 INFO - PID 12924 | 22:01:55 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37133/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:55 INFO - PID 12924 | RSS: Main: 171294720 22:01:55 INFO - PID 12924 | 22:01:58 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37133/tests/kraken/driver.html?testName=json-parse-financial) 22:01:59 INFO - PID 12924 | RSS: Main: 172380160 22:01:59 INFO - PID 12924 | 22:02:01 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37133/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:02:01 INFO - PID 12924 | RSS: Main: 172158976 22:02:01 INFO - PID 12924 | 22:02:03 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:02:04 INFO - PID 12924 | RSS: Main: 172367872 22:02:04 INFO - PID 12924 | 22:02:06 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:02:07 INFO - PID 12924 | RSS: Main: 172093440 22:02:07 INFO - PID 12924 | 22:02:09 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:02:10 INFO - PID 12924 | RSS: Main: 172728320 22:02:10 INFO - PID 12924 | 22:02:13 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:02:14 INFO - PID 12924 | RSS: Main: 172969984 22:02:14 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | Cycle 1(1): loaded http://localhost:37133/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37133/tests/kraken/driver.html?testName=ai-astar) 22:02:16 INFO - PID 12924 | RSS: Main: 174026752 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | __start_tp_report 22:02:16 INFO - PID 12924 | _x_x_mozilla_page_load 22:02:16 INFO - PID 12924 | _x_x_mozilla_page_load_details 22:02:16 INFO - PID 12924 | |i|pagename|runs| 22:02:16 INFO - PID 12924 | |0;ai-astar;99;107;101;107;107;108;109;99;109;110 22:02:16 INFO - PID 12924 | |1;audio-beat-detection;151;121;145;193;118;144;157;120;172;116 22:02:16 INFO - PID 12924 | |2;audio-dft;162;162;168;163;162;163;165;165;163;164 22:02:16 INFO - PID 12924 | |3;audio-fft;75;76;75;172;76;76;75;89;99;75 22:02:16 INFO - PID 12924 | |4;audio-oscillator;81;83;134;79;79;79;129;79;78;129 22:02:16 INFO - PID 12924 | |5;imaging-gaussian-blur;114;120;114;115;113;113;114;115;116;114 22:02:16 INFO - PID 12924 | |6;imaging-darkroom;150;150;151;153;152;152;150;149;150;151 22:02:16 INFO - PID 12924 | |7;imaging-desaturate;99;99;99;104;99;94;93;94;99;99 22:02:16 INFO - PID 12924 | |8;json-parse-financial;63;65;53;54;54;53;60;52;52;54 22:02:16 INFO - PID 12924 | |9;json-stringify-tinderbox;55;60;55;55;54;58;54;54;53;54 22:02:16 INFO - PID 12924 | |10;stanford-crypto-aes;81;79;77;76;78;78;76;77;79;78 22:02:16 INFO - PID 12924 | |11;stanford-crypto-ccm;122;122;120;121;121;120;130;129;121;168 22:02:16 INFO - PID 12924 | |12;stanford-crypto-pbkdf2;172;190;178;174;171;182;185;175;172;171 22:02:16 INFO - PID 12924 | |13;stanford-crypto-sha256-iterative;70;74;66;67;67;78;69;74;69;70 22:02:16 INFO - PID 12924 | __end_tp_report 22:02:16 INFO - PID 12924 | __start_cc_report 22:02:16 INFO - PID 12924 | _x_x_mozilla_cycle_collect,955 22:02:16 INFO - PID 12924 | __end_cc_report 22:02:16 INFO - PID 12924 | __startTimestamp1502946136307__endTimestamp 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | ------- Summary: start ------- 22:02:16 INFO - PID 12924 | Number of tests: 14 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#0] ai-astar Cycles:10 Average:105.60 Median:109.00 stddev:4.25 (3.9%) stddev-sans-first:3.77 22:02:16 INFO - PID 12924 | Values: 99.0 107.0 101.0 107.0 107.0 108.0 109.0 99.0 109.0 110.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#1] audio-beat-detection Cycles:10 Average:143.70 Median:148.00 stddev:25.75 (17.4%) stddev-sans-first:27.18 22:02:16 INFO - PID 12924 | Values: 151.0 121.0 145.0 193.0 118.0 144.0 157.0 120.0 172.0 116.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:1.89 (1.2%) stddev-sans-first:1.90 22:02:16 INFO - PID 12924 | Values: 162.0 162.0 168.0 163.0 162.0 163.0 165.0 165.0 163.0 164.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#3] audio-fft Cycles:10 Average:88.80 Median:76.00 stddev:30.33 (39.9%) stddev-sans-first:31.76 22:02:16 INFO - PID 12924 | Values: 75.0 76.0 75.0 172.0 76.0 76.0 75.0 89.0 99.0 75.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.00 stddev:24.69 (31.3%) stddev-sans-first:25.66 22:02:16 INFO - PID 12924 | Values: 81.0 83.0 134.0 79.0 79.0 79.0 129.0 79.0 78.0 129.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:114.50 stddev:2.04 (1.8%) stddev-sans-first:2.15 22:02:16 INFO - PID 12924 | Values: 114.0 120.0 114.0 115.0 113.0 113.0 114.0 115.0 116.0 114.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 22:02:16 INFO - PID 12924 | Values: 150.0 150.0 151.0 153.0 152.0 152.0 150.0 149.0 150.0 151.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:99.00 stddev:3.31 (3.3%) stddev-sans-first:3.49 22:02:16 INFO - PID 12924 | Values: 99.0 99.0 99.0 104.0 99.0 94.0 93.0 94.0 99.0 99.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:54.00 stddev:4.81 (8.9%) stddev-sans-first:4.38 22:02:16 INFO - PID 12924 | Values: 63.0 65.0 53.0 54.0 54.0 53.0 60.0 52.0 52.0 54.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:2.15 (3.9%) stddev-sans-first:2.28 22:02:16 INFO - PID 12924 | Values: 55.0 60.0 55.0 55.0 54.0 58.0 54.0 54.0 53.0 54.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.00 stddev:1.52 (2.0%) stddev-sans-first:1.13 22:02:16 INFO - PID 12924 | Values: 81.0 79.0 77.0 76.0 78.0 78.0 76.0 77.0 79.0 78.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:122.00 stddev:14.71 (12.1%) stddev-sans-first:15.48 22:02:16 INFO - PID 12924 | Values: 122.0 122.0 120.0 121.0 121.0 120.0 130.0 129.0 121.0 168.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:176.50 stddev:6.62 (3.7%) stddev-sans-first:6.77 22:02:16 INFO - PID 12924 | Values: 172.0 190.0 178.0 174.0 171.0 182.0 185.0 175.0 172.0 171.0 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:3.81 (5.4%) stddev-sans-first:4.03 22:02:16 INFO - PID 12924 | Values: 70.0 74.0 66.0 67.0 67.0 78.0 69.0 74.0 69.0 70.0 22:02:16 INFO - PID 12924 | -------- Summary: end -------- 22:02:16 INFO - PID 12924 | 22:02:16 INFO - PID 12924 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 22:02:17 INFO - TEST-INFO | 12924: exit 0 22:02:17 INFO - TEST-OK | kraken | took 62510ms 22:02:17 INFO - SUITE-END | took 1174s 22:02:17 INFO - Completed test suite (00:19:34) 22:02:17 INFO - javascript benchmark 22:02:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8683.951748943948, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3185.2036990752313, 3205.583274174358, 3219.533167690685, 3232.143481977275, 3241.9837900810494, 6272.905906411407, 6331.55679102463, 6338.207724034496, 6378.138951241587, 6431.6784160792, 6221.222347206599, 6306.148669929569, 6311.084892690568, 6324.241091069078, 6324.2727086385075, 5700.942990570104, 5754.02181629123, 5755.366909639936, 5756.395578464264, 5769.682667453289, 5827.796027139051, 5864.530837533009, 5882.088276317178, 5915.467607915287, 5927.585069045169, 5757.596968212227, 5823.330317013555, 5824.708764561755, 5863.442972917566, 5916.083007133901, 5654.773809047633, 5718.027935250976, 5769.24999750034, 5820.185174075633, 5832.941670583282, 5721.0, 5739.3399759027825, 5787.942120578825, 5817.912731309034, 5828.504577110951, 6046.304674962392, 6196.814095577095, 6212.627242365473, 6241.032639940817, 6304.747810087591, 6679.56582822115, 6727.058211850345, 6752.696128674222, 6756.560823546503, 6821.522493425462, 6865.9313406865795, 6869.896951545731, 6873.621950792704, 6877.243503214642, 6887.449004079712, 6308.3060863304545, 6364.204474440695, 6399.552031357807, 6400.295967443578, 6406.263279722798, 6959.8956015659805, 6974.930250697529, 6980.197277313073, 6983.196932352743, 7080.468964827659, 6407.103005579223, 6494.805155845333, 6593.142891424084, 6661.700223489955, 6665.800025999228, 6727.360900714424, 6759.188897332253, 6764.4926630502905, 6780.627065511346, 6862.965685171642, 6746.224184218878, 6837.0, 6841.179058512911, 6842.076319696876, 6846.863062738717, 6791.252962174157, 6797.354251346114, 6799.32006799326, 6894.827629309308, 6899.517033807585, 5382.515573598395, 5437.157240627709, 5464.3442786865835, 5491.917621235684, 5492.505674489315, 4686.062787442525, 4715.764211789466, 4719.693219940693, 4724.267738500538, 4738.64460165489, 5722.570807189478, 5742.913856292159, 5795.333536643256, 5799.101139323411, 5808.5062769665055, 6738.561993470409, 6827.863442731117, 6829.317068293131, 6831.760888368884, 6835.384815366641, 5742.138679198154, 5747.770089196469, 5791.768329266866, 5820.621659592113, 5839.678817664984, 5787.363390027093, 5911.201987731602, 5919.733611987471, 5938.406159384113, 5994.460498555151, 6595.769148079794, 6596.60420374779, 6600.207975043026, 6608.537402381787, 6612.966935165294, 6795.864082718417, 6851.828704282433, 6855.177378714586, 6858.3827455529245, 6887.621180835102, 6548.869022619616, 6597.703103360264, 6620.205575330991, 6671.199456065303, 6682.365175308338, 6542.182227221598, 6600.669966501751, 6667.633280169443, 6675.332466753286, 6764.3573860483175, 6840.6921688525135, 6854.074699915647, 6859.897101543381, 6872.553284036521, 6878.312168783082, 6528.608283503005, 6674.032265321598, 6676.399124078856, 6681.732730690913, 6681.899771503334, 6520.250171230369, 6543.247526534509, 6553.148090748363, 6606.405423511907, 6627.502937279627, 6397.552171348148, 6454.935450645434, 6481.902771458526, 6496.155499784998, 6557.344265573404, 6576.145101136822, 6615.900761488678, 6633.502487313567, 6635.336466353326, 6637.937929931188, 6332.335104813928, 6358.904616430665, 6393.936060639334, 6433.774817881352, 6435.06691529735], "value": 6181.190126496236, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.9361057504826, 770.283636218317, 785.0148064179458, 785.2971590426566, 1136.3749937534353, 30508.84745576272, 30978.53532197019, 41644.16711665765, 42536.361954570704, 42597.78701106498, 42433.15133697332, 42904.0, 42925.57074429255, 42956.3556546652, 43040.56959430405, 7434.442416818733, 7516.511426757271, 7718.53688778675, 7723.343515801163, 7728.7681369559, 7565.394768418513, 7680.231976802303, 7682.884756728654, 7683.1548529661695, 7683.308502234798, 7621.237876212362, 7647.388208943299, 7675.424343174284, 7697.114831794332, 7701.9614901925415, 7603.733869314575, 7648.541087534738, 7651.655675494589, 7651.770446886602, 7664.540127592362, 7477.327040566375, 7551.546907185587, 7552.69789208431, 7556.206598307153, 7562.243775622449, 37669.05827354338, 37928.0, 37961.24077518434, 37977.0, 38018.23963520714, 3536.1159710072484, 3568.0366301098816, 3581.158427769472, 3583.910402239939, 3586.6234045425117, 30900.0729978101, 31017.534736978963, 31017.534736978963, 31041.37917241665, 31043.84478077595, 4610.077984403133, 4630.328602352673, 4630.444346678387, 4649.418822647169, 4693.48371679115, 186929.0, 189349.0, 191034.0, 191341.04329478403, 191580.0, 49055.75472122688, 49102.50897491051, 49263.0, 49267.753661231465, 49510.0, 50936.74531627318, 51326.74336628368, 51329.0, 51387.48612513902, 51555.7422212894, 12989.28558929249, 16519.752203716955, 16836.74744878828, 16837.494875153767, 16846.0, 10849.24055316136, 13759.518416855562, 14044.508442204473, 14053.367598458093, 14057.578272651837, 14402.351894164787, 14463.0, 14501.202433866029, 14529.200893950934, 14588.124712517283, 5617.8595535111135, 5778.566607504454, 5807.5644326675665, 5861.765529378862, 5940.227770389908, 974.3715303629119, 1006.225206590921, 1011.838105903052, 1018.9082982531608, 1023.2530252915413, 22826.885865570897, 22902.969366378555, 23011.769882300963, 23083.0, 23363.0, 963.2534785541261, 967.4969016111583, 971.3637567393368, 984.0, 989.6288891665625, 10519.008330503233, 10543.0, 10632.46837658114, 10683.358998460117, 10829.187810914213, 233218.0, 234400.0, 236732.0, 236812.0, 236882.0, 52787.73606132022, 52949.0, 53298.73350633222, 53353.46646533562, 53356.19965700518, 1382.2743059893637, 1465.2014652014464, 1486.7100915321626, 1489.560579629012, 1499.7825315329435, 19316.32392866243, 19436.514087147934, 19518.609627807647, 19660.80339196647, 19999.400017999484, 50585.0, 51877.22184167316, 51991.480085198666, 52057.219141713664, 52123.739381302854, 206312.0, 213781.0, 217112.0, 219627.0, 220007.0, 36801.0, 36989.0, 37009.0, 37656.05859853526, 37681.81159094187, 46890.0, 47513.28730068982, 47701.76149119232, 48016.0, 48288.275675864184, 35283.29433411266, 35352.46971295381, 35453.645463545035, 35638.64361356457, 35884.28231435305, 34401.13997150091, 35025.64974350326, 35285.823570881985, 35305.29389412146, 35439.645603543635, 37303.0, 38252.42621360626, 38374.80812595919, 38479.0, 38799.806000970944, 33425.83287083549, 33756.0, 33907.321853562295, 34042.82978585091, 34650.0, 23494.76505234926, 24512.632310515, 24707.382315442257, 24982.62526062147, 25353.0], "value": 17337.19073029668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.3262754184809, 564.2072887592931, 569.2485918587461, 570.8858228354328, 586.2291087220306, 21823.345299641016, 22641.207557735503, 22667.0, 22678.88660556699, 22727.659085113715, 26009.73990260097, 26527.602085968676, 26684.599731004, 26764.19707408776, 26792.0, 6379.904301435494, 6535.836604084889, 6538.313477084909, 6544.181977252843, 6544.672766361687, 6330.588511746745, 6497.480201583886, 6551.1483507144, 6619.338066193391, 6968.616726080064, 6806.863862722743, 6818.0, 6820.420264277543, 6850.246472888003, 6877.243503214642, 6829.556078854858, 6872.484563657721, 6876.724931002754, 6885.896711549331, 6894.827629309258, 6765.086713293692, 6796.830079248059, 6799.320067993211, 6811.352921472501, 6828.0, 25089.372765680822, 25552.105676301428, 28221.0, 32161.517577236362, 32306.192345191324, 1922.404054743034, 1983.8016198380192, 1991.601679664073, 1999.3701983875033, 2001.4395969128668, 19619.80380196194, 20215.090320935593, 20947.0, 21669.566608667737, 21761.238356657443, 2483.8261321707487, 2485.763852434016, 2560.167945417728, 2608.960865587018, 2620.331815387083, 138629.30685346609, 145765.0, 146364.0, 146629.0, 146693.0, 20230.69653955192, 20237.595248094956, 20939.371818845153, 22026.779732202795, 22617.51207367188, 45259.32111018337, 45615.31577026347, 45945.77027114843, 45990.540094599295, 46036.3094553582, 11597.88402115968, 11830.645080647595, 11850.585229516926, 11865.703357416134, 11918.284902905853, 9520.333576649706, 9622.37454565451, 9748.366356186825, 9811.116999470081, 9886.703398898044, 8857.867131993025, 9217.124373184537, 9226.215771659485, 11354.0, 11911.10666700001, 2555.195113539229, 2622.9966688142354, 2689.9193024209303, 2717.402171522262, 2826.547752359613, 925.7407925780792, 973.2894986659778, 977.203579083045, 978.8335982882927, 987.7876256604865, 19916.70124948127, 20044.899775501322, 20188.0, 20404.591908162052, 20546.69179962302, 1045.8849526552074, 1055.6885718712997, 1059.427908929185, 1068.0227591753614, 1075.693427373195, 11160.10719142483, 11405.828912566318, 11411.543538258542, 11628.302301861915, 11675.416229188506, 463191.0, 480297.0, 484294.0, 487031.0, 487576.0, 118281.0, 121669.0, 121811.39094304472, 121979.39010304892, 122813.0, 1200.6698158006618, 1233.9136260461682, 1234.2594443334108, 1250.4123062160952, 1253.053944272087, 18133.727994080364, 18185.18166682476, 18193.909030454764, 18293.0, 18642.533936651693, 56420.0, 56894.43105569057, 57270.713646431504, 57678.0, 58210.70894645499, 69027.96458053234, 69771.3022869785, 70069.0, 70398.0, 71906.28093718996, 12358.50565977351, 12410.937945310216, 14660.56018319452, 14954.775678365051, 15035.0, 23380.18169364064, 23458.296251112493, 23650.645240321064, 23905.64141537913, 23963.0, 17804.3768468103, 17912.462626121236, 18032.819671803114, 18464.0, 18652.90673546678, 17206.741898871278, 17439.56401089983, 17477.0, 17612.0, 17824.55438614045, 18969.620607587494, 19236.615267694287, 19601.70597441068, 19656.410307690792, 19698.50753731168, 14275.500357487437, 14966.0, 14989.400423983354, 15022.399104035716, 15099.698006040038, 18945.90527047411, 18995.145218465477, 19225.711614325515, 19232.423027309203, 19254.903725481283], "value": 12631.70598774325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.1942673249514, 1446.2913172545457, 1454.4909281751382, 1454.9345279462423, 1465.838757736649, 14246.928765356171, 14574.198419086946, 14878.851211487881, 14880.404783808635, 14888.553343399702, 13096.869031309685, 13288.335583220849, 13440.865591344083, 13454.394552245149, 13466.192028478274, 2589.6115582662565, 2670.359113812681, 2733.876975536096, 2734.6171535984977, 2739.260399692092, 2794.4690508803264, 2804.4531316393313, 2830.0, 2838.3329917469378, 2838.815476993989, 2760.268528839859, 2791.427757309757, 2794.3572978215025, 2819.0, 2828.250513613894, 2549.6557964674903, 2586.7671909528044, 2672.986635066822, 2696.0968075694664, 2714.864256787153, 2536.1884197056947, 2588.4952434275324, 2589.741025897414, 2597.2597809624167, 2612.6211699303494, 14208.289585520683, 14422.639434014234, 14501.347439365254, 14502.70994580113, 14566.0, 7772.65023073963, 8042.839143217103, 8061.153578874251, 8075.919240807634, 8090.838183236302, 5274.340707411574, 5339.652922560022, 5436.238926550286, 5505.587080968903, 5511.283533140666, 1881.9341323053764, 1886.141805478504, 1890.4895678166956, 1928.0456174193864, 1928.0841600239773, 23963.041478340845, 24212.0, 24218.0, 24668.629970550457, 24786.0, 6514.739410423625, 6516.609003459807, 6603.570767900071, 6649.601023938482, 6762.492813039042, 16744.330226790793, 16755.41356052532, 16756.497305080866, 16782.58043548921, 16789.6642067158, 7845.764627061198, 7891.565963871927, 7938.444308898437, 7955.0, 7989.121196668362, 7211.89182162268, 7230.710771569184, 7359.190489046201, 7395.7041718330665, 7410.11078670563, 4966.726830024311, 4999.125153098194, 5020.874478138003, 5038.974805125951, 5053.469385714447, 1480.7556753135611, 1482.6145202247494, 1492.9776053359208, 1501.3469140923733, 1502.721996430664, 910.4855756497558, 938.558877327655, 940.1773448232797, 943.1228957069853, 944.9338546301831, 7631.465797394129, 7685.42359323053, 7701.730439434593, 7746.225377462209, 7811.101723301779, 717.2612209424301, 724.699249811333, 725.804032911111, 738.8189893476133, 739.4454159380465, 5000.499950004971, 5218.165093585008, 5337.5463085637375, 5355.625106242525, 5415.458454154632, 19780.021997800104, 20267.391978240677, 20349.898250508653, 20559.691604625943, 20568.485787855425, 18940.90529547371, 19715.704264436044, 20082.598348032956, 20109.698354524695, 20159.899200503904, 9273.67542136022, 9639.662611808553, 9771.80456390854, 10442.477876106164, 10693.358398496115, 8453.87319190225, 8679.479231246145, 8708.17272359125, 8755.212030917248, 8860.955695221483, 16682.0, 17059.573510662332, 17148.485545433658, 17617.64764704673, 17883.73174402359, 17110.230039647995, 17774.0, 17891.642167156846, 17900.28398864031, 17953.192106355506, 13379.598612041655, 13586.45654173822, 13678.589642310746, 13679.042467027213, 13680.110792798436, 13597.52408665692, 13680.384382702603, 13768.724625507633, 13804.516841910887, 13832.446702131801, 11213.719657008314, 11217.49521271561, 11260.718482038015, 11410.201285909907, 11492.770144596894, 11069.612563560237, 11081.889181108409, 11206.215564910379, 11209.215354925076, 11399.373034483184, 9514.762130946505, 9586.424814511152, 9612.855807163038, 9660.178884794872, 9677.274204434836, 7315.853682926205, 7376.7786966391095, 7441.404687625085, 7456.254374562501, 7504.249575042452, 7067.116610423697, 7218.133823941161, 7219.422446204396, 7221.494495385273, 7232.566046037255], "value": 6521.017305117565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.40027967138604, 512.8948565544063, 528.8281308574713, 533.4233961289551, 536.7369988705533, 6237.251529816423, 6325.078451360163, 6370.267419246788, 6372.139761132245, 6386.521010924176, 6133.785317513888, 6190.907136392958, 6197.459041792866, 6201.441870231678, 6220.382700497869, 5124.538791508754, 5131.332926719521, 5148.176291793314, 5160.329157209558, 5171.482851714817, 4769.713817170964, 4916.926246106311, 5085.23721441783, 5130.666506677054, 5139.743012849362, 4929.630277729167, 4946.9752651236695, 4956.430010548779, 4967.950320496803, 4996.32549605804, 4919.60643148549, 4926.1625523660705, 4945.678530895516, 4967.875803104916, 4975.527324904128, 4407.647388208936, 4419.535948725402, 4428.31361139024, 4489.079738653568, 4507.504174540798, 6031.306399763996, 6058.485028772559, 6060.454584081075, 6105.816825495198, 6113.724882380304, 5719.113537401668, 5744.684042377709, 5745.942540574582, 5775.8556036099435, 5823.737931793037, 6422.582532135443, 6446.613203207822, 6457.450211949145, 6477.935220647781, 6490.610563366213, 4855.174620314555, 4858.6356023298395, 4883.218685010382, 4893.804247830082, 4898.289747986522, 6678.298778628271, 6695.631740254284, 6761.222459417131, 6905.930940690579, 7014.508984371096, 4840.854774356775, 4990.451050384455, 4997.3253610762085, 5005.549500544896, 5025.0, 5041.193409054534, 5100.209467532539, 5114.795408183631, 5120.897582048338, 5135.6918584885025, 5692.14617807324, 5717.771289148471, 5724.0, 5726.255586773693, 5778.711064446761, 6595.967020164869, 6644.568103073285, 6675.7997260082275, 6682.532222744361, 6692.297308782508, 1741.947741567755, 1750.9824901751074, 1757.5957529768225, 1786.7141257398753, 1798.8291112344307, 1183.6329039958862, 1217.8477690288714, 1223.62067758995, 1231.5073970411906, 1248.7502499500135, 5663.0, 5674.602777805597, 5677.772889084473, 5730.226419433407, 5762.827115186551, 6640.402363787282, 6666.899996500057, 6726.293739157416, 6741.966290168518, 6827.453803695693, 5733.627314224562, 5748.5688573357165, 5762.423757624288, 5814.622049566765, 5820.097884827858, 3564.8395822188063, 3577.4633804929467, 3619.94570081449, 3620.3664358737115, 3631.473436351714, 6568.737250510022, 6601.207855057328, 6629.46964242869, 6652.234992975773, 6657.23441804189, 6903.896441553381, 6948.513604047668, 6966.0, 6973.546719463218, 6976.93023069773, 6540.967295163494, 6589.341065893373, 6590.242122155918, 6618.437432818168, 6643.541889500915, 6155.6614386209185, 6829.180498340231, 6829.931700683128, 6839.931600684128, 6843.349881761224, 6678.332166783282, 6679.4990375721045, 6698.899516507354, 6710.571023124714, 6737.124173857367, 6413.775517856852, 6599.60402375859, 6604.7027883746305, 6611.834704132435, 6611.950065690032, 5042.117629414764, 5071.112555302733, 5074.16276314404, 5082.288479612783, 5084.1102807009365, 6582.243042050034, 6624.56940298879, 6753.797386078426, 6805.251422343637, 6862.519623626298, 6587.374199451045, 6589.341065893564, 6590.176227971504, 6614.5039122067, 6624.337566243337, 6519.250286217146, 6532.314107018695, 6560.507961902972, 6574.243961944438, 6605.702743376463, 6393.442622950857, 6415.839604009937, 6423.678816059271, 6484.902726459201, 6531.575447595891, 6571.835704107244, 6599.340065993362, 6602.570832895846, 6627.966860165861, 6635.8009259722285, 6311.589746666452, 6354.301026887131, 6390.977443609, 6393.328700486382, 6406.231252249573], "value": 5081.5123599380795, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.7390756680559, 903.1600611431368, 920.769807548113, 924.7780532672157, 929.1498279074647, 19134.42596722097, 20071.59856802865, 20079.397618071445, 20113.698294525577, 20160.395188144343, 17969.550761230978, 18001.279948802032, 18251.81748182518, 22488.662670059963, 22538.774612253874, 1050.1965996013057, 1073.0396295315688, 1073.581303291717, 1074.425182527348, 1074.5970261152067, 1019.2457581389755, 1061.5753698520575, 1062.1821197677823, 1065.3554599467327, 1065.9626913058044, 1105.5743538737604, 1109.4009235013084, 1110.5779803674593, 1112.6495154026495, 1113.582406597526, 1105.6461932181705, 1105.9944700276487, 1106.1537923488538, 1106.4578356605286, 1106.4965440724452, 800.8918795962587, 801.7193982106274, 802.9156938521429, 803.2489622203259, 803.8914746509205, 19851.0, 20067.698984515246, 20294.188232470682, 20330.28843990468, 20392.796072039237, 22600.66099008516, 22760.20339288117, 22960.77039229603, 22973.425664358525, 23250.76749232503, 16092.517224483285, 16277.186140692918, 16387.754183687255, 16589.087600181985, 16725.498235052968, 3610.5667319921513, 3617.981910090459, 3621.3481573316794, 3664.578573464059, 3666.4133738601963, 130402.0, 130480.0, 130926.0, 134076.32961835127, 134810.0, 17460.650786984188, 17534.82465175332, 17541.736873946902, 17564.91217543904, 17952.102394880203, 31066.68933310683, 31707.682923170934, 31878.521822172686, 31931.680683193335, 32510.349793004007, 8404.20160084791, 8631.136886311444, 8634.611442485104, 8654.697085601974, 8858.247049000907, 4294.592013758688, 4327.891802704895, 4392.1874453226255, 4404.471463424409, 4406.801693923717, 5223.582113430916, 5307.8142265021315, 5319.946800532022, 5328.120860058125, 5329.573634109262, 1016.2378216337746, 1017.6183931025865, 1044.060345688871, 1044.185535282481, 1046.0428707732492, 695.8399568099366, 707.6178863413802, 716.3660160757767, 717.9748708795167, 722.8626560953402, 11420.828687569694, 11513.481893314822, 12307.56923507673, 12464.563740269046, 12611.684707882192, 690.5787469643514, 696.8188271049462, 700.6881937537848, 703.855709579535, 705.1538154214962, 6211.3167551569295, 6601.141851559267, 6712.127423434922, 6760.08738820253, 6796.286389929085, 111331.0, 112493.43753281345, 113362.43318783518, 113495.43252283685, 114117.0, 76770.16149192517, 97694.51152744191, 100124.49937750411, 100379.0, 102322.0, 86145.0, 88440.0, 88620.5568972151, 89116.0, 92238.0, 12657.93671031639, 12884.935575322063, 13492.730145397234, 13498.52755153565, 13546.458141674222, 40091.59908400878, 40473.39289910595, 40913.38629920613, 41571.58428415798, 41603.16793664049, 72302.27697722956, 73491.0, 74052.2594774067, 74272.0, 76791.61604191943, 19362.51593710112, 19502.512437188616, 19513.804861951197, 19770.40688779339, 19773.802261977195, 20799.584008320053, 22142.335729928127, 22214.666779998635, 22351.217707380165, 22356.77643223612, 17658.20538075764, 18402.171902264163, 18576.0, 19146.0, 19658.705119423506, 20299.188032478534, 21181.152753889673, 21395.037223324678, 21815.345539633836, 22088.88955555212, 20917.163313467292, 21056.684149738074, 21223.469413264793, 21364.392346457564, 21520.461988450414, 13993.580192594238, 14085.647858803612, 14154.858451415354, 14169.0, 14174.858251417767, 13987.796284913074, 14354.775009873487, 14366.209858457885, 15182.924085379502, 15564.066156030674], "value": 9559.961023726928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 107.0, 107.0, 108.0, 109.0, 99.0, 109.0, 110.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 145.0, 193.0, 118.0, 144.0, 157.0, 120.0, 172.0, 116.0], "value": 143.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 168.0, 163.0, 162.0, 163.0, 165.0, 165.0, 163.0, 164.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 172.0, 76.0, 76.0, 75.0, 89.0, 99.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 134.0, 79.0, 79.0, 79.0, 129.0, 79.0, 78.0, 129.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 114.0, 115.0, 113.0, 113.0, 114.0, 115.0, 116.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 153.0, 152.0, 152.0, 150.0, 149.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 104.0, 99.0, 94.0, 93.0, 94.0, 99.0, 99.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 53.0, 54.0, 54.0, 53.0, 60.0, 52.0, 52.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 55.0, 55.0, 54.0, 58.0, 54.0, 54.0, 53.0, 54.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 77.0, 76.0, 78.0, 78.0, 76.0, 77.0, 79.0, 78.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 120.0, 121.0, 121.0, 120.0, 130.0, 129.0, 121.0, 168.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 190.0, 178.0, 174.0, 171.0, 182.0, 185.0, 175.0, 172.0, 171.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 66.0, 67.0, 67.0, 78.0, 69.0, 74.0, 69.0, 70.0], "value": 70.4, "unit": "score"}]}]} 22:02:17 INFO - Return code: 0 22:02:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:02:17 INFO - # TBPL SUCCESS # 22:02:17 INFO - Running post-action listener: _package_coverage_data 22:02:17 INFO - Running post-action listener: _resource_record_post_action 22:02:17 INFO - [mozharness: 2017-08-17 05:02:17.565563Z] Finished run-tests step (success) 22:02:17 INFO - Running post-run listener: _resource_record_post_run 22:02:17 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 8192; Write bytes: 431894528; Read time: 88; Write time: 389016 22:02:17 INFO - TinderboxPrint: CPU usage
13.1% 22:02:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 88 22:02:17 INFO - TinderboxPrint: I/O write bytes / time
431,894,528 / 389,016 22:02:17 INFO - TinderboxPrint: CPU idle
8,259.9 (86.8%) 22:02:17 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 22:02:17 INFO - TinderboxPrint: Swap in / out
0 / 0 22:02:17 INFO - install - Wall time: 19s; CPU: 14.0%; Read bytes: 4096; Write bytes: 106549248; Read time: 80; Write time: 121800 22:02:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:02:17 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 325345280; Read time: 0; Write time: 267216 22:02:18 INFO - Running post-run listener: _upload_blobber_files 22:02:18 INFO - Blob upload gear active. 22:02:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:02:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:02:18 INFO - (blobuploader) - INFO - Open directory for files ... 22:02:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:02:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:02:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:19 INFO - (blobuploader) - INFO - Done attempting. 22:02:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:02:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:26 INFO - (blobuploader) - INFO - Done attempting. 22:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:27 INFO - (blobuploader) - INFO - Done attempting. 22:02:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:02:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:02:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:02:27 INFO - (blobuploader) - INFO - Done attempting. 22:02:27 INFO - (blobuploader) - INFO - Iteration through files over. 22:02:27 INFO - Return code: 0 22:02:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:02:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:02:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d7c27a52aac92a43d4d1cfc21da59dba325ff777dae68dfd995573ffc7e7794e781fd90cbcce7d6b2474f79e248ecd2cf77e9a8be7d8e0a3942299f01ce85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ad5549fbbfcabbc6b3a88175330a045b1a5670b7a3e8929cebc57971caf288c74583ca53bf51153697cf6139b44027bf5d3110f03cae6581b1e7f7b8da7a27", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2e349d7e1286fe786c9115137cf7db2302998cf95d9b433b2d8013ccc90b5aa891f4eebbe62f9595ac71c9de9d2635cffabb411c33452e63e3830b617f83ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218b2756d637ee5020929e74b0785332da8df7212710384d8c52cf02b38415fedf9e2e4b08f5f9d072cd26b4585a7ea5837c9b2781247403bf184c6784dc6e98"} 22:02:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:02:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:02:27 INFO - Contents: 22:02:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d7c27a52aac92a43d4d1cfc21da59dba325ff777dae68dfd995573ffc7e7794e781fd90cbcce7d6b2474f79e248ecd2cf77e9a8be7d8e0a3942299f01ce85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ad5549fbbfcabbc6b3a88175330a045b1a5670b7a3e8929cebc57971caf288c74583ca53bf51153697cf6139b44027bf5d3110f03cae6581b1e7f7b8da7a27", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2e349d7e1286fe786c9115137cf7db2302998cf95d9b433b2d8013ccc90b5aa891f4eebbe62f9595ac71c9de9d2635cffabb411c33452e63e3830b617f83ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218b2756d637ee5020929e74b0785332da8df7212710384d8c52cf02b38415fedf9e2e4b08f5f9d072cd26b4585a7ea5837c9b2781247403bf184c6784dc6e98"} 22:02:27 INFO - Running post-run listener: copy_logs_to_upload_dir 22:02:27 INFO - Copying logs to upload dir... 22:02:27 INFO - mkdir: /builds/slave/test/build/upload/logs 22:02:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.058177 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-16 22:02:27.485851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:27.494500) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d7c27a52aac92a43d4d1cfc21da59dba325ff777dae68dfd995573ffc7e7794e781fd90cbcce7d6b2474f79e248ecd2cf77e9a8be7d8e0a3942299f01ce85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ad5549fbbfcabbc6b3a88175330a045b1a5670b7a3e8929cebc57971caf288c74583ca53bf51153697cf6139b44027bf5d3110f03cae6581b1e7f7b8da7a27", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2e349d7e1286fe786c9115137cf7db2302998cf95d9b433b2d8013ccc90b5aa891f4eebbe62f9595ac71c9de9d2635cffabb411c33452e63e3830b617f83ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218b2756d637ee5020929e74b0785332da8df7212710384d8c52cf02b38415fedf9e2e4b08f5f9d072cd26b4585a7ea5837c9b2781247403bf184c6784dc6e98"} build_url:https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011203 build_url: 'https://queue.taskcluster.net/v1/task/GAdvR_fzSk6gV6tKKcdXVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9d7c27a52aac92a43d4d1cfc21da59dba325ff777dae68dfd995573ffc7e7794e781fd90cbcce7d6b2474f79e248ecd2cf77e9a8be7d8e0a3942299f01ce85c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40ad5549fbbfcabbc6b3a88175330a045b1a5670b7a3e8929cebc57971caf288c74583ca53bf51153697cf6139b44027bf5d3110f03cae6581b1e7f7b8da7a27", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be2e349d7e1286fe786c9115137cf7db2302998cf95d9b433b2d8013ccc90b5aa891f4eebbe62f9595ac71c9de9d2635cffabb411c33452e63e3830b617f83ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/218b2756d637ee5020929e74b0785332da8df7212710384d8c52cf02b38415fedf9e2e4b08f5f9d072cd26b4585a7ea5837c9b2781247403bf184c6784dc6e98"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:27.527793) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:27.528137) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5c37b704b588aaa989324530000001d0-1502942784.173307-1762197004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 22:02:27.579935) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 22:02:27.580263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 22:02:27.580547) ========= ========= Total master_lag: 0.34 =========