builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1503411053.54 results: success (0) revision: 8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.543289) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.543757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.544034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.560406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.560807) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-22 07:10:53-- 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% 37.5M=0s 2017-08-22 07:10:53 (37.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.703457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.706803) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016989 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:53.756490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 07:10:53.759859) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0 --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 8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0 --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=20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-22 07:10:53,903 truncating revision to first 12 chars 2017-08-22 07:10:53,903 Setting DEBUG logging. 2017-08-22 07:10:53,903 attempt 1/10 2017-08-22 07:10:53,903 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/8f55314ca1a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-22 07:10:54,540 unpacking tar archive at: mozilla-beta-8f55314ca1a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.067067 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-22 07:10:54.844668) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:54.845032) ========= script_repo_revision: 8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:54.845435) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:54.845716) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-22 07:10:54.857550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-08-22 07:10:54.857962) ========= /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=20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:55 INFO - MultiFileLogger online at 20170822 07:10:55 in /builds/slave/test 07:10:55 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 07:10:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:10:55 INFO - {'append_to_log': False, 07:10:55 INFO - 'base_work_dir': '/builds/slave/test', 07:10:55 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:10:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:10:55 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:10:55 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:55 INFO - 'code_coverage': False, 07:10:55 INFO - 'config_files': ('talos/linux_config.py',), 07:10:55 INFO - 'default_actions': ('clobber', 07:10:55 INFO - 'read-buildbot-config', 07:10:55 INFO - 'download-and-extract', 07:10:55 INFO - 'populate-webroot', 07:10:55 INFO - 'create-virtualenv', 07:10:55 INFO - 'install', 07:10:55 INFO - 'setup-mitmproxy', 07:10:55 INFO - 'run-tests'), 07:10:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:55 INFO - 'disable_ccov_upload': False, 07:10:55 INFO - 'download_minidump_stackwalk': True, 07:10:55 INFO - 'download_symbols': 'ondemand', 07:10:55 INFO - 'enable_stylo': False, 07:10:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:55 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:55 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:55 INFO - 'gecko_profile': False, 07:10:55 INFO - 'gecko_profile_interval': 0, 07:10:55 INFO - 'installer_path': 'installer.exe', 07:10:55 INFO - 'log_level': 'info', 07:10:55 INFO - 'log_name': 'talos', 07:10:55 INFO - 'log_to_console': True, 07:10:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:55 INFO - 'opt_config_files': (), 07:10:55 INFO - 'pip_index': False, 07:10:55 INFO - 'suite': 'dromaeojs-e10s', 07:10:55 INFO - 'system_bits': '32', 07:10:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:55 INFO - 'title': 'talos-linux64-ix-015', 07:10:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:55 INFO - 'use_talos_json': True, 07:10:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:10:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:55 INFO - 'work_dir': 'build'} 07:10:55 INFO - [mozharness: 2017-08-22 14:10:55.107036Z] Running clobber step. 07:10:55 INFO - Running pre-action listener: _resource_record_pre_action 07:10:55 INFO - Running main action method: clobber 07:10:55 INFO - rmtree: /builds/slave/test/build 07:10:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:10:56 INFO - Running post-action listener: _resource_record_post_action 07:10:56 INFO - [mozharness: 2017-08-22 14:10:56.123499Z] Finished clobber step (success) 07:10:56 INFO - [mozharness: 2017-08-22 14:10:56.123602Z] Running read-buildbot-config step. 07:10:56 INFO - Running pre-action listener: _resource_record_pre_action 07:10:56 INFO - Running main action method: read_buildbot_config 07:10:56 INFO - Using buildbot properties: 07:10:56 INFO - { 07:10:56 INFO - "project": "", 07:10:56 INFO - "product": "firefox", 07:10:56 INFO - "who": "ffxbld@noreply.mozilla.org", 07:10:56 INFO - "installer_path": "public/build/target.tar.bz2", 07:10:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:10:56 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:10:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:10:56 INFO - "stage_platform": "linux64", 07:10:56 INFO - "basedir": "/builds/slave/test", 07:10:56 INFO - "buildnumber": 59, 07:10:56 INFO - "platform": "ubuntu64_hw", 07:10:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:10:56 INFO - "slavebuilddir": "test", 07:10:56 INFO - "taskId": "ViyZHenyT7OFz2QrXNRifQ", 07:10:56 INFO - "branch": "mozilla-beta", 07:10:56 INFO - "script_repo_revision": "production", 07:10:56 INFO - "revision": "8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0", 07:10:56 INFO - "slavename": "talos-linux64-ix-015", 07:10:56 INFO - "repo_path": "releases/mozilla-beta" 07:10:56 INFO - } 07:10:56 INFO - Finding installer, test and symbols from parent task. 07:10:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViyZHenyT7OFz2QrXNRifQ'}, attempt #1 07:10:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ViyZHenyT7OFz2QrXNRifQ'}, attempt #1 07:10:57 INFO - Task dependencies: D4mshFvxTweNQ9MMo4rVQg 07:10:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg'}, attempt #1 07:10:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2 07:10:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.test_packages.json 07:10:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.crashreporter-symbols.zip 07:10:57 INFO - Running post-action listener: _resource_record_post_action 07:10:57 INFO - [mozharness: 2017-08-22 14:10:57.492483Z] Finished read-buildbot-config step (success) 07:10:57 INFO - [mozharness: 2017-08-22 14:10:57.492705Z] Running download-and-extract step. 07:10:57 INFO - Running pre-action listener: _resource_record_pre_action 07:10:57 INFO - Running main action method: download_and_extract 07:10:57 INFO - mkdir: /builds/slave/test/build/tests 07:10:57 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')]} 07:10:57 INFO - trying https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.test_packages.json 07:10:57 INFO - Downloading https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:10:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:10:58 INFO - Downloaded 989 bytes. 07:10:58 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:10:58 INFO - Using the following test package requirements: 07:10:58 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:10:58 INFO - u'common': [u'target.common.tests.zip'], 07:10:58 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:10:58 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:10:58 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:10:58 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:10:58 INFO - u'mozbase': [u'target.common.tests.zip'], 07:10:58 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:10:58 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:10:58 INFO - u'web-platform': [u'target.common.tests.zip', 07:10:58 INFO - u'target.web-platform.tests.tar.gz'], 07:10:58 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:10:58 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:10:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.common.tests.zip 07:10:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:10:58 INFO - Fetch https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.common.tests.zip into memory 07:10:59 INFO - Content-Length response header: 72857476 07:10:59 INFO - Bytes received: 72857476 07:11:10 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:11:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.common.tests.zip 07:11:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:11:10 INFO - Fetch https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.common.tests.zip into memory 07:11:11 INFO - Content-Length response header: 72857476 07:11:11 INFO - Bytes received: 72857476 07:11:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.talos.tests.zip 07:11:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:11:23 INFO - Fetch https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.talos.tests.zip into memory 07:11:24 INFO - Content-Length response header: 14496472 07:11:24 INFO - Bytes received: 14496472 07:11:24 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')]} 07:11:24 INFO - trying https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2 07:11:24 INFO - Downloading https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:11:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:11:25 INFO - Downloaded 54020439 bytes. 07:11:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2 07:11:25 INFO - mkdir: /builds/slave/test/properties 07:11:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:11:25 INFO - Writing to file /builds/slave/test/properties/build_url 07:11:25 INFO - Contents: 07:11:25 INFO - build_url:https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2 07:11:25 INFO - Running post-action listener: _resource_record_post_action 07:11:25 INFO - Running post-action listener: set_extra_try_arguments 07:11:25 INFO - [mozharness: 2017-08-22 14:11:25.997656Z] Finished download-and-extract step (success) 07:11:25 INFO - [mozharness: 2017-08-22 14:11:25.997753Z] Running populate-webroot step. 07:11:25 INFO - Running pre-action listener: _resource_record_pre_action 07:11:25 INFO - Running main action method: populate_webroot 07:11:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:11:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:11:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:11:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:11:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:11:26 INFO - 'tests': ['damp', 'tps']}, 07:11:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:11:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:11:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:11:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:11:26 INFO - 'other-e10s': {'tests': ['a11yr', 07:11:26 INFO - 'ts_paint', 07:11:26 INFO - 'tpaint', 07:11:26 INFO - 'sessionrestore', 07:11:26 INFO - 'sessionrestore_many_windows', 07:11:26 INFO - 'sessionrestore_no_auto_restore', 07:11:26 INFO - 'tabpaint']}, 07:11:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:11:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:11:26 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:11:26 INFO - 'talos_options': ['--mitmproxy', 07:11:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:11:26 INFO - '--firstNonBlankPaint'], 07:11:26 INFO - 'tests': ['quantum_pageload_google', 07:11:26 INFO - 'quantum_pageload_youtube', 07:11:26 INFO - 'quantum_pageload_amazon', 07:11:26 INFO - 'quantum_pageload_facebook']}, 07:11:26 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:11:26 INFO - 'talos_options': ['--stylo', 07:11:26 INFO - '--mitmproxy', 07:11:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:11:26 INFO - '--firstNonBlankPaint'], 07:11:26 INFO - 'tests': ['quantum_pageload_google', 07:11:26 INFO - 'quantum_pageload_youtube', 07:11:26 INFO - 'quantum_pageload_amazon', 07:11:26 INFO - 'quantum_pageload_facebook']}, 07:11:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:11:26 INFO - 'tsvgr_opacity', 07:11:26 INFO - 'tart', 07:11:26 INFO - 'tscrollx', 07:11:26 INFO - 'cart', 07:11:26 INFO - 'tsvg_static']}, 07:11:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:11:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:11:26 INFO - 'talos_options': ['--stylo', 07:11:26 INFO - '--stylo-threads=1', 07:11:26 INFO - '--mitmproxy', 07:11:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:11:26 INFO - '--firstNonBlankPaint'], 07:11:26 INFO - 'tests': ['tp6_google', 07:11:26 INFO - 'tp6_youtube', 07:11:26 INFO - 'tp6_amazon', 07:11:26 INFO - 'tp6_facebook']}, 07:11:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:11:26 INFO - 'talos_options': ['--xperf_path', 07:11:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:11:26 INFO - 'tests': ['tp5n']}}} 07:11:26 INFO - Running post-action listener: _resource_record_post_action 07:11:26 INFO - [mozharness: 2017-08-22 14:11:26.006545Z] Finished populate-webroot step (success) 07:11:26 INFO - [mozharness: 2017-08-22 14:11:26.006635Z] Running create-virtualenv step. 07:11:26 INFO - Running pre-action listener: _resource_record_pre_action 07:11:26 INFO - Running main action method: create_virtualenv 07:11:26 INFO - Creating virtualenv /builds/slave/test/build/venv 07:11:26 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 07:11:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:11:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:11:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:11:26 INFO - Using real prefix '/usr' 07:11:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:11:26 INFO - Installing distribute.............................................................................................................................................................................................done. 07:11:28 INFO - Installing pip.................done. 07:11:28 INFO - Return code: 0 07:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:11:28 INFO - Reading from file tmpfile_stdout 07:11:28 INFO - Output received: 07:11:28 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) 07:11:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:11:28 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')]} 07:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:28 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')]} 07:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:28 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:28 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 07:11:28 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 07:11:28 INFO - Using env: {'DISPLAY': ':0', 07:11:28 INFO - 'HOME': '/home/cltbld', 07:11:28 INFO - 'LANG': 'en_US.UTF-8', 07:11:28 INFO - 'LANGUAGE': 'en_US:en', 07:11:28 INFO - 'LOGNAME': 'cltbld', 07:11:28 INFO - 'MAIL': '/var/mail/cltbld', 07:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:28 INFO - 'MOZ_NO_REMOTE': '1', 07:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:28 INFO - 'NO_EM_RESTART': '1', 07:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:28 INFO - 'PWD': '/builds/slave/test', 07:11:28 INFO - 'SHELL': '/bin/bash', 07:11:28 INFO - 'SHLVL': '1', 07:11:28 INFO - 'TERM': 'linux', 07:11:28 INFO - 'TMOUT': '86400', 07:11:28 INFO - 'USER': 'cltbld', 07:11:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:28 INFO - '_': '/tools/buildbot/bin/python'} 07:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:28 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 07:11:28 INFO - Cleaning up... 07:11:28 INFO - Return code: 0 07:11:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:11:28 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')]} 07:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:28 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')]} 07:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:28 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:28 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 07:11:28 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 07:11:28 INFO - Using env: {'DISPLAY': ':0', 07:11:28 INFO - 'HOME': '/home/cltbld', 07:11:28 INFO - 'LANG': 'en_US.UTF-8', 07:11:28 INFO - 'LANGUAGE': 'en_US:en', 07:11:28 INFO - 'LOGNAME': 'cltbld', 07:11:28 INFO - 'MAIL': '/var/mail/cltbld', 07:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:28 INFO - 'MOZ_NO_REMOTE': '1', 07:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:28 INFO - 'NO_EM_RESTART': '1', 07:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:28 INFO - 'PWD': '/builds/slave/test', 07:11:28 INFO - 'SHELL': '/bin/bash', 07:11:28 INFO - 'SHLVL': '1', 07:11:28 INFO - 'TERM': 'linux', 07:11:28 INFO - 'TMOUT': '86400', 07:11:28 INFO - 'USER': 'cltbld', 07:11:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:28 INFO - '_': '/tools/buildbot/bin/python'} 07:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:29 INFO - Downloading/unpacking psutil>=3.1.1 07:11:29 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 07:11:29 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 07:11:29 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 07:11:29 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 07:11:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:30 INFO - Installing collected packages: psutil 07:11:30 INFO - Running setup.py install for psutil 07:11:30 INFO - building 'psutil._psutil_linux' extension 07:11:30 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 07:11:30 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 07:11:30 INFO - building 'psutil._psutil_posix' extension 07:11:30 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 07:11:30 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 07:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:11:30 INFO - Successfully installed psutil 07:11:30 INFO - Cleaning up... 07:11:30 INFO - Return code: 0 07:11:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:11:30 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')]} 07:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:30 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')]} 07:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:30 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:30 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 07:11:30 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 07:11:30 INFO - Using env: {'DISPLAY': ':0', 07:11:30 INFO - 'HOME': '/home/cltbld', 07:11:30 INFO - 'LANG': 'en_US.UTF-8', 07:11:30 INFO - 'LANGUAGE': 'en_US:en', 07:11:30 INFO - 'LOGNAME': 'cltbld', 07:11:30 INFO - 'MAIL': '/var/mail/cltbld', 07:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:30 INFO - 'MOZ_NO_REMOTE': '1', 07:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:30 INFO - 'NO_EM_RESTART': '1', 07:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:30 INFO - 'PWD': '/builds/slave/test', 07:11:30 INFO - 'SHELL': '/bin/bash', 07:11:30 INFO - 'SHLVL': '1', 07:11:30 INFO - 'TERM': 'linux', 07:11:30 INFO - 'TMOUT': '86400', 07:11:30 INFO - 'USER': 'cltbld', 07:11:30 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:30 INFO - '_': '/tools/buildbot/bin/python'} 07:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:11:31 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 07:11:31 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 07:11:31 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 07:11:31 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 07:11:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:11:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:11:32 INFO - Installing collected packages: mozsystemmonitor 07:11:32 INFO - Running setup.py install for mozsystemmonitor 07:11:32 INFO - Successfully installed mozsystemmonitor 07:11:32 INFO - Cleaning up... 07:11:32 INFO - Return code: 0 07:11:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:11:32 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')]} 07:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:32 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')]} 07:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:32 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:32 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 07:11:32 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 07:11:32 INFO - Using env: {'DISPLAY': ':0', 07:11:32 INFO - 'HOME': '/home/cltbld', 07:11:32 INFO - 'LANG': 'en_US.UTF-8', 07:11:32 INFO - 'LANGUAGE': 'en_US:en', 07:11:32 INFO - 'LOGNAME': 'cltbld', 07:11:32 INFO - 'MAIL': '/var/mail/cltbld', 07:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:32 INFO - 'MOZ_NO_REMOTE': '1', 07:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:32 INFO - 'NO_EM_RESTART': '1', 07:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:32 INFO - 'PWD': '/builds/slave/test', 07:11:32 INFO - 'SHELL': '/bin/bash', 07:11:32 INFO - 'SHLVL': '1', 07:11:32 INFO - 'TERM': 'linux', 07:11:32 INFO - 'TMOUT': '86400', 07:11:32 INFO - 'USER': 'cltbld', 07:11:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:32 INFO - '_': '/tools/buildbot/bin/python'} 07:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:32 INFO - Downloading/unpacking jsonschema==2.5.1 07:11:32 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 07:11:32 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 07:11:32 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 07:11:32 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 07:11:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:11:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:11:33 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 07:11:33 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 07:11:33 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 07:11:33 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 07:11:33 INFO - Downloading functools32-3.2.3-2.tar.gz 07:11:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:11:33 INFO - warning: no files found matching '*.txt' 07:11:33 INFO - no previously-included directories found matching 'build' 07:11:33 INFO - no previously-included directories found matching 'dist' 07:11:33 INFO - no previously-included directories found matching '.git*' 07:11:33 INFO - Installing collected packages: jsonschema, functools32 07:11:33 INFO - Running setup.py install for functools32 07:11:34 INFO - warning: no files found matching '*.txt' 07:11:34 INFO - no previously-included directories found matching 'build' 07:11:34 INFO - no previously-included directories found matching 'dist' 07:11:34 INFO - no previously-included directories found matching '.git*' 07:11:34 INFO - Successfully installed jsonschema functools32 07:11:34 INFO - Cleaning up... 07:11:34 INFO - Return code: 0 07:11:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:11:34 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')]} 07:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:34 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')]} 07:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:34 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:34 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 07:11:34 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 07:11:34 INFO - Using env: {'DISPLAY': ':0', 07:11:34 INFO - 'HOME': '/home/cltbld', 07:11:34 INFO - 'LANG': 'en_US.UTF-8', 07:11:34 INFO - 'LANGUAGE': 'en_US:en', 07:11:34 INFO - 'LOGNAME': 'cltbld', 07:11:34 INFO - 'MAIL': '/var/mail/cltbld', 07:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:34 INFO - 'MOZ_NO_REMOTE': '1', 07:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:34 INFO - 'NO_EM_RESTART': '1', 07:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:34 INFO - 'PWD': '/builds/slave/test', 07:11:34 INFO - 'SHELL': '/bin/bash', 07:11:34 INFO - 'SHLVL': '1', 07:11:34 INFO - 'TERM': 'linux', 07:11:34 INFO - 'TMOUT': '86400', 07:11:34 INFO - 'USER': 'cltbld', 07:11:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:34 INFO - '_': '/tools/buildbot/bin/python'} 07:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:11:34 INFO - Cleaning up... 07:11:34 INFO - Return code: 0 07:11:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:11:34 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')]} 07:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:34 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')]} 07:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:34 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:34 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 07:11:34 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 07:11:34 INFO - Using env: {'DISPLAY': ':0', 07:11:34 INFO - 'HOME': '/home/cltbld', 07:11:34 INFO - 'LANG': 'en_US.UTF-8', 07:11:34 INFO - 'LANGUAGE': 'en_US:en', 07:11:34 INFO - 'LOGNAME': 'cltbld', 07:11:34 INFO - 'MAIL': '/var/mail/cltbld', 07:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:34 INFO - 'MOZ_NO_REMOTE': '1', 07:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:34 INFO - 'NO_EM_RESTART': '1', 07:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:34 INFO - 'PWD': '/builds/slave/test', 07:11:34 INFO - 'SHELL': '/bin/bash', 07:11:34 INFO - 'SHLVL': '1', 07:11:34 INFO - 'TERM': 'linux', 07:11:34 INFO - 'TMOUT': '86400', 07:11:34 INFO - 'USER': 'cltbld', 07:11:34 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:34 INFO - '_': '/tools/buildbot/bin/python'} 07:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:34 INFO - Downloading/unpacking blobuploader==1.2.4 07:11:34 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 07:11:34 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 07:11:34 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 07:11:34 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 07:11:35 INFO - Downloading blobuploader-1.2.4.tar.gz 07:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:11:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:11:35 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 07:11:35 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 07:11:35 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 07:11:35 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 07:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:11:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:11:36 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 07:11:36 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 07:11:36 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 07:11:36 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 07:11:36 INFO - Downloading docopt-0.6.1.tar.gz 07:11:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:11:36 INFO - Installing collected packages: blobuploader, requests, docopt 07:11:36 INFO - Running setup.py install for blobuploader 07:11:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:11:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:11:36 INFO - Running setup.py install for requests 07:11:36 INFO - Running setup.py install for docopt 07:11:36 INFO - Successfully installed blobuploader requests docopt 07:11:36 INFO - Cleaning up... 07:11:36 INFO - Return code: 0 07:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:36 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:36 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 07:11:36 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 07:11:36 INFO - Using env: {'DISPLAY': ':0', 07:11:36 INFO - 'HOME': '/home/cltbld', 07:11:36 INFO - 'LANG': 'en_US.UTF-8', 07:11:36 INFO - 'LANGUAGE': 'en_US:en', 07:11:36 INFO - 'LOGNAME': 'cltbld', 07:11:36 INFO - 'MAIL': '/var/mail/cltbld', 07:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:36 INFO - 'MOZ_NO_REMOTE': '1', 07:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:36 INFO - 'NO_EM_RESTART': '1', 07:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:36 INFO - 'PWD': '/builds/slave/test', 07:11:36 INFO - 'SHELL': '/bin/bash', 07:11:36 INFO - 'SHLVL': '1', 07:11:36 INFO - 'TERM': 'linux', 07:11:36 INFO - 'TMOUT': '86400', 07:11:36 INFO - 'USER': 'cltbld', 07:11:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:36 INFO - '_': '/tools/buildbot/bin/python'} 07:11:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:37 INFO - Running setup.py (path:/tmp/pip-6pHPV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:37 INFO - Running setup.py (path:/tmp/pip-407Ahn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:37 INFO - Running setup.py (path:/tmp/pip-iOsOdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:37 INFO - Running setup.py (path:/tmp/pip-TNdRtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:37 INFO - Running setup.py (path:/tmp/pip-XRH4ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:37 INFO - Running setup.py (path:/tmp/pip-Pw8WJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:37 INFO - Running setup.py (path:/tmp/pip-iXV5Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:37 INFO - Running setup.py (path:/tmp/pip-mnjydf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:37 INFO - Running setup.py (path:/tmp/pip-bfAWNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:37 INFO - Running setup.py (path:/tmp/pip-6zJ19k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:37 INFO - Running setup.py (path:/tmp/pip-kmcCLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:37 INFO - Running setup.py (path:/tmp/pip-uiZsVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:37 INFO - Running setup.py (path:/tmp/pip-vsO38E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:37 INFO - Running setup.py (path:/tmp/pip-CVYffR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:38 INFO - Running setup.py (path:/tmp/pip-zfhgie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:38 INFO - Running setup.py (path:/tmp/pip-NDf0Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:38 INFO - Running setup.py (path:/tmp/pip-xa42Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:11:38 INFO - Running setup.py install for manifestparser 07:11:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Running setup.py install for mozcrash 07:11:38 INFO - Running setup.py install for mozdebug 07:11:38 INFO - Running setup.py install for mozdevice 07:11:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Running setup.py install for mozfile 07:11:38 INFO - Running setup.py install for mozhttpd 07:11:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Running setup.py install for mozinfo 07:11:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Running setup.py install for mozInstall 07:11:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:11:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Running setup.py install for mozleak 07:11:39 INFO - Running setup.py install for mozlog 07:11:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Running setup.py install for moznetwork 07:11:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Running setup.py install for mozprocess 07:11:39 INFO - Running setup.py install for mozprofile 07:11:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Running setup.py install for mozrunner 07:11:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Running setup.py install for mozscreenshot 07:11:39 INFO - Running setup.py install for moztest 07:11:39 INFO - Running setup.py install for mozversion 07:11:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:11:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:11:39 INFO - Cleaning up... 07:11:39 INFO - Return code: 0 07:11:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:39 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')]} 07:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:39 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')]} 07:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:39 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:39 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 07:11:39 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 07:11:39 INFO - Using env: {'DISPLAY': ':0', 07:11:39 INFO - 'HOME': '/home/cltbld', 07:11:39 INFO - 'LANG': 'en_US.UTF-8', 07:11:39 INFO - 'LANGUAGE': 'en_US:en', 07:11:39 INFO - 'LOGNAME': 'cltbld', 07:11:39 INFO - 'MAIL': '/var/mail/cltbld', 07:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:39 INFO - 'MOZ_NO_REMOTE': '1', 07:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:39 INFO - 'NO_EM_RESTART': '1', 07:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:39 INFO - 'PWD': '/builds/slave/test', 07:11:39 INFO - 'SHELL': '/bin/bash', 07:11:39 INFO - 'SHLVL': '1', 07:11:39 INFO - 'TERM': 'linux', 07:11:39 INFO - 'TMOUT': '86400', 07:11:39 INFO - 'USER': 'cltbld', 07:11:39 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:39 INFO - '_': '/tools/buildbot/bin/python'} 07:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:11:40 INFO - Running setup.py (path:/tmp/pip-PIwhKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:11:40 INFO - Running setup.py (path:/tmp/pip-FNuxMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:11:40 INFO - Running setup.py (path:/tmp/pip-Jx5rA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:11:40 INFO - Running setup.py (path:/tmp/pip-LeZnGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:11:40 INFO - Running setup.py (path:/tmp/pip-heRidv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:11:40 INFO - Running setup.py (path:/tmp/pip-zFO0sK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:11:40 INFO - Running setup.py (path:/tmp/pip-3geQUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:11:40 INFO - Running setup.py (path:/tmp/pip-s4KFGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:11:40 INFO - Running setup.py (path:/tmp/pip-ZezkIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:11:40 INFO - Running setup.py (path:/tmp/pip-QYQmeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:11:40 INFO - Running setup.py (path:/tmp/pip-YXkLfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:11:40 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)) 07:11:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:11:40 INFO - Running setup.py (path:/tmp/pip-m_NMw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:11:41 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)) 07:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:11:41 INFO - Running setup.py (path:/tmp/pip-YddIV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:11:41 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)) 07:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:11:41 INFO - Running setup.py (path:/tmp/pip-tFVdPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:11:41 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)) 07:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:41 INFO - Running setup.py (path:/tmp/pip-vfdGcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:11:41 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)) 07:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:11:41 INFO - Running setup.py (path:/tmp/pip-Nh1cWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:11:41 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)) 07:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:11:41 INFO - Running setup.py (path:/tmp/pip-litQME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:11:41 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)) 07:11:41 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)) 07:11:41 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)) 07:11:41 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)) 07:11:41 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)) 07:11:41 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)) 07:11:41 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)) 07:11:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:11:41 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 07:11:41 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 07:11:41 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 07:11:41 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 07:11:42 INFO - Downloading blessings-1.6.tar.gz 07:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:11:42 INFO - Installing collected packages: blessings 07:11:42 INFO - Running setup.py install for blessings 07:11:42 INFO - Successfully installed blessings 07:11:42 INFO - Cleaning up... 07:11:42 INFO - Return code: 0 07:11:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:11:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:42 INFO - Reading from file tmpfile_stdout 07:11:42 INFO - Current package versions: 07:11:42 INFO - argparse == 1.2.1 07:11:42 INFO - blessings == 1.6 07:11:42 INFO - blobuploader == 1.2.4 07:11:42 INFO - docopt == 0.6.1 07:11:42 INFO - functools32 == 3.2.3-2 07:11:42 INFO - jsonschema == 2.5.1 07:11:42 INFO - manifestparser == 1.1 07:11:42 INFO - mozInstall == 1.13 07:11:42 INFO - mozcrash == 1.0 07:11:42 INFO - mozdebug == 0.1 07:11:42 INFO - mozdevice == 0.51 07:11:42 INFO - mozfile == 1.2 07:11:42 INFO - mozhttpd == 0.7 07:11:42 INFO - mozinfo == 0.10 07:11:42 INFO - mozleak == 0.1 07:11:42 INFO - mozlog == 3.5 07:11:42 INFO - moznetwork == 0.27 07:11:42 INFO - mozprocess == 0.25 07:11:42 INFO - mozprofile == 0.28 07:11:42 INFO - mozrunner == 6.13 07:11:42 INFO - mozscreenshot == 0.1 07:11:42 INFO - mozsystemmonitor == 0.3 07:11:42 INFO - moztest == 0.8 07:11:42 INFO - mozversion == 1.4 07:11:42 INFO - psutil == 3.1.1 07:11:42 INFO - requests == 1.2.3 07:11:42 INFO - wsgiref == 0.1.2 07:11:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:11:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:42 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:42 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 07:11:42 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 07:11:42 INFO - Using env: {'DISPLAY': ':0', 07:11:42 INFO - 'HOME': '/home/cltbld', 07:11:42 INFO - 'LANG': 'en_US.UTF-8', 07:11:42 INFO - 'LANGUAGE': 'en_US:en', 07:11:42 INFO - 'LOGNAME': 'cltbld', 07:11:42 INFO - 'MAIL': '/var/mail/cltbld', 07:11:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:42 INFO - 'MOZ_NO_REMOTE': '1', 07:11:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:42 INFO - 'NO_EM_RESTART': '1', 07:11:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:42 INFO - 'PWD': '/builds/slave/test', 07:11:42 INFO - 'SHELL': '/bin/bash', 07:11:42 INFO - 'SHLVL': '1', 07:11:42 INFO - 'TERM': 'linux', 07:11:42 INFO - 'TMOUT': '86400', 07:11:42 INFO - 'USER': 'cltbld', 07:11:42 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:42 INFO - '_': '/tools/buildbot/bin/python'} 07:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 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)) 07:11:43 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:11:43 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 07:11:43 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 07:11:43 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 07:11:43 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 07:11:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:11:44 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)) 07:11:44 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)) 07:11:44 INFO - Installing collected packages: simplejson 07:11:44 INFO - Running setup.py install for simplejson 07:11:44 INFO - building 'simplejson._speedups' extension 07:11:44 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 07:11:45 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 07:11:45 INFO - Successfully installed simplejson 07:11:45 INFO - Cleaning up... 07:11:45 INFO - Return code: 0 07:11:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07: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')]} 07:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07: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')]} 07:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:11:45 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, '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': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', '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 07:11:45 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 07:11:45 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 07:11:45 INFO - Using env: {'DISPLAY': ':0', 07:11:45 INFO - 'HOME': '/home/cltbld', 07:11:45 INFO - 'LANG': 'en_US.UTF-8', 07:11:45 INFO - 'LANGUAGE': 'en_US:en', 07:11:45 INFO - 'LOGNAME': 'cltbld', 07:11:45 INFO - 'MAIL': '/var/mail/cltbld', 07:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:45 INFO - 'MOZ_NO_REMOTE': '1', 07:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:45 INFO - 'NO_EM_RESTART': '1', 07:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:11:45 INFO - 'PWD': '/builds/slave/test', 07:11:45 INFO - 'SHELL': '/bin/bash', 07:11:45 INFO - 'SHLVL': '1', 07:11:45 INFO - 'TERM': 'linux', 07:11:45 INFO - 'TMOUT': '86400', 07:11:45 INFO - 'USER': 'cltbld', 07:11:45 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:45 INFO - '_': '/tools/buildbot/bin/python'} 07:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:11:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:11:45 INFO - Cleaning up... 07:11:45 INFO - Return code: 0 07:11:45 INFO - Running post-action listener: _resource_record_post_action 07:11:45 INFO - Running post-action listener: _start_resource_monitoring 07:11:45 INFO - Starting resource monitoring. 07:11:45 INFO - [mozharness: 2017-08-22 14:11:45.688752Z] Finished create-virtualenv step (success) 07:11:45 INFO - [mozharness: 2017-08-22 14:11:45.689220Z] Running install step. 07:11:45 INFO - Running pre-action listener: _resource_record_pre_action 07:11:45 INFO - Running main action method: install 07:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:11:45 INFO - Reading from file tmpfile_stdout 07:11:45 INFO - Detecting whether we're running mozinstall >=1.0... 07:11:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:11:46 INFO - Reading from file tmpfile_stdout 07:11:46 INFO - Output received: 07:11:46 INFO - Usage: mozinstall [options] installer 07:11:46 INFO - Options: 07:11:46 INFO - -h, --help show this help message and exit 07:11:46 INFO - -d DEST, --destination=DEST 07:11:46 INFO - Directory to install application into. [default: 07:11:46 INFO - "/builds/slave/test"] 07:11:46 INFO - --app=APP Application being installed. [default: firefox] 07:11:46 INFO - mkdir: /builds/slave/test/build/application 07:11:46 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'] 07:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:12:00 INFO - Reading from file tmpfile_stdout 07:12:00 INFO - Output received: 07:12:00 INFO - /builds/slave/test/build/application/firefox/firefox 07:12:00 INFO - Running post-action listener: _resource_record_post_action 07:12:00 INFO - [mozharness: 2017-08-22 14:12:00.819471Z] Finished install step (success) 07:12:00 INFO - [mozharness: 2017-08-22 14:12:00.819723Z] Running setup-mitmproxy step. 07:12:00 INFO - Running pre-action listener: _resource_record_pre_action 07:12:00 INFO - Running main action method: setup_mitmproxy 07:12:00 INFO - Skipping: mitmproxy is not required 07:12:00 INFO - Running post-action listener: _resource_record_post_action 07:12:00 INFO - [mozharness: 2017-08-22 14:12:00.820844Z] Finished setup-mitmproxy step (success) 07:12:00 INFO - [mozharness: 2017-08-22 14:12:00.821065Z] Running run-tests step. 07:12:00 INFO - Running pre-action listener: _resource_record_pre_action 07:12:00 INFO - Running pre-action listener: _set_gcov_prefix 07:12:00 INFO - Running main action method: run_tests 07:12:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:12:00 INFO - Python 2.7.3 07:12:00 INFO - Return code: 0 07:12:00 INFO - grabbing minidump binary from tooltool 07:12:00 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')]} 07:12:00 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 0x17bf050>, '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 0x17bff50>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c03e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:12:00 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 07:12:00 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 07:12:00 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 07:12:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:12:00 INFO - Return code: 0 07:12:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:12:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:12:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:12:00 INFO - ENV: RUST_BACKTRACE is now 1 07:12:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:12:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:12:00 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/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:12:00 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/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 07:12:00 INFO - Using env: {'DISPLAY': ':0', 07:12:00 INFO - 'HOME': '/home/cltbld', 07:12:00 INFO - 'LANG': 'en_US.UTF-8', 07:12:00 INFO - 'LANGUAGE': 'en_US:en', 07:12:00 INFO - 'LOGNAME': 'cltbld', 07:12:00 INFO - 'MAIL': '/var/mail/cltbld', 07:12:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:12:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:12:00 INFO - 'MOZ_NO_REMOTE': '1', 07:12:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:12:00 INFO - 'NO_EM_RESTART': '1', 07:12:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:12:00 INFO - 'PWD': '/builds/slave/test', 07:12:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:12:00 INFO - 'RUST_BACKTRACE': '1', 07:12:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:12:00 INFO - 'SHELL': '/bin/bash', 07:12:00 INFO - 'SHLVL': '1', 07:12:00 INFO - 'TERM': 'linux', 07:12:00 INFO - 'TMOUT': '86400', 07:12:00 INFO - 'USER': 'cltbld', 07:12:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358', 07:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:12:00 INFO - '_': '/tools/buildbot/bin/python'} 07:12:00 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/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 07:12:01 INFO - mozversion application_buildid: 20170822130024 07:12:01 INFO - mozversion application_changeset: 8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0 07:12:01 INFO - mozversion application_display_name: Firefox 07:12:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:12:01 INFO - mozversion application_name: Firefox 07:12:01 INFO - mozversion application_remotingname: firefox 07:12:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:12:01 INFO - mozversion application_vendor: Mozilla 07:12:01 INFO - mozversion application_version: 56.0 07:12:01 INFO - mozversion platform_buildid: 20170822130024 07:12:01 INFO - mozversion platform_changeset: 8f55314ca1a9dda9b2e24c684b70cc51b7f74fe0 07:12:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:12:01 INFO - mozversion platform_version: 56.0 07:12:01 INFO - using testdate: 1503411121 07:12:01 INFO - actual date: 1503411121 07:12:01 INFO - starting webserver on 'localhost:51369' 07:12:01 INFO - SUITE-START | Running 2 tests 07:12:01 INFO - TEST-START | dromaeo_css 07:12:01 INFO - Initialising browser for dromaeo_css test... 07:12:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51369/getInfo.html -profile /tmp/tmpuq_Zxs/profile 07:12:01 INFO - TEST-INFO | started process 10430 (/builds/slave/test/build/application/firefox/firefox http://localhost:51369/getInfo.html) 07:12:06 INFO - TEST-INFO | 10430: exit 0 07:12:06 INFO - Browser initialized. 07:12:06 INFO - Running cycle 1/1 for dromaeo_css test... 07:12:06 INFO - TEST-INFO | started process 10593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuq_Zxs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:12:06 INFO - PID 10593 | 1503411126852 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 07:12:17 INFO - PID 10593 | RSS: Main: 150175744 07:12:17 INFO - PID 10593 | 07:15:15 INFO - PID 10593 | Cycle 1(1): loaded http://localhost:51369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51369/tests/dromaeo/cssquery-ext.html) 07:15:16 INFO - PID 10593 | RSS: Main: 159490048 07:15:16 INFO - PID 10593 | 07:18:18 INFO - PID 10593 | Cycle 1(1): loaded http://localhost:51369/tests/dromaeo/cssquery-ext.html (next: http://localhost:51369/tests/dromaeo/cssquery-jquery.html) 07:18:18 INFO - PID 10593 | RSS: Main: 156729344 07:18:18 INFO - PID 10593 | 07:21:20 INFO - PID 10593 | Cycle 1(1): loaded http://localhost:51369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51369/tests/dromaeo/cssquery-mootools.html) 07:21:20 INFO - PID 10593 | RSS: Main: 158613504 07:21:20 INFO - PID 10593 | 07:24:22 INFO - PID 10593 | Cycle 1(1): loaded http://localhost:51369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51369/tests/dromaeo/cssquery-prototype.html) 07:24:22 INFO - PID 10593 | RSS: Main: 158375936 07:24:22 INFO - PID 10593 | 07:27:26 INFO - PID 10593 | Cycle 1(1): loaded http://localhost:51369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51369/tests/dromaeo/cssquery-yui.html) 07:27:26 INFO - PID 10593 | RSS: Main: 161124352 07:27:26 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | Cycle 1(1): loaded http://localhost:51369/tests/dromaeo/cssquery-yui.html (next: http://localhost:51369/tests/dromaeo/cssquery-dojo.html) 07:30:28 INFO - PID 10593 | RSS: Main: 163360768 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | __start_tp_report 07:30:28 INFO - PID 10593 | _x_x_mozilla_page_load 07:30:28 INFO - PID 10593 | _x_x_mozilla_page_load_details 07:30:28 INFO - PID 10593 | |i|pagename|runs| 07:30:28 INFO - PID 10593 | |0;dojo.html;3531.788092714439;3572.303400836837;3596.9460458093117;3608.6391360863918;3691.243295124498;6378.3621637836195;6450.6452145132;6471.482281417481;6514.478841692665;6538.869222615551;6369.71336289868;6434.356564343575;6491.902621460682;6532.738690452376;6550.213974323064;5538.556915446755;5592;5599.692016939067;5645.125005624114;5670.773169073233;5630.127330263796;5682.488576028157;5693.886122277552;5710.428957104298;5713.228714123603;5614.29821272341;5641.830745077634;5669.404712505168;5673.319201695782;5735.11105778605;5504;5554.50009499143;5587.580931430119;5613.831585052455;5650.152477128422;5550.5282051025715;5580.944190558083;5599.524040456566;5606.635568688063;5623.662580245198;6247.406496382836;6279.37206279373;6306.9684651576445;6372.267189273247;6390.968045159744;6890.414314783249;6966.407855332252;6991.685374158175;7019.262977387352;7039.014537964689;6959.721611135599;7005;7043.049188359609;7057.576545407292;7071.434285257167;6484.481241500669;6496.480281577463;6537.5423720339595;6545.639989800607;6567.770128045496;7028.0863487746265;7050.083489146481;7132.786016419412;7135.4648401370105;7137.4290056795335;6859.828504287433;6866.073080134218;6882.174139103339;6914.274001229899;6919.6540172991145;6963.059986901805;6983.336583024605;7023.89464158038;7048.718051277891;7069.151701795818;6892.517523773287;6906.205786334535;6955.7217711292;6964.860702785916;6989.685464154024;6872.965635171792;6876.587404755731;6899.55152915069;6900.689468973908;6909.309069093151;5097.490250974873;5141.562967147835;5151.5106064923775;5161.096808058574;5180.715060671624;4573.885652858705;4587.036722288357;4633.212353899845;4636.884077898012;4640.744759038285;6552.541322107502;6627.966860165765;6636.369544893228;6713.530052896348;6728.529002969745;6987.1266091738535;7046.330598593126;7062.646867656596;7102.715891364391;7122.109736282965;6652.600843949379;6657.7669781557415;6661.600303981777;6662.200535935719;6712.295209003082;5887;5890.646561206341;5957.4042595740075;5961.165436838846;5962.672053037038;7026.051483049825;7128.251533588898;7153.213146553875;7250.9637451812405;7271.745488907863;7046.682899269443;7057.435405167677;7065.6467176639935;7072.222055573986;7082.929170708433;7145.892811607934;7148.356647901714;7171.1394632644415;7171.4621403395995;7291.270872912666;6687.331266873468;6802.081718967876;6853.348931851466;6887.449004079762;6946.5137440378685;7030.296970303133;7063.046488723957;7088;7088.043114179726;7093.042439270839;6808;6808.693608787716;6820.31796820314;6873.518853680394;6889.069975553437;6668.699908504226;6743.527953043436;6745.865082698417;6748.426383757239;6753.628550429774;6716.261211266855;6747.055412242192;6801.251862295243;6816.863662726619;6833.077534532775;6783.762568310085;6828.419584335387;6876.17485901695;6904.4131248842405;6906.8618627628175;6624.6025238485845;6630.038644396632;6710.362515561014;6716.328367163244;6719.697613607302 07:30:28 INFO - PID 10593 | |1;ext.html;879.8856148700668;959.7840485890674;984.1437948984385;1347.7641412752766;1377.2975782351011;42838.35742463862;43840.561594384046;43898.561014389845;43991.120177596466;44040;42185.789071054605;42483.575164248345;42517.57482425175;42598.78700606493;42608.360874586826;7273.818154546139;7314.670839812221;7374.705011799521;7390.482666213367;7391.889121663179;7298.416126709877;7427.071616047994;7436.553806771584;7442.627868606575;7442.962785186067;7343.63281835906;7433.368163706092;7439.925600744004;7848.803779905491;8027.839443211133;7927.28654421102;7975.7208497702595;7975.843502692135;7976.920230797676;7982.161873003338;7748.263914928073;7758.806029849243;7834.804129896741;7837.6864925402915;7840.215978402114;40318.39522407166;40375;40520.189596207914;40544.18911621751;40786.59213407858;3660.5607327120915;3699.315626609059;3711.777293362407;3717.2565486902727;3720.9069773255615;32303.676963230537;32414.189645258823;32511.512327315108;32533.186670333194;32542;5253.159494480865;5303.178007408857;5318.175682769177;5325.334333208349;5335.8132465363915;208909;210801;210952.94523527438;211781;212081;52507.73746131321;52895.20657190145;52918;53015.734921325915;53060.73469632627;54442.18336724952;54739.72630136824;54794.17808732872;54857.45142548603;54959.72520137454;17265.741013884803;17527.123643818013;17581.033043182746;17582.648347032988;17585.7362139568;14323.997320187487;14364.640883977983;14428.422863085569;14444.061136026125;14479.203643799481;14785.038972466755;15072.09567425936;15264.542063738105;15357.9232103841;15510;5148.433672296044;6089.147519347295;6301.873962520815;6344.238691356974;6425.742970281136;951.2722767083187;956.7608097975506;975.5756246032998;977.3012296208245;979.588572799426;22311.426157637645;22412.215572454887;22544;22576.322710318716;22938;1064.2799185611836;1065.984010239847;1066.664000839733;1071.3839542263229;1081.086481922774;11382.829257561143;11690.240134391237;11977.00748998429;12029.09781766371;17069.829301707072;282960;284018;285279;285847;286099;63209;63737;64050.6797466019;64076.35923640704;64078;1527.1295361643756;1539.7613369927678;1558.532440267915;1582.3986884983863;1592.1720705233213;29493.705062949095;29551.556726648687;29657.5551366734;30032.399352013275;30084.699153009064;42691.57308427;43099.784501077294;43133;43231.35152972645;43239.78380108079;233470;234281;234328;234898;235936;35776.82111589425;35868.820655896554;36264.27471450609;36285.63714362823;36290.81854590816;43757.12485750331;44035.55964440315;44507.777461112484;44626.10747784961;44774.552254477036;32723.509147362332;33110.337793244486;33270.334593308486;33360.33279334448;33368.33263334671;32852.34295314032;32941;32969.835150824096;33416;33539.66460335365;37417.625823741415;38907.416388754755;38945.80527097346;38980.415293771184;39019.804900975316;31955.36089278248;32089.839550802095;32305.35389292248;32534.34931301408;32718.34563308673;24845.503089938462;25003.624945626194;25229.116980906314;25395.746042539336;25705.871470642527 07:30:28 INFO - PID 10593 | |2;jquery.html;600.4235933503836;600.7266693654387;603.3061978724468;608.3885694876653;618.0944915698502;23780.76219237807;24299.149529766462;24431.267061988125;24471.143509977177;24786.628200577004;28625.284367890814;28953.710462895364;29017.419651606957;29192.416151676953;29203.707962920365;6401.295857455676;6538.313477084909;6538.542302038859;6559.409653131217;6564.606123632573;5990.760369585211;6437.935620643804;6451.45162661172;6472.352764723513;6487.41613254807;6419.486441084702;6441.420272175504;6458.677066146697;6459.51553633477;6460.127882735841;6397.456216221627;6417.294097649255;6449.226092868862;6454.2577603575255;6458.612483250997;5961.2846458425265;5974.074018527135;5977.671228082454;5984.3417224105315;6023.186869772612;31430.528542071886;32036.359272814647;32543.349133017207;32769;32869.50695739566;2264.5923733727923;2300.9309720708407;2306.688597039395;2307.7807608277353;2307.9884600577057;19883;20419.8979005104;20460.488487787774;20487;20493.2827351042;2371.1108334374608;2407;2416.1422694943394;2420.0803694596116;2470.8023358131304;148607;150260.2486987558;151077;152281;152477;15388.692226155414;15775.684486310209;16391.344346226255;16497.83502164963;16828.074455904796;25345.366365840633;25516.74483255181;25522.23433297004;25526.23421297364;25534;11252.831207531894;11294.192929131299;11304.321740695585;11325.546978120783;11385.943070284595;9324.580393882292;10462.97777067012;10516.3690178588;10558.419286939139;10620.946895265473;8535;9844.753881153028;9984.550695218733;10046.547905344278;10349.689509314732;2941.4411261860178;2954.601128847621;2957.4972254716317;2966;3000.8649610767566;1057.1014637558014;1058.8147074261974;1080.4597701149426;1081.853949716794;1086.9293495922739;21931.561368772534;22403.21588744419;22486.775132248797;22499.775002250095;22581.887090564443;1109.4563663804838;1120.3110087296418;1124.2804605052772;1133.6202372205403;1134.177721152158;11906.404679765978;12170.634880953585;12258.754824903452;12304.446299916524;12447.128700991025;604328;611082;619204;628749;632763;121329;123148;123702.38148809198;125592;126795;1229.8893099620898;1260.489501751792;1262.7158889249845;1275.9681007974689;1283.9807402888964;18862.905685471484;19214.231430743173;19596.90201548983;19628.60742785108;23263.41841453977;67659.66170169118;67839;68342;68788;69155.65422173058;79749;79764.60117699375;79982;80834.59582702049;80908.59545702234;14068.859311407165;14406.927965360106;15633.76549351738;16059.678806423572;16459.58851028734;23738.88130559336;24007.27978160658;25687.74312256928;26063.218103456926;26152.60771088473;20053.29813456522;20666.276680316118;20730.378088657366;20982.160713571895;21146.68279975771;16421.261043253322;16585.91707041457;16850.07324597159;16860.747088793432;16969;20714.067866946327;20717.689234661793;20757.858317792667;20854.895725521274;21509;15908.522744317688;15940.123293218985;15991.840081599501;16001.519954401387;16105.516834494983;20724.378268651966;20809.271675491284;21044.47388815292;21106;21148 07:30:28 INFO - PID 10593 | |3;mootools.html;1437.9137251764894;1443.0764310841057;1463;1486.4945918387752;1505.239853873794;15332.080075195483;16018.519444416672;16019.759703604426;16020.35918563256;16054.59863503413;15771.290291936863;16892.493225203234;16897.408590699328;16897.746533802;16902.408415705453;2898.594196812448;2934.7358737713653;2966.5253559430494;2967.0505438259765;2967.2581854536365;2830.377316990259;2874.382007868308;2917.226934862263;2972.4203780262856;2994.1017694691614;2967.1246982140215;2972.806767560102;2979.716926891942;3005.413944280866;3010.3527741535568;2775.9306017349527;2796.4127533217843;2798.104606525923;2816.6197563328997;2824.223338581886;2757.765589924859;2784.582312653098;2786.289496178482;2788.0659978907092;2791.3440341519727;15981.600459988476;16247.350105995745;16347.509574712658;16384.50846474596;16387.508374748777;8522.190391912758;8755.649774009033;8763.386562940597;8790.340724445628;8790.472571645721;5357.383900851413;5420.24116623669;5524.447555244484;5547.5007249347755;5687.800926967537;1967.6064787042505;1980.712796644493;2001.7197592337084;2009.939701808948;2015.586804705032;27673;27823.86088069567;27858.16425507238;27892.72107278942;27895.16314510568;7206.171290301578;7367.594782287026;7396.963015184997;7570.735024274124;7572.81067973294;19169.137388817537;19277.518062048563;19291;19310.71033934492;19324.516887077654;8599.828003440021;8710.52092134926;8725.476471411735;8749.65001399937;8758.430702004349;7962.6416811243635;7963.681452741941;7975.082865470546;7995.680172793023;7997.920020799717;5477.4248703886315;5848.093545500455;6002.939970600325;6010.639361638316;6024.668643224577;1513.6821267533942;1658.7511873218873;1698.167897730128;1728.110023337982;1736.791585009807;978.5351957819978;995.4574756757439;999.2256001598819;1005.3214080495636;1022.8107800057013;9593.952030239805;9706.805863882682;9827.803443931225;9871.012898710214;9933.65232216869;1041.7603951091291;1055.3034996902009;1059.2532264753331;1066.589363095214;1090.1224514266091;5644;5987.2815262168815;6016.157737916695;6151.5386346024225;6253.937460625336;23236.419089522897;23701.28896133119;23892.283231503083;24052.51894962126;24055.879720601286;22626.434339141324;23395.41511462193;23891.044358225823;23925.64111538328;23970.88014559916;12375.75248495025;12400.81398779019;12466.688332791571;12480.81278780819;12481.063920206021;9061.41100828444;9115.544222788967;9184.678536251198;9230.907690923004;9260.444373337621;20262.290819821235;20351;20648.48378790542;20714.275000374913;21015.8949205253;20823.8958805205;21131.154753809675;21446;21472.355829325144;21497.89251053797;12396.566120185751;12514.436850341574;12591.685207869876;12607.054470914534;12611.306378148924;15041.022333548284;15049.774253386428;15162;15384.538463846102;15408.306626201624;12238.204516706386;12508.812367814671;12512.687182820502;12523.248605083723;12875.227486350848;11864.644060678194;12074.36996005528;12320.876791231973;12443.813342800046;12606.306653134166;10849.891501084889;10997.890021100007;11003;11039.282446641264;11117.221794474633;8173.468724532886;8266.958665206635;8297.336213102817;8304.83390332202;8349.791255218668;8047.557384343917;8074.798130046795;8092.959535202522;8108.75673729789;8215.917840821516 07:30:28 INFO - PID 10593 | |4;prototype.html;520.6563667979132;524.3262407805969;549.7031602934414;551.5559974220756;557.2727590494405;6217.792683597326;6251.749930002806;6281.874362512747;6306.558540902139;6369.394907483793;6163.784267550636;6221.3156552779155;6222.813315600528;6236.532260080489;6255.874882502348;5003.824866129687;5023.8492845214705;5025.899482010367;5033.697978121324;5057.140286151344;4773.976130119345;4850.666066831614;4880.219164933611;4902.583280421169;4973.403191617011;4864.610831133501;4878.902421951559;4882.584980276681;4915.705057696549;4918.877028074309;4821.590164835993;4854.2718592211095;4866.221404575251;4885.804567817283;4901.632377571661;4416.189362361449;4420.58004489573;4435.401220835178;4450.443694538183;4450.955490445086;6026.54800889935;6077.754060417604;6086.7565297388055;6185.257769067695;6188;5849.678267695275;5879.7648094076185;5885.323187833411;5886.8822623547285;5930.55520835939;6519.608823470607;6640.0703901453835;6655.567388119756;6674.631700501385;6674.833129171761;5018.84943451697;5075.873103172414;5088.338515992898;5097.9490205097845;5109.821156259551;6812.250652428229;6822.4200942919915;6937.826554336131;6958.016965164954;6992.3007699230175;5152.88250608384;5162.5869930406225;5186.170212765939;5191;5200.947990520122;5167.715775632301;5230.189320655229;5238.790448382022;5280.709560974184;5285.471452854761;5730.627509211888;5772.480476757112;5790.218320526759;5837.562182836305;5847.649141051551;6581.572197807127;6625.370589793962;6676.599404035774;6688.899666505006;6694.230163531159;1816.418746001267;1828.597708504127;1838.3657638114828;1845.9261629534938;1849.6115815678859;1241.0454028951103;1270.8220849081135;1285.8971282297393;1307.405130665545;1319.5447570588133;6418.358164183544;6439.323870993572;6439.5170362223025;6465.7369920527435;6484.513661475408;6776.424003959719;6856.451483881277;6869.896951545731;6877.037214789933;6890.517663763489;6116.755329786848;6293.181886354744;6311.905321420182;6351.2060992375955;6405.573018435115;3593.1196856770257;3596.82015899204;3603.207294395229;3612.819359032038;3613.94579081314;6934.861302773917;6961.61711105894;6962.825929351706;6980.965095174492;7076.787696369117;6820.669969355928;6860.382565569123;6900.171979362408;6913.066735990677;6970.163580370388;6889.276625954303;6932.584044957218;6950.687219075154;7036.894446583407;7064.611446370499;6707.496937729592;6738.35985581369;6843.247242803188;6856.691448884912;6890.586564806128;6720.731170753115;6728.226253980659;6748.358905903931;6756.391924726799;6767.593944363354;6908.378245957888;7043.154821421463;7075.469339799639;7091.503594748318;7109.395701365442;5180.9740951295;5182.689038657692;5229.947700522946;5253.422123566328;5257.5005374489365;6625.966870165618;6671.498188179433;6676.599404035774;6775.457963363017;6874.518783685294;6531.902021469777;6533.607983521004;6560.475161986934;6564.5076619252795;6654.733810647714;6465.159529261354;6527.314631963575;6545.607263564201;6562.343765623399;6641.767538136142;6493.448056915215;6585.769498067544;6592.868387515891;6638.668066596554;6639.668016599054;6512.934870651233;6601.933980660132;6603.9009414859775;6630.138082049302;6650.201975762746;6380.553361264667;6404.519661025349;6487.124238227779;6491.902621460587;6498.122753428227 07:30:28 INFO - PID 10593 | |5;yui.html;896.2695403246355;906.8730377747114;924.4360939826709;930.5998420679109;944.2163004706094;17011.914940425297;17440.91279543602;17551.736723949136;17572.20925058372;20197.39407817764;19926.60146797063;19993.800371977653;20186;20375.490612734688;20385.28651497198;992.9602815887356;1069.4064794039305;1070.7216123807789;1073.3613499967507;1077.4774234496263;976.2239019979133;1073.3613499967546;1077.3320541264388;1077.9892201078007;1078.2883297023966;1135.2393896089598;1144.8511693479836;1146.5070019891443;1147.0192984997832;1147.2141583015618;1129.6949823547636;1137.601839356227;1139.7207684117445;1140;1140.0936255676716;829.9253067223979;834.2450082675189;837.0248660310731;839.8068444257793;841.6254766628853;17992.190351434216;18308.908455457637;18976.905115474474;19038.524036899187;19043;20566.794332056637;20881.791182088138;20891.791082089137;20932.267370641955;21373.67939480909;16206.270717817726;16284.83715162845;16495.83504164955;16586.75119873203;16595.50213493597;3610.801405922673;3636.8908932731797;3637.5816781069984;3640.362936486131;3642.25333806569;143067;143475.09015894023;143712;144271;147911.26044369818;13717.314134293245;14201.928990354982;14342.85657143436;14375.712485750226;14378.856211437751;29358.26604334866;29929.401411971638;29955.850220748758;30006.24984375408;30245.546316805267;7426.443016773764;8514.403991720645;8935.865962010575;8972.8654070189;8998.775030624287;4600.976995115003;4675.579197872208;4682.719036857799;4692.976535117303;4726.456457507362;5712.34308054579;5725.341585717612;5769.85575360611;5903.58674892762;5930.673812940244;1035.6841163445072;1043.7077618266896;1043.780806030742;1050.6375300521308;1057.4289883462998;715.992840071603;738.770980995893;740.5482655580092;749.2133260076897;755.1844008470838;12523.812142817866;13283.667908302177;13399.598012059654;13436.865631343562;13458.394372253271;753.3257734327746;753.3897542990195;762.1502025241927;777.0869228656306;782.6008735544913;6063.998880369468;6180.598261113103;6182.474489668429;6201.286852012076;6213.502919766408;130216;130969.34515327553;132659;134968.27611033566;135270;119890.4005479967;120033.39983300203;121319.39340303242;122345.38827305807;126863.365683171;103298;103755;104589;105279.94720052855;106177;11951.282923024299;11971.16201865861;12259.877401225873;12337.691557711129;12399.814002789784;48777;49007.509924900296;49109.75445122751;49453;51175;61885.38114618796;61963;62263.37736622576;63414.68292658507;64045.679771600844;16671.333146674;16966.49100526986;17054.829451705325;17186.140692965553;17269.827301726822;18782.812171878653;18810.905945470186;18934.14796334196;19041.809581904003;19274.22903083861;16234.756478652593;16634.75047874307;16706.49880503587;16809.579760506083;16831.831681683027;17470.47588572345;17833.554161146076;17842.375516856846;17993.820061799215;18072.277108915496;16792.58018549546;16941.407050753165;17060.914695426443;17078.402255920984;17274.654506910043;13304;13708.314584270547;14653.92673036628;14883.883708722105;15572.844271557593;15271.312790924212;15734.21328933526;15749.842501574838;15803;16326.428574999818 07:30:28 INFO - PID 10593 | __end_tp_report 07:30:28 INFO - PID 10593 | __start_cc_report 07:30:28 INFO - PID 10593 | _x_x_mozilla_cycle_collect,283 07:30:28 INFO - PID 10593 | __end_cc_report 07:30:28 INFO - PID 10593 | __startTimestamp1503412228542__endTimestamp 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | ------- Summary: start ------- 07:30:28 INFO - PID 10593 | Number of tests: 6 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | [#0] dojo.html Cycles:165 Average:6414.28 Median:6728.53 stddev:816.86 (12.1%) stddev-sans-first:787.44 07:30:28 INFO - PID 10593 | Values: 3531.8 3572.3 3596.9 3608.6 3691.2 6378.4 6450.6 6471.5 6514.5 6538.9 6369.7 6434.4 6491.9 6532.7 6550.2 5538.6 5592.0 5599.7 5645.1 5670.8 5630.1 5682.5 5693.9 5710.4 5713.2 5614.3 5641.8 5669.4 5673.3 5735.1 5504.0 5554.5 5587.6 5613.8 5650.2 5550.5 5580.9 5599.5 5606.6 5623.7 6247.4 6279.4 6307.0 6372.3 6391.0 6890.4 6966.4 6991.7 7019.3 7039.0 6959.7 7005.0 7043.0 7057.6 7071.4 6484.5 6496.5 6537.5 6545.6 6567.8 7028.1 7050.1 7132.8 7135.5 7137.4 6859.8 6866.1 6882.2 6914.3 6919.7 6963.1 6983.3 7023.9 7048.7 7069.2 6892.5 6906.2 6955.7 6964.9 6989.7 6873.0 6876.6 6899.6 6900.7 6909.3 5097.5 5141.6 5151.5 5161.1 5180.7 4573.9 4587.0 4633.2 4636.9 4640.7 6552.5 6628.0 6636.4 6713.5 6728.5 6987.1 7046.3 7062.6 7102.7 7122.1 6652.6 6657.8 6661.6 6662.2 6712.3 5887.0 5890.6 5957.4 5961.2 5962.7 7026.1 7128.3 7153.2 7251.0 7271.7 7046.7 7057.4 7065.6 7072.2 7082.9 7145.9 7148.4 7171.1 7171.5 7291.3 6687.3 6802.1 6853.3 6887.4 6946.5 7030.3 7063.0 7088.0 7088.0 7093.0 6808.0 6808.7 6820.3 6873.5 6889.1 6668.7 6743.5 6745.9 6748.4 6753.6 6716.3 6747.1 6801.3 6816.9 6833.1 6783.8 6828.4 6876.2 6904.4 6906.9 6624.6 6630.0 6710.4 6716.3 6719.7 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | [#1] ext.html Cycles:180 Average:42144.36 Median:3719.08 stddev:63898.37 (1718.1%) stddev-sans-first:64002.50 07:30:28 INFO - PID 10593 | Values: 879.9 959.8 984.1 1347.8 1377.3 42838.4 43840.6 43898.6 43991.1 44040.0 42185.8 42483.6 42517.6 42598.8 42608.4 7273.8 7314.7 7374.7 7390.5 7391.9 7298.4 7427.1 7436.6 7442.6 7443.0 7343.6 7433.4 7439.9 7848.8 8027.8 7927.3 7975.7 7975.8 7976.9 7982.2 7748.3 7758.8 7834.8 7837.7 7840.2 40318.4 40375.0 40520.2 40544.2 40786.6 3660.6 3699.3 3711.8 3717.3 3720.9 32303.7 32414.2 32511.5 32533.2 32542.0 5253.2 5303.2 5318.2 5325.3 5335.8 208909.0 210801.0 210952.9 211781.0 212081.0 52507.7 52895.2 52918.0 53015.7 53060.7 54442.2 54739.7 54794.2 54857.5 54959.7 17265.7 17527.1 17581.0 17582.6 17585.7 14324.0 14364.6 14428.4 14444.1 14479.2 14785.0 15072.1 15264.5 15357.9 15510.0 5148.4 6089.1 6301.9 6344.2 6425.7 951.3 956.8 975.6 977.3 979.6 22311.4 22412.2 22544.0 22576.3 22938.0 1064.3 1066.0 1066.7 1071.4 1081.1 11382.8 11690.2 11977.0 12029.1 17069.8 282960.0 284018.0 285279.0 285847.0 286099.0 63209.0 63737.0 64050.7 64076.4 64078.0 1527.1 1539.8 1558.5 1582.4 1592.2 29493.7 29551.6 29657.6 30032.4 30084.7 42691.6 43099.8 43133.0 43231.4 43239.8 233470.0 234281.0 234328.0 234898.0 235936.0 35776.8 35868.8 36264.3 36285.6 36290.8 43757.1 44035.6 44507.8 44626.1 44774.6 32723.5 33110.3 33270.3 33360.3 33368.3 32852.3 32941.0 32969.8 33416.0 33539.7 37417.6 38907.4 38945.8 38980.4 39019.8 31955.4 32089.8 32305.4 32534.3 32718.3 24845.5 25003.6 25229.1 25395.7 25705.9 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | [#2] jquery.html Cycles:180 Average:40442.45 Median:2282.76 stddev:103311.90 (4525.7%) stddev-sans-first:103558.40 07:30:28 INFO - PID 10593 | Values: 600.4 600.7 603.3 608.4 618.1 23780.8 24299.1 24431.3 24471.1 24786.6 28625.3 28953.7 29017.4 29192.4 29203.7 6401.3 6538.3 6538.5 6559.4 6564.6 5990.8 6437.9 6451.5 6472.4 6487.4 6419.5 6441.4 6458.7 6459.5 6460.1 6397.5 6417.3 6449.2 6454.3 6458.6 5961.3 5974.1 5977.7 5984.3 6023.2 31430.5 32036.4 32543.3 32769.0 32869.5 2264.6 2300.9 2306.7 2307.8 2308.0 19883.0 20419.9 20460.5 20487.0 20493.3 2371.1 2407.0 2416.1 2420.1 2470.8 148607.0 150260.2 151077.0 152281.0 152477.0 15388.7 15775.7 16391.3 16497.8 16828.1 25345.4 25516.7 25522.2 25526.2 25534.0 11252.8 11294.2 11304.3 11325.5 11385.9 9324.6 10463.0 10516.4 10558.4 10620.9 8535.0 9844.8 9984.6 10046.5 10349.7 2941.4 2954.6 2957.5 2966.0 3000.9 1057.1 1058.8 1080.5 1081.9 1086.9 21931.6 22403.2 22486.8 22499.8 22581.9 1109.5 1120.3 1124.3 1133.6 1134.2 11906.4 12170.6 12258.8 12304.4 12447.1 604328.0 611082.0 619204.0 628749.0 632763.0 121329.0 123148.0 123702.4 125592.0 126795.0 1229.9 1260.5 1262.7 1276.0 1284.0 18862.9 19214.2 19596.9 19628.6 23263.4 67659.7 67839.0 68342.0 68788.0 69155.7 79749.0 79764.6 79982.0 80834.6 80908.6 14068.9 14406.9 15633.8 16059.7 16459.6 23738.9 24007.3 25687.7 26063.2 26152.6 20053.3 20666.3 20730.4 20982.2 21146.7 16421.3 16585.9 16850.1 16860.7 16969.0 20714.1 20717.7 20757.9 20854.9 21509.0 15908.5 15940.1 15991.8 16001.5 16105.5 20724.4 20809.3 21044.5 21106.0 21148.0 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | [#3] mootools.html Cycles:180 Average:10231.75 Median:24054.20 stddev:7250.06 (30.1%) stddev-sans-first:7240.29 07:30:28 INFO - PID 10593 | Values: 1437.9 1443.1 1463.0 1486.5 1505.2 15332.1 16018.5 16019.8 16020.4 16054.6 15771.3 16892.5 16897.4 16897.7 16902.4 2898.6 2934.7 2966.5 2967.1 2967.3 2830.4 2874.4 2917.2 2972.4 2994.1 2967.1 2972.8 2979.7 3005.4 3010.4 2775.9 2796.4 2798.1 2816.6 2824.2 2757.8 2784.6 2786.3 2788.1 2791.3 15981.6 16247.4 16347.5 16384.5 16387.5 8522.2 8755.6 8763.4 8790.3 8790.5 5357.4 5420.2 5524.4 5547.5 5687.8 1967.6 1980.7 2001.7 2009.9 2015.6 27673.0 27823.9 27858.2 27892.7 27895.2 7206.2 7367.6 7397.0 7570.7 7572.8 19169.1 19277.5 19291.0 19310.7 19324.5 8599.8 8710.5 8725.5 8749.7 8758.4 7962.6 7963.7 7975.1 7995.7 7997.9 5477.4 5848.1 6002.9 6010.6 6024.7 1513.7 1658.8 1698.2 1728.1 1736.8 978.5 995.5 999.2 1005.3 1022.8 9594.0 9706.8 9827.8 9871.0 9933.7 1041.8 1055.3 1059.3 1066.6 1090.1 5644.0 5987.3 6016.2 6151.5 6253.9 23236.4 23701.3 23892.3 24052.5 24055.9 22626.4 23395.4 23891.0 23925.6 23970.9 12375.8 12400.8 12466.7 12480.8 12481.1 9061.4 9115.5 9184.7 9230.9 9260.4 20262.3 20351.0 20648.5 20714.3 21015.9 20823.9 21131.2 21446.0 21472.4 21497.9 12396.6 12514.4 12591.7 12607.1 12611.3 15041.0 15049.8 15162.0 15384.5 15408.3 12238.2 12508.8 12512.7 12523.2 12875.2 11864.6 12074.4 12320.9 12443.8 12606.3 10849.9 10997.9 11003.0 11039.3 11117.2 8173.5 8267.0 8297.3 8304.8 8349.8 8047.6 8074.8 8093.0 8108.8 8215.9 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | [#4] prototype.html Cycles:180 Average:5641.81 Median:6309.23 stddev:1589.06 (25.2%) stddev-sans-first:1546.33 07:30:28 INFO - PID 10593 | Values: 520.7 524.3 549.7 551.6 557.3 6217.8 6251.7 6281.9 6306.6 6369.4 6163.8 6221.3 6222.8 6236.5 6255.9 5003.8 5023.8 5025.9 5033.7 5057.1 4774.0 4850.7 4880.2 4902.6 4973.4 4864.6 4878.9 4882.6 4915.7 4918.9 4821.6 4854.3 4866.2 4885.8 4901.6 4416.2 4420.6 4435.4 4450.4 4451.0 6026.5 6077.8 6086.8 6185.3 6188.0 5849.7 5879.8 5885.3 5886.9 5930.6 6519.6 6640.1 6655.6 6674.6 6674.8 5018.8 5075.9 5088.3 5097.9 5109.8 6812.3 6822.4 6937.8 6958.0 6992.3 5152.9 5162.6 5186.2 5191.0 5200.9 5167.7 5230.2 5238.8 5280.7 5285.5 5730.6 5772.5 5790.2 5837.6 5847.6 6581.6 6625.4 6676.6 6688.9 6694.2 1816.4 1828.6 1838.4 1845.9 1849.6 1241.0 1270.8 1285.9 1307.4 1319.5 6418.4 6439.3 6439.5 6465.7 6484.5 6776.4 6856.5 6869.9 6877.0 6890.5 6116.8 6293.2 6311.9 6351.2 6405.6 3593.1 3596.8 3603.2 3612.8 3613.9 6934.9 6961.6 6962.8 6981.0 7076.8 6820.7 6860.4 6900.2 6913.1 6970.2 6889.3 6932.6 6950.7 7036.9 7064.6 6707.5 6738.4 6843.2 6856.7 6890.6 6720.7 6728.2 6748.4 6756.4 6767.6 6908.4 7043.2 7075.5 7091.5 7109.4 5181.0 5182.7 5229.9 5253.4 5257.5 6626.0 6671.5 6676.6 6775.5 6874.5 6531.9 6533.6 6560.5 6564.5 6654.7 6465.2 6527.3 6545.6 6562.3 6641.8 6493.4 6585.8 6592.9 6638.7 6639.7 6512.9 6601.9 6603.9 6630.1 6650.2 6380.6 6404.5 6487.1 6491.9 6498.1 07:30:28 INFO - PID 10593 | 07:30:28 INFO - PID 10593 | [#5] yui.html Cycles:180 Average:25977.17 Median:17511.11 stddev:38062.11 (217.4%) stddev-sans-first:38122.30 07:30:28 INFO - PID 10593 | Values: 896.3 906.9 924.4 930.6 944.2 17011.9 17440.9 17551.7 17572.2 20197.4 19926.6 19993.8 20186.0 20375.5 20385.3 993.0 1069.4 1070.7 1073.4 1077.5 976.2 1073.4 1077.3 1078.0 1078.3 1135.2 1144.9 1146.5 1147.0 1147.2 1129.7 1137.6 1139.7 1140.0 1140.1 829.9 834.2 837.0 839.8 841.6 17992.2 18308.9 18976.9 19038.5 19043.0 20566.8 20881.8 20891.8 20932.3 21373.7 16206.3 16284.8 16495.8 16586.8 16595.5 3610.8 3636.9 3637.6 3640.4 3642.3 143067.0 143475.1 143712.0 144271.0 147911.3 13717.3 14201.9 14342.9 14375.7 14378.9 29358.3 29929.4 29955.9 30006.2 30245.5 7426.4 8514.4 8935.9 8972.9 8998.8 4601.0 4675.6 4682.7 4693.0 4726.5 5712.3 5725.3 5769.9 5903.6 5930.7 1035.7 1043.7 1043.8 1050.6 1057.4 716.0 738.8 740.5 749.2 755.2 12523.8 13283.7 13399.6 13436.9 13458.4 753.3 753.4 762.2 777.1 782.6 6064.0 6180.6 6182.5 6201.3 6213.5 130216.0 130969.3 132659.0 134968.3 135270.0 119890.4 120033.4 121319.4 122345.4 126863.4 103298.0 103755.0 104589.0 105279.9 106177.0 11951.3 11971.2 12259.9 12337.7 12399.8 48777.0 49007.5 49109.8 49453.0 51175.0 61885.4 61963.0 62263.4 63414.7 64045.7 16671.3 16966.5 17054.8 17186.1 17269.8 18782.8 18810.9 18934.1 19041.8 19274.2 16234.8 16634.8 16706.5 16809.6 16831.8 17470.5 17833.6 17842.4 17993.8 18072.3 16792.6 16941.4 17060.9 17078.4 17274.7 13304.0 13708.3 14653.9 14883.9 15572.8 15271.3 15734.2 15749.8 15803.0 16326.4 07:30:28 INFO - PID 10593 | -------- Summary: end -------- 07:30:28 INFO - PID 10593 | 07:30:29 INFO - TEST-INFO | 10593: exit 0 07:30:29 INFO - TEST-OK | dromaeo_css | took 1108005ms 07:30:29 INFO - TEST-START | kraken 07:30:29 INFO - Initialising browser for kraken test... 07:30:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51369/getInfo.html -profile /tmp/tmpsUr3lp/profile 07:30:29 INFO - TEST-INFO | started process 10956 (/builds/slave/test/build/application/firefox/firefox http://localhost:51369/getInfo.html) 07:30:34 INFO - TEST-INFO | 10956: exit 0 07:30:34 INFO - Browser initialized. 07:30:34 INFO - Running cycle 1/1 for kraken test... 07:30:34 INFO - TEST-INFO | started process 11119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsUr3lp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:34 INFO - PID 11119 | 1503412234509 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 07:30:45 INFO - PID 11119 | RSS: Main: 150499328 07:30:45 INFO - PID 11119 | 07:30:47 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51369/tests/kraken/driver.html?testName=audio-beat-detection) 07:30:48 INFO - PID 11119 | RSS: Main: 157523968 07:30:48 INFO - PID 11119 | 07:30:51 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51369/tests/kraken/driver.html?testName=audio-dft) 07:30:51 INFO - PID 11119 | RSS: Main: 157880320 07:30:51 INFO - PID 11119 | 07:30:54 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51369/tests/kraken/driver.html?testName=audio-fft) 07:30:55 INFO - PID 11119 | RSS: Main: 158466048 07:30:55 INFO - PID 11119 | 07:30:57 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51369/tests/kraken/driver.html?testName=audio-oscillator) 07:30:58 INFO - PID 11119 | RSS: Main: 158314496 07:30:58 INFO - PID 11119 | 07:31:00 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:31:00 INFO - PID 11119 | RSS: Main: 158060544 07:31:00 INFO - PID 11119 | 07:31:03 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51369/tests/kraken/driver.html?testName=imaging-darkroom) 07:31:04 INFO - PID 11119 | RSS: Main: 157630464 07:31:04 INFO - PID 11119 | 07:31:07 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51369/tests/kraken/driver.html?testName=imaging-desaturate) 07:31:08 INFO - PID 11119 | RSS: Main: 160620544 07:31:08 INFO - PID 11119 | 07:31:11 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51369/tests/kraken/driver.html?testName=json-parse-financial) 07:31:11 INFO - PID 11119 | RSS: Main: 161427456 07:31:11 INFO - PID 11119 | 07:31:13 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:31:13 INFO - PID 11119 | RSS: Main: 161378304 07:31:13 INFO - PID 11119 | 07:31:15 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:31:16 INFO - PID 11119 | RSS: Main: 161488896 07:31:16 INFO - PID 11119 | 07:31:18 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:31:18 INFO - PID 11119 | RSS: Main: 161792000 07:31:18 INFO - PID 11119 | 07:31:21 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:31:22 INFO - PID 11119 | RSS: Main: 161452032 07:31:22 INFO - PID 11119 | 07:31:24 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:31:25 INFO - PID 11119 | RSS: Main: 161509376 07:31:25 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | Cycle 1(1): loaded http://localhost:51369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51369/tests/kraken/driver.html?testName=ai-astar) 07:31:27 INFO - PID 11119 | RSS: Main: 163196928 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | __start_tp_report 07:31:27 INFO - PID 11119 | _x_x_mozilla_page_load 07:31:27 INFO - PID 11119 | _x_x_mozilla_page_load_details 07:31:27 INFO - PID 11119 | |i|pagename|runs| 07:31:27 INFO - PID 11119 | |0;ai-astar;96;113;99;105;106;107;105;100;105;107 07:31:27 INFO - PID 11119 | |1;audio-beat-detection;138;113;139;164;112;139;147;117;167;114 07:31:27 INFO - PID 11119 | |2;audio-dft;161;162;162;162;170;162;165;162;164;162 07:31:27 INFO - PID 11119 | |3;audio-fft;75;76;75;190;75;74;77;75;176;74 07:31:27 INFO - PID 11119 | |4;audio-oscillator;78;77;131;78;78;78;127;78;79;129 07:31:27 INFO - PID 11119 | |5;imaging-gaussian-blur;114;114;114;115;116;113;114;113;115;114 07:31:27 INFO - PID 11119 | |6;imaging-darkroom;148;148;148;147;147;149;147;148;148;148 07:31:27 INFO - PID 11119 | |7;imaging-desaturate;93;94;94;93;93;94;94;94;94;94 07:31:27 INFO - PID 11119 | |8;json-parse-financial;48;45;45;48;49;44;51;46;46;48 07:31:27 INFO - PID 11119 | |9;json-stringify-tinderbox;53;52;52;53;53;53;52;52;56;53 07:31:27 INFO - PID 11119 | |10;stanford-crypto-aes;74;72;72;73;74;73;74;74;74;73 07:31:27 INFO - PID 11119 | |11;stanford-crypto-ccm;118;134;127;118;116;114;125;117;116;142 07:31:27 INFO - PID 11119 | |12;stanford-crypto-pbkdf2;159;163;175;162;164;162;158;160;159;159 07:31:27 INFO - PID 11119 | |13;stanford-crypto-sha256-iterative;60;70;62;67;60;60;63;61;60;62 07:31:27 INFO - PID 11119 | __end_tp_report 07:31:27 INFO - PID 11119 | __start_cc_report 07:31:27 INFO - PID 11119 | _x_x_mozilla_cycle_collect,812 07:31:27 INFO - PID 11119 | __end_cc_report 07:31:27 INFO - PID 11119 | __startTimestamp1503412287532__endTimestamp 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | ------- Summary: start ------- 07:31:27 INFO - PID 11119 | Number of tests: 14 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#0] ai-astar Cycles:10 Average:104.30 Median:107.00 stddev:4.83 (4.5%) stddev-sans-first:4.09 07:31:27 INFO - PID 11119 | Values: 96.0 113.0 99.0 105.0 106.0 107.0 105.0 100.0 105.0 107.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:139.00 stddev:20.62 (14.8%) stddev-sans-first:21.85 07:31:27 INFO - PID 11119 | Values: 138.0 113.0 139.0 164.0 112.0 139.0 147.0 117.0 167.0 114.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.00 stddev:2.66 (1.6%) stddev-sans-first:2.70 07:31:27 INFO - PID 11119 | Values: 161.0 162.0 162.0 162.0 170.0 162.0 165.0 162.0 164.0 162.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#3] audio-fft Cycles:10 Average:96.70 Median:75.00 stddev:45.61 (60.8%) stddev-sans-first:47.70 07:31:27 INFO - PID 11119 | Values: 75.0 76.0 75.0 190.0 75.0 74.0 77.0 75.0 176.0 74.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.00 stddev:24.66 (31.6%) stddev-sans-first:25.52 07:31:27 INFO - PID 11119 | Values: 78.0 77.0 131.0 78.0 78.0 78.0 127.0 78.0 79.0 129.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 07:31:27 INFO - PID 11119 | Values: 114.0 114.0 114.0 115.0 116.0 113.0 114.0 113.0 115.0 114.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:31:27 INFO - PID 11119 | Values: 148.0 148.0 148.0 147.0 147.0 149.0 147.0 148.0 148.0 148.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 07:31:27 INFO - PID 11119 | Values: 93.0 94.0 94.0 93.0 93.0 94.0 94.0 94.0 94.0 94.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#8] json-parse-financial Cycles:10 Average:47.00 Median:48.00 stddev:2.16 (4.5%) stddev-sans-first:2.26 07:31:27 INFO - PID 11119 | Values: 48.0 45.0 45.0 48.0 49.0 44.0 51.0 46.0 46.0 48.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#9] json-stringify-tinderbox Cycles:10 Average:52.90 Median:53.00 stddev:1.20 (2.3%) stddev-sans-first:1.27 07:31:27 INFO - PID 11119 | Values: 53.0 52.0 52.0 53.0 53.0 53.0 52.0 52.0 56.0 53.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#10] stanford-crypto-aes Cycles:10 Average:73.30 Median:74.00 stddev:0.82 (1.1%) stddev-sans-first:0.83 07:31:27 INFO - PID 11119 | Values: 74.0 72.0 72.0 73.0 74.0 73.0 74.0 74.0 74.0 73.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#11] stanford-crypto-ccm Cycles:10 Average:122.70 Median:121.50 stddev:9.23 (7.6%) stddev-sans-first:9.63 07:31:27 INFO - PID 11119 | Values: 118.0 134.0 127.0 118.0 116.0 114.0 125.0 117.0 116.0 142.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.10 Median:162.00 stddev:4.95 (3.1%) stddev-sans-first:5.13 07:31:27 INFO - PID 11119 | Values: 159.0 163.0 175.0 162.0 164.0 162.0 158.0 160.0 159.0 159.0 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:62.00 stddev:3.41 (5.5%) stddev-sans-first:3.49 07:31:27 INFO - PID 11119 | Values: 60.0 70.0 62.0 67.0 60.0 60.0 63.0 61.0 60.0 62.0 07:31:27 INFO - PID 11119 | -------- Summary: end -------- 07:31:27 INFO - PID 11119 | 07:31:27 INFO - PID 11119 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:31:28 INFO - TEST-INFO | 11119: exit 0 07:31:28 INFO - TEST-OK | kraken | took 59003ms 07:31:28 INFO - SUITE-END | took 1167s 07:31:28 INFO - Completed test suite (00:19:27) 07:31:28 INFO - javascript benchmark 07:31:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9028.362494609788, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3531.788092714439, 3572.303400836837, 3596.9460458093117, 3608.6391360863918, 3691.243295124498, 6378.3621637836195, 6450.6452145132, 6471.482281417481, 6514.478841692665, 6538.869222615551, 6369.71336289868, 6434.356564343575, 6491.902621460682, 6532.738690452376, 6550.213974323064, 5538.556915446755, 5592.0, 5599.692016939067, 5645.125005624114, 5670.773169073233, 5630.127330263796, 5682.488576028157, 5693.886122277552, 5710.428957104298, 5713.228714123603, 5614.29821272341, 5641.830745077634, 5669.404712505168, 5673.319201695782, 5735.11105778605, 5504.0, 5554.50009499143, 5587.580931430119, 5613.831585052455, 5650.152477128422, 5550.5282051025715, 5580.944190558083, 5599.524040456566, 5606.635568688063, 5623.662580245198, 6247.406496382836, 6279.37206279373, 6306.9684651576445, 6372.267189273247, 6390.968045159744, 6890.414314783249, 6966.407855332252, 6991.685374158175, 7019.262977387352, 7039.014537964689, 6959.721611135599, 7005.0, 7043.049188359609, 7057.576545407292, 7071.434285257167, 6484.481241500669, 6496.480281577463, 6537.5423720339595, 6545.639989800607, 6567.770128045496, 7028.0863487746265, 7050.083489146481, 7132.786016419412, 7135.4648401370105, 7137.4290056795335, 6859.828504287433, 6866.073080134218, 6882.174139103339, 6914.274001229899, 6919.6540172991145, 6963.059986901805, 6983.336583024605, 7023.89464158038, 7048.718051277891, 7069.151701795818, 6892.517523773287, 6906.205786334535, 6955.7217711292, 6964.860702785916, 6989.685464154024, 6872.965635171792, 6876.587404755731, 6899.55152915069, 6900.689468973908, 6909.309069093151, 5097.490250974873, 5141.562967147835, 5151.5106064923775, 5161.096808058574, 5180.715060671624, 4573.885652858705, 4587.036722288357, 4633.212353899845, 4636.884077898012, 4640.744759038285, 6552.541322107502, 6627.966860165765, 6636.369544893228, 6713.530052896348, 6728.529002969745, 6987.1266091738535, 7046.330598593126, 7062.646867656596, 7102.715891364391, 7122.109736282965, 6652.600843949379, 6657.7669781557415, 6661.600303981777, 6662.200535935719, 6712.295209003082, 5887.0, 5890.646561206341, 5957.4042595740075, 5961.165436838846, 5962.672053037038, 7026.051483049825, 7128.251533588898, 7153.213146553875, 7250.9637451812405, 7271.745488907863, 7046.682899269443, 7057.435405167677, 7065.6467176639935, 7072.222055573986, 7082.929170708433, 7145.892811607934, 7148.356647901714, 7171.1394632644415, 7171.4621403395995, 7291.270872912666, 6687.331266873468, 6802.081718967876, 6853.348931851466, 6887.449004079762, 6946.5137440378685, 7030.296970303133, 7063.046488723957, 7088.0, 7088.043114179726, 7093.042439270839, 6808.0, 6808.693608787716, 6820.31796820314, 6873.518853680394, 6889.069975553437, 6668.699908504226, 6743.527953043436, 6745.865082698417, 6748.426383757239, 6753.628550429774, 6716.261211266855, 6747.055412242192, 6801.251862295243, 6816.863662726619, 6833.077534532775, 6783.762568310085, 6828.419584335387, 6876.17485901695, 6904.4131248842405, 6906.8618627628175, 6624.6025238485845, 6630.038644396632, 6710.362515561014, 6716.328367163244, 6719.697613607302], "value": 6352.457756256426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [879.8856148700668, 959.7840485890674, 984.1437948984385, 1347.7641412752766, 1377.2975782351011, 42838.35742463862, 43840.561594384046, 43898.561014389845, 43991.120177596466, 44040.0, 42185.789071054605, 42483.575164248345, 42517.57482425175, 42598.78700606493, 42608.360874586826, 7273.818154546139, 7314.670839812221, 7374.705011799521, 7390.482666213367, 7391.889121663179, 7298.416126709877, 7427.071616047994, 7436.553806771584, 7442.627868606575, 7442.962785186067, 7343.63281835906, 7433.368163706092, 7439.925600744004, 7848.803779905491, 8027.839443211133, 7927.28654421102, 7975.7208497702595, 7975.843502692135, 7976.920230797676, 7982.161873003338, 7748.263914928073, 7758.806029849243, 7834.804129896741, 7837.6864925402915, 7840.215978402114, 40318.39522407166, 40375.0, 40520.189596207914, 40544.18911621751, 40786.59213407858, 3660.5607327120915, 3699.315626609059, 3711.777293362407, 3717.2565486902727, 3720.9069773255615, 32303.676963230537, 32414.189645258823, 32511.512327315108, 32533.186670333194, 32542.0, 5253.159494480865, 5303.178007408857, 5318.175682769177, 5325.334333208349, 5335.8132465363915, 208909.0, 210801.0, 210952.94523527438, 211781.0, 212081.0, 52507.73746131321, 52895.20657190145, 52918.0, 53015.734921325915, 53060.73469632627, 54442.18336724952, 54739.72630136824, 54794.17808732872, 54857.45142548603, 54959.72520137454, 17265.741013884803, 17527.123643818013, 17581.033043182746, 17582.648347032988, 17585.7362139568, 14323.997320187487, 14364.640883977983, 14428.422863085569, 14444.061136026125, 14479.203643799481, 14785.038972466755, 15072.09567425936, 15264.542063738105, 15357.9232103841, 15510.0, 5148.433672296044, 6089.147519347295, 6301.873962520815, 6344.238691356974, 6425.742970281136, 951.2722767083187, 956.7608097975506, 975.5756246032998, 977.3012296208245, 979.588572799426, 22311.426157637645, 22412.215572454887, 22544.0, 22576.322710318716, 22938.0, 1064.2799185611836, 1065.984010239847, 1066.664000839733, 1071.3839542263229, 1081.086481922774, 11382.829257561143, 11690.240134391237, 11977.00748998429, 12029.09781766371, 17069.829301707072, 282960.0, 284018.0, 285279.0, 285847.0, 286099.0, 63209.0, 63737.0, 64050.6797466019, 64076.35923640704, 64078.0, 1527.1295361643756, 1539.7613369927678, 1558.532440267915, 1582.3986884983863, 1592.1720705233213, 29493.705062949095, 29551.556726648687, 29657.5551366734, 30032.399352013275, 30084.699153009064, 42691.57308427, 43099.784501077294, 43133.0, 43231.35152972645, 43239.78380108079, 233470.0, 234281.0, 234328.0, 234898.0, 235936.0, 35776.82111589425, 35868.820655896554, 36264.27471450609, 36285.63714362823, 36290.81854590816, 43757.12485750331, 44035.55964440315, 44507.777461112484, 44626.10747784961, 44774.552254477036, 32723.509147362332, 33110.337793244486, 33270.334593308486, 33360.33279334448, 33368.33263334671, 32852.34295314032, 32941.0, 32969.835150824096, 33416.0, 33539.66460335365, 37417.625823741415, 38907.416388754755, 38945.80527097346, 38980.415293771184, 39019.804900975316, 31955.36089278248, 32089.839550802095, 32305.35389292248, 32534.34931301408, 32718.34563308673, 24845.503089938462, 25003.624945626194, 25229.116980906314, 25395.746042539336, 25705.871470642527], "value": 18294.21858052184, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.4235933503836, 600.7266693654387, 603.3061978724468, 608.3885694876653, 618.0944915698502, 23780.76219237807, 24299.149529766462, 24431.267061988125, 24471.143509977177, 24786.628200577004, 28625.284367890814, 28953.710462895364, 29017.419651606957, 29192.416151676953, 29203.707962920365, 6401.295857455676, 6538.313477084909, 6538.542302038859, 6559.409653131217, 6564.606123632573, 5990.760369585211, 6437.935620643804, 6451.45162661172, 6472.352764723513, 6487.41613254807, 6419.486441084702, 6441.420272175504, 6458.677066146697, 6459.51553633477, 6460.127882735841, 6397.456216221627, 6417.294097649255, 6449.226092868862, 6454.2577603575255, 6458.612483250997, 5961.2846458425265, 5974.074018527135, 5977.671228082454, 5984.3417224105315, 6023.186869772612, 31430.528542071886, 32036.359272814647, 32543.349133017207, 32769.0, 32869.50695739566, 2264.5923733727923, 2300.9309720708407, 2306.688597039395, 2307.7807608277353, 2307.9884600577057, 19883.0, 20419.8979005104, 20460.488487787774, 20487.0, 20493.2827351042, 2371.1108334374608, 2407.0, 2416.1422694943394, 2420.0803694596116, 2470.8023358131304, 148607.0, 150260.2486987558, 151077.0, 152281.0, 152477.0, 15388.692226155414, 15775.684486310209, 16391.344346226255, 16497.83502164963, 16828.074455904796, 25345.366365840633, 25516.74483255181, 25522.23433297004, 25526.23421297364, 25534.0, 11252.831207531894, 11294.192929131299, 11304.321740695585, 11325.546978120783, 11385.943070284595, 9324.580393882292, 10462.97777067012, 10516.3690178588, 10558.419286939139, 10620.946895265473, 8535.0, 9844.753881153028, 9984.550695218733, 10046.547905344278, 10349.689509314732, 2941.4411261860178, 2954.601128847621, 2957.4972254716317, 2966.0, 3000.8649610767566, 1057.1014637558014, 1058.8147074261974, 1080.4597701149426, 1081.853949716794, 1086.9293495922739, 21931.561368772534, 22403.21588744419, 22486.775132248797, 22499.775002250095, 22581.887090564443, 1109.4563663804838, 1120.3110087296418, 1124.2804605052772, 1133.6202372205403, 1134.177721152158, 11906.404679765978, 12170.634880953585, 12258.754824903452, 12304.446299916524, 12447.128700991025, 604328.0, 611082.0, 619204.0, 628749.0, 632763.0, 121329.0, 123148.0, 123702.38148809198, 125592.0, 126795.0, 1229.8893099620898, 1260.489501751792, 1262.7158889249845, 1275.9681007974689, 1283.9807402888964, 18862.905685471484, 19214.231430743173, 19596.90201548983, 19628.60742785108, 23263.41841453977, 67659.66170169118, 67839.0, 68342.0, 68788.0, 69155.65422173058, 79749.0, 79764.60117699375, 79982.0, 80834.59582702049, 80908.59545702234, 14068.859311407165, 14406.927965360106, 15633.76549351738, 16059.678806423572, 16459.58851028734, 23738.88130559336, 24007.27978160658, 25687.74312256928, 26063.218103456926, 26152.60771088473, 20053.29813456522, 20666.276680316118, 20730.378088657366, 20982.160713571895, 21146.68279975771, 16421.261043253322, 16585.91707041457, 16850.07324597159, 16860.747088793432, 16969.0, 20714.067866946327, 20717.689234661793, 20757.858317792667, 20854.895725521274, 21509.0, 15908.522744317688, 15940.123293218985, 15991.840081599501, 16001.519954401387, 16105.516834494983, 20724.378268651966, 20809.271675491284, 21044.47388815292, 21106.0, 21148.0], "value": 12956.971294411604, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.9137251764894, 1443.0764310841057, 1463.0, 1486.4945918387752, 1505.239853873794, 15332.080075195483, 16018.519444416672, 16019.759703604426, 16020.35918563256, 16054.59863503413, 15771.290291936863, 16892.493225203234, 16897.408590699328, 16897.746533802, 16902.408415705453, 2898.594196812448, 2934.7358737713653, 2966.5253559430494, 2967.0505438259765, 2967.2581854536365, 2830.377316990259, 2874.382007868308, 2917.226934862263, 2972.4203780262856, 2994.1017694691614, 2967.1246982140215, 2972.806767560102, 2979.716926891942, 3005.413944280866, 3010.3527741535568, 2775.9306017349527, 2796.4127533217843, 2798.104606525923, 2816.6197563328997, 2824.223338581886, 2757.765589924859, 2784.582312653098, 2786.289496178482, 2788.0659978907092, 2791.3440341519727, 15981.600459988476, 16247.350105995745, 16347.509574712658, 16384.50846474596, 16387.508374748777, 8522.190391912758, 8755.649774009033, 8763.386562940597, 8790.340724445628, 8790.472571645721, 5357.383900851413, 5420.24116623669, 5524.447555244484, 5547.5007249347755, 5687.800926967537, 1967.6064787042505, 1980.712796644493, 2001.7197592337084, 2009.939701808948, 2015.586804705032, 27673.0, 27823.86088069567, 27858.16425507238, 27892.72107278942, 27895.16314510568, 7206.171290301578, 7367.594782287026, 7396.963015184997, 7570.735024274124, 7572.81067973294, 19169.137388817537, 19277.518062048563, 19291.0, 19310.71033934492, 19324.516887077654, 8599.828003440021, 8710.52092134926, 8725.476471411735, 8749.65001399937, 8758.430702004349, 7962.6416811243635, 7963.681452741941, 7975.082865470546, 7995.680172793023, 7997.920020799717, 5477.4248703886315, 5848.093545500455, 6002.939970600325, 6010.639361638316, 6024.668643224577, 1513.6821267533942, 1658.7511873218873, 1698.167897730128, 1728.110023337982, 1736.791585009807, 978.5351957819978, 995.4574756757439, 999.2256001598819, 1005.3214080495636, 1022.8107800057013, 9593.952030239805, 9706.805863882682, 9827.803443931225, 9871.012898710214, 9933.65232216869, 1041.7603951091291, 1055.3034996902009, 1059.2532264753331, 1066.589363095214, 1090.1224514266091, 5644.0, 5987.2815262168815, 6016.157737916695, 6151.5386346024225, 6253.937460625336, 23236.419089522897, 23701.28896133119, 23892.283231503083, 24052.51894962126, 24055.879720601286, 22626.434339141324, 23395.41511462193, 23891.044358225823, 23925.64111538328, 23970.88014559916, 12375.75248495025, 12400.81398779019, 12466.688332791571, 12480.81278780819, 12481.063920206021, 9061.41100828444, 9115.544222788967, 9184.678536251198, 9230.907690923004, 9260.444373337621, 20262.290819821235, 20351.0, 20648.48378790542, 20714.275000374913, 21015.8949205253, 20823.8958805205, 21131.154753809675, 21446.0, 21472.355829325144, 21497.89251053797, 12396.566120185751, 12514.436850341574, 12591.685207869876, 12607.054470914534, 12611.306378148924, 15041.022333548284, 15049.774253386428, 15162.0, 15384.538463846102, 15408.306626201624, 12238.204516706386, 12508.812367814671, 12512.687182820502, 12523.248605083723, 12875.227486350848, 11864.644060678194, 12074.36996005528, 12320.876791231973, 12443.813342800046, 12606.306653134166, 10849.891501084889, 10997.890021100007, 11003.0, 11039.282446641264, 11117.221794474633, 8173.468724532886, 8266.958665206635, 8297.336213102817, 8304.83390332202, 8349.791255218668, 8047.557384343917, 8074.798130046795, 8092.959535202522, 8108.75673729789, 8215.917840821516], "value": 7308.141289631293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.6563667979132, 524.3262407805969, 549.7031602934414, 551.5559974220756, 557.2727590494405, 6217.792683597326, 6251.749930002806, 6281.874362512747, 6306.558540902139, 6369.394907483793, 6163.784267550636, 6221.3156552779155, 6222.813315600528, 6236.532260080489, 6255.874882502348, 5003.824866129687, 5023.8492845214705, 5025.899482010367, 5033.697978121324, 5057.140286151344, 4773.976130119345, 4850.666066831614, 4880.219164933611, 4902.583280421169, 4973.403191617011, 4864.610831133501, 4878.902421951559, 4882.584980276681, 4915.705057696549, 4918.877028074309, 4821.590164835993, 4854.2718592211095, 4866.221404575251, 4885.804567817283, 4901.632377571661, 4416.189362361449, 4420.58004489573, 4435.401220835178, 4450.443694538183, 4450.955490445086, 6026.54800889935, 6077.754060417604, 6086.7565297388055, 6185.257769067695, 6188.0, 5849.678267695275, 5879.7648094076185, 5885.323187833411, 5886.8822623547285, 5930.55520835939, 6519.608823470607, 6640.0703901453835, 6655.567388119756, 6674.631700501385, 6674.833129171761, 5018.84943451697, 5075.873103172414, 5088.338515992898, 5097.9490205097845, 5109.821156259551, 6812.250652428229, 6822.4200942919915, 6937.826554336131, 6958.016965164954, 6992.3007699230175, 5152.88250608384, 5162.5869930406225, 5186.170212765939, 5191.0, 5200.947990520122, 5167.715775632301, 5230.189320655229, 5238.790448382022, 5280.709560974184, 5285.471452854761, 5730.627509211888, 5772.480476757112, 5790.218320526759, 5837.562182836305, 5847.649141051551, 6581.572197807127, 6625.370589793962, 6676.599404035774, 6688.899666505006, 6694.230163531159, 1816.418746001267, 1828.597708504127, 1838.3657638114828, 1845.9261629534938, 1849.6115815678859, 1241.0454028951103, 1270.8220849081135, 1285.8971282297393, 1307.405130665545, 1319.5447570588133, 6418.358164183544, 6439.323870993572, 6439.5170362223025, 6465.7369920527435, 6484.513661475408, 6776.424003959719, 6856.451483881277, 6869.896951545731, 6877.037214789933, 6890.517663763489, 6116.755329786848, 6293.181886354744, 6311.905321420182, 6351.2060992375955, 6405.573018435115, 3593.1196856770257, 3596.82015899204, 3603.207294395229, 3612.819359032038, 3613.94579081314, 6934.861302773917, 6961.61711105894, 6962.825929351706, 6980.965095174492, 7076.787696369117, 6820.669969355928, 6860.382565569123, 6900.171979362408, 6913.066735990677, 6970.163580370388, 6889.276625954303, 6932.584044957218, 6950.687219075154, 7036.894446583407, 7064.611446370499, 6707.496937729592, 6738.35985581369, 6843.247242803188, 6856.691448884912, 6890.586564806128, 6720.731170753115, 6728.226253980659, 6748.358905903931, 6756.391924726799, 6767.593944363354, 6908.378245957888, 7043.154821421463, 7075.469339799639, 7091.503594748318, 7109.395701365442, 5180.9740951295, 5182.689038657692, 5229.947700522946, 5253.422123566328, 5257.5005374489365, 6625.966870165618, 6671.498188179433, 6676.599404035774, 6775.457963363017, 6874.518783685294, 6531.902021469777, 6533.607983521004, 6560.475161986934, 6564.5076619252795, 6654.733810647714, 6465.159529261354, 6527.314631963575, 6545.607263564201, 6562.343765623399, 6641.767538136142, 6493.448056915215, 6585.769498067544, 6592.868387515891, 6638.668066596554, 6639.668016599054, 6512.934870651233, 6601.933980660132, 6603.9009414859775, 6630.138082049302, 6650.201975762746, 6380.553361264667, 6404.519661025349, 6487.124238227779, 6491.902621460587, 6498.122753428227], "value": 5180.838454567802, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.2695403246355, 906.8730377747114, 924.4360939826709, 930.5998420679109, 944.2163004706094, 17011.914940425297, 17440.91279543602, 17551.736723949136, 17572.20925058372, 20197.39407817764, 19926.60146797063, 19993.800371977653, 20186.0, 20375.490612734688, 20385.28651497198, 992.9602815887356, 1069.4064794039305, 1070.7216123807789, 1073.3613499967507, 1077.4774234496263, 976.2239019979133, 1073.3613499967546, 1077.3320541264388, 1077.9892201078007, 1078.2883297023966, 1135.2393896089598, 1144.8511693479836, 1146.5070019891443, 1147.0192984997832, 1147.2141583015618, 1129.6949823547636, 1137.601839356227, 1139.7207684117445, 1140.0, 1140.0936255676716, 829.9253067223979, 834.2450082675189, 837.0248660310731, 839.8068444257793, 841.6254766628853, 17992.190351434216, 18308.908455457637, 18976.905115474474, 19038.524036899187, 19043.0, 20566.794332056637, 20881.791182088138, 20891.791082089137, 20932.267370641955, 21373.67939480909, 16206.270717817726, 16284.83715162845, 16495.83504164955, 16586.75119873203, 16595.50213493597, 3610.801405922673, 3636.8908932731797, 3637.5816781069984, 3640.362936486131, 3642.25333806569, 143067.0, 143475.09015894023, 143712.0, 144271.0, 147911.26044369818, 13717.314134293245, 14201.928990354982, 14342.85657143436, 14375.712485750226, 14378.856211437751, 29358.26604334866, 29929.401411971638, 29955.850220748758, 30006.24984375408, 30245.546316805267, 7426.443016773764, 8514.403991720645, 8935.865962010575, 8972.8654070189, 8998.775030624287, 4600.976995115003, 4675.579197872208, 4682.719036857799, 4692.976535117303, 4726.456457507362, 5712.34308054579, 5725.341585717612, 5769.85575360611, 5903.58674892762, 5930.673812940244, 1035.6841163445072, 1043.7077618266896, 1043.780806030742, 1050.6375300521308, 1057.4289883462998, 715.992840071603, 738.770980995893, 740.5482655580092, 749.2133260076897, 755.1844008470838, 12523.812142817866, 13283.667908302177, 13399.598012059654, 13436.865631343562, 13458.394372253271, 753.3257734327746, 753.3897542990195, 762.1502025241927, 777.0869228656306, 782.6008735544913, 6063.998880369468, 6180.598261113103, 6182.474489668429, 6201.286852012076, 6213.502919766408, 130216.0, 130969.34515327553, 132659.0, 134968.27611033566, 135270.0, 119890.4005479967, 120033.39983300203, 121319.39340303242, 122345.38827305807, 126863.365683171, 103298.0, 103755.0, 104589.0, 105279.94720052855, 106177.0, 11951.282923024299, 11971.16201865861, 12259.877401225873, 12337.691557711129, 12399.814002789784, 48777.0, 49007.509924900296, 49109.75445122751, 49453.0, 51175.0, 61885.38114618796, 61963.0, 62263.37736622576, 63414.68292658507, 64045.679771600844, 16671.333146674, 16966.49100526986, 17054.829451705325, 17186.140692965553, 17269.827301726822, 18782.812171878653, 18810.905945470186, 18934.14796334196, 19041.809581904003, 19274.22903083861, 16234.756478652593, 16634.75047874307, 16706.49880503587, 16809.579760506083, 16831.831681683027, 17470.47588572345, 17833.554161146076, 17842.375516856846, 17993.820061799215, 18072.277108915496, 16792.58018549546, 16941.407050753165, 17060.914695426443, 17078.402255920984, 17274.654506910043, 13304.0, 13708.314584270547, 14653.92673036628, 14883.883708722105, 15572.844271557593, 15271.312790924212, 15734.21328933526, 15749.842501574838, 15803.0, 16326.428574999818], "value": 9498.648638622388, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1468.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 113.0, 99.0, 105.0, 106.0, 107.0, 105.0, 100.0, 105.0, 107.0], "value": 104.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 113.0, 139.0, 164.0, 112.0, 139.0, 147.0, 117.0, 167.0, 114.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 170.0, 162.0, 165.0, 162.0, 164.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 190.0, 75.0, 74.0, 77.0, 75.0, 176.0, 74.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 131.0, 78.0, 78.0, 78.0, 127.0, 78.0, 79.0, 129.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 116.0, 113.0, 114.0, 113.0, 115.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 147.0, 148.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 45.0, 45.0, 48.0, 49.0, 44.0, 51.0, 46.0, 46.0, 48.0], "value": 47.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 56.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 72.0, 73.0, 74.0, 73.0, 74.0, 74.0, 74.0, 73.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 134.0, 127.0, 118.0, 116.0, 114.0, 125.0, 117.0, 116.0, 142.0], "value": 122.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 175.0, 162.0, 164.0, 162.0, 158.0, 160.0, 159.0, 159.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 70.0, 62.0, 67.0, 60.0, 60.0, 63.0, 61.0, 60.0, 62.0], "value": 62.5, "unit": "score"}]}]} 07:31:28 INFO - Return code: 0 07:31:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:31:28 INFO - # TBPL SUCCESS # 07:31:28 INFO - Running post-action listener: _package_coverage_data 07:31:28 INFO - Running post-action listener: _resource_record_post_action 07:31:28 INFO - [mozharness: 2017-08-22 14:31:28.795427Z] Finished run-tests step (success) 07:31:28 INFO - Running post-run listener: _resource_record_post_run 07:31:28 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 16384; Write bytes: 386129920; Read time: 40; Write time: 219844 07:31:28 INFO - TinderboxPrint: CPU usage
13.0% 07:31:28 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 40 07:31:28 INFO - TinderboxPrint: I/O write bytes / time
386,129,920 / 219,844 07:31:28 INFO - TinderboxPrint: CPU idle
8,203.8 (87.0%) 07:31:28 INFO - TinderboxPrint: CPU user
1,182.3 (12.5%) 07:31:28 INFO - TinderboxPrint: Swap in / out
0 / 0 07:31:28 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 109977600; Read time: 0; Write time: 84040 07:31:28 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:31:28 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 12288; Write bytes: 276152320; Read time: 20; Write time: 135804 07:31:29 INFO - Running post-run listener: _upload_blobber_files 07:31:29 INFO - Blob upload gear active. 07:31:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:31:29 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 07:31:29 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'] 07:31:29 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 07:31:29 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:31:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:31:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:30 INFO - (blobuploader) - INFO - Done attempting. 07:31:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:31:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:31:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:36 INFO - (blobuploader) - INFO - Done attempting. 07:31:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:31:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:31:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:37 INFO - (blobuploader) - INFO - Done attempting. 07:31:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:31:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:31:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:38 INFO - (blobuploader) - INFO - Done attempting. 07:31:38 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:38 INFO - Return code: 0 07:31:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:31:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f215f91fdc55aa1fa9cbfb3e3dbb16c83e31add9206a8bd234aec5041d68ae2cdf3d6bfe817f720e9b833fa50dc1c534cc643c87f59a319728d5635262d0626a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b81548f6c64f08b53c7edab69432dd3f91af91be3aaa5ce6a0042bd4dd5bc3d0d0e535afa8461c2f5838105dfb46dbc7b4059324142351ab22043154a5e18972", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94df059c278b3f7c7431bf5cca64a5951b4deb28c059e8f26155e97c761271c52cf6c420801c1c45e9afc2a45ebb5307b58f23a6815b235e7970b8b446015cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a878cc0737ad58b1b38ed8c3deeff935618f663b79b8fc0b00b215e434ff2f8053332713d48807eedfdc7ac22ff614219b582582708fd51321207ff668e3c08e"} 07:31:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:31:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:31:38 INFO - Contents: 07:31:38 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f215f91fdc55aa1fa9cbfb3e3dbb16c83e31add9206a8bd234aec5041d68ae2cdf3d6bfe817f720e9b833fa50dc1c534cc643c87f59a319728d5635262d0626a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b81548f6c64f08b53c7edab69432dd3f91af91be3aaa5ce6a0042bd4dd5bc3d0d0e535afa8461c2f5838105dfb46dbc7b4059324142351ab22043154a5e18972", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94df059c278b3f7c7431bf5cca64a5951b4deb28c059e8f26155e97c761271c52cf6c420801c1c45e9afc2a45ebb5307b58f23a6815b235e7970b8b446015cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a878cc0737ad58b1b38ed8c3deeff935618f663b79b8fc0b00b215e434ff2f8053332713d48807eedfdc7ac22ff614219b582582708fd51321207ff668e3c08e"} 07:31:38 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:38 INFO - Copying logs to upload dir... 07:31:38 INFO - mkdir: /builds/slave/test/build/upload/logs 07:31:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.510317 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-08-22 07:31:38.427529) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 07:31:38.435026) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f215f91fdc55aa1fa9cbfb3e3dbb16c83e31add9206a8bd234aec5041d68ae2cdf3d6bfe817f720e9b833fa50dc1c534cc643c87f59a319728d5635262d0626a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b81548f6c64f08b53c7edab69432dd3f91af91be3aaa5ce6a0042bd4dd5bc3d0d0e535afa8461c2f5838105dfb46dbc7b4059324142351ab22043154a5e18972", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94df059c278b3f7c7431bf5cca64a5951b4deb28c059e8f26155e97c761271c52cf6c420801c1c45e9afc2a45ebb5307b58f23a6815b235e7970b8b446015cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a878cc0737ad58b1b38ed8c3deeff935618f663b79b8fc0b00b215e434ff2f8053332713d48807eedfdc7ac22ff614219b582582708fd51321207ff668e3c08e"} build_url:https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/D4mshFvxTweNQ9MMo4rVQg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/f215f91fdc55aa1fa9cbfb3e3dbb16c83e31add9206a8bd234aec5041d68ae2cdf3d6bfe817f720e9b833fa50dc1c534cc643c87f59a319728d5635262d0626a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b81548f6c64f08b53c7edab69432dd3f91af91be3aaa5ce6a0042bd4dd5bc3d0d0e535afa8461c2f5838105dfb46dbc7b4059324142351ab22043154a5e18972", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94df059c278b3f7c7431bf5cca64a5951b4deb28c059e8f26155e97c761271c52cf6c420801c1c45e9afc2a45ebb5307b58f23a6815b235e7970b8b446015cc4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a878cc0737ad58b1b38ed8c3deeff935618f663b79b8fc0b00b215e434ff2f8053332713d48807eedfdc7ac22ff614219b582582708fd51321207ff668e3c08e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-22 07:31:38.464425) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:31:38.464750) ========= 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=20e666a3d4cfbb71505a330e000001b4-1503411052.273256-926796358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-22 07:31:38.544534) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 07:31:38.547863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-22 07:31:38.548189) ========= ========= Total master_lag: 0.22 =========