builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-021 starttime: 1504717864.55 results: success (0) revision: 97bee4069ef3dc6dba83760a80293c9a17b803f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.547218) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.547689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.547996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.566015) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.566401) ========= 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=df17445c3590ff7897617a0e00000225-1504717863.189577-252015041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 10:11:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2017-09-06 10:11:04 (46.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.353335 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.936734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.940169) ========= 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=df17445c3590ff7897617a0e00000225-1504717863.189577-252015041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014372 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.993022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:04.993488) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 97bee4069ef3dc6dba83760a80293c9a17b803f4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 97bee4069ef3dc6dba83760a80293c9a17b803f4 --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=df17445c3590ff7897617a0e00000225-1504717863.189577-252015041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 10:11:04,784 truncating revision to first 12 chars 2017-09-06 10:11:04,784 Setting DEBUG logging. 2017-09-06 10:11:04,784 attempt 1/10 2017-09-06 10:11:04,784 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/97bee4069ef3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 10:11:05,328 unpacking tar archive at: mozilla-beta-97bee4069ef3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.931547 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:05.944862) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:05.945210) ========= script_repo_revision: 97bee4069ef3dc6dba83760a80293c9a17b803f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:05.945623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:05.945988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 10:11:05.959362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-09-06 10:11:05.959719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 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', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] 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=df17445c3590ff7897617a0e00000225-1504717863.189577-252015041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:05 INFO - MultiFileLogger online at 20170906 10:11:05 in /builds/slave/test 10:11:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 10:11:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:05 INFO - {'append_to_log': False, 10:11:05 INFO - 'base_work_dir': '/builds/slave/test', 10:11:05 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 10:11:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:05 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 10:11:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:05 INFO - 'code_coverage': False, 10:11:05 INFO - 'config_files': ('talos/linux_config.py',), 10:11:05 INFO - 'default_actions': ('clobber', 10:11:05 INFO - 'read-buildbot-config', 10:11:05 INFO - 'download-and-extract', 10:11:05 INFO - 'populate-webroot', 10:11:05 INFO - 'create-virtualenv', 10:11:05 INFO - 'install', 10:11:05 INFO - 'setup-mitmproxy', 10:11:05 INFO - 'run-tests'), 10:11:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:05 INFO - 'disable_ccov_upload': False, 10:11:05 INFO - 'download_minidump_stackwalk': True, 10:11:05 INFO - 'download_symbols': 'ondemand', 10:11:05 INFO - 'enable_stylo': False, 10:11:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:05 INFO - 'gecko_profile': False, 10:11:05 INFO - 'gecko_profile_interval': 0, 10:11:05 INFO - 'installer_path': 'installer.exe', 10:11:05 INFO - 'log_level': 'info', 10:11:05 INFO - 'log_name': 'talos', 10:11:05 INFO - 'log_to_console': True, 10:11:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:05 INFO - 'opt_config_files': (), 10:11:05 INFO - 'pip_index': False, 10:11:05 INFO - 'suite': 'dromaeojs-e10s', 10:11:05 INFO - 'system_bits': '32', 10:11:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:05 INFO - 'title': 'talos-linux64-ix-021', 10:11:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:05 INFO - 'use_talos_json': True, 10:11:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:05 INFO - 'work_dir': 'build'} 10:11:05 INFO - [mozharness: 2017-09-06 17:11:05.855137Z] Running clobber step. 10:11:05 INFO - Running pre-action listener: _resource_record_pre_action 10:11:05 INFO - Running main action method: clobber 10:11:05 INFO - rmtree: /builds/slave/test/build 10:11:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:07 INFO - Running post-action listener: _resource_record_post_action 10:11:07 INFO - [mozharness: 2017-09-06 17:11:07.458835Z] Finished clobber step (success) 10:11:07 INFO - [mozharness: 2017-09-06 17:11:07.458936Z] Running read-buildbot-config step. 10:11:07 INFO - Running pre-action listener: _resource_record_pre_action 10:11:07 INFO - Running main action method: read_buildbot_config 10:11:07 INFO - Using buildbot properties: 10:11:07 INFO - { 10:11:07 INFO - "project": "", 10:11:07 INFO - "product": "firefox", 10:11:07 INFO - "who": "ffxbld@noreply.mozilla.org", 10:11:07 INFO - "installer_path": "public/build/target.tar.bz2", 10:11:07 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 10:11:07 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 10:11:07 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 10:11:07 INFO - "stage_platform": "linux64", 10:11:07 INFO - "basedir": "/builds/slave/test", 10:11:07 INFO - "buildnumber": 72, 10:11:07 INFO - "platform": "ubuntu64_hw", 10:11:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:11:07 INFO - "slavebuilddir": "test", 10:11:07 INFO - "taskId": "bYq_GxTcQeC1UO1su7vPhA", 10:11:07 INFO - "branch": "mozilla-beta", 10:11:07 INFO - "script_repo_revision": "production", 10:11:07 INFO - "revision": "97bee4069ef3dc6dba83760a80293c9a17b803f4", 10:11:07 INFO - "slavename": "talos-linux64-ix-021", 10:11:07 INFO - "repo_path": "releases/mozilla-beta" 10:11:07 INFO - } 10:11:07 INFO - Finding installer, test and symbols from parent task. 10:11:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bYq_GxTcQeC1UO1su7vPhA'}, attempt #1 10:11:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bYq_GxTcQeC1UO1su7vPhA'}, attempt #1 10:11:09 INFO - Task dependencies: aipV6OXITM-Fe8SZgXbz9g 10:11:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g'}, attempt #1 10:11:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2 10:11:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.test_packages.json 10:11:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.crashreporter-symbols.zip 10:11:09 INFO - Running post-action listener: _resource_record_post_action 10:11:09 INFO - [mozharness: 2017-09-06 17:11:09.638250Z] Finished read-buildbot-config step (success) 10:11:09 INFO - [mozharness: 2017-09-06 17:11:09.638472Z] Running download-and-extract step. 10:11:09 INFO - Running pre-action listener: _resource_record_pre_action 10:11:09 INFO - Running main action method: download_and_extract 10:11:09 INFO - mkdir: /builds/slave/test/build/tests 10:11:09 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')]} 10:11:09 INFO - trying https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.test_packages.json 10:11:09 INFO - Downloading https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:11:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:11:11 INFO - Downloaded 989 bytes. 10:11:11 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:11:11 INFO - Using the following test package requirements: 10:11:11 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:11:11 INFO - u'common': [u'target.common.tests.zip'], 10:11:11 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:11:11 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:11:11 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:11:11 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:11:11 INFO - u'mozbase': [u'target.common.tests.zip'], 10:11:11 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:11:11 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:11:11 INFO - u'web-platform': [u'target.common.tests.zip', 10:11:11 INFO - u'target.web-platform.tests.tar.gz'], 10:11:11 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:11:11 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:11:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.common.tests.zip 10:11:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:11:11 INFO - Fetch https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.common.tests.zip into memory 10:11:13 INFO - Content-Length response header: 72867103 10:11:13 INFO - Bytes received: 72867103 10:11:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:11:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.common.tests.zip 10:11:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:11:24 INFO - Fetch https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.common.tests.zip into memory 10:11:25 INFO - Content-Length response header: 72867103 10:11:25 INFO - Bytes received: 72867103 10:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.talos.tests.zip 10:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.talos.tests.zip into memory 10:11:45 INFO - Content-Length response header: 14496472 10:11:45 INFO - Bytes received: 14496472 10:11:45 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')]} 10:11:45 INFO - trying https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2 10:11:45 INFO - Downloading https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:11:47 INFO - Downloaded 54213816 bytes. 10:11:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2 10:11:47 INFO - mkdir: /builds/slave/test/properties 10:11:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:47 INFO - Contents: 10:11:47 INFO - build_url:https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2 10:11:47 INFO - Running post-action listener: _resource_record_post_action 10:11:47 INFO - Running post-action listener: set_extra_try_arguments 10:11:47 INFO - [mozharness: 2017-09-06 17:11:47.460749Z] Finished download-and-extract step (success) 10:11:47 INFO - [mozharness: 2017-09-06 17:11:47.460846Z] Running populate-webroot step. 10:11:47 INFO - Running pre-action listener: _resource_record_pre_action 10:11:47 INFO - Running main action method: populate_webroot 10:11:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:11:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:11:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:11:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:11:47 INFO - 'tests': ['damp', 'tps']}, 10:11:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:11:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:11:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:11:47 INFO - 'other-e10s': {'tests': ['a11yr', 10:11:47 INFO - 'ts_paint', 10:11:47 INFO - 'tpaint', 10:11:47 INFO - 'sessionrestore', 10:11:47 INFO - 'sessionrestore_many_windows', 10:11:47 INFO - 'sessionrestore_no_auto_restore', 10:11:47 INFO - 'tabpaint']}, 10:11:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:11:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:11:47 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:11:47 INFO - 'talos_options': ['--mitmproxy', 10:11:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:11:47 INFO - '--firstNonBlankPaint'], 10:11:47 INFO - 'tests': ['quantum_pageload_google', 10:11:47 INFO - 'quantum_pageload_youtube', 10:11:47 INFO - 'quantum_pageload_amazon', 10:11:47 INFO - 'quantum_pageload_facebook']}, 10:11:47 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:11:47 INFO - 'talos_options': ['--stylo', 10:11:47 INFO - '--mitmproxy', 10:11:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:11:47 INFO - '--firstNonBlankPaint'], 10:11:47 INFO - 'tests': ['quantum_pageload_google', 10:11:47 INFO - 'quantum_pageload_youtube', 10:11:47 INFO - 'quantum_pageload_amazon', 10:11:47 INFO - 'quantum_pageload_facebook']}, 10:11:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:11:47 INFO - 'tsvgr_opacity', 10:11:47 INFO - 'tart', 10:11:47 INFO - 'tscrollx', 10:11:47 INFO - 'cart', 10:11:47 INFO - 'tsvg_static']}, 10:11:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:11:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:11:47 INFO - 'talos_options': ['--stylo', 10:11:47 INFO - '--stylo-threads=1', 10:11:47 INFO - '--mitmproxy', 10:11:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:11:47 INFO - '--firstNonBlankPaint'], 10:11:47 INFO - 'tests': ['tp6_google', 10:11:47 INFO - 'tp6_youtube', 10:11:47 INFO - 'tp6_amazon', 10:11:47 INFO - 'tp6_facebook']}, 10:11:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:11:47 INFO - 'talos_options': ['--xperf_path', 10:11:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:47 INFO - 'tests': ['tp5n']}}} 10:11:47 INFO - Running post-action listener: _resource_record_post_action 10:11:47 INFO - [mozharness: 2017-09-06 17:11:47.469579Z] Finished populate-webroot step (success) 10:11:47 INFO - [mozharness: 2017-09-06 17:11:47.469670Z] Running create-virtualenv step. 10:11:47 INFO - Running pre-action listener: _resource_record_pre_action 10:11:47 INFO - Running main action method: create_virtualenv 10:11:47 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:47 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 10:11:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:11:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:47 INFO - Using real prefix '/usr' 10:11:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:50 INFO - Installing pip.................done. 10:11:50 INFO - Return code: 0 10:11:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:11:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:11:50 INFO - Reading from file tmpfile_stdout 10:11:50 INFO - Output received: 10:11:50 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) 10:11:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:50 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')]} 10:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:50 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')]} 10:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:50 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:50 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 10:11:50 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 10:11:50 INFO - Using env: {'DISPLAY': ':0', 10:11:50 INFO - 'HOME': '/home/cltbld', 10:11:50 INFO - 'LANG': 'en_US.UTF-8', 10:11:50 INFO - 'LANGUAGE': 'en_US:en', 10:11:50 INFO - 'LOGNAME': 'cltbld', 10:11:50 INFO - 'MAIL': '/var/mail/cltbld', 10:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:50 INFO - 'MOZ_NO_REMOTE': '1', 10:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:50 INFO - 'NO_EM_RESTART': '1', 10:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:50 INFO - 'PWD': '/builds/slave/test', 10:11:50 INFO - 'SHELL': '/bin/bash', 10:11:50 INFO - 'SHLVL': '1', 10:11:50 INFO - 'TERM': 'linux', 10:11:50 INFO - 'TMOUT': '86400', 10:11:50 INFO - 'USER': 'cltbld', 10:11:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:50 INFO - '_': '/tools/buildbot/bin/python'} 10:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:50 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 10:11:50 INFO - Cleaning up... 10:11:50 INFO - Return code: 0 10:11:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:11:50 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')]} 10:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:50 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')]} 10:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:50 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:50 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 10:11:50 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 10:11:50 INFO - Using env: {'DISPLAY': ':0', 10:11:50 INFO - 'HOME': '/home/cltbld', 10:11:50 INFO - 'LANG': 'en_US.UTF-8', 10:11:50 INFO - 'LANGUAGE': 'en_US:en', 10:11:50 INFO - 'LOGNAME': 'cltbld', 10:11:50 INFO - 'MAIL': '/var/mail/cltbld', 10:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:50 INFO - 'MOZ_NO_REMOTE': '1', 10:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:50 INFO - 'NO_EM_RESTART': '1', 10:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:50 INFO - 'PWD': '/builds/slave/test', 10:11:50 INFO - 'SHELL': '/bin/bash', 10:11:50 INFO - 'SHLVL': '1', 10:11:50 INFO - 'TERM': 'linux', 10:11:50 INFO - 'TMOUT': '86400', 10:11:50 INFO - 'USER': 'cltbld', 10:11:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:50 INFO - '_': '/tools/buildbot/bin/python'} 10:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:50 INFO - Downloading/unpacking psutil>=3.1.1 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:51 INFO - Installing collected packages: psutil 10:11:51 INFO - Running setup.py install for psutil 10:11:52 INFO - building 'psutil._psutil_linux' extension 10:11:52 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 10:11:52 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 10:11:52 INFO - building 'psutil._psutil_posix' extension 10:11:52 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 10:11:52 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 10:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:52 INFO - Successfully installed psutil 10:11:52 INFO - Cleaning up... 10:11:52 INFO - Return code: 0 10:11:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:11:52 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')]} 10:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:52 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')]} 10:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:52 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:52 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 10:11:52 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 10:11:52 INFO - Using env: {'DISPLAY': ':0', 10:11:52 INFO - 'HOME': '/home/cltbld', 10:11:52 INFO - 'LANG': 'en_US.UTF-8', 10:11:52 INFO - 'LANGUAGE': 'en_US:en', 10:11:52 INFO - 'LOGNAME': 'cltbld', 10:11:52 INFO - 'MAIL': '/var/mail/cltbld', 10:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:52 INFO - 'MOZ_NO_REMOTE': '1', 10:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:52 INFO - 'NO_EM_RESTART': '1', 10:11:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:52 INFO - 'PWD': '/builds/slave/test', 10:11:52 INFO - 'SHELL': '/bin/bash', 10:11:52 INFO - 'SHLVL': '1', 10:11:52 INFO - 'TERM': 'linux', 10:11:52 INFO - 'TMOUT': '86400', 10:11:52 INFO - 'USER': 'cltbld', 10:11:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:52 INFO - '_': '/tools/buildbot/bin/python'} 10:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:11:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:11:53 INFO - Installing collected packages: mozsystemmonitor 10:11:53 INFO - Running setup.py install for mozsystemmonitor 10:11:53 INFO - Successfully installed mozsystemmonitor 10:11:53 INFO - Cleaning up... 10:11:53 INFO - Return code: 0 10:11:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:11:53 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')]} 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:53 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')]} 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:53 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:53 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 10:11:53 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 10:11:53 INFO - Using env: {'DISPLAY': ':0', 10:11:53 INFO - 'HOME': '/home/cltbld', 10:11:53 INFO - 'LANG': 'en_US.UTF-8', 10:11:53 INFO - 'LANGUAGE': 'en_US:en', 10:11:53 INFO - 'LOGNAME': 'cltbld', 10:11:53 INFO - 'MAIL': '/var/mail/cltbld', 10:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:53 INFO - 'MOZ_NO_REMOTE': '1', 10:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:53 INFO - 'NO_EM_RESTART': '1', 10:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:53 INFO - 'PWD': '/builds/slave/test', 10:11:53 INFO - 'SHELL': '/bin/bash', 10:11:53 INFO - 'SHLVL': '1', 10:11:53 INFO - 'TERM': 'linux', 10:11:53 INFO - 'TMOUT': '86400', 10:11:53 INFO - 'USER': 'cltbld', 10:11:53 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:53 INFO - '_': '/tools/buildbot/bin/python'} 10:11:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:54 INFO - Downloading/unpacking jsonschema==2.5.1 10:11:54 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 10:11:54 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 10:11:54 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 10:11:54 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 10:11:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:11:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:11:55 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 10:11:55 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 10:11:55 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 10:11:55 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 10:11:55 INFO - Downloading functools32-3.2.3-2.tar.gz 10:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:11:55 INFO - warning: no files found matching '*.txt' 10:11:55 INFO - no previously-included directories found matching 'build' 10:11:55 INFO - no previously-included directories found matching 'dist' 10:11:55 INFO - no previously-included directories found matching '.git*' 10:11:55 INFO - Installing collected packages: jsonschema, functools32 10:11:55 INFO - Running setup.py install for functools32 10:11:55 INFO - warning: no files found matching '*.txt' 10:11:55 INFO - no previously-included directories found matching 'build' 10:11:55 INFO - no previously-included directories found matching 'dist' 10:11:55 INFO - no previously-included directories found matching '.git*' 10:11:55 INFO - Successfully installed jsonschema functools32 10:11:55 INFO - Cleaning up... 10:11:55 INFO - Return code: 0 10:11:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:11:55 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')]} 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:55 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')]} 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:55 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:55 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 10:11:55 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 10:11:55 INFO - Using env: {'DISPLAY': ':0', 10:11:55 INFO - 'HOME': '/home/cltbld', 10:11:55 INFO - 'LANG': 'en_US.UTF-8', 10:11:55 INFO - 'LANGUAGE': 'en_US:en', 10:11:55 INFO - 'LOGNAME': 'cltbld', 10:11:55 INFO - 'MAIL': '/var/mail/cltbld', 10:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:55 INFO - 'MOZ_NO_REMOTE': '1', 10:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:55 INFO - 'NO_EM_RESTART': '1', 10:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:55 INFO - 'PWD': '/builds/slave/test', 10:11:55 INFO - 'SHELL': '/bin/bash', 10:11:55 INFO - 'SHLVL': '1', 10:11:55 INFO - 'TERM': 'linux', 10:11:55 INFO - 'TMOUT': '86400', 10:11:55 INFO - 'USER': 'cltbld', 10:11:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:55 INFO - '_': '/tools/buildbot/bin/python'} 10:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:11:55 INFO - Cleaning up... 10:11:55 INFO - Return code: 0 10:11:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:55 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')]} 10:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:55 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')]} 10:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:55 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:55 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 10:11:55 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 10:11:55 INFO - Using env: {'DISPLAY': ':0', 10:11:55 INFO - 'HOME': '/home/cltbld', 10:11:55 INFO - 'LANG': 'en_US.UTF-8', 10:11:55 INFO - 'LANGUAGE': 'en_US:en', 10:11:55 INFO - 'LOGNAME': 'cltbld', 10:11:55 INFO - 'MAIL': '/var/mail/cltbld', 10:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:55 INFO - 'MOZ_NO_REMOTE': '1', 10:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:55 INFO - 'NO_EM_RESTART': '1', 10:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:55 INFO - 'PWD': '/builds/slave/test', 10:11:55 INFO - 'SHELL': '/bin/bash', 10:11:55 INFO - 'SHLVL': '1', 10:11:55 INFO - 'TERM': 'linux', 10:11:55 INFO - 'TMOUT': '86400', 10:11:55 INFO - 'USER': 'cltbld', 10:11:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:55 INFO - '_': '/tools/buildbot/bin/python'} 10:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:56 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:56 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 10:11:56 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 10:11:56 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 10:11:56 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 10:11:57 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 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 10:11:57 INFO - Downloading docopt-0.6.1.tar.gz 10:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:57 INFO - Running setup.py install for blobuploader 10:11:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:57 INFO - Running setup.py install for requests 10:11:58 INFO - Running setup.py install for docopt 10:11:58 INFO - Successfully installed blobuploader requests docopt 10:11:58 INFO - Cleaning up... 10:11:58 INFO - Return code: 0 10:11:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:58 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')]} 10:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:58 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')]} 10:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:58 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:11:58 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 10:11:58 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 10:11:58 INFO - Using env: {'DISPLAY': ':0', 10:11:58 INFO - 'HOME': '/home/cltbld', 10:11:58 INFO - 'LANG': 'en_US.UTF-8', 10:11:58 INFO - 'LANGUAGE': 'en_US:en', 10:11:58 INFO - 'LOGNAME': 'cltbld', 10:11:58 INFO - 'MAIL': '/var/mail/cltbld', 10:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:58 INFO - 'MOZ_NO_REMOTE': '1', 10:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:58 INFO - 'NO_EM_RESTART': '1', 10:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:58 INFO - 'PWD': '/builds/slave/test', 10:11:58 INFO - 'SHELL': '/bin/bash', 10:11:58 INFO - 'SHLVL': '1', 10:11:58 INFO - 'TERM': 'linux', 10:11:58 INFO - 'TMOUT': '86400', 10:11:58 INFO - 'USER': 'cltbld', 10:11:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:58 INFO - '_': '/tools/buildbot/bin/python'} 10:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:58 INFO - Running setup.py (path:/tmp/pip-Z5ATYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:58 INFO - Running setup.py (path:/tmp/pip-vkbvZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:58 INFO - Running setup.py (path:/tmp/pip-0Jxbjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:58 INFO - Running setup.py (path:/tmp/pip-g11RES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:58 INFO - Running setup.py (path:/tmp/pip-nLq3Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:58 INFO - Running setup.py (path:/tmp/pip-feKO9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:59 INFO - Running setup.py (path:/tmp/pip-oC6NsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:59 INFO - Running setup.py (path:/tmp/pip-86i_Ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:59 INFO - Running setup.py (path:/tmp/pip-zZ96MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:59 INFO - Running setup.py (path:/tmp/pip-UutCBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:59 INFO - Running setup.py (path:/tmp/pip-UiuzqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:59 INFO - Running setup.py (path:/tmp/pip-LLEKem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:59 INFO - Running setup.py (path:/tmp/pip-Hn39b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:59 INFO - Running setup.py (path:/tmp/pip-GJRxTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:59 INFO - Running setup.py (path:/tmp/pip-m3XL8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:59 INFO - Running setup.py (path:/tmp/pip-_SsABh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:59 INFO - Running setup.py (path:/tmp/pip-vWfMCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:59 INFO - Running setup.py install for manifestparser 10:11:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:59 INFO - Running setup.py install for mozcrash 10:12:00 INFO - Running setup.py install for mozdebug 10:12:00 INFO - Running setup.py install for mozdevice 10:12:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Running setup.py install for mozfile 10:12:00 INFO - Running setup.py install for mozhttpd 10:12:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Running setup.py install for mozinfo 10:12:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Running setup.py install for mozInstall 10:12:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Running setup.py install for mozleak 10:12:00 INFO - Running setup.py install for mozlog 10:12:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Running setup.py install for moznetwork 10:12:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:12:00 INFO - Running setup.py install for mozprocess 10:12:01 INFO - Running setup.py install for mozprofile 10:12:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:12:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:12:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:12:01 INFO - Running setup.py install for mozrunner 10:12:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:12:01 INFO - Running setup.py install for mozscreenshot 10:12:01 INFO - Running setup.py install for moztest 10:12:01 INFO - Running setup.py install for mozversion 10:12:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:12:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:12:01 INFO - Cleaning up... 10:12:01 INFO - Return code: 0 10:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:01 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')]} 10:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:01 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')]} 10:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:01 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:12:01 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 10:12:01 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 10:12:01 INFO - Using env: {'DISPLAY': ':0', 10:12:01 INFO - 'HOME': '/home/cltbld', 10:12:01 INFO - 'LANG': 'en_US.UTF-8', 10:12:01 INFO - 'LANGUAGE': 'en_US:en', 10:12:01 INFO - 'LOGNAME': 'cltbld', 10:12:01 INFO - 'MAIL': '/var/mail/cltbld', 10:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:01 INFO - 'MOZ_NO_REMOTE': '1', 10:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:01 INFO - 'NO_EM_RESTART': '1', 10:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:01 INFO - 'PWD': '/builds/slave/test', 10:12:01 INFO - 'SHELL': '/bin/bash', 10:12:01 INFO - 'SHLVL': '1', 10:12:01 INFO - 'TERM': 'linux', 10:12:01 INFO - 'TMOUT': '86400', 10:12:01 INFO - 'USER': 'cltbld', 10:12:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:01 INFO - '_': '/tools/buildbot/bin/python'} 10:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:12:01 INFO - Running setup.py (path:/tmp/pip-ZVesZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:12:01 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)) 10:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:12:01 INFO - Running setup.py (path:/tmp/pip-deWFCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:12:01 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)) 10:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:12:01 INFO - Running setup.py (path:/tmp/pip-C_ZRDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:12:02 INFO - Running setup.py (path:/tmp/pip-XHZutb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:12:02 INFO - Running setup.py (path:/tmp/pip-J_WyyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:12:02 INFO - Running setup.py (path:/tmp/pip-8mSmsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:12:02 INFO - Running setup.py (path:/tmp/pip-M8C5Kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:12:02 INFO - Running setup.py (path:/tmp/pip-8YK6sZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:12:02 INFO - Running setup.py (path:/tmp/pip-lurPKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:12:02 INFO - Running setup.py (path:/tmp/pip-GftzYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:12:02 INFO - Running setup.py (path:/tmp/pip-B06tks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:12:02 INFO - Running setup.py (path:/tmp/pip-CICefn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:12:02 INFO - Running setup.py (path:/tmp/pip-AD5Dbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:12:02 INFO - Running setup.py (path:/tmp/pip-jH2K6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:02 INFO - Running setup.py (path:/tmp/pip-tCa4_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:12:02 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)) 10:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:12:02 INFO - Running setup.py (path:/tmp/pip-F5gMnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:12:03 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)) 10:12:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:12:03 INFO - Running setup.py (path:/tmp/pip-Sb2EZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:12:03 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)) 10:12:03 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)) 10:12:03 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)) 10:12:03 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)) 10:12:03 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)) 10:12:03 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)) 10:12:03 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)) 10:12:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:12:03 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 10:12:03 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 10:12:03 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 10:12:03 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 10:12:04 INFO - Downloading blessings-1.6.tar.gz 10:12:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:12:04 INFO - Installing collected packages: blessings 10:12:04 INFO - Running setup.py install for blessings 10:12:04 INFO - Successfully installed blessings 10:12:04 INFO - Cleaning up... 10:12:04 INFO - Return code: 0 10:12:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:12:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:04 INFO - Reading from file tmpfile_stdout 10:12:04 INFO - Current package versions: 10:12:04 INFO - argparse == 1.2.1 10:12:04 INFO - blessings == 1.6 10:12:04 INFO - blobuploader == 1.2.4 10:12:04 INFO - docopt == 0.6.1 10:12:04 INFO - functools32 == 3.2.3-2 10:12:04 INFO - jsonschema == 2.5.1 10:12:04 INFO - manifestparser == 1.1 10:12:04 INFO - mozInstall == 1.13 10:12:04 INFO - mozcrash == 1.0 10:12:04 INFO - mozdebug == 0.1 10:12:04 INFO - mozdevice == 0.51 10:12:04 INFO - mozfile == 1.2 10:12:04 INFO - mozhttpd == 0.7 10:12:04 INFO - mozinfo == 0.10 10:12:04 INFO - mozleak == 0.1 10:12:04 INFO - mozlog == 3.5 10:12:04 INFO - moznetwork == 0.27 10:12:04 INFO - mozprocess == 0.25 10:12:04 INFO - mozprofile == 0.28 10:12:04 INFO - mozrunner == 6.13 10:12:04 INFO - mozscreenshot == 0.1 10:12:04 INFO - mozsystemmonitor == 0.3 10:12:04 INFO - moztest == 0.8 10:12:04 INFO - mozversion == 1.4 10:12:04 INFO - psutil == 3.1.1 10:12:04 INFO - requests == 1.2.3 10:12:04 INFO - wsgiref == 0.1.2 10:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12:04 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')]} 10:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:04 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')]} 10:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:04 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:12:04 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 10:12:04 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 10:12:04 INFO - Using env: {'DISPLAY': ':0', 10:12:04 INFO - 'HOME': '/home/cltbld', 10:12:04 INFO - 'LANG': 'en_US.UTF-8', 10:12:04 INFO - 'LANGUAGE': 'en_US:en', 10:12:04 INFO - 'LOGNAME': 'cltbld', 10:12:04 INFO - 'MAIL': '/var/mail/cltbld', 10:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:04 INFO - 'MOZ_NO_REMOTE': '1', 10:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:04 INFO - 'NO_EM_RESTART': '1', 10:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:04 INFO - 'PWD': '/builds/slave/test', 10:12:04 INFO - 'SHELL': '/bin/bash', 10:12:04 INFO - 'SHLVL': '1', 10:12:04 INFO - 'TERM': 'linux', 10:12:04 INFO - 'TMOUT': '86400', 10:12:04 INFO - 'USER': 'cltbld', 10:12:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:04 INFO - '_': '/tools/buildbot/bin/python'} 10:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 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)) 10:12:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:12:06 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)) 10:12:06 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)) 10:12:06 INFO - Installing collected packages: simplejson 10:12:06 INFO - Running setup.py install for simplejson 10:12:06 INFO - building 'simplejson._speedups' extension 10:12:06 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 10:12:06 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 10:12:07 INFO - Successfully installed simplejson 10:12:07 INFO - Cleaning up... 10:12:07 INFO - Return code: 0 10:12:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12:07 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')]} 10:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:07 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')]} 10:12:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:07 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 0xbf61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, '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': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', '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 10:12:07 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 10:12:07 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 10:12:07 INFO - Using env: {'DISPLAY': ':0', 10:12:07 INFO - 'HOME': '/home/cltbld', 10:12:07 INFO - 'LANG': 'en_US.UTF-8', 10:12:07 INFO - 'LANGUAGE': 'en_US:en', 10:12:07 INFO - 'LOGNAME': 'cltbld', 10:12:07 INFO - 'MAIL': '/var/mail/cltbld', 10:12:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:07 INFO - 'MOZ_NO_REMOTE': '1', 10:12:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:07 INFO - 'NO_EM_RESTART': '1', 10:12:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:07 INFO - 'PWD': '/builds/slave/test', 10:12:07 INFO - 'SHELL': '/bin/bash', 10:12:07 INFO - 'SHLVL': '1', 10:12:07 INFO - 'TERM': 'linux', 10:12:07 INFO - 'TMOUT': '86400', 10:12:07 INFO - 'USER': 'cltbld', 10:12:07 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:12:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:07 INFO - '_': '/tools/buildbot/bin/python'} 10:12:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:12:07 INFO - Cleaning up... 10:12:07 INFO - Return code: 0 10:12:07 INFO - Running post-action listener: _resource_record_post_action 10:12:07 INFO - Running post-action listener: _start_resource_monitoring 10:12:07 INFO - Starting resource monitoring. 10:12:07 INFO - [mozharness: 2017-09-06 17:12:07.382605Z] Finished create-virtualenv step (success) 10:12:07 INFO - [mozharness: 2017-09-06 17:12:07.383119Z] Running install step. 10:12:07 INFO - Running pre-action listener: _resource_record_pre_action 10:12:07 INFO - Running main action method: install 10:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:07 INFO - Reading from file tmpfile_stdout 10:12:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:07 INFO - Reading from file tmpfile_stdout 10:12:07 INFO - Output received: 10:12:07 INFO - Usage: mozinstall [options] installer 10:12:07 INFO - Options: 10:12:07 INFO - -h, --help show this help message and exit 10:12:07 INFO - -d DEST, --destination=DEST 10:12:07 INFO - Directory to install application into. [default: 10:12:07 INFO - "/builds/slave/test"] 10:12:07 INFO - --app=APP Application being installed. [default: firefox] 10:12:07 INFO - mkdir: /builds/slave/test/build/application 10:12:07 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'] 10:12:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:12:22 INFO - Reading from file tmpfile_stdout 10:12:22 INFO - Output received: 10:12:22 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:22 INFO - Running post-action listener: _resource_record_post_action 10:12:22 INFO - [mozharness: 2017-09-06 17:12:22.483316Z] Finished install step (success) 10:12:22 INFO - [mozharness: 2017-09-06 17:12:22.483568Z] Running setup-mitmproxy step. 10:12:22 INFO - Running pre-action listener: _resource_record_pre_action 10:12:22 INFO - Running main action method: setup_mitmproxy 10:12:22 INFO - Skipping: mitmproxy is not required 10:12:22 INFO - Running post-action listener: _resource_record_post_action 10:12:22 INFO - [mozharness: 2017-09-06 17:12:22.484695Z] Finished setup-mitmproxy step (success) 10:12:22 INFO - [mozharness: 2017-09-06 17:12:22.484915Z] Running run-tests step. 10:12:22 INFO - Running pre-action listener: _resource_record_pre_action 10:12:22 INFO - Running pre-action listener: _set_gcov_prefix 10:12:22 INFO - Running main action method: run_tests 10:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:22 INFO - Python 2.7.3 10:12:22 INFO - Return code: 0 10:12:22 INFO - grabbing minidump binary from tooltool 10:12:22 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')]} 10:12:22 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 0xf63050>, '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 0xf63f50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf643e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:22 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 10:12:22 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 10:12:22 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 10:12:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:22 INFO - Return code: 0 10:12:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:22 INFO - ENV: RUST_BACKTRACE is now 1 10:12:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 10:12:22 INFO - Using env: {'DISPLAY': ':0', 10:12:22 INFO - 'HOME': '/home/cltbld', 10:12:22 INFO - 'LANG': 'en_US.UTF-8', 10:12:22 INFO - 'LANGUAGE': 'en_US:en', 10:12:22 INFO - 'LOGNAME': 'cltbld', 10:12:22 INFO - 'MAIL': '/var/mail/cltbld', 10:12:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:22 INFO - 'MOZ_NO_REMOTE': '1', 10:12:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:22 INFO - 'NO_EM_RESTART': '1', 10:12:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:22 INFO - 'PWD': '/builds/slave/test', 10:12:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:22 INFO - 'RUST_BACKTRACE': '1', 10:12:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:12:22 INFO - 'SHELL': '/bin/bash', 10:12:22 INFO - 'SHLVL': '1', 10:12:22 INFO - 'TERM': 'linux', 10:12:22 INFO - 'TMOUT': '86400', 10:12:22 INFO - 'USER': 'cltbld', 10:12:22 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1504717863.189577-252015041', 10:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:22 INFO - '_': '/tools/buildbot/bin/python'} 10:12:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 10:12:22 INFO - mozversion application_buildid: 20170906160034 10:12:22 INFO - mozversion application_changeset: 97bee4069ef3dc6dba83760a80293c9a17b803f4 10:12:22 INFO - mozversion application_display_name: Firefox 10:12:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:22 INFO - mozversion application_name: Firefox 10:12:22 INFO - mozversion application_remotingname: firefox 10:12:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:12:22 INFO - mozversion application_vendor: Mozilla 10:12:22 INFO - mozversion application_version: 56.0 10:12:22 INFO - mozversion platform_buildid: 20170906160034 10:12:22 INFO - mozversion platform_changeset: 97bee4069ef3dc6dba83760a80293c9a17b803f4 10:12:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:12:22 INFO - mozversion platform_version: 56.0 10:12:22 INFO - using testdate: 1504717942 10:12:22 INFO - actual date: 1504717942 10:12:22 INFO - starting webserver on 'localhost:53898' 10:12:22 INFO - SUITE-START | Running 2 tests 10:12:22 INFO - TEST-START | dromaeo_css 10:12:22 INFO - Initialising browser for dromaeo_css test... 10:12:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53898/getInfo.html -profile /tmp/tmpOaTltK/profile 10:12:22 INFO - TEST-INFO | started process 14572 (/builds/slave/test/build/application/firefox/firefox http://localhost:53898/getInfo.html) 10:12:28 INFO - TEST-INFO | 14572: exit 0 10:12:28 INFO - Browser initialized. 10:12:28 INFO - Running cycle 1/1 for dromaeo_css test... 10:12:28 INFO - TEST-INFO | started process 14736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOaTltK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:12:29 INFO - PID 14736 | 1504717949069 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4395 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 10:12:39 INFO - PID 14736 | RSS: Main: 151392256 10:12:39 INFO - PID 14736 | 10:15:37 INFO - PID 14736 | Cycle 1(1): loaded http://localhost:53898/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53898/tests/dromaeo/cssquery-ext.html) 10:15:38 INFO - PID 14736 | RSS: Main: 161120256 10:15:38 INFO - PID 14736 | 10:18:40 INFO - PID 14736 | Cycle 1(1): loaded http://localhost:53898/tests/dromaeo/cssquery-ext.html (next: http://localhost:53898/tests/dromaeo/cssquery-jquery.html) 10:18:41 INFO - PID 14736 | RSS: Main: 155303936 10:18:41 INFO - PID 14736 | 10:21:42 INFO - PID 14736 | Cycle 1(1): loaded http://localhost:53898/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53898/tests/dromaeo/cssquery-mootools.html) 10:21:43 INFO - PID 14736 | RSS: Main: 157143040 10:21:43 INFO - PID 14736 | 10:24:44 INFO - PID 14736 | Cycle 1(1): loaded http://localhost:53898/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53898/tests/dromaeo/cssquery-prototype.html) 10:24:45 INFO - PID 14736 | RSS: Main: 159662080 10:24:45 INFO - PID 14736 | 10:27:48 INFO - PID 14736 | Cycle 1(1): loaded http://localhost:53898/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53898/tests/dromaeo/cssquery-yui.html) 10:27:49 INFO - PID 14736 | RSS: Main: 161820672 10:27:49 INFO - PID 14736 | 10:30:50 INFO - PID 14736 | Cycle 1(1): loaded http://localhost:53898/tests/dromaeo/cssquery-yui.html (next: http://localhost:53898/tests/dromaeo/cssquery-dojo.html) 10:30:51 INFO - PID 14736 | RSS: Main: 164270080 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | __start_tp_report 10:30:51 INFO - PID 14736 | _x_x_mozilla_page_load 10:30:51 INFO - PID 14736 | _x_x_mozilla_page_load_details 10:30:51 INFO - PID 14736 | |i|pagename|runs| 10:30:51 INFO - PID 14736 | |0;dojo.html;3548.5741710994685;3592.335417947679;3597.622249663787;3615.83728732207;3657.1588534637035;6282.2147231596055;6346.397092276238;6418.101465794786;6453.225612926455;6456.354364563541;6458.289588145312;6461.967690161543;6501.544891857572;6558.376954189344;6568.047633093199;5554.166874968747;5637.8590535236635;5679.2049113123985;5692.8861422771515;5708.22938903249;5460.699661518614;5534.806281780138;5622.775088996455;5674.829755107354;5699.316082070158;5602.691851948141;5652.491275785179;5666.829995100154;5670.5463562914865;5698.715064246791;5615.859603509945;5624.465675760796;5648.43515648436;5696.8606278744;5700.572457065737;5518.944810551883;5554.694491802949;5555.30558680165;5583.078791999315;5641.548676105902;6349.968250158766;6350.301466838644;6372.044193370985;6388.680565971683;6403.519736019817;6945.583265004066;6953.79138625842;7030.964845175741;7038.3665470107935;7046.330598593126;6818.965905170442;6897.379235868796;6923.58458492487;7021.89467157993;7063.82340441493;6419.967900160516;6457.160569125984;6503.902441463382;6577.375149360803;6584.967075164642;7076.2923707628825;7122.92877071233;7231.783046508614;7235.493515453973;7252.419806415474;6693.364130407604;6757.155355580552;6855.485838562127;6960.338767817049;6984.685689144001;6982.301769823079;7044.401225895856;7051.259617740064;7056.647167641598;7059.2234854166;6920.515563910579;6931.306869313028;6980.581165130108;7022.12223472066;7026.789196324118;6836.931630683729;6887.242403335629;6929.203141638675;6931.09895713554;7019.473539484559;5099.643024988215;5147.613928955343;5177.352830896138;5182.5594824439595;5183.533481986639;4565.931511027271;4606.447226332862;4612.123696497655;4626.86119416418;4652.232381657056;6521.934780652133;6641.734330626721;6661.966690166518;6745.291744366869;6747.426468750113;7012.983117447941;7022.157341119098;7027.086478757831;7029.332213439715;7030.964845175844;6684.966575167093;6693.062971184038;6713.429358504582;6715.395614394728;6718.462522998148;5881.705914704333;5908.940910590925;5926.377730338339;5937.079752638348;5940.34656187819;7180;7184.892226616605;7195.784126476214;7278.526895751759;7287.635618219174;6939.583624982315;7017.543859649107;7031.648417578998;7104.857902842017;7104.893426598605;7110.0401445804155;7173.677184526813;7230.602316872412;7237.276272372931;7284.344409003215;6919.481038922;6949.583025018515;6955.8608827822145;6974.197967233833;6989.650517474208;7026.1217347831525;7040.5071644984355;7042.894356584758;7122.857542849218;7144.249853765487;6729.495287853529;6855.862882742417;6856.4514838813775;6856.5200435969;6857.931420685729;6866.759663411756;6881.41507971828;6964.6517674115075;6968.303169682991;6973.3375329343635;6864.4165245954655;6865.588064716133;6875.759348422781;6950.096487456598;6952.30476952321;6646.667666616553;6795.116634837439;6796.524243303119;6825.146856642919;6914.688839002358;6631.635260060743;6678.565893216925;6686.866262674816;6735.158105236846;6760.797176084725 10:30:51 INFO - PID 14736 | |1;ext.html;893.3255392178907;940.9012053734358;970.1608108985728;985.9852102218464;995.9402435853849;42136.789316053415;43286;43423.131537369234;43504.782476087654;43522.347164792554;41165;41233.58766412335;41239.587604123946;41317.79341103298;41362.793186034025;7050.365467107959;7170;7173;7179.3538581527655;7198.6400679966055;7099.609521476316;7099.787006389816;7134.357907788298;7143.678534465961;7170.60561669108;7667.079950405959;7818.179091195428;7819.2180781921925;7822.022247219098;7822.569758663271;7730.536167829948;7760.844783104363;7763.4953728007495;7782.64978075988;7794.181610930856;7662.501937374052;7668;7698.769036928901;7749.108852481924;7763.767086987399;40034;40213.798931005156;40276.194476110315;40315.798421007705;40323;3710.628937106295;3750.587435382106;3753.0992561785247;3753.380692185786;3755.361588529929;31837;31986.840065799755;32008.83995580007;32180.678193218002;32189.356212875613;4845.103655823648;5028.698278103326;5040.5463508284065;5058.772355244023;5076.873078173038;201785;204355;206528;209162.9541852296;224255;52122.73938630358;52228.738856306234;52237;52242.73878630659;52327.73836130795;55376.16935745967;55438.72280638652;55445.1683224752;55503;55523;17113.572160695832;17178.656426871392;17196.742048869277;17228.655426891393;17554;14258.928705356615;14282.428702851978;14342.569722908329;14431.061980971203;14431.2062836545;15288.464903728316;15288.847111528965;15382.692346153015;15425.922870385577;15508.767368489482;5931.317898441648;5935.643861368331;5968.7015649217365;6004.328074007025;6134.9079763803575;1125.0493333133488;1127.9718007049726;1129.1474936423112;1142.360278244186;1147.391882302381;26627.733722662913;26739.598906016425;26948.59577106345;32846.507302390484;33198.17004574905;1244.4151248912997;1251.0367017396736;1253.9749205015848;1254.1847798930585;1256.8931640810633;14345.497907573184;14581.489647862274;14610.196439195734;14624;14880.255987200597;271037;277075;277197;277304;277641;57532.71233643805;57533.71233143807;57693.423065769646;58086;58285.41714582885;1569.1291333309894;1584.619691274109;1606.8794840387018;1613.048301502096;1619.1418548169254;25350;26080.73919260783;26198.21405357766;26279.868600656875;26503.60244596294;38731.80634096811;38880.80559597184;38884.805575971935;38905.41641875431;38927.80536097301;241260;242952;243177;243883;244672;33426.83286583552;33886.830565848;35037.299254014266;37214.8139259302;37450.8127459361;47809.52190478051;48351;48444.273335899285;50178.74910625423;50267.74866125646;36219.45670814887;36518;36652;36673.083172919825;36968;35869.82065089658;36094.63905360913;36377.81811090928;36700.81649591735;36882.26235475329;42055.7897210512;43289.7835510833;43623.345649815914;43655;43730.78134609306;35176.296474070885;35816;35868.820655897594;35950;36538.26923461569;26478.470430591664;27008;27533.724662753917;27754.5836812452;27941.301467463476 10:30:51 INFO - PID 14736 | |2;jquery.html;599.35868620576;600.6996501749128;605.806142034549;606.5663050918592;625.0686477149048;23911;24671.50656986859;24729;24745.257642270717;24758.381040473974;22808.543829123406;23537.646935295983;28791;28831.135065948;28937.710622893766;6352.809415717536;6440.194975628046;6485.6108633482145;6492.642904640243;6493.350664933492;6222.782202622909;6335.809925702236;6352;6576.80269591913;6595.93404065958;6555.868882622344;6560.9671951640175;6561.475081993453;6573.868522629545;6575.868482630344;6495.090687303781;6534.771283005072;6536.182977127883;6544.345565443466;6544.443722283588;6094.512439004913;6098.420650038239;6102.938970610326;6105.542084343692;6122.4183702548635;29400.558991615144;31949.680503195137;32768.50847237293;32809.6719032809;32983.67016329854;2271.341311019802;2304.493011537459;2305.8501197422115;2306.1121468234683;2309.6535519672016;20791;20852.47868803292;20921.686174707393;21055.684164737388;21079.156833726633;2358.127492827665;2373.2405630198346;2377;2394.820388470872;2405.927822165338;152554;157746.21126894292;160338;164052;166855.16572417182;15917.840821591868;16461.753073703905;16588.83411165873;16590.419335323204;16944.322227111024;25588;25639.359016024748;25704.485910281688;25762.74237257641;25841.612375814377;11459.77080458386;11607.245529040585;11756.529738810352;11893.286402815858;11949.522019119311;11180.720481987853;11183.776324473465;11192.328460292245;11234.775304493864;11330.150238732129;10027;10036.548355324028;10142.290039697298;10202.540885660163;10338.759348878182;2831.546952487592;2835.4187391584674;2880.7551358134792;2930.5457654063653;2988.491956367423;1073.7798751255973;1075.6988043347876;1090.6128324444708;1094.4254266509986;1110.7167672243527;22341.664875026887;26765;27009.324766880985;27811.58282625762;28508.71491285102;1149.6436104807538;1151.573917650458;1158.6697791129657;1168.4216312925157;1172.783035138502;12382.62852114438;12799.232046077264;12855.550055748005;12884.420201090787;12939.741205175844;651096;659690;668675;679781;690596;147638;148815;150309.2484537592;150338;152378.23810881097;1348.7841945288706;1376.215557132445;1393.5610282760897;1397.5597686728647;1397.881180099703;20944.581108378054;20971.685424718336;21221.681674774583;21275.8936205318;23485.76514234836;66811.66594166998;71480.28519714736;72413.63793181212;72749;74867;91836.54081729549;91998.54000729954;93366;93747;94745.5262723682;23566.528669426858;23918.402039949142;24379;24380.51238975246;24491.63262551099;25750;25979.870100649376;26233.475330493664;26246;26399.34001649974;21016.789832101484;21046.15815367368;21143.15427382949;21161.788382116596;21265.149394024684;17976.82023179804;18472.983985880368;18508.81491185125;18823.34118305853;19114.904425477784;20381.592368152258;21422;21761.564768704855;21871.890640546695;21953.67069493991;23897;24394.75605243996;24428.900699468923;24485.877570612745;24657.137000204908;20303;20366.18535258573;20539.794602054386;21083.262085826922;21323.7867621328 10:30:51 INFO - PID 14736 | |3;mootools.html;1413.590058882924;1462.2323280277853;1470.5294305822142;1506.4652048522778;1509.4943194029993;15542.533723988285;16181.83818161818;16301.836981630195;16349.264283107244;16362.918185409057;16162.353505859752;16566.337346506127;16572.337106515755;16575.419860304894;16586.66826663466;2991.5662228976785;2997.955030674542;3043.8478076096217;3058.831764252965;3060.26553627129;2988.6114805075417;2992.670806211315;2993.0721476342296;3015.26126099106;3015.42706885691;2870.3111253299267;2927.2389178813555;2944.1461976027035;2948.8378139202337;2951.0261613667544;2840.9289767755868;2847.6867544570187;2848.088611644275;2851.942961140776;2869.856507174633;2799.538076217422;2803.1730639461407;2808.4663913856302;2816.5493521036537;2818.140467157516;15698.450554230662;15994.440194593133;16008.519744407686;16085.115318657468;16085.597860053475;8505.489670619783;8587.957060214721;8917.86623200646;9015.323850711224;9023.458592484472;5710.7430165642645;5885.176075349455;5886.823395298148;5897.911531327033;5901.4098590141075;1892.6782446983907;1926.1236137557378;1954.042519165613;1965.9017049147628;1968.8917109558968;27955.580666289818;28076.438471230664;28174.295642608893;28196.43607127846;28238.858805706044;7376.557406555624;7598.404335089583;7611.505252158592;7792.727254546064;7821;18917.43247702571;19013.42959711211;19027.429177124708;19033;19066.61866762657;8503.787405314917;8827.249683776823;8839.911600883908;8942.329325300629;8957.865632015524;6814.2163651180745;7064.258252883476;7395;8072.233137851895;8369.916300837036;5875.441833025856;6001.399860013964;6021.638701677914;6067.1202675611785;6138.570300079041;1667.2080761638367;1703.8892471989282;1736.3749050341867;1741.3034786085414;1747.1480230955228;951.7953639967441;964.6623681711485;972.6644307713827;980.294188184506;1019.5004447820514;8800.031996480382;8938.240249578728;9084.8637270441;9164.8625270621;9310.348275620641;1086.6902932664152;1094.8084085285202;1097.0839349143555;1099.9395033273247;1128.7911736328806;5782.248307720053;5816.1566572846705;5840.707964601753;5918.970405147947;6088.330283668793;23516;23844;24424.877875610862;24476.265712028668;24668;24078.277651670476;24399.26802195937;24678;24680;24698.753012470006;11751.823722644167;11976.52093916251;12117.454714537691;12221.144519883701;12255.632331030083;9455.290853185901;9478.715638530855;9599.904000960181;9611.471369074488;9795.951020245138;20654.17383304651;20684;20771.96140192954;20969.161233550487;21357.03893324773;20975.475613109185;21355;21581.676274855574;21810.890945545172;21913.233036843634;13398;13475.46098156102;13754.793678095037;13776.380062897395;13852.930735346661;15000.024998375071;15254.542363729106;15297.23513824282;15298.923505382401;15303.770443443134;11754.118441117122;11919.880801191877;11974.341411222467;12043.75912481728;12095.274283543016;11589.710257243636;11607.709807254887;11719.648410547697;11730.941345293219;12028;10489.318194317346;10531.94734026325;10679.8932010682;10695.94652026735;10707.839382409426;7585;7789.454738168274;7820;7833.451658383859;7892.210778922062;7983.121856595886;8145.755627331189;8156.306713929383;8215.424920255764;8284.792880177803 10:30:51 INFO - PID 14736 | |4;prototype.html;541.4774742373609;542.9185622156676;549.2694716027684;557.8995780759465;564.7289301135455;6246.500279977602;6250.343713910031;6251.374862513746;6278;6280.371962803717;6105;6186.226721659793;6201.441870231678;6251.187345645071;6268.122462855193;4936.975315123419;4969.701817890929;4973.980334031515;4986.227134794112;5006.1990081586955;4699.7415142167165;4891.608671306287;4934.605231581465;4977.278294647274;5006.849794506171;4784.449788274341;4831.396075490564;4839.467658557556;4846.273059041137;4861.319415281863;4792.137415265251;4838.830640927551;4868.853934381957;4870.902581948341;4910;4449.710768800018;4460.353248778942;4480.549976518096;4482.125985432842;4483.775811209459;6126.969365153191;6134.539909506805;6143.477804386633;6144.218176728743;6156.7994241123;5815.691469419389;5837.153612726131;5849.151872978395;5865.237519122529;5898.705064746746;6653.201615806086;6684.398404143651;6715.6977935993;6746.313421644589;6772.187337519529;5086.847394578169;5101.591872650179;5103.464136265713;5103.795848166106;5107.3105130807235;6688.264290927994;6774.762883299061;6897.41371983382;6971.755988540377;7012.894806577905;5101.464346243665;5173.508516690984;5177.792888284502;5200.141976573823;5210.166373380241;5241.371035475691;5270.8155214567305;5278.577713782888;5308.309919710413;5309.150535914235;5766.682832444172;5824.737886795105;5825.592208545361;5845.941540584625;5856.038227193938;6716.932830671729;6738.32616738332;6738.764143254963;6745.291744366869;6757.358050985148;1783.482789990914;1817.809130041353;1830.6727622473866;1855.35990083421;1863.7577114974968;1250.8248845161684;1295.086963690596;1296.6126244918037;1300.596814987357;1305.7062161013696;6269.780557680459;6370.394812492806;6400.359964003563;6414.64719440426;6420.839479013062;6872.553284036521;6876.17485901685;6877.6217308048535;6907.585544867324;6929.722811087601;6138.7237574309265;6288.308286088527;6340.904886426615;6369.617822930639;6414.454771344394;3547.627499112556;3551.449525323579;3591.4971903932947;3605.8737944171826;3625.836837342326;6967.3626697725995;6977.79066628002;6985.545939513915;7006.684699188447;7082.752103676346;6958.547694399847;7005.719771209095;7013.473989450812;7029.9648501757165;7053.1685795229405;6988.161420629353;6988.336108069725;6992.860142797115;6993.405560527311;7004.824879378057;6794.592324460548;6812.659367031728;6879.346462086094;6900.896486552605;6910.447164226749;6682.899756503753;6730.764423245163;6734.73061077571;6792.796216113326;6802.863942721019;6986.71624336561;7058.752943647153;7061.470389720895;7106.324899134574;7108.431325494052;5202.271681964604;5206.2450944612065;5210.635255532076;5247.501487358695;5282.47175282484;6553.672316384066;6725.0161202444415;6734.191896972395;6895.5173137879865;6902.827429314308;6514.57655252407;6531.43245621057;6607.273199948098;6619.338066193534;6685.2646208916;6481.351864813481;6536.607803531803;6592.67036648156;6636.7013484392355;6686;6471.514636402195;6539.833531510244;6555.475561955128;6567.474602031731;6673.9332606673315;6661.600303981777;6693.1298931138645;6724.226713927961;6744.359285867835;6751.426128778912;6419.876521608793;6500.3174666659315;6560.475161986934;6584.967075164594;6591.604503729792 10:30:51 INFO - PID 14736 | |5;yui.html;960.7598100474877;978.7748817771911;1004.2919741582185;1021.3004092196841;1022.9948850255747;19333.70999435008;19719.408417747472;19853.801461985393;19938.202471901142;21697.240596579122;20396.694049589267;21039.2636257731;21059.47351316218;21113.366599002016;21176;974.0746291023538;979.1041197304457;990.2474119669031;990.7572644702022;994.6121012805012;952.3571589177312;1035.140833108518;1036.2590747615454;1059.5973530058568;1065.1957771882219;1139.692283083571;1141.4863311509812;1141.9771604567904;1142.5715356741223;1143.3997151495448;1139.8917102875214;1141.303804679145;1142.1490989213048;1142.7543078238177;1143.9714007149805;837.4514692876176;837.9664813407456;838.3963546246692;838.8196537744415;839.6473481137875;18504.16731247097;19562.51093722654;20018.69971950422;20023.898685572287;20051.398458046282;19800.70298945517;19802.108905099307;19968.400947971582;19971.80028199714;20091.497712557157;16205.837941620552;16278.918605406898;16367.672646547122;16519;16562.337506499727;3784.0729021389934;3789.829457674384;3808.352580061396;3820.3505404081093;3834.5015148030857;135643.32178339144;135926;139151;141251.58748412487;141361;15258.542243732705;15378.384864605514;15604.063756174666;15611.219439028004;15771.132587707556;26577.867110664323;27157.728422715914;27208;27515;27685.72314276872;8368.121347258571;8847.646094156291;9063.59213835379;9244.3528952974;9382.155605995493;4649.139909116824;4762.333273341735;4762.690425122356;4767.976160119247;4769.928451073237;5644.491995720405;5648.51987581052;5719.456651618173;5751.051076572318;5765.971170144123;1213.1629175868622;1221.2916508425092;1235.3946566182506;1240.8324876141605;1250.3998080921208;736.7421402509186;756.1153450462972;757.5909009135005;765.9961700191575;770.0489894979696;12747.61757147287;13660.521881734092;13694.863051369559;13756.105853119516;13769.793453098211;658.4962503684685;664.378805816563;671.0308525074229;672.8721542906832;674.7469698862926;6109.633421994695;6124.418180272956;6125;6251.6561589113035;6328.272248691367;126745;130022.34988825185;130748;133250;133884;113341;114381;116390.4180479109;117636;118490.4075479617;99011;101192.49403752934;101706;102435.4878225604;104842.47578762057;12192.878071219175;12211.87788122143;12251.326177060348;12329.93835030855;12431.191972521758;49755;50339.74830125826;50938;51530;51936.74031629818;60593;61898.38101618926;62125;62151.37848621637;65216.67391663011;17111.914440427718;17371.392001279895;17541.386051488138;20279.087441065483;21056.052477638237;22497.66253506166;22603.886980564992;23000.654990174826;23325.300240992798;23636.409089772893;18479;21295.254666086614;21403.57192856103;21644.783552164277;21671.674924875824;18433.354832580797;18462.723059154392;20296.086676099905;20537.589248215252;20700.068496917975;20177.79822201759;20524;20602.587948240653;20656;20753.896230518752;14541.200233986809;14803;15340.232988350761;15863.762043569124;15953.840461595235;14870.776938345716;15212.1633310169;15226.695466090838;15345.846541534442;15401.614959626098 10:30:51 INFO - PID 14736 | __end_tp_report 10:30:51 INFO - PID 14736 | __start_cc_report 10:30:51 INFO - PID 14736 | _x_x_mozilla_cycle_collect,305 10:30:51 INFO - PID 14736 | __end_cc_report 10:30:51 INFO - PID 14736 | __startTimestamp1504719051144__endTimestamp 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | ------- Summary: start ------- 10:30:51 INFO - PID 14736 | Number of tests: 6 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | [#0] dojo.html Cycles:165 Average:6429.95 Median:6757.16 stddev:826.27 (12.2%) stddev-sans-first:797.28 10:30:51 INFO - PID 14736 | Values: 3548.6 3592.3 3597.6 3615.8 3657.2 6282.2 6346.4 6418.1 6453.2 6456.4 6458.3 6462.0 6501.5 6558.4 6568.0 5554.2 5637.9 5679.2 5692.9 5708.2 5460.7 5534.8 5622.8 5674.8 5699.3 5602.7 5652.5 5666.8 5670.5 5698.7 5615.9 5624.5 5648.4 5696.9 5700.6 5518.9 5554.7 5555.3 5583.1 5641.5 6350.0 6350.3 6372.0 6388.7 6403.5 6945.6 6953.8 7031.0 7038.4 7046.3 6819.0 6897.4 6923.6 7021.9 7063.8 6420.0 6457.2 6503.9 6577.4 6585.0 7076.3 7122.9 7231.8 7235.5 7252.4 6693.4 6757.2 6855.5 6960.3 6984.7 6982.3 7044.4 7051.3 7056.6 7059.2 6920.5 6931.3 6980.6 7022.1 7026.8 6836.9 6887.2 6929.2 6931.1 7019.5 5099.6 5147.6 5177.4 5182.6 5183.5 4565.9 4606.4 4612.1 4626.9 4652.2 6521.9 6641.7 6662.0 6745.3 6747.4 7013.0 7022.2 7027.1 7029.3 7031.0 6685.0 6693.1 6713.4 6715.4 6718.5 5881.7 5908.9 5926.4 5937.1 5940.3 7180.0 7184.9 7195.8 7278.5 7287.6 6939.6 7017.5 7031.6 7104.9 7104.9 7110.0 7173.7 7230.6 7237.3 7284.3 6919.5 6949.6 6955.9 6974.2 6989.7 7026.1 7040.5 7042.9 7122.9 7144.2 6729.5 6855.9 6856.5 6856.5 6857.9 6866.8 6881.4 6964.7 6968.3 6973.3 6864.4 6865.6 6875.8 6950.1 6952.3 6646.7 6795.1 6796.5 6825.1 6914.7 6631.6 6678.6 6686.9 6735.2 6760.8 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | [#1] ext.html Cycles:180 Average:42434.01 Median:20600.70 stddev:63494.38 (308.2%) stddev-sans-first:63595.88 10:30:51 INFO - PID 14736 | Values: 893.3 940.9 970.2 986.0 995.9 42136.8 43286.0 43423.1 43504.8 43522.3 41165.0 41233.6 41239.6 41317.8 41362.8 7050.4 7170.0 7173.0 7179.4 7198.6 7099.6 7099.8 7134.4 7143.7 7170.6 7667.1 7818.2 7819.2 7822.0 7822.6 7730.5 7760.8 7763.5 7782.6 7794.2 7662.5 7668.0 7698.8 7749.1 7763.8 40034.0 40213.8 40276.2 40315.8 40323.0 3710.6 3750.6 3753.1 3753.4 3755.4 31837.0 31986.8 32008.8 32180.7 32189.4 4845.1 5028.7 5040.5 5058.8 5076.9 201785.0 204355.0 206528.0 209163.0 224255.0 52122.7 52228.7 52237.0 52242.7 52327.7 55376.2 55438.7 55445.2 55503.0 55523.0 17113.6 17178.7 17196.7 17228.7 17554.0 14258.9 14282.4 14342.6 14431.1 14431.2 15288.5 15288.8 15382.7 15425.9 15508.8 5931.3 5935.6 5968.7 6004.3 6134.9 1125.0 1128.0 1129.1 1142.4 1147.4 26627.7 26739.6 26948.6 32846.5 33198.2 1244.4 1251.0 1254.0 1254.2 1256.9 14345.5 14581.5 14610.2 14624.0 14880.3 271037.0 277075.0 277197.0 277304.0 277641.0 57532.7 57533.7 57693.4 58086.0 58285.4 1569.1 1584.6 1606.9 1613.0 1619.1 25350.0 26080.7 26198.2 26279.9 26503.6 38731.8 38880.8 38884.8 38905.4 38927.8 241260.0 242952.0 243177.0 243883.0 244672.0 33426.8 33886.8 35037.3 37214.8 37450.8 47809.5 48351.0 48444.3 50178.7 50267.7 36219.5 36518.0 36652.0 36673.1 36968.0 35869.8 36094.6 36377.8 36700.8 36882.3 42055.8 43289.8 43623.3 43655.0 43730.8 35176.3 35816.0 35868.8 35950.0 36538.3 26478.5 27008.0 27533.7 27754.6 27941.3 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | [#2] jquery.html Cycles:180 Average:44045.30 Median:2375.12 stddev:112167.28 (4722.6%) stddev-sans-first:112434.50 10:30:51 INFO - PID 14736 | Values: 599.4 600.7 605.8 606.6 625.1 23911.0 24671.5 24729.0 24745.3 24758.4 22808.5 23537.6 28791.0 28831.1 28937.7 6352.8 6440.2 6485.6 6492.6 6493.4 6222.8 6335.8 6352.0 6576.8 6595.9 6555.9 6561.0 6561.5 6573.9 6575.9 6495.1 6534.8 6536.2 6544.3 6544.4 6094.5 6098.4 6102.9 6105.5 6122.4 29400.6 31949.7 32768.5 32809.7 32983.7 2271.3 2304.5 2305.9 2306.1 2309.7 20791.0 20852.5 20921.7 21055.7 21079.2 2358.1 2373.2 2377.0 2394.8 2405.9 152554.0 157746.2 160338.0 164052.0 166855.2 15917.8 16461.8 16588.8 16590.4 16944.3 25588.0 25639.4 25704.5 25762.7 25841.6 11459.8 11607.2 11756.5 11893.3 11949.5 11180.7 11183.8 11192.3 11234.8 11330.2 10027.0 10036.5 10142.3 10202.5 10338.8 2831.5 2835.4 2880.8 2930.5 2988.5 1073.8 1075.7 1090.6 1094.4 1110.7 22341.7 26765.0 27009.3 27811.6 28508.7 1149.6 1151.6 1158.7 1168.4 1172.8 12382.6 12799.2 12855.6 12884.4 12939.7 651096.0 659690.0 668675.0 679781.0 690596.0 147638.0 148815.0 150309.2 150338.0 152378.2 1348.8 1376.2 1393.6 1397.6 1397.9 20944.6 20971.7 21221.7 21275.9 23485.8 66811.7 71480.3 72413.6 72749.0 74867.0 91836.5 91998.5 93366.0 93747.0 94745.5 23566.5 23918.4 24379.0 24380.5 24491.6 25750.0 25979.9 26233.5 26246.0 26399.3 21016.8 21046.2 21143.2 21161.8 21265.1 17976.8 18473.0 18508.8 18823.3 19114.9 20381.6 21422.0 21761.6 21871.9 21953.7 23897.0 24394.8 24428.9 24485.9 24657.1 20303.0 20366.2 20539.8 21083.3 21323.8 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | [#3] mootools.html Cycles:180 Average:10253.29 Median:26327.17 stddev:7343.52 (27.9%) stddev-sans-first:7334.08 10:30:51 INFO - PID 14736 | Values: 1413.6 1462.2 1470.5 1506.5 1509.5 15542.5 16181.8 16301.8 16349.3 16362.9 16162.4 16566.3 16572.3 16575.4 16586.7 2991.6 2998.0 3043.8 3058.8 3060.3 2988.6 2992.7 2993.1 3015.3 3015.4 2870.3 2927.2 2944.1 2948.8 2951.0 2840.9 2847.7 2848.1 2851.9 2869.9 2799.5 2803.2 2808.5 2816.5 2818.1 15698.5 15994.4 16008.5 16085.1 16085.6 8505.5 8588.0 8917.9 9015.3 9023.5 5710.7 5885.2 5886.8 5897.9 5901.4 1892.7 1926.1 1954.0 1965.9 1968.9 27955.6 28076.4 28174.3 28196.4 28238.9 7376.6 7598.4 7611.5 7792.7 7821.0 18917.4 19013.4 19027.4 19033.0 19066.6 8503.8 8827.2 8839.9 8942.3 8957.9 6814.2 7064.3 7395.0 8072.2 8369.9 5875.4 6001.4 6021.6 6067.1 6138.6 1667.2 1703.9 1736.4 1741.3 1747.1 951.8 964.7 972.7 980.3 1019.5 8800.0 8938.2 9084.9 9164.9 9310.3 1086.7 1094.8 1097.1 1099.9 1128.8 5782.2 5816.2 5840.7 5919.0 6088.3 23516.0 23844.0 24424.9 24476.3 24668.0 24078.3 24399.3 24678.0 24680.0 24698.8 11751.8 11976.5 12117.5 12221.1 12255.6 9455.3 9478.7 9599.9 9611.5 9796.0 20654.2 20684.0 20772.0 20969.2 21357.0 20975.5 21355.0 21581.7 21810.9 21913.2 13398.0 13475.5 13754.8 13776.4 13852.9 15000.0 15254.5 15297.2 15298.9 15303.8 11754.1 11919.9 11974.3 12043.8 12095.3 11589.7 11607.7 11719.6 11730.9 12028.0 10489.3 10531.9 10679.9 10695.9 10707.8 7585.0 7789.5 7820.0 7833.5 7892.2 7983.1 8145.8 8156.3 8215.4 8284.8 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | [#4] prototype.html Cycles:180 Average:5658.08 Median:6279.19 stddev:1600.62 (25.5%) stddev-sans-first:1558.36 10:30:51 INFO - PID 14736 | Values: 541.5 542.9 549.3 557.9 564.7 6246.5 6250.3 6251.4 6278.0 6280.4 6105.0 6186.2 6201.4 6251.2 6268.1 4937.0 4969.7 4974.0 4986.2 5006.2 4699.7 4891.6 4934.6 4977.3 5006.8 4784.4 4831.4 4839.5 4846.3 4861.3 4792.1 4838.8 4868.9 4870.9 4910.0 4449.7 4460.4 4480.5 4482.1 4483.8 6127.0 6134.5 6143.5 6144.2 6156.8 5815.7 5837.2 5849.2 5865.2 5898.7 6653.2 6684.4 6715.7 6746.3 6772.2 5086.8 5101.6 5103.5 5103.8 5107.3 6688.3 6774.8 6897.4 6971.8 7012.9 5101.5 5173.5 5177.8 5200.1 5210.2 5241.4 5270.8 5278.6 5308.3 5309.2 5766.7 5824.7 5825.6 5845.9 5856.0 6716.9 6738.3 6738.8 6745.3 6757.4 1783.5 1817.8 1830.7 1855.4 1863.8 1250.8 1295.1 1296.6 1300.6 1305.7 6269.8 6370.4 6400.4 6414.6 6420.8 6872.6 6876.2 6877.6 6907.6 6929.7 6138.7 6288.3 6340.9 6369.6 6414.5 3547.6 3551.4 3591.5 3605.9 3625.8 6967.4 6977.8 6985.5 7006.7 7082.8 6958.5 7005.7 7013.5 7030.0 7053.2 6988.2 6988.3 6992.9 6993.4 7004.8 6794.6 6812.7 6879.3 6900.9 6910.4 6682.9 6730.8 6734.7 6792.8 6802.9 6986.7 7058.8 7061.5 7106.3 7108.4 5202.3 5206.2 5210.6 5247.5 5282.5 6553.7 6725.0 6734.2 6895.5 6902.8 6514.6 6531.4 6607.3 6619.3 6685.3 6481.4 6536.6 6592.7 6636.7 6686.0 6471.5 6539.8 6555.5 6567.5 6673.9 6661.6 6693.1 6724.2 6744.4 6751.4 6419.9 6500.3 6560.5 6585.0 6591.6 10:30:51 INFO - PID 14736 | 10:30:51 INFO - PID 14736 | [#5] yui.html Cycles:180 Average:26052.63 Median:20134.65 stddev:36726.05 (182.4%) stddev-sans-first:36780.75 10:30:51 INFO - PID 14736 | Values: 960.8 978.8 1004.3 1021.3 1023.0 19333.7 19719.4 19853.8 19938.2 21697.2 20396.7 21039.3 21059.5 21113.4 21176.0 974.1 979.1 990.2 990.8 994.6 952.4 1035.1 1036.3 1059.6 1065.2 1139.7 1141.5 1142.0 1142.6 1143.4 1139.9 1141.3 1142.1 1142.8 1144.0 837.5 838.0 838.4 838.8 839.6 18504.2 19562.5 20018.7 20023.9 20051.4 19800.7 19802.1 19968.4 19971.8 20091.5 16205.8 16278.9 16367.7 16519.0 16562.3 3784.1 3789.8 3808.4 3820.4 3834.5 135643.3 135926.0 139151.0 141251.6 141361.0 15258.5 15378.4 15604.1 15611.2 15771.1 26577.9 27157.7 27208.0 27515.0 27685.7 8368.1 8847.6 9063.6 9244.4 9382.2 4649.1 4762.3 4762.7 4768.0 4769.9 5644.5 5648.5 5719.5 5751.1 5766.0 1213.2 1221.3 1235.4 1240.8 1250.4 736.7 756.1 757.6 766.0 770.0 12747.6 13660.5 13694.9 13756.1 13769.8 658.5 664.4 671.0 672.9 674.7 6109.6 6124.4 6125.0 6251.7 6328.3 126745.0 130022.3 130748.0 133250.0 133884.0 113341.0 114381.0 116390.4 117636.0 118490.4 99011.0 101192.5 101706.0 102435.5 104842.5 12192.9 12211.9 12251.3 12329.9 12431.2 49755.0 50339.7 50938.0 51530.0 51936.7 60593.0 61898.4 62125.0 62151.4 65216.7 17111.9 17371.4 17541.4 20279.1 21056.1 22497.7 22603.9 23000.7 23325.3 23636.4 18479.0 21295.3 21403.6 21644.8 21671.7 18433.4 18462.7 20296.1 20537.6 20700.1 20177.8 20524.0 20602.6 20656.0 20753.9 14541.2 14803.0 15340.2 15863.8 15953.8 14870.8 15212.2 15226.7 15345.8 15401.6 10:30:51 INFO - PID 14736 | -------- Summary: end -------- 10:30:51 INFO - PID 14736 | 10:30:51 INFO - TEST-INFO | 14736: exit 0 10:30:51 INFO - TEST-OK | dromaeo_css | took 1109022ms 10:30:51 INFO - TEST-START | kraken 10:30:51 INFO - Initialising browser for kraken test... 10:30:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53898/getInfo.html -profile /tmp/tmpdzpwx9/profile 10:30:51 INFO - TEST-INFO | started process 15098 (/builds/slave/test/build/application/firefox/firefox http://localhost:53898/getInfo.html) 10:30:57 INFO - TEST-INFO | 15098: exit 0 10:30:57 INFO - Browser initialized. 10:30:57 INFO - Running cycle 1/1 for kraken test... 10:30:57 INFO - TEST-INFO | started process 15260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdzpwx9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:30:58 INFO - PID 15260 | 1504719058281 addons.xpi WARN Exception running bootstrap method startup on clicktoplay-rollout@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getStringPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js :: defineCohort :: line 49" data: no] Stack trace: defineCohort()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:49 < startup()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/clicktoplay-rollout@mozilla.org.xpi!/bootstrap.js:40 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4395 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2229 < callProvider()@resource://gre/modules/AddonManager.jsm:269 < _startProvider()@resource://gre/modules/AddonManager.jsm:739 < startup()@resource://gre/modules/AddonManager.jsm:906 < startup()@resource://gre/modules/AddonManager.jsm:3090 < observe()@jar:file:///builds/slave/test/build/application/firefox/omni.ja!/components/addonManager.js:65 10:31:09 INFO - PID 15260 | RSS: Main: 151863296 10:31:09 INFO - PID 15260 | 10:31:11 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53898/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:12 INFO - PID 15260 | RSS: Main: 158277632 10:31:12 INFO - PID 15260 | 10:31:15 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53898/tests/kraken/driver.html?testName=audio-dft) 10:31:15 INFO - PID 15260 | RSS: Main: 159674368 10:31:15 INFO - PID 15260 | 10:31:18 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53898/tests/kraken/driver.html?testName=audio-fft) 10:31:19 INFO - PID 15260 | RSS: Main: 160215040 10:31:19 INFO - PID 15260 | 10:31:21 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53898/tests/kraken/driver.html?testName=audio-oscillator) 10:31:21 INFO - PID 15260 | RSS: Main: 159289344 10:31:21 INFO - PID 15260 | 10:31:24 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53898/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:24 INFO - PID 15260 | RSS: Main: 159719424 10:31:24 INFO - PID 15260 | 10:31:27 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53898/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:28 INFO - PID 15260 | RSS: Main: 159236096 10:31:28 INFO - PID 15260 | 10:31:31 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53898/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:32 INFO - PID 15260 | RSS: Main: 161828864 10:31:32 INFO - PID 15260 | 10:31:35 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53898/tests/kraken/driver.html?testName=json-parse-financial) 10:31:35 INFO - PID 15260 | RSS: Main: 162226176 10:31:35 INFO - PID 15260 | 10:31:37 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53898/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:37 INFO - PID 15260 | RSS: Main: 162889728 10:31:37 INFO - PID 15260 | 10:31:39 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:40 INFO - PID 15260 | RSS: Main: 162508800 10:31:40 INFO - PID 15260 | 10:31:42 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:42 INFO - PID 15260 | RSS: Main: 162779136 10:31:42 INFO - PID 15260 | 10:31:45 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:46 INFO - PID 15260 | RSS: Main: 162263040 10:31:46 INFO - PID 15260 | 10:31:48 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:49 INFO - PID 15260 | RSS: Main: 162840576 10:31:49 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | Cycle 1(1): loaded http://localhost:53898/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53898/tests/kraken/driver.html?testName=ai-astar) 10:31:51 INFO - PID 15260 | RSS: Main: 164573184 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | __start_tp_report 10:31:51 INFO - PID 15260 | _x_x_mozilla_page_load 10:31:51 INFO - PID 15260 | _x_x_mozilla_page_load_details 10:31:51 INFO - PID 15260 | |i|pagename|runs| 10:31:51 INFO - PID 15260 | |0;ai-astar;98;113;100;106;106;106;112;111;106;108 10:31:51 INFO - PID 15260 | |1;audio-beat-detection;144;114;141;167;121;148;142;114;169;116 10:31:51 INFO - PID 15260 | |2;audio-dft;164;164;162;162;164;162;160;162;162;162 10:31:51 INFO - PID 15260 | |3;audio-fft;74;77;77;179;75;75;91;75;159;78 10:31:51 INFO - PID 15260 | |4;audio-oscillator;79;78;125;77;78;77;131;77;77;130 10:31:51 INFO - PID 15260 | |5;imaging-gaussian-blur;113;114;114;114;114;114;114;114;118;115 10:31:51 INFO - PID 15260 | |6;imaging-darkroom;149;150;146;148;147;147;147;148;148;147 10:31:51 INFO - PID 15260 | |7;imaging-desaturate;94;94;94;93;94;94;95;94;93;94 10:31:51 INFO - PID 15260 | |8;json-parse-financial;48;46;46;46;47;48;47;47;47;48 10:31:51 INFO - PID 15260 | |9;json-stringify-tinderbox;52;53;51;52;53;53;54;52;52;52 10:31:51 INFO - PID 15260 | |10;stanford-crypto-aes;73;73;73;73;80;72;72;72;72;80 10:31:51 INFO - PID 15260 | |11;stanford-crypto-ccm;125;133;118;120;122;121;118;114;121;152 10:31:51 INFO - PID 15260 | |12;stanford-crypto-pbkdf2;163;165;160;171;155;164;158;163;158;156 10:31:51 INFO - PID 15260 | |13;stanford-crypto-sha256-iterative;60;59;60;68;60;59;59;58;60;60 10:31:51 INFO - PID 15260 | __end_tp_report 10:31:51 INFO - PID 15260 | __start_cc_report 10:31:51 INFO - PID 15260 | _x_x_mozilla_cycle_collect,811 10:31:51 INFO - PID 15260 | __end_cc_report 10:31:51 INFO - PID 15260 | __startTimestamp1504719111354__endTimestamp 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | ------- Summary: start ------- 10:31:51 INFO - PID 15260 | Number of tests: 14 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.50 stddev:4.84 (4.4%) stddev-sans-first:4.00 10:31:51 INFO - PID 15260 | Values: 98.0 113.0 100.0 106.0 106.0 106.0 112.0 111.0 106.0 108.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:143.00 stddev:20.78 (14.5%) stddev-sans-first:21.91 10:31:51 INFO - PID 15260 | Values: 144.0 114.0 141.0 167.0 121.0 148.0 142.0 114.0 169.0 116.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.20 10:31:51 INFO - PID 15260 | Values: 164.0 164.0 162.0 162.0 164.0 162.0 160.0 162.0 162.0 162.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:39.07 (51.4%) stddev-sans-first:40.62 10:31:51 INFO - PID 15260 | Values: 74.0 77.0 77.0 179.0 75.0 75.0 91.0 75.0 159.0 78.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:77.00 stddev:24.74 (32.1%) stddev-sans-first:25.72 10:31:51 INFO - PID 15260 | Values: 79.0 78.0 125.0 77.0 78.0 77.0 131.0 77.0 77.0 130.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.33 10:31:51 INFO - PID 15260 | Values: 113.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 118.0 115.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.13 10:31:51 INFO - PID 15260 | Values: 149.0 150.0 146.0 148.0 147.0 147.0 147.0 148.0 148.0 147.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:31:51 INFO - PID 15260 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 93.0 94.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#8] json-parse-financial Cycles:10 Average:47.00 Median:47.00 stddev:0.82 (1.7%) stddev-sans-first:0.78 10:31:51 INFO - PID 15260 | Values: 48.0 46.0 46.0 46.0 47.0 48.0 47.0 47.0 47.0 48.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#9] json-stringify-tinderbox Cycles:10 Average:52.40 Median:52.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 10:31:51 INFO - PID 15260 | Values: 52.0 53.0 51.0 52.0 53.0 53.0 54.0 52.0 52.0 52.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#10] stanford-crypto-aes Cycles:10 Average:74.00 Median:73.00 stddev:3.20 (4.4%) stddev-sans-first:3.37 10:31:51 INFO - PID 15260 | Values: 73.0 73.0 73.0 73.0 80.0 72.0 72.0 72.0 72.0 80.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:121.50 stddev:10.93 (9.0%) stddev-sans-first:11.59 10:31:51 INFO - PID 15260 | Values: 125.0 133.0 118.0 120.0 122.0 121.0 118.0 114.0 121.0 152.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:163.00 stddev:4.85 (3.0%) stddev-sans-first:5.11 10:31:51 INFO - PID 15260 | Values: 163.0 165.0 160.0 171.0 155.0 164.0 158.0 163.0 158.0 156.0 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:60.00 stddev:2.79 (4.7%) stddev-sans-first:2.96 10:31:51 INFO - PID 15260 | Values: 60.0 59.0 60.0 68.0 60.0 59.0 59.0 58.0 60.0 60.0 10:31:51 INFO - PID 15260 | -------- Summary: end -------- 10:31:51 INFO - PID 15260 | 10:31:51 INFO - PID 15260 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:31:52 INFO - TEST-INFO | 15260: exit 0 10:31:52 INFO - TEST-OK | kraken | took 60214ms 10:31:52 INFO - SUITE-END | took 1169s 10:31:52 INFO - Completed test suite (00:19:29) 10:31:52 INFO - javascript benchmark 10:31:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9197.472144133928, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3548.5741710994685, 3592.335417947679, 3597.622249663787, 3615.83728732207, 3657.1588534637035, 6282.2147231596055, 6346.397092276238, 6418.101465794786, 6453.225612926455, 6456.354364563541, 6458.289588145312, 6461.967690161543, 6501.544891857572, 6558.376954189344, 6568.047633093199, 5554.166874968747, 5637.8590535236635, 5679.2049113123985, 5692.8861422771515, 5708.22938903249, 5460.699661518614, 5534.806281780138, 5622.775088996455, 5674.829755107354, 5699.316082070158, 5602.691851948141, 5652.491275785179, 5666.829995100154, 5670.5463562914865, 5698.715064246791, 5615.859603509945, 5624.465675760796, 5648.43515648436, 5696.8606278744, 5700.572457065737, 5518.944810551883, 5554.694491802949, 5555.30558680165, 5583.078791999315, 5641.548676105902, 6349.968250158766, 6350.301466838644, 6372.044193370985, 6388.680565971683, 6403.519736019817, 6945.583265004066, 6953.79138625842, 7030.964845175741, 7038.3665470107935, 7046.330598593126, 6818.965905170442, 6897.379235868796, 6923.58458492487, 7021.89467157993, 7063.82340441493, 6419.967900160516, 6457.160569125984, 6503.902441463382, 6577.375149360803, 6584.967075164642, 7076.2923707628825, 7122.92877071233, 7231.783046508614, 7235.493515453973, 7252.419806415474, 6693.364130407604, 6757.155355580552, 6855.485838562127, 6960.338767817049, 6984.685689144001, 6982.301769823079, 7044.401225895856, 7051.259617740064, 7056.647167641598, 7059.2234854166, 6920.515563910579, 6931.306869313028, 6980.581165130108, 7022.12223472066, 7026.789196324118, 6836.931630683729, 6887.242403335629, 6929.203141638675, 6931.09895713554, 7019.473539484559, 5099.643024988215, 5147.613928955343, 5177.352830896138, 5182.5594824439595, 5183.533481986639, 4565.931511027271, 4606.447226332862, 4612.123696497655, 4626.86119416418, 4652.232381657056, 6521.934780652133, 6641.734330626721, 6661.966690166518, 6745.291744366869, 6747.426468750113, 7012.983117447941, 7022.157341119098, 7027.086478757831, 7029.332213439715, 7030.964845175844, 6684.966575167093, 6693.062971184038, 6713.429358504582, 6715.395614394728, 6718.462522998148, 5881.705914704333, 5908.940910590925, 5926.377730338339, 5937.079752638348, 5940.34656187819, 7180.0, 7184.892226616605, 7195.784126476214, 7278.526895751759, 7287.635618219174, 6939.583624982315, 7017.543859649107, 7031.648417578998, 7104.857902842017, 7104.893426598605, 7110.0401445804155, 7173.677184526813, 7230.602316872412, 7237.276272372931, 7284.344409003215, 6919.481038922, 6949.583025018515, 6955.8608827822145, 6974.197967233833, 6989.650517474208, 7026.1217347831525, 7040.5071644984355, 7042.894356584758, 7122.857542849218, 7144.249853765487, 6729.495287853529, 6855.862882742417, 6856.4514838813775, 6856.5200435969, 6857.931420685729, 6866.759663411756, 6881.41507971828, 6964.6517674115075, 6968.303169682991, 6973.3375329343635, 6864.4165245954655, 6865.588064716133, 6875.759348422781, 6950.096487456598, 6952.30476952321, 6646.667666616553, 6795.116634837439, 6796.524243303119, 6825.146856642919, 6914.688839002358, 6631.635260060743, 6678.565893216925, 6686.866262674816, 6735.158105236846, 6760.797176084725], "value": 6366.983350827264, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.3255392178907, 940.9012053734358, 970.1608108985728, 985.9852102218464, 995.9402435853849, 42136.789316053415, 43286.0, 43423.131537369234, 43504.782476087654, 43522.347164792554, 41165.0, 41233.58766412335, 41239.587604123946, 41317.79341103298, 41362.793186034025, 7050.365467107959, 7170.0, 7173.0, 7179.3538581527655, 7198.6400679966055, 7099.609521476316, 7099.787006389816, 7134.357907788298, 7143.678534465961, 7170.60561669108, 7667.079950405959, 7818.179091195428, 7819.2180781921925, 7822.022247219098, 7822.569758663271, 7730.536167829948, 7760.844783104363, 7763.4953728007495, 7782.64978075988, 7794.181610930856, 7662.501937374052, 7668.0, 7698.769036928901, 7749.108852481924, 7763.767086987399, 40034.0, 40213.798931005156, 40276.194476110315, 40315.798421007705, 40323.0, 3710.628937106295, 3750.587435382106, 3753.0992561785247, 3753.380692185786, 3755.361588529929, 31837.0, 31986.840065799755, 32008.83995580007, 32180.678193218002, 32189.356212875613, 4845.103655823648, 5028.698278103326, 5040.5463508284065, 5058.772355244023, 5076.873078173038, 201785.0, 204355.0, 206528.0, 209162.9541852296, 224255.0, 52122.73938630358, 52228.738856306234, 52237.0, 52242.73878630659, 52327.73836130795, 55376.16935745967, 55438.72280638652, 55445.1683224752, 55503.0, 55523.0, 17113.572160695832, 17178.656426871392, 17196.742048869277, 17228.655426891393, 17554.0, 14258.928705356615, 14282.428702851978, 14342.569722908329, 14431.061980971203, 14431.2062836545, 15288.464903728316, 15288.847111528965, 15382.692346153015, 15425.922870385577, 15508.767368489482, 5931.317898441648, 5935.643861368331, 5968.7015649217365, 6004.328074007025, 6134.9079763803575, 1125.0493333133488, 1127.9718007049726, 1129.1474936423112, 1142.360278244186, 1147.391882302381, 26627.733722662913, 26739.598906016425, 26948.59577106345, 32846.507302390484, 33198.17004574905, 1244.4151248912997, 1251.0367017396736, 1253.9749205015848, 1254.1847798930585, 1256.8931640810633, 14345.497907573184, 14581.489647862274, 14610.196439195734, 14624.0, 14880.255987200597, 271037.0, 277075.0, 277197.0, 277304.0, 277641.0, 57532.71233643805, 57533.71233143807, 57693.423065769646, 58086.0, 58285.41714582885, 1569.1291333309894, 1584.619691274109, 1606.8794840387018, 1613.048301502096, 1619.1418548169254, 25350.0, 26080.73919260783, 26198.21405357766, 26279.868600656875, 26503.60244596294, 38731.80634096811, 38880.80559597184, 38884.805575971935, 38905.41641875431, 38927.80536097301, 241260.0, 242952.0, 243177.0, 243883.0, 244672.0, 33426.83286583552, 33886.830565848, 35037.299254014266, 37214.8139259302, 37450.8127459361, 47809.52190478051, 48351.0, 48444.273335899285, 50178.74910625423, 50267.74866125646, 36219.45670814887, 36518.0, 36652.0, 36673.083172919825, 36968.0, 35869.82065089658, 36094.63905360913, 36377.81811090928, 36700.81649591735, 36882.26235475329, 42055.7897210512, 43289.7835510833, 43623.345649815914, 43655.0, 43730.78134609306, 35176.296474070885, 35816.0, 35868.820655897594, 35950.0, 36538.26923461569, 26478.470430591664, 27008.0, 27533.724662753917, 27754.5836812452, 27941.301467463476], "value": 18606.41609692369, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.35868620576, 600.6996501749128, 605.806142034549, 606.5663050918592, 625.0686477149048, 23911.0, 24671.50656986859, 24729.0, 24745.257642270717, 24758.381040473974, 22808.543829123406, 23537.646935295983, 28791.0, 28831.135065948, 28937.710622893766, 6352.809415717536, 6440.194975628046, 6485.6108633482145, 6492.642904640243, 6493.350664933492, 6222.782202622909, 6335.809925702236, 6352.0, 6576.80269591913, 6595.93404065958, 6555.868882622344, 6560.9671951640175, 6561.475081993453, 6573.868522629545, 6575.868482630344, 6495.090687303781, 6534.771283005072, 6536.182977127883, 6544.345565443466, 6544.443722283588, 6094.512439004913, 6098.420650038239, 6102.938970610326, 6105.542084343692, 6122.4183702548635, 29400.558991615144, 31949.680503195137, 32768.50847237293, 32809.6719032809, 32983.67016329854, 2271.341311019802, 2304.493011537459, 2305.8501197422115, 2306.1121468234683, 2309.6535519672016, 20791.0, 20852.47868803292, 20921.686174707393, 21055.684164737388, 21079.156833726633, 2358.127492827665, 2373.2405630198346, 2377.0, 2394.820388470872, 2405.927822165338, 152554.0, 157746.21126894292, 160338.0, 164052.0, 166855.16572417182, 15917.840821591868, 16461.753073703905, 16588.83411165873, 16590.419335323204, 16944.322227111024, 25588.0, 25639.359016024748, 25704.485910281688, 25762.74237257641, 25841.612375814377, 11459.77080458386, 11607.245529040585, 11756.529738810352, 11893.286402815858, 11949.522019119311, 11180.720481987853, 11183.776324473465, 11192.328460292245, 11234.775304493864, 11330.150238732129, 10027.0, 10036.548355324028, 10142.290039697298, 10202.540885660163, 10338.759348878182, 2831.546952487592, 2835.4187391584674, 2880.7551358134792, 2930.5457654063653, 2988.491956367423, 1073.7798751255973, 1075.6988043347876, 1090.6128324444708, 1094.4254266509986, 1110.7167672243527, 22341.664875026887, 26765.0, 27009.324766880985, 27811.58282625762, 28508.71491285102, 1149.6436104807538, 1151.573917650458, 1158.6697791129657, 1168.4216312925157, 1172.783035138502, 12382.62852114438, 12799.232046077264, 12855.550055748005, 12884.420201090787, 12939.741205175844, 651096.0, 659690.0, 668675.0, 679781.0, 690596.0, 147638.0, 148815.0, 150309.2484537592, 150338.0, 152378.23810881097, 1348.7841945288706, 1376.215557132445, 1393.5610282760897, 1397.5597686728647, 1397.881180099703, 20944.581108378054, 20971.685424718336, 21221.681674774583, 21275.8936205318, 23485.76514234836, 66811.66594166998, 71480.28519714736, 72413.63793181212, 72749.0, 74867.0, 91836.54081729549, 91998.54000729954, 93366.0, 93747.0, 94745.5262723682, 23566.528669426858, 23918.402039949142, 24379.0, 24380.51238975246, 24491.63262551099, 25750.0, 25979.870100649376, 26233.475330493664, 26246.0, 26399.34001649974, 21016.789832101484, 21046.15815367368, 21143.15427382949, 21161.788382116596, 21265.149394024684, 17976.82023179804, 18472.983985880368, 18508.81491185125, 18823.34118305853, 19114.904425477784, 20381.592368152258, 21422.0, 21761.564768704855, 21871.890640546695, 21953.67069493991, 23897.0, 24394.75605243996, 24428.900699468923, 24485.877570612745, 24657.137000204908, 20303.0, 20366.18535258573, 20539.794602054386, 21083.262085826922, 21323.7867621328], "value": 13751.67535686529, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1413.590058882924, 1462.2323280277853, 1470.5294305822142, 1506.4652048522778, 1509.4943194029993, 15542.533723988285, 16181.83818161818, 16301.836981630195, 16349.264283107244, 16362.918185409057, 16162.353505859752, 16566.337346506127, 16572.337106515755, 16575.419860304894, 16586.66826663466, 2991.5662228976785, 2997.955030674542, 3043.8478076096217, 3058.831764252965, 3060.26553627129, 2988.6114805075417, 2992.670806211315, 2993.0721476342296, 3015.26126099106, 3015.42706885691, 2870.3111253299267, 2927.2389178813555, 2944.1461976027035, 2948.8378139202337, 2951.0261613667544, 2840.9289767755868, 2847.6867544570187, 2848.088611644275, 2851.942961140776, 2869.856507174633, 2799.538076217422, 2803.1730639461407, 2808.4663913856302, 2816.5493521036537, 2818.140467157516, 15698.450554230662, 15994.440194593133, 16008.519744407686, 16085.115318657468, 16085.597860053475, 8505.489670619783, 8587.957060214721, 8917.86623200646, 9015.323850711224, 9023.458592484472, 5710.7430165642645, 5885.176075349455, 5886.823395298148, 5897.911531327033, 5901.4098590141075, 1892.6782446983907, 1926.1236137557378, 1954.042519165613, 1965.9017049147628, 1968.8917109558968, 27955.580666289818, 28076.438471230664, 28174.295642608893, 28196.43607127846, 28238.858805706044, 7376.557406555624, 7598.404335089583, 7611.505252158592, 7792.727254546064, 7821.0, 18917.43247702571, 19013.42959711211, 19027.429177124708, 19033.0, 19066.61866762657, 8503.787405314917, 8827.249683776823, 8839.911600883908, 8942.329325300629, 8957.865632015524, 6814.2163651180745, 7064.258252883476, 7395.0, 8072.233137851895, 8369.916300837036, 5875.441833025856, 6001.399860013964, 6021.638701677914, 6067.1202675611785, 6138.570300079041, 1667.2080761638367, 1703.8892471989282, 1736.3749050341867, 1741.3034786085414, 1747.1480230955228, 951.7953639967441, 964.6623681711485, 972.6644307713827, 980.294188184506, 1019.5004447820514, 8800.031996480382, 8938.240249578728, 9084.8637270441, 9164.8625270621, 9310.348275620641, 1086.6902932664152, 1094.8084085285202, 1097.0839349143555, 1099.9395033273247, 1128.7911736328806, 5782.248307720053, 5816.1566572846705, 5840.707964601753, 5918.970405147947, 6088.330283668793, 23516.0, 23844.0, 24424.877875610862, 24476.265712028668, 24668.0, 24078.277651670476, 24399.26802195937, 24678.0, 24680.0, 24698.753012470006, 11751.823722644167, 11976.52093916251, 12117.454714537691, 12221.144519883701, 12255.632331030083, 9455.290853185901, 9478.715638530855, 9599.904000960181, 9611.471369074488, 9795.951020245138, 20654.17383304651, 20684.0, 20771.96140192954, 20969.161233550487, 21357.03893324773, 20975.475613109185, 21355.0, 21581.676274855574, 21810.890945545172, 21913.233036843634, 13398.0, 13475.46098156102, 13754.793678095037, 13776.380062897395, 13852.930735346661, 15000.024998375071, 15254.542363729106, 15297.23513824282, 15298.923505382401, 15303.770443443134, 11754.118441117122, 11919.880801191877, 11974.341411222467, 12043.75912481728, 12095.274283543016, 11589.710257243636, 11607.709807254887, 11719.648410547697, 11730.941345293219, 12028.0, 10489.318194317346, 10531.94734026325, 10679.8932010682, 10695.94652026735, 10707.839382409426, 7585.0, 7789.454738168274, 7820.0, 7833.451658383859, 7892.210778922062, 7983.121856595886, 8145.755627331189, 8156.306713929383, 8215.424920255764, 8284.792880177803], "value": 7318.515364476005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.4774742373609, 542.9185622156676, 549.2694716027684, 557.8995780759465, 564.7289301135455, 6246.500279977602, 6250.343713910031, 6251.374862513746, 6278.0, 6280.371962803717, 6105.0, 6186.226721659793, 6201.441870231678, 6251.187345645071, 6268.122462855193, 4936.975315123419, 4969.701817890929, 4973.980334031515, 4986.227134794112, 5006.1990081586955, 4699.7415142167165, 4891.608671306287, 4934.605231581465, 4977.278294647274, 5006.849794506171, 4784.449788274341, 4831.396075490564, 4839.467658557556, 4846.273059041137, 4861.319415281863, 4792.137415265251, 4838.830640927551, 4868.853934381957, 4870.902581948341, 4910.0, 4449.710768800018, 4460.353248778942, 4480.549976518096, 4482.125985432842, 4483.775811209459, 6126.969365153191, 6134.539909506805, 6143.477804386633, 6144.218176728743, 6156.7994241123, 5815.691469419389, 5837.153612726131, 5849.151872978395, 5865.237519122529, 5898.705064746746, 6653.201615806086, 6684.398404143651, 6715.6977935993, 6746.313421644589, 6772.187337519529, 5086.847394578169, 5101.591872650179, 5103.464136265713, 5103.795848166106, 5107.3105130807235, 6688.264290927994, 6774.762883299061, 6897.41371983382, 6971.755988540377, 7012.894806577905, 5101.464346243665, 5173.508516690984, 5177.792888284502, 5200.141976573823, 5210.166373380241, 5241.371035475691, 5270.8155214567305, 5278.577713782888, 5308.309919710413, 5309.150535914235, 5766.682832444172, 5824.737886795105, 5825.592208545361, 5845.941540584625, 5856.038227193938, 6716.932830671729, 6738.32616738332, 6738.764143254963, 6745.291744366869, 6757.358050985148, 1783.482789990914, 1817.809130041353, 1830.6727622473866, 1855.35990083421, 1863.7577114974968, 1250.8248845161684, 1295.086963690596, 1296.6126244918037, 1300.596814987357, 1305.7062161013696, 6269.780557680459, 6370.394812492806, 6400.359964003563, 6414.64719440426, 6420.839479013062, 6872.553284036521, 6876.17485901685, 6877.6217308048535, 6907.585544867324, 6929.722811087601, 6138.7237574309265, 6288.308286088527, 6340.904886426615, 6369.617822930639, 6414.454771344394, 3547.627499112556, 3551.449525323579, 3591.4971903932947, 3605.8737944171826, 3625.836837342326, 6967.3626697725995, 6977.79066628002, 6985.545939513915, 7006.684699188447, 7082.752103676346, 6958.547694399847, 7005.719771209095, 7013.473989450812, 7029.9648501757165, 7053.1685795229405, 6988.161420629353, 6988.336108069725, 6992.860142797115, 6993.405560527311, 7004.824879378057, 6794.592324460548, 6812.659367031728, 6879.346462086094, 6900.896486552605, 6910.447164226749, 6682.899756503753, 6730.764423245163, 6734.73061077571, 6792.796216113326, 6802.863942721019, 6986.71624336561, 7058.752943647153, 7061.470389720895, 7106.324899134574, 7108.431325494052, 5202.271681964604, 5206.2450944612065, 5210.635255532076, 5247.501487358695, 5282.47175282484, 6553.672316384066, 6725.0161202444415, 6734.191896972395, 6895.5173137879865, 6902.827429314308, 6514.57655252407, 6531.43245621057, 6607.273199948098, 6619.338066193534, 6685.2646208916, 6481.351864813481, 6536.607803531803, 6592.67036648156, 6636.7013484392355, 6686.0, 6471.514636402195, 6539.833531510244, 6555.475561955128, 6567.474602031731, 6673.9332606673315, 6661.600303981777, 6693.1298931138645, 6724.226713927961, 6744.359285867835, 6751.426128778912, 6419.876521608793, 6500.3174666659315, 6560.475161986934, 6584.967075164594, 6591.604503729792], "value": 5195.651004911489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [960.7598100474877, 978.7748817771911, 1004.2919741582185, 1021.3004092196841, 1022.9948850255747, 19333.70999435008, 19719.408417747472, 19853.801461985393, 19938.202471901142, 21697.240596579122, 20396.694049589267, 21039.2636257731, 21059.47351316218, 21113.366599002016, 21176.0, 974.0746291023538, 979.1041197304457, 990.2474119669031, 990.7572644702022, 994.6121012805012, 952.3571589177312, 1035.140833108518, 1036.2590747615454, 1059.5973530058568, 1065.1957771882219, 1139.692283083571, 1141.4863311509812, 1141.9771604567904, 1142.5715356741223, 1143.3997151495448, 1139.8917102875214, 1141.303804679145, 1142.1490989213048, 1142.7543078238177, 1143.9714007149805, 837.4514692876176, 837.9664813407456, 838.3963546246692, 838.8196537744415, 839.6473481137875, 18504.16731247097, 19562.51093722654, 20018.69971950422, 20023.898685572287, 20051.398458046282, 19800.70298945517, 19802.108905099307, 19968.400947971582, 19971.80028199714, 20091.497712557157, 16205.837941620552, 16278.918605406898, 16367.672646547122, 16519.0, 16562.337506499727, 3784.0729021389934, 3789.829457674384, 3808.352580061396, 3820.3505404081093, 3834.5015148030857, 135643.32178339144, 135926.0, 139151.0, 141251.58748412487, 141361.0, 15258.542243732705, 15378.384864605514, 15604.063756174666, 15611.219439028004, 15771.132587707556, 26577.867110664323, 27157.728422715914, 27208.0, 27515.0, 27685.72314276872, 8368.121347258571, 8847.646094156291, 9063.59213835379, 9244.3528952974, 9382.155605995493, 4649.139909116824, 4762.333273341735, 4762.690425122356, 4767.976160119247, 4769.928451073237, 5644.491995720405, 5648.51987581052, 5719.456651618173, 5751.051076572318, 5765.971170144123, 1213.1629175868622, 1221.2916508425092, 1235.3946566182506, 1240.8324876141605, 1250.3998080921208, 736.7421402509186, 756.1153450462972, 757.5909009135005, 765.9961700191575, 770.0489894979696, 12747.61757147287, 13660.521881734092, 13694.863051369559, 13756.105853119516, 13769.793453098211, 658.4962503684685, 664.378805816563, 671.0308525074229, 672.8721542906832, 674.7469698862926, 6109.633421994695, 6124.418180272956, 6125.0, 6251.6561589113035, 6328.272248691367, 126745.0, 130022.34988825185, 130748.0, 133250.0, 133884.0, 113341.0, 114381.0, 116390.4180479109, 117636.0, 118490.4075479617, 99011.0, 101192.49403752934, 101706.0, 102435.4878225604, 104842.47578762057, 12192.878071219175, 12211.87788122143, 12251.326177060348, 12329.93835030855, 12431.191972521758, 49755.0, 50339.74830125826, 50938.0, 51530.0, 51936.74031629818, 60593.0, 61898.38101618926, 62125.0, 62151.37848621637, 65216.67391663011, 17111.914440427718, 17371.392001279895, 17541.386051488138, 20279.087441065483, 21056.052477638237, 22497.66253506166, 22603.886980564992, 23000.654990174826, 23325.300240992798, 23636.409089772893, 18479.0, 21295.254666086614, 21403.57192856103, 21644.783552164277, 21671.674924875824, 18433.354832580797, 18462.723059154392, 20296.086676099905, 20537.589248215252, 20700.068496917975, 20177.79822201759, 20524.0, 20602.587948240653, 20656.0, 20753.896230518752, 14541.200233986809, 14803.0, 15340.232988350761, 15863.762043569124, 15953.840461595235, 14870.776938345716, 15212.1633310169, 15226.695466090838, 15345.846541534442, 15401.614959626098], "value": 9771.667590598081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 113.0, 100.0, 106.0, 106.0, 106.0, 112.0, 111.0, 106.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 114.0, 141.0, 167.0, 121.0, 148.0, 142.0, 114.0, 169.0, 116.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 162.0, 164.0, 162.0, 160.0, 162.0, 162.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 77.0, 179.0, 75.0, 75.0, 91.0, 75.0, 159.0, 78.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 125.0, 77.0, 78.0, 77.0, 131.0, 77.0, 77.0, 130.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 146.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 46.0, 46.0, 47.0, 48.0, 47.0, 47.0, 47.0, 48.0], "value": 47.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 51.0, 52.0, 53.0, 53.0, 54.0, 52.0, 52.0, 52.0], "value": 52.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 73.0, 80.0, 72.0, 72.0, 72.0, 72.0, 80.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 133.0, 118.0, 120.0, 122.0, 121.0, 118.0, 114.0, 121.0, 152.0], "value": 124.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 160.0, 171.0, 155.0, 164.0, 158.0, 163.0, 158.0, 156.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 68.0, 60.0, 59.0, 59.0, 58.0, 60.0, 60.0], "value": 60.3, "unit": "score"}]}]} 10:31:52 INFO - Return code: 0 10:31:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:31:52 INFO - # TBPL SUCCESS # 10:31:52 INFO - Running post-action listener: _package_coverage_data 10:31:52 INFO - Running post-action listener: _resource_record_post_action 10:31:52 INFO - [mozharness: 2017-09-06 17:31:52.669551Z] Finished run-tests step (success) 10:31:52 INFO - Running post-run listener: _resource_record_post_run 10:31:52 INFO - Total resource usage - Wall time: 1185s; CPU: 13.0%; Read bytes: 536576; Write bytes: 387829760; Read time: 84; Write time: 429664 10:31:52 INFO - TinderboxPrint: CPU usage
13.0% 10:31:52 INFO - TinderboxPrint: I/O read bytes / time
536,576 / 84 10:31:52 INFO - TinderboxPrint: I/O write bytes / time
387,829,760 / 429,664 10:31:52 INFO - TinderboxPrint: CPU idle
8,215.8 (86.9%) 10:31:52 INFO - TinderboxPrint: CPU user
1,183.9 (12.5%) 10:31:52 INFO - TinderboxPrint: Swap in / out
0 / 0 10:31:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 109756416; Read time: 0; Write time: 116700 10:31:52 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:31:52 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 532480; Write bytes: 278073344; Read time: 76; Write time: 312964 10:31:53 INFO - Running post-run listener: _upload_blobber_files 10:31:53 INFO - Blob upload gear active. 10:31:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:31:53 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 10:31:53 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:31:53 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:31:53 INFO - (blobuploader) - INFO - Open directory for files ... 10:31:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:31:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:31:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:31:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:31:54 INFO - (blobuploader) - INFO - Done attempting. 10:31:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:31:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:31:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:32:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:01 INFO - (blobuploader) - INFO - Done attempting. 10:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:02 INFO - (blobuploader) - INFO - Done attempting. 10:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:32:03 INFO - (blobuploader) - INFO - Done attempting. 10:32:03 INFO - (blobuploader) - INFO - Iteration through files over. 10:32:03 INFO - Return code: 0 10:32:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:32:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:32:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/83b9a4c03c0bdc1363848b672872c159604c36de68ef0476b751058e55ba4871cf3cf776bfd3e809f0e6d4931d4e7e9f429c517473d931d15ebcbf20ef23b5d9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/65e89f19519bec71e72039774e88c01cf6c9c07e49453bf1e2396d6135267e8371e37bb56c1c01e1d850e3630ad6d3b442025753bc17534a4373ee414b6ea1d6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db79b0cb80c327362ed44e6879ae1c6a2f2d03cc8c852e2d67ae1ddcac90b3a21740cf8fb4ff9f59061b81957a0078a1921f96fbb9af9adfa7c82c4f584ce92c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ed1d6e4e6c58b21b7480d602d212ffe9039f61dfd0f34bb2329e13809744b5638807d9733a947a5af3b0730721c6b05fb7f95e23c0fc6764ced255aaa2af7131"} 10:32:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:32:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:32:03 INFO - Contents: 10:32:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/83b9a4c03c0bdc1363848b672872c159604c36de68ef0476b751058e55ba4871cf3cf776bfd3e809f0e6d4931d4e7e9f429c517473d931d15ebcbf20ef23b5d9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/65e89f19519bec71e72039774e88c01cf6c9c07e49453bf1e2396d6135267e8371e37bb56c1c01e1d850e3630ad6d3b442025753bc17534a4373ee414b6ea1d6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db79b0cb80c327362ed44e6879ae1c6a2f2d03cc8c852e2d67ae1ddcac90b3a21740cf8fb4ff9f59061b81957a0078a1921f96fbb9af9adfa7c82c4f584ce92c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ed1d6e4e6c58b21b7480d602d212ffe9039f61dfd0f34bb2329e13809744b5638807d9733a947a5af3b0730721c6b05fb7f95e23c0fc6764ced255aaa2af7131"} 10:32:03 INFO - Running post-run listener: copy_logs_to_upload_dir 10:32:03 INFO - Copying logs to upload dir... 10:32:03 INFO - mkdir: /builds/slave/test/build/upload/logs 10:32:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.026725 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-09-06 10:32:04.228550) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 10:32:04.233634) ========= 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=df17445c3590ff7897617a0e00000225-1504717863.189577-252015041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/83b9a4c03c0bdc1363848b672872c159604c36de68ef0476b751058e55ba4871cf3cf776bfd3e809f0e6d4931d4e7e9f429c517473d931d15ebcbf20ef23b5d9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/65e89f19519bec71e72039774e88c01cf6c9c07e49453bf1e2396d6135267e8371e37bb56c1c01e1d850e3630ad6d3b442025753bc17534a4373ee414b6ea1d6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db79b0cb80c327362ed44e6879ae1c6a2f2d03cc8c852e2d67ae1ddcac90b3a21740cf8fb4ff9f59061b81957a0078a1921f96fbb9af9adfa7c82c4f584ce92c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ed1d6e4e6c58b21b7480d602d212ffe9039f61dfd0f34bb2329e13809744b5638807d9733a947a5af3b0730721c6b05fb7f95e23c0fc6764ced255aaa2af7131"} build_url:https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/aipV6OXITM-Fe8SZgXbz9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/83b9a4c03c0bdc1363848b672872c159604c36de68ef0476b751058e55ba4871cf3cf776bfd3e809f0e6d4931d4e7e9f429c517473d931d15ebcbf20ef23b5d9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/65e89f19519bec71e72039774e88c01cf6c9c07e49453bf1e2396d6135267e8371e37bb56c1c01e1d850e3630ad6d3b442025753bc17534a4373ee414b6ea1d6", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/db79b0cb80c327362ed44e6879ae1c6a2f2d03cc8c852e2d67ae1ddcac90b3a21740cf8fb4ff9f59061b81957a0078a1921f96fbb9af9adfa7c82c4f584ce92c", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/ed1d6e4e6c58b21b7480d602d212ffe9039f61dfd0f34bb2329e13809744b5638807d9733a947a5af3b0730721c6b05fb7f95e23c0fc6764ced255aaa2af7131"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 10:32:04.505024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:32:04.505741) ========= 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=df17445c3590ff7897617a0e00000225-1504717863.189577-252015041 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004615 ========= master_lag: 0.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 10:32:04.903430) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 10:32:04.903854) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 10:32:04.912494) ========= ========= Total master_lag: 0.97 =========