builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0345 starttime: 1490372584.11 results: success (0) buildid: 20170324073515 builduid: 73f3a1b53d1341f7a30f023d3c68d480 revision: 073e0a5f1fd515d258064c3622de8f79187f15ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.109265) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.109765) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.110037) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.135288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.135577) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgCfNMV1cM/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-24 09:23:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2017-03-24 09:23:04 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149750 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.308611) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.308915) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgCfNMV1cM/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:04.356644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 09:23:04.356980) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 073e0a5f1fd515d258064c3622de8f79187f15ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 073e0a5f1fd515d258064c3622de8f79187f15ba --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgCfNMV1cM/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-24 09:23:04,452 truncating revision to first 12 chars 2017-03-24 09:23:04,452 Setting DEBUG logging. 2017-03-24 09:23:04,453 attempt 1/10 2017-03-24 09:23:04,453 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/073e0a5f1fd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 09:23:05,630 unpacking tar archive at: mozilla-aurora-073e0a5f1fd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.439620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-24 09:23:05.821465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:05.822095) ========= script_repo_revision: 073e0a5f1fd515d258064c3622de8f79187f15ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:05.823000) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:05.823665) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 09:23:05.845695) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-24 09:23:05.846332) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgCfNMV1cM/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:23:06 INFO - MultiFileLogger online at 20170324 09:23:06 in /builds/slave/test 09:23:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:23:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:06 INFO - {'append_to_log': False, 09:23:06 INFO - 'base_work_dir': '/builds/slave/test', 09:23:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:23:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:06 INFO - 'branch': 'Mozilla-Aurora', 09:23:06 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:06 INFO - 'config_files': ('talos/mac_config.py',), 09:23:06 INFO - 'default_actions': ('clobber', 09:23:06 INFO - 'read-buildbot-config', 09:23:06 INFO - 'download-and-extract', 09:23:06 INFO - 'populate-webroot', 09:23:06 INFO - 'create-virtualenv', 09:23:06 INFO - 'install', 09:23:06 INFO - 'run-tests'), 09:23:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:06 INFO - 'download_minidump_stackwalk': True, 09:23:06 INFO - 'download_symbols': 'ondemand', 09:23:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:06 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:06 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:06 INFO - 'gecko_profile': False, 09:23:06 INFO - 'gecko_profile_interval': 0, 09:23:06 INFO - 'installer_path': 'installer.exe', 09:23:06 INFO - 'log_level': 'info', 09:23:06 INFO - 'log_name': 'talos', 09:23:06 INFO - 'log_to_console': True, 09:23:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:06 INFO - 'opt_config_files': (), 09:23:06 INFO - 'pip_index': False, 09:23:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:06 INFO - 'cmd': ('bash', 09:23:06 INFO - '-c', 09:23:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:06 INFO - 'enabled': True, 09:23:06 INFO - 'halt_on_failure': False, 09:23:06 INFO - 'name': 'check_screen_resolution'},), 09:23:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:06 INFO - 'cmd': ('bash', 09:23:06 INFO - '-c', 09:23:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:06 INFO - 'enabled': True, 09:23:06 INFO - 'halt_on_failure': False, 09:23:06 INFO - 'name': 'check_screen_resolution'},), 09:23:06 INFO - 'run_cmd_checks_enabled': True, 09:23:06 INFO - 'suite': 'dromaeojs-e10s', 09:23:06 INFO - 'system_bits': '32', 09:23:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:06 INFO - 'title': 't-yosemite-r7-0345', 09:23:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:06 INFO - 'use_talos_json': True, 09:23:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:06 INFO - 'work_dir': 'build'} 09:23:06 INFO - [mozharness: 2017-03-24 16:23:06.063561Z] Running clobber step. 09:23:06 INFO - Running pre-action listener: _resource_record_pre_action 09:23:06 INFO - Running main action method: clobber 09:23:06 INFO - rmtree: /builds/slave/test/build 09:23:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:07 INFO - Running post-action listener: _resource_record_post_action 09:23:07 INFO - [mozharness: 2017-03-24 16:23:07.058186Z] Finished clobber step (success) 09:23:07 INFO - [mozharness: 2017-03-24 16:23:07.058306Z] Running read-buildbot-config step. 09:23:07 INFO - Running pre-action listener: _resource_record_pre_action 09:23:07 INFO - Running main action method: read_buildbot_config 09:23:07 INFO - Using buildbot properties: 09:23:07 INFO - { 09:23:07 INFO - "project": "", 09:23:07 INFO - "product": "firefox", 09:23:07 INFO - "script_repo_revision": "production", 09:23:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:23:07 INFO - "repository": "", 09:23:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:23:07 INFO - "buildid": "20170324073515", 09:23:07 INFO - "pgo_build": "False", 09:23:07 INFO - "basedir": "/builds/slave/test", 09:23:07 INFO - "buildnumber": 86, 09:23:07 INFO - "slavename": "t-yosemite-r7-0345", 09:23:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:23:07 INFO - "platform": "yosemite_r7", 09:23:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:23:07 INFO - "branch": "mozilla-aurora", 09:23:07 INFO - "repo_path": "releases/mozilla-aurora", 09:23:07 INFO - "revision": "073e0a5f1fd515d258064c3622de8f79187f15ba", 09:23:07 INFO - "stage_platform": "macosx64", 09:23:07 INFO - "builduid": "73f3a1b53d1341f7a30f023d3c68d480", 09:23:07 INFO - "slavebuilddir": "test" 09:23:07 INFO - } 09:23:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 09:23:07 INFO - Running post-action listener: _resource_record_post_action 09:23:07 INFO - [mozharness: 2017-03-24 16:23:07.061414Z] Finished read-buildbot-config step (success) 09:23:07 INFO - [mozharness: 2017-03-24 16:23:07.061502Z] Running download-and-extract step. 09:23:07 INFO - Running pre-action listener: _resource_record_pre_action 09:23:07 INFO - Running main action method: download_and_extract 09:23:07 INFO - mkdir: /builds/slave/test/build/tests 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:07 INFO - trying https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 09:23:07 INFO - Downloading https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 09:23:08 INFO - Downloaded 1199 bytes. 09:23:08 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 09:23:08 INFO - Using the following test package requirements: 09:23:08 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:23:08 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 09:23:08 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 09:23:08 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'jsshell-mac.zip'], 09:23:08 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 09:23:08 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 09:23:08 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 09:23:08 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 09:23:08 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 09:23:08 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 09:23:08 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 09:23:08 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:23:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:23:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:23:08 INFO - Fetch https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:23:10 INFO - Expected file size: 51788072 09:23:10 INFO - Obtained file size: 51788072 09:23:26 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:23:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 09:23:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:23:26 INFO - Fetch https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 09:23:28 INFO - Expected file size: 51788072 09:23:28 INFO - Obtained file size: 51788072 09:23:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 09:23:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:23:43 INFO - Fetch https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 09:23:44 INFO - Expected file size: 14404438 09:23:44 INFO - Obtained file size: 14404438 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:45 INFO - trying https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:23:45 INFO - Downloading https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 09:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 09:23:47 INFO - Downloaded 74666672 bytes. 09:23:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:23:47 INFO - mkdir: /builds/slave/test/properties 09:23:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:47 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:47 INFO - Contents: 09:23:47 INFO - build_url:https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 09:23:47 INFO - Running post-action listener: _resource_record_post_action 09:23:47 INFO - Running post-action listener: set_extra_try_arguments 09:23:47 INFO - [mozharness: 2017-03-24 16:23:47.912144Z] Finished download-and-extract step (success) 09:23:47 INFO - [mozharness: 2017-03-24 16:23:47.912251Z] Running populate-webroot step. 09:23:47 INFO - Running pre-action listener: _resource_record_pre_action 09:23:47 INFO - Running main action method: populate_webroot 09:23:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:47 INFO - '--tppagecycles', 09:23:47 INFO - '7'], 09:23:47 INFO - 'tests': ['tsvgm']}}, 09:23:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['damp', 'tps']}, 09:23:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'tests': ['damp', 'tps']}, 09:23:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['dromaeo_dom']}, 09:23:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['basic_compositor_video']}, 09:23:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:23:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['a11yr', 09:23:47 INFO - 'ts_paint', 09:23:47 INFO - 'tpaint', 09:23:47 INFO - 'sessionrestore', 09:23:47 INFO - 'sessionrestore_no_auto_restore', 09:23:47 INFO - 'tabpaint']}, 09:23:47 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:47 INFO - 'ts_paint', 09:23:47 INFO - 'tpaint', 09:23:47 INFO - 'sessionrestore', 09:23:47 INFO - 'sessionrestore_no_auto_restore', 09:23:47 INFO - 'tabpaint']}, 09:23:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:47 INFO - 'ts_paint', 09:23:47 INFO - 'tpaint', 09:23:47 INFO - 'sessionrestore', 09:23:47 INFO - 'sessionrestore_no_auto_restore', 09:23:47 INFO - 'tabpaint']}, 09:23:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:47 INFO - 'ts_paint', 09:23:47 INFO - 'tpaint', 09:23:47 INFO - 'sessionrestore', 09:23:47 INFO - 'sessionrestore_no_auto_restore', 09:23:47 INFO - 'tabpaint']}, 09:23:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['a11yr', 09:23:47 INFO - 'ts_paint', 09:23:47 INFO - 'tpaint', 09:23:47 INFO - 'sessionrestore', 09:23:47 INFO - 'sessionrestore_no_auto_restore', 09:23:47 INFO - 'tabpaint']}, 09:23:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['a11yr', 09:23:47 INFO - 'ts_paint', 09:23:47 INFO - 'tpaint', 09:23:47 INFO - 'sessionrestore', 09:23:47 INFO - 'sessionrestore_no_auto_restore', 09:23:47 INFO - 'tabpaint']}, 09:23:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['tsvgx', 09:23:47 INFO - 'tsvgr_opacity', 09:23:47 INFO - 'tart', 09:23:47 INFO - 'tscrollx', 09:23:47 INFO - 'cart', 09:23:47 INFO - 'tsvg_static']}, 09:23:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:47 INFO - 'tsvgr_opacity', 09:23:47 INFO - 'tart', 09:23:47 INFO - 'tscrollx', 09:23:47 INFO - 'cart', 09:23:47 INFO - 'tsvg_static']}, 09:23:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'talos_options': ['--disable-e10s'], 09:23:47 INFO - 'tests': ['tp5o']}, 09:23:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'talos_options': ['--disable-e10s', 09:23:47 INFO - '--xperf_path', 09:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:47 INFO - 'tests': ['tp5n']}, 09:23:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:47 INFO - 'talos_options': ['--xperf_path', 09:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:47 INFO - 'tests': ['tp5n']}}, 09:23:47 INFO - 'talos.zip': {'path': '', 09:23:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:47 INFO - Running post-action listener: _resource_record_post_action 09:23:47 INFO - [mozharness: 2017-03-24 16:23:47.931095Z] Finished populate-webroot step (success) 09:23:47 INFO - [mozharness: 2017-03-24 16:23:47.931201Z] Running create-virtualenv step. 09:23:47 INFO - Running pre-action listener: _resource_record_pre_action 09:23:47 INFO - Running main action method: create_virtualenv 09:23:47 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:23:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:48 INFO - Using real prefix '/tools/python27' 09:23:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:48 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:51 INFO - Installing pip.................done. 09:23:51 INFO - Return code: 0 09:23:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:52 INFO - Reading from file tmpfile_stdout 09:23:52 INFO - Output received: 09:23:52 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:23:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:52 INFO - 'HOME': '/Users/cltbld', 09:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:52 INFO - 'LOGNAME': 'cltbld', 09:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:52 INFO - 'MOZ_NO_REMOTE': '1', 09:23:52 INFO - 'NO_EM_RESTART': '1', 09:23:52 INFO - 'PAGER': '/bin/cat', 09:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:52 INFO - 'PWD': '/builds/slave/test', 09:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:52 INFO - 'SHELL': '/bin/bash', 09:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:23:52 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:52 INFO - 'USER': 'cltbld', 09:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:52 INFO - 'XPC_FLAGS': '0x0', 09:23:52 INFO - 'XPC_SERVICE_NAME': '0', 09:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:52 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 09:23:52 INFO - Cleaning up... 09:23:52 INFO - Return code: 0 09:23:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:23:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:52 INFO - 'HOME': '/Users/cltbld', 09:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:52 INFO - 'LOGNAME': 'cltbld', 09:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:52 INFO - 'MOZ_NO_REMOTE': '1', 09:23:52 INFO - 'NO_EM_RESTART': '1', 09:23:52 INFO - 'PAGER': '/bin/cat', 09:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:52 INFO - 'PWD': '/builds/slave/test', 09:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:52 INFO - 'SHELL': '/bin/bash', 09:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:23:52 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:52 INFO - 'USER': 'cltbld', 09:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:52 INFO - 'XPC_FLAGS': '0x0', 09:23:52 INFO - 'XPC_SERVICE_NAME': '0', 09:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:52 INFO - Downloading/unpacking psutil>=3.1.1 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:55 INFO - Installing collected packages: psutil 09:23:55 INFO - Running setup.py install for psutil 09:23:56 INFO - building 'psutil._psutil_osx' extension 09:23:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:23:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:23:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:23:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:23:56 INFO - building 'psutil._psutil_posix' extension 09:23:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:23:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:23:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:23:56 INFO - ^ 09:23:56 INFO - 1 warning generated. 09:23:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:56 INFO - Successfully installed psutil 09:23:56 INFO - Cleaning up... 09:23:56 INFO - Return code: 0 09:23:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:23:56 INFO - 'HOME': '/Users/cltbld', 09:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:23:56 INFO - 'LOGNAME': 'cltbld', 09:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:56 INFO - 'MOZ_NO_REMOTE': '1', 09:23:56 INFO - 'NO_EM_RESTART': '1', 09:23:56 INFO - 'PAGER': '/bin/cat', 09:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:56 INFO - 'PWD': '/builds/slave/test', 09:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:23:56 INFO - 'SHELL': '/bin/bash', 09:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:23:56 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:23:56 INFO - 'USER': 'cltbld', 09:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:56 INFO - 'XPC_FLAGS': '0x0', 09:23:56 INFO - 'XPC_SERVICE_NAME': '0', 09:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:59 INFO - Installing collected packages: mozsystemmonitor 09:23:59 INFO - Running setup.py install for mozsystemmonitor 09:24:00 INFO - Successfully installed mozsystemmonitor 09:24:00 INFO - Cleaning up... 09:24:00 INFO - Return code: 0 09:24:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:00 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:00 INFO - 'HOME': '/Users/cltbld', 09:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:00 INFO - 'LOGNAME': 'cltbld', 09:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:00 INFO - 'MOZ_NO_REMOTE': '1', 09:24:00 INFO - 'NO_EM_RESTART': '1', 09:24:00 INFO - 'PAGER': '/bin/cat', 09:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:00 INFO - 'PWD': '/builds/slave/test', 09:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:00 INFO - 'SHELL': '/bin/bash', 09:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:00 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:00 INFO - 'USER': 'cltbld', 09:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:00 INFO - 'XPC_FLAGS': '0x0', 09:24:00 INFO - 'XPC_SERVICE_NAME': '0', 09:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:00 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:00 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 09:24:00 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 09:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:00 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 09:24:00 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 09:24:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:04 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:04 INFO - warning: no files found matching '*.txt' 09:24:04 INFO - no previously-included directories found matching 'build' 09:24:04 INFO - no previously-included directories found matching 'dist' 09:24:04 INFO - no previously-included directories found matching '.git*' 09:24:04 INFO - Installing collected packages: jsonschema, functools32 09:24:04 INFO - Running setup.py install for functools32 09:24:04 INFO - warning: no files found matching '*.txt' 09:24:04 INFO - no previously-included directories found matching 'build' 09:24:04 INFO - no previously-included directories found matching 'dist' 09:24:04 INFO - no previously-included directories found matching '.git*' 09:24:04 INFO - Successfully installed jsonschema functools32 09:24:04 INFO - Cleaning up... 09:24:04 INFO - Return code: 0 09:24:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:04 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:24:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:04 INFO - 'HOME': '/Users/cltbld', 09:24:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:04 INFO - 'LOGNAME': 'cltbld', 09:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:04 INFO - 'MOZ_NO_REMOTE': '1', 09:24:04 INFO - 'NO_EM_RESTART': '1', 09:24:04 INFO - 'PAGER': '/bin/cat', 09:24:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:04 INFO - 'PWD': '/builds/slave/test', 09:24:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:04 INFO - 'SHELL': '/bin/bash', 09:24:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:04 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:04 INFO - 'USER': 'cltbld', 09:24:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:04 INFO - 'XPC_FLAGS': '0x0', 09:24:04 INFO - 'XPC_SERVICE_NAME': '0', 09:24:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:24:05 INFO - Cleaning up... 09:24:05 INFO - Return code: 0 09:24:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:05 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:05 INFO - 'HOME': '/Users/cltbld', 09:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:05 INFO - 'LOGNAME': 'cltbld', 09:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:05 INFO - 'MOZ_NO_REMOTE': '1', 09:24:05 INFO - 'NO_EM_RESTART': '1', 09:24:05 INFO - 'PAGER': '/bin/cat', 09:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:05 INFO - 'PWD': '/builds/slave/test', 09:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:05 INFO - 'SHELL': '/bin/bash', 09:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:05 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:05 INFO - 'USER': 'cltbld', 09:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:05 INFO - 'XPC_FLAGS': '0x0', 09:24:05 INFO - 'XPC_SERVICE_NAME': '0', 09:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:05 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:05 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 09:24:05 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 09:24:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:05 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 09:24:05 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 09:24:07 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:09 INFO - Downloading docopt-0.6.1.tar.gz 09:24:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:09 INFO - Running setup.py install for blobuploader 09:24:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:09 INFO - Running setup.py install for requests 09:24:09 INFO - Running setup.py install for docopt 09:24:10 INFO - Successfully installed blobuploader requests docopt 09:24:10 INFO - Cleaning up... 09:24:10 INFO - Return code: 0 09:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:24:10 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:10 INFO - 'HOME': '/Users/cltbld', 09:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:10 INFO - 'LOGNAME': 'cltbld', 09:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:10 INFO - 'MOZ_NO_REMOTE': '1', 09:24:10 INFO - 'NO_EM_RESTART': '1', 09:24:10 INFO - 'PAGER': '/bin/cat', 09:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:10 INFO - 'PWD': '/builds/slave/test', 09:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:10 INFO - 'SHELL': '/bin/bash', 09:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:10 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:10 INFO - 'USER': 'cltbld', 09:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:10 INFO - 'XPC_FLAGS': '0x0', 09:24:10 INFO - 'XPC_SERVICE_NAME': '0', 09:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:10 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-EXVufP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:10 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-28ao7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:10 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Sk8BRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:10 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-iItmxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:10 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-A6n7ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:10 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ay87sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-YtqevO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-RGxOgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-_kn1y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-NI4BDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-WGYBJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HvJxk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-o6_fmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HeJIx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:11 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-XC1Bna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:12 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-59ut7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:12 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-aZClID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:12 INFO - Running setup.py install for manifestparser 09:24:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:12 INFO - Running setup.py install for mozcrash 09:24:12 INFO - Running setup.py install for mozdebug 09:24:12 INFO - Running setup.py install for mozdevice 09:24:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:12 INFO - Running setup.py install for mozfile 09:24:12 INFO - Running setup.py install for mozhttpd 09:24:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Running setup.py install for mozinfo 09:24:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Running setup.py install for mozInstall 09:24:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Running setup.py install for mozleak 09:24:13 INFO - Running setup.py install for mozlog 09:24:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Running setup.py install for moznetwork 09:24:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:13 INFO - Running setup.py install for mozprocess 09:24:14 INFO - Running setup.py install for mozprofile 09:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:14 INFO - Running setup.py install for mozrunner 09:24:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:14 INFO - Running setup.py install for mozscreenshot 09:24:14 INFO - Running setup.py install for moztest 09:24:14 INFO - Running setup.py install for mozversion 09:24:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:14 INFO - Cleaning up... 09:24:14 INFO - Return code: 0 09:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:24:14 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:14 INFO - 'HOME': '/Users/cltbld', 09:24:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:14 INFO - 'LOGNAME': 'cltbld', 09:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:14 INFO - 'MOZ_NO_REMOTE': '1', 09:24:14 INFO - 'NO_EM_RESTART': '1', 09:24:14 INFO - 'PAGER': '/bin/cat', 09:24:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:14 INFO - 'PWD': '/builds/slave/test', 09:24:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:14 INFO - 'SHELL': '/bin/bash', 09:24:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:14 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:14 INFO - 'USER': 'cltbld', 09:24:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:14 INFO - 'XPC_FLAGS': '0x0', 09:24:14 INFO - 'XPC_SERVICE_NAME': '0', 09:24:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0oiZmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:15 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-0g1WTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:15 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-8tsJ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:15 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-2H4to9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-6tcE1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:15 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-h3ghfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:15 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-zlAJWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-kGur1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-i1LS5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-iTS_77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-yjo2co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-13R7u6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-eO7Q4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Jo5hfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-myDrG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HrZzY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:16 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)) 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:16 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-fk4t0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:16 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)) 09:24:16 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)) 09:24:16 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)) 09:24:16 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)) 09:24:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:16 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:16 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 09:24:16 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 09:24:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:16 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 09:24:16 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 09:24:19 INFO - Downloading blessings-1.6.tar.gz 09:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:19 INFO - Installing collected packages: blessings 09:24:19 INFO - Running setup.py install for blessings 09:24:19 INFO - Successfully installed blessings 09:24:19 INFO - Cleaning up... 09:24:19 INFO - Return code: 0 09:24:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:20 INFO - Reading from file tmpfile_stdout 09:24:20 INFO - Current package versions: 09:24:20 INFO - blessings == 1.6 09:24:20 INFO - blobuploader == 1.2.4 09:24:20 INFO - docopt == 0.6.1 09:24:20 INFO - functools32 == 3.2.3-2 09:24:20 INFO - jsonschema == 2.5.1 09:24:20 INFO - manifestparser == 1.1 09:24:20 INFO - mozInstall == 1.12 09:24:20 INFO - mozcrash == 1.0 09:24:20 INFO - mozdebug == 0.1 09:24:20 INFO - mozdevice == 0.49 09:24:20 INFO - mozfile == 1.2 09:24:20 INFO - mozhttpd == 0.7 09:24:20 INFO - mozinfo == 0.9 09:24:20 INFO - mozleak == 0.1 09:24:20 INFO - mozlog == 3.4 09:24:20 INFO - moznetwork == 0.27 09:24:20 INFO - mozprocess == 0.25 09:24:20 INFO - mozprofile == 0.28 09:24:20 INFO - mozrunner == 6.13 09:24:20 INFO - mozscreenshot == 0.1 09:24:20 INFO - mozsystemmonitor == 0.3 09:24:20 INFO - moztest == 0.8 09:24:20 INFO - mozversion == 1.4 09:24:20 INFO - psutil == 3.1.1 09:24:20 INFO - requests == 1.2.3 09:24:20 INFO - wsgiref == 0.1.2 09:24:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 09:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:20 INFO - 'HOME': '/Users/cltbld', 09:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:20 INFO - 'LOGNAME': 'cltbld', 09:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:20 INFO - 'MOZ_NO_REMOTE': '1', 09:24:20 INFO - 'NO_EM_RESTART': '1', 09:24:20 INFO - 'PAGER': '/bin/cat', 09:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:20 INFO - 'PWD': '/builds/slave/test', 09:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:20 INFO - 'SHELL': '/bin/bash', 09:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:20 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:20 INFO - 'USER': 'cltbld', 09:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:20 INFO - 'XPC_FLAGS': '0x0', 09:24:20 INFO - 'XPC_SERVICE_NAME': '0', 09:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 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)) 09:24:20 INFO - Cleaning up... 09:24:20 INFO - Return code: 0 09:24:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:20 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x106025b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106028768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe85a57b670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:24:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:24:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:20 INFO - 'HOME': '/Users/cltbld', 09:24:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:20 INFO - 'LOGNAME': 'cltbld', 09:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:20 INFO - 'MOZ_NO_REMOTE': '1', 09:24:20 INFO - 'NO_EM_RESTART': '1', 09:24:20 INFO - 'PAGER': '/bin/cat', 09:24:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:20 INFO - 'PWD': '/builds/slave/test', 09:24:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:20 INFO - 'SHELL': '/bin/bash', 09:24:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:20 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:20 INFO - 'USER': 'cltbld', 09:24:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:20 INFO - 'XPC_FLAGS': '0x0', 09:24:20 INFO - 'XPC_SERVICE_NAME': '0', 09:24:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:20 INFO - Cleaning up... 09:24:20 INFO - Return code: 0 09:24:20 INFO - Running post-action listener: _resource_record_post_action 09:24:20 INFO - Running post-action listener: _start_resource_monitoring 09:24:20 INFO - Starting resource monitoring. 09:24:20 INFO - [mozharness: 2017-03-24 16:24:20.745498Z] Finished create-virtualenv step (success) 09:24:20 INFO - [mozharness: 2017-03-24 16:24:20.746473Z] Running install step. 09:24:20 INFO - Running pre-action listener: _resource_record_pre_action 09:24:20 INFO - Running main action method: install 09:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:21 INFO - Reading from file tmpfile_stdout 09:24:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:21 INFO - Reading from file tmpfile_stdout 09:24:21 INFO - Output received: 09:24:21 INFO - Usage: mozinstall [options] installer 09:24:21 INFO - Options: 09:24:21 INFO - -h, --help show this help message and exit 09:24:21 INFO - -d DEST, --destination=DEST 09:24:21 INFO - Directory to install application into. [default: 09:24:21 INFO - "/builds/slave/test"] 09:24:21 INFO - --app=APP Application being installed. [default: firefox] 09:24:21 INFO - mkdir: /builds/slave/test/build/application 09:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:24:41 INFO - Reading from file tmpfile_stdout 09:24:41 INFO - Output received: 09:24:41 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:24:41 INFO - Running post-action listener: _resource_record_post_action 09:24:41 INFO - [mozharness: 2017-03-24 16:24:41.135451Z] Finished install step (success) 09:24:41 INFO - [mozharness: 2017-03-24 16:24:41.135594Z] Running run-tests step. 09:24:41 INFO - Running pre-action listener: _resource_record_pre_action 09:24:41 INFO - Running main action method: run_tests 09:24:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:24:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:24:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:24:41 INFO - 2017-03-24 09:24:41.150 screenresolution[1960:15925] starting screenresolution argv=screenresolution get 09:24:41 INFO - 2017-03-24 09:24:41.152 screenresolution[1960:15925] Display 0: 1600x1200x32@60 09:24:41 INFO - 2017-03-24 09:24:41.158 screenresolution[1961:15928] starting screenresolution argv=screenresolution list 09:24:41 INFO - Available Modes on Display 0 09:24:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:24:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:24:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:24:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:24:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:24:41 INFO - Intel Iris: 09:24:41 INFO - Chipset Model: Intel Iris 09:24:41 INFO - Type: GPU 09:24:41 INFO - Bus: Built-In 09:24:41 INFO - VRAM (Dynamic, Max): 1536 MB 09:24:41 INFO - Vendor: Intel (0x8086) 09:24:41 INFO - Device ID: 0x0a2e 09:24:41 INFO - Revision ID: 0x0009 09:24:41 INFO - Displays: 09:24:41 INFO - Display: 09:24:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:24:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:24:41 INFO - Display Serial Number: 1600x1200 60 09:24:41 INFO - Main Display: Yes 09:24:41 INFO - Mirror: Off 09:24:41 INFO - Online: Yes 09:24:41 INFO - Rotation: Supported 09:24:41 INFO - Return code: 0 09:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:41 INFO - Python 2.7.3 09:24:41 INFO - Return code: 0 09:24:41 INFO - grabbing minidump binary from tooltool 09:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 09:24:41 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/macosx64/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 0x105e03d30>, '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 0x105d2adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105df8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:41 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:24:41 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:24:41 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:24:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:41 INFO - Return code: 0 09:24:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:24:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:41 INFO - ENV: RUST_BACKTRACE is now 1 09:24:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:24:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 09:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --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 09:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgCfNMV1cM/Render', 09:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:41 INFO - 'HOME': '/Users/cltbld', 09:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:41 INFO - 'LOGNAME': 'cltbld', 09:24:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:41 INFO - 'MOZ_NO_REMOTE': '1', 09:24:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:41 INFO - 'NO_EM_RESTART': '1', 09:24:41 INFO - 'PAGER': '/bin/cat', 09:24:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:41 INFO - 'PWD': '/builds/slave/test', 09:24:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:41 INFO - 'RUST_BACKTRACE': '1', 09:24:41 INFO - 'SHELL': '/bin/bash', 09:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners', 09:24:41 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 09:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:41 INFO - 'USER': 'cltbld', 09:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:41 INFO - 'XPC_FLAGS': '0x0', 09:24:41 INFO - 'XPC_SERVICE_NAME': '0', 09:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--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 09:24:41 INFO - mozversion application_buildid: 20170324073515 09:24:41 INFO - mozversion application_changeset: 073e0a5f1fd515d258064c3622de8f79187f15ba 09:24:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:24:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:41 INFO - mozversion application_name: Firefox 09:24:41 INFO - mozversion application_remotingname: firefox-dev 09:24:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:24:41 INFO - mozversion application_vendor: Mozilla 09:24:41 INFO - mozversion application_version: 54.0a2 09:24:41 INFO - mozversion platform_buildid: 20170324073515 09:24:41 INFO - mozversion platform_changeset: 073e0a5f1fd515d258064c3622de8f79187f15ba 09:24:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:24:41 INFO - mozversion platform_version: 54.0a2 09:24:41 INFO - using testdate: 1490372681 09:24:41 INFO - actual date: 1490372681 09:24:41 INFO - starting webserver on 'localhost:52772' 09:24:41 INFO - SUITE-START | Running 2 tests 09:24:41 INFO - TEST-START | dromaeo_css 09:24:41 INFO - operating with platform_type : mac_ 09:24:41 INFO - Initialising browser for dromaeo_css test... 09:24:41 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpR_1e1j/profile http://localhost:52772/getInfo.html) 09:24:44 INFO - PROCESS | 1971 | 2017-03-24 09:24:44.595 plugin-container[1973:16104] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b3f, name = 'com.apple.tsm.portname' 09:24:44 INFO - PROCESS | 1971 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:44 INFO - PROCESS | 1971 | 2017-03-24 09:24:44.598 plugin-container[1973:16104] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 09:24:44 INFO - PROCESS | 1971 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:44 INFO - PROCESS | 1971 | 2017-03-24 09:24:44.598 plugin-container[1973:16104] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:24:44 INFO - PROCESS | 1971 | __metrics Screen width/height:1600/1200 09:24:44 INFO - PROCESS | 1971 | colorDepth:24 09:24:44 INFO - PROCESS | 1971 | Browser inner width/height: 1024/689 09:24:44 INFO - PROCESS | 1971 | __metrics 09:24:44 ERROR - PROCESS | 1971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 09:24:45 INFO - TEST-INFO | 1971: exit 0 09:24:45 INFO - Browser initialized. 09:24:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:45 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpR_1e1j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:48 INFO - PROCESS | 1974 | 2017-03-24 09:24:48.103 plugin-container[1975:16234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 09:24:48 INFO - PROCESS | 1974 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:48 INFO - PROCESS | 1974 | 2017-03-24 09:24:48.103 plugin-container[1975:16234] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c13, name = 'com.apple.CFPasteboardClient' 09:24:48 INFO - PROCESS | 1974 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:24:48 INFO - PROCESS | 1974 | 2017-03-24 09:24:48.103 plugin-container[1975:16234] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:24:57 INFO - PROCESS | 1974 | RSS: Main: 220909568 09:24:57 INFO - PROCESS | 1974 | 09:28:01 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:52772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52772/tests/dromaeo/cssquery-ext.html) 09:28:03 INFO - PROCESS | 1974 | RSS: Main: 241123328 09:28:03 INFO - PROCESS | 1974 | 09:29:46 INFO - PROCESS | 1974 | ************************* 09:29:46 INFO - PROCESS | 1974 | A coding exception was thrown and uncaught in a Task. 09:29:46 INFO - PROCESS | 1974 | 09:29:46 ERROR - PROCESS | 1974 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:29:46 INFO - PROCESS | 1974 | Full stack: 09:29:46 INFO - PROCESS | 1974 | ************************* 09:31:05 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:52772/tests/dromaeo/cssquery-ext.html (next: http://localhost:52772/tests/dromaeo/cssquery-jquery.html) 09:31:06 INFO - PROCESS | 1974 | RSS: Main: 249864192 09:31:06 INFO - PROCESS | 1974 | 09:34:08 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:52772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52772/tests/dromaeo/cssquery-mootools.html) 09:34:09 INFO - PROCESS | 1974 | RSS: Main: 256499712 09:34:09 INFO - PROCESS | 1974 | 09:37:11 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:52772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52772/tests/dromaeo/cssquery-prototype.html) 09:37:11 INFO - PROCESS | 1974 | RSS: Main: 252719104 09:37:11 INFO - PROCESS | 1974 | 09:40:14 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:52772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52772/tests/dromaeo/cssquery-yui.html) 09:40:15 INFO - PROCESS | 1974 | RSS: Main: 257957888 09:40:15 INFO - PROCESS | 1974 | 09:43:17 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:52772/tests/dromaeo/cssquery-yui.html (next: http://localhost:52772/tests/dromaeo/cssquery-dojo.html) 09:43:18 INFO - PROCESS | 1974 | RSS: Main: 253960192 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | __start_tp_report 09:43:18 INFO - PROCESS | 1974 | _x_x_mozilla_page_load 09:43:18 INFO - PROCESS | 1974 | _x_x_mozilla_page_load_details 09:43:18 INFO - PROCESS | 1974 | |i|pagename|runs| 09:43:18 INFO - PROCESS | 1974 | |0;dojo.html;3497.6677215664513;3518.683318501333;3531.0995696097493;3534.5405097337343;3534.7525673202886;6136.417040381168;6151.661658608775;6151.938480615193;6177.104319873616;6211.658358790265;6139.293981192153;6213.565050446459;6214.005759078548;6221.626702397859;6227.657478838662;5439.102548079562;5519.69641669708;5527.778888844441;5532.170174473841;5595.552355811546;5592.133219351007;5599.832005039855;5605.081622821615;5606.803761868336;5634.098544232903;4609.262517997121;5366.838994830161;5380.3274590676165;5595.328560572737;5601.691906945116;5487.6158668892995;5535.833924982217;5548.361938377098;5558.082916318803;5588.469095435927;5384.138537833967;5480.342358916955;5498.862528436781;5517.36550296717;5534.059209934321;5804.245448091763;6130.264368275835;6149.13912052313;6192.690365481753;6204.100405441186;6293.46505547029;6324.841878953063;6367.140436041122;6420.293767685551;6439.291677915426;6648.202215734143;6653.7671181508895;6663.700133493956;6675.065490831287;6689.665516724193;5778.768849245983;6189.288231853305;6226.470749986257;6239.126522286883;6286.654234017173;6228.283747369111;6456.515761317826;6641.468682505388;6663.966680166568;6684.732610695615;5622.690752008597;6138.754449821957;6407.295197528269;6428.774992875227;6434.80695579124;6510.804675859732;6555.442787363032;6603.075569420285;6606.537542371988;6607.174103237096;6201.56589038772;6260.342664020303;6397.264314603787;6398.840028999219;6491.7078731457195;6210.037444196157;6488.188976377953;6508.349165083454;6527.640979746159;6532.5753826001155;4344.23975804233;4369.453818272716;4423.933640995388;5116.872078198;5234.26720259164;4624.491305956342;4676.111538807616;4704.670673052853;4709.552592503706;4761.738104404221;5227.215917612389;5999.5500337473995;6068.4538391544975;6255.937440625627;6275.529335299871;6411.038344248307;6425.74297028123;6503.837404064841;6512.804615861532;6572;6210.472109870711;6212.47193988516;6219.098230756515;6243.500519958392;6258.030005349178;4848.636352273594;5383.650062745909;5786.218860453869;5817.825465236049;5837.124431335334;6347.619142851444;6414;6629.635370054693;6701.229358623626;6830.726770929206;6473.546851720334;6592.24189218246;6598.571092878948;6611.537192396486;6623.304553021863;6832.658367081725;6834.2482326943;6839.863202736017;6840.110785597841;6843.726250950105;6286.4342209201395;6321.399467050623;6337.809865704036;6474.9963755617955;6509.251436084911;5493.148561972901;6522.21733391996;6580.8354791130605;6587.209534855848;6607.141071660845;5330.680159190461;6340.334264902303;6384.010478375859;6394.392532709385;6400.23197216337;6181.165542651865;6268.310485846644;6274.623522588659;6290.842728931813;6385.265694445013;5115.4373018967135;6057.727402266997;6263.812085637438;6300.432961033529;6329.46199573023;6346.873062538816;6400.199975003125;6402.839929001812;6419.422251997343;6423.4861211103935;5445.50990410849;5970.791022314198;6134.14122022926;6202.72087756043;6311.842203944938 09:43:18 INFO - PROCESS | 1974 | |1;ext.html;706.1808302369253;741.792298156516;828.353883970503;961.8990006049364;961.9326647134703;39114.413283800764;39592.60407395925;41531.58468415319;41551.79224103883;41554.75335739933;39604.80197599008;39804.8058558243;39812.203755924864;39829.004274893145;39956.40065399021;7767.883481747765;10536.736581585445;10774;10874.72813179669;10878.292910960801;10539.104176144998;10638.734031649194;10658.0940620047;10658.946705266462;10662.78674426511;10684;10688.732781680443;10694.51874665638;10702.625408110718;10709.25035247533;10620.309679870783;10631.52158152885;10641.255112142191;10666.839997400046;10672.733181670443;10388.168946484264;10427.165826733919;10430.739231519197;10439.79120417595;10457.633982810641;34348.79779207716;34530.964071077906;34567.4814877777;34600.826995865114;34723.82638086793;3228.531862879869;3741.8129093545213;3811.4663947047434;3815.236952609489;3971.007248187953;25182.49635007308;25414;25498.87250563735;26620.935162593472;26728.59907101395;3061.785675002751;3094.226443389153;3116.0340294508774;3128.99872040947;3210.486322188462;334761;349454;368066;385352;385947.0702646469;43776;43838.34242486365;44148.55851441509;44156.3376549352;44187.55812441834;38539.807300963876;44904.3264351035;45729.31406028912;45773;45824.54175458203;11000.394978276112;13682;13711.588652340446;13742.244176570384;13804.654883627989;12115.878841211652;12117.575884843987;12117.69705757363;12145.574904878464;12160.939195304143;11998.760024799456;12023.458944347525;12051.337176455203;12067.637970860887;12101.576444824388;5076.949230507722;5775.653460792282;5798.420157984252;5819.73811178498;5827.679477628772;965.8213230552229;1120.618989543559;1141.7374003979132;1161.35544772652;1187.6080893305189;26485.940562377287;26536.60195097075;26594.202173934813;26640;26778.330541736614;1082.4154956323655;1102.8365074845954;1241.7268200995766;1296.9114074661607;1310.2073245686413;14580.927095364455;14811.333489992976;15067.397304107932;15178.620534486727;15183.468578599917;519093;521669;522328;522421;522584;50433;50782.74608626933;50896.74551627218;50938.490615093375;51113;1315.2174456198547;1471.8078356531244;1503.5789978805951;1508.9094654320556;1509.433962264151;27755.722442775314;29954.400911982073;30242.24394390158;30277.091687249416;30370.848145760014;49820.750896245285;49914;50060;50084;50249;425916.6112508377;493140;515926;516851;517337;28509.144725658265;29182.27044323909;35464.64535354613;35478.93563193108;35701.64298356983;44318.77840610776;44450.66648000565;44684.776576116914;45208.32187517124;45712.31431528596;31497.685023149475;32119.678803212602;32283;32799.18002049872;33108.33783324272;36518.45222321614;36662.450063248536;37410;37461.43807842939;37514.437283441315;35742.7867576712;36147.192640368405;36521.45217821788;36679.08302292357;36944.26111477809;24631.753682463663;26419.207423777316;32461.02616921496;32840.178995525304;33010;21440;22609;24667.753322467262;25283.74716252814;25302.240932772045 09:43:18 INFO - PROCESS | 1974 | |2;jquery.html;415.39145152351836;429.9974908613234;430.87289249671335;440.78181300256375;441.3908805847929;19751.703724444127;20340.08469618867;20818.89590552049;21040.684389734168;21193.682094768592;19768.60462790747;21444.678329825067;21756.129754809826;21973.011214495345;21977.120915163374;5672.744726487318;6171.938280617182;6563.048357988089;6576.342365763409;6649.368310010565;6406.263279722845;6901.723931042752;7230.096237970254;7355.411567074621;7388.113426388814;7131.572105673677;7288.453365997545;7340.853182936365;7355.668994895243;7376.299251571092;7217.603031833247;7291.197968223491;7302.598357090358;7328.450366222554;7332.266773322678;7001.82495437613;7116.323949224816;7146.749863754743;7183.281671832827;7189.964050179716;25127;25711.97152113913;25791.226263212135;25892.22323330303;26216;2904.12876137158;2963.6888126746812;2976.285691434062;2977.702229777027;2978.4638765022287;15521.456749013843;16233;16350.264238109314;16417.67164656712;16886.493405197863;2094.371688493461;2099.895005249731;2122.5330427305967;2133.1467413034757;2163.0266380129005;112284;133702;163785.9999999988;164264;168493;20248.785072895673;20816.791832081486;21031.94840257981;21077.47306317324;21303.46741331448;31347.529787053212;32001.51997720036;32104.83947580294;32122.518162227585;32129.196770080936;10250.282480226313;10288.434136122585;10368.585256589802;10498.265121441578;10616.363018218932;7296.562206267641;8713.390062695551;8724.258438032712;8737.859224490041;8862.955685221661;7739.651715672809;7966.442349035628;8042.396820238506;9602.855957160647;9666.323357365058;3555.5733312002726;4148.62662360389;4195.91608167835;4196.181744559782;4221.7255878367805;737.2627372627372;871.4553404122423;889.5107690770051;921.6313474610209;931.7810314576069;18306.542336441697;18530.44408667742;19377.80622193788;20476.078576464093;21038.894805525873;880.9427387219811;912.2610685344891;935.6023689931752;936.7517607833929;946.7822400847843;9125.269978401711;10387.84418233727;10512.737181570523;10754.623588174376;10813.18901082422;425093;428152;428970;683469;760122;149718;155462;160066;160337.19831401002;163610;1184.1474138620179;1250.9061820363509;1278.4438769135456;1289.8387701537308;1294.779887419141;18367.54081147982;19193.80806191976;19501.51246218856;19694.409167724993;19783.307584234484;68185;68701;68812.62374752577;69272.6536367335;70433.6478317605;79381.0154746136;80093;91778.08221917695;98130.50934745281;99534.00465995248;9488.573014214238;11658.76682466329;11668.30809532596;12030;12119.151659383759;12952.611421657366;12961.675958100746;13046.282454465096;13311.733765324832;13330.533431330245;9402.905970940477;11006.669799906016;11145.888541114486;11422.657320280405;11578.478968446272;9986.800263994824;10989.505472253608;11158.330500170016;11197.160212983896;11510.712232193928;11446.198766086294;11633.418329083343;11651.88348116508;11751;11876;10093.798124037332;11574;11626.709332266422;11712.824307635221;11919.582814601446;9680.612775488902;11157.27477713946;11302.587176602925;11431.885681143081;11531.8270225945 09:43:18 INFO - PROCESS | 1974 | |3;mootools.html;1331.3343328335832;1348.878600925917;1485.3167542930264;1552.860242578168;1561.9687606247876;10692.465376731161;11210.66368008959;11369.204155709092;11403.885961140386;11542.422878856045;11137.777244455106;11341.773164536704;11393.48729307181;11416.086713062956;11462.426878656075;2200.9449763755874;2245.8546141467887;2370.5614461324667;2394.676718642987;2395.4490467192554;2302.2747834432184;2374.7031621047367;2380.702412198475;2382.5473160099614;2386.0455817672896;2331.5803155432013;2360.398098484884;2372.6678265042906;2385.916492922748;2398.736139024706;2289.072925465173;2349.706286714161;2357.7406485286606;2367.4199821043953;2372.395039264985;2346.988265058681;2352.259038402915;2377.1442280778906;2379.4170428245016;2381.618940969454;11028;11251.774964500746;11252.437378131142;11256.718582035515;11292.491837867316;5624.606277560572;5800.564957628195;5809.535237181015;5813.563982701272;5817.185594016841;3568.2149927016017;3585.6055833858254;3667.889963301105;3709.7403181777286;3734.775913445202;1175.8941695247383;1181.4742439614374;1195.593498210604;1231.0828432817518;1234.8950339221176;10837.078848297904;13102.213867167906;13476.730465390638;15614;15783.210839457981;4385.451818522684;4750.026244619845;4937.259411088366;4972.5276098770555;4976.477469865612;13028.153170043917;13099.476020959246;13135.343232838512;13149;13170.868291317156;5882.294124705063;5960.791372301948;5996.760129594767;6001.939980600138;6003.459688628044;5248.239005344204;5273.762680679379;5304.389995150607;5322.520973112439;5332.92000619991;3841.4237864320576;4026.6979976501293;4120.443740095049;4182.53992060873;4185.748855068706;1072.5602502973743;1133.9036181924628;1135.074913945132;1147.20269412759;1160.2458402038742;704.6476761619191;786.2491320788633;799.0770659887838;815.804206990318;821.593311310893;6063.029915213545;6301.180846489927;6622.304658010936;6718.764843230463;6908.896366554506;874.807542340684;1042.781015986636;1047.2041248650928;1073.5061871539024;1080.36258607422;4060.939085913714;4093.91812163761;4240.597143271384;4308.849190278325;4318.892027699333;13104.541341053018;13684.589462316146;13691.041627086208;13705.862941370458;13713.0400871938;12111.273323600612;13405.463781448632;13422.597322080353;13694.589162324946;13705;8299.502029878227;10218.744531386776;10222.591096356062;10418.062374386342;10436.16510679159;6483.416492515507;6541.411272985454;6566;6685.8997115044285;6703.363180497845;12199.634010979686;12305.323207223331;12355.011599072232;12409.06931980087;12471.625851224479;10646.574137034431;11264.887351126385;12453.06602004835;12521.186122901981;13028.41372138275;8212.343012558862;8443;8498.70254541088;8539.8719019216;8553.315734741082;10155.086042256233;10193.286469947032;10244.846327305246;10291.22815788804;10387.428691422045;9189.678361257324;9237.722868313962;9258.861117083114;9268.304877134107;9390.248780097712;8917.643294268157;8960;8983.640654374014;9089.409188402733;9180.770480738034;7775.339096176662;7886.526808391515;7922.643481043482;7930.167332430243;7953.32396746283;5610.102383618601;5628;5774.769009239583;5781.595288329777;5849.736761845642;5821.79623713168;5854.5609079320075;5889.087191485327;5929.288485381781;5986.6707331097205 09:43:18 INFO - PROCESS | 1974 | |4;prototype.html;372.1143678046253;373.60771190250233;384.6326757946161;390.61719514875404;392.5093632958802;4553.112143132086;4658.16002678942;5050.964552266791;5324.600654950875;5395.838124856261;4106.548279689239;4201.852935147271;5086.949130508694;5223.843284701456;5261.447872877501;3873.477080594126;4030.455888455065;4060.837566497344;4066.512018557777;4114.362273847559;3517.4723791431234;3541.707276843946;3913.4912461380122;3987.484755792809;4032.4556184914954;3341.298327351259;4144.735855564052;4171.228322760284;4172.436721042651;4204.789760511978;3990.8403663853555;4020.7386519876113;4035.4148648446103;4084.8570300039655;4100.528439229482;3085.305806193611;3635.2547727715755;3660.359437098524;3668.3396988542054;3675.5956844747056;4508.211063063951;4721.976390118028;5108.897822043538;5230.495567969431;5261.394939581959;4508;4540.432445944257;4591.517890621503;4758.547937945889;4761.809547613097;5591.944080559183;5641.210230567724;5694.743736531866;5742.97128514359;5743.157137217063;4055.6958228133008;4109.767069879024;4112.732672376286;4130.542327315273;4138.8344466221315;5603.7430445200125;5683.976884160849;5787.942120578782;5860.413958604148;5893.970530147321;3882.4176373544196;4109.73964319623;4128.793560321972;4145.2952997990415;4221.324588065895;3663.4796559428073;4287.121140166259;4294.677899157576;4309.7932578877335;4318.481782186158;4234.179676922251;4377.759223242689;4510.977445112753;4819.542143496362;4821.180399332122;5581.944180558143;5584.329880414376;5584.692841893653;5602.411746766612;5695.5443564514735;1565.3269094289565;1572.4339237874356;1605.7912471378645;1628.6335574495645;1761.1595882302768;1220.854404142571;1288.8388951381078;1321.7422602592403;1385.9376328065262;1396.57404491629;4347.7173983690955;4429.645628349725;4680.180968330528;4976.968655389146;5135.563477104413;5805.793798356682;5864.44287792659;5878.118282257696;5886.676232807236;5947.156381521742;4511.233090374644;4869.610431165498;4982.6512144149565;5141.974290128525;5219.799446127412;2773.7240869200396;2860.6424196975377;2967.1840243933093;3042.8243805679044;3079.39951709419;5682;6000.859836631026;6106.328303886569;6147.7273295060395;6174.228221472316;5196.662216955886;5217.68693878361;5494.532964698045;5881.529617595601;5972.431854302691;5301.098813201842;5594.293740409133;5717.714114294268;5900.551271222481;5971.701414929236;5190.766415511235;5219.425863154974;5295.602829787705;5860.472557469848;5873.559483038704;4804.447488538863;4811.831585894477;5783;5804.883902322014;5823.7379317929945;4761.714297142183;5390.865228369322;5546.306711661043;5899.823005309848;6288.748450062129;4718.575328220477;4723.284111635754;4730.526947305242;4748.358971538936;4781.947971446276;5689.630174038674;5714.314282286152;5977.462028417463;6009.128676341818;6040;5325.520703136736;5348.438413966477;5555.416681248411;5800.854978625399;5806.68063256525;4860.063348687433;5001.24981252815;5571.554275658019;5652;5692.7722891083895;4923.950760492493;5276;5457.645253058538;5516.696581688046;5559.803877468458;4940.333055037668;5230.704656066654;5695.629784064023;5713.857153571194;5713.914291285717;4724.173269677862;4731.526847315241;5559.555235581225;5580.693061881473;5641.9435805641415 09:43:18 INFO - PROCESS | 1974 | |5;yui.html;696.9825754356137;700.7232143303395;762.9122650895149;773.9264769846865;855.7946092937693;15110.622234444145;15472.149031803247;16148.59628509285;16175.11036892972;16197.514074577766;15020.474283400083;15049.548513544583;15222.467213647524;15223.54329370118;15233.619159521017;764.8814433762776;881.8544940084878;935.9204467620226;947.526236881561;971.0968799016912;880.1286726141138;923.1045885491063;934.1125930366179;935.7005758157393;939.3706216834703;979.2606582030556;981.0679854138561;982.6167794560128;983.1986930651532;983.6016413352604;966.9323147379686;980.0248752491245;982.0670363154995;983.7196399026315;990.7572644702058;725.3218240944681;736.686908064076;738.2764890407377;739.7558805594194;739.8089076586691;15855.762163567555;16228.675426491522;16311.91844040784;16402.09788461634;16747.581310467212;13857.4457021719;14023.579292621238;14068.859311406857;14107.647308817259;14140.929295353457;11696.532138714441;11775.175737698364;11854.585089521825;11860.169788114836;11870.762584748343;3314.419976504126;3565.447355659877;3640.854365825364;3670.4127339625798;3816.732828701992;102591.46112808239;116400.25399619012;121394;121756;122281.38859305647;10520.02093040643;10586.10018148466;10780.892191078146;10949.616763413242;10950.178736594788;22390.440238994157;22398;22400.663990040164;22412.215572454887;22419.663705044437;7451.515651482637;7500.437467189873;7719.922800772033;7818.061832580127;7876.448648594658;4203.831846726158;4233.470816147981;4253.404523366731;4294.656427485794;4426.84506042287;3436.6735160159747;3519.1905861651962;3527.9294414112087;3530.3115892400733;3541.327147841902;550.7906995341824;653.4315145823165;656.7701304543372;666.8866292730247;673.3064943108606;668.2815972829131;692.2313489035462;695.7112798188796;709.3899246647878;717.2110678253879;8685.739427817176;9448.669296574724;9697.175740062174;10164.593416263267;10321.432321222255;631.3686313686313;664.3223911610131;678.8472593666386;697.7557854750796;711.6868577825741;4739.905201895943;4834.419869615669;4834.806607735652;4848.0788650156355;4852.441969173519;104184;104395.4780226094;105960;106586;107070;71970;78226;85456.14543854607;86200.56899715461;87038.56480717556;67873.66063169751;68815;72824.17939551553;73710.63144684242;74640.25359746441;8682.044975052866;9210.879618119277;9486.810263794823;9547.856782148134;9590.568424420779;47318;48023.75988120037;48858.02283954372;49045.75477122592;49297.753511232215;69643.56247531313;70909.6454517724;70947.64526177336;71403.64298178475;71663.28336716775;10671.89328106709;10725.088367488539;10771.407572583583;11093.001629853352;11444.484998174936;10310.381377117397;12055.397230138633;12256.816147757969;12314.75370492603;12681.873181268069;11373.601923932623;11772;11812.586559470377;11869.991050760436;12157.1489995703;9769.755756106155;11353.659390218307;11782.116341274268;11790.23363481371;11790.764184716087;11169.106471482424;11274.436278185894;11573.652790416301;11685.415729213675;12097.57658481949;9625.374350667184;9770.56032478526;10020.498975051363;10365.170786337225;10387;7575.924240757522;8883;8935.508547029976;9678.564464598969;9678.70963871085 09:43:18 INFO - PROCESS | 1974 | __end_tp_report 09:43:18 INFO - PROCESS | 1974 | __start_cc_report 09:43:18 INFO - PROCESS | 1974 | _x_x_mozilla_cycle_collect,410 09:43:18 INFO - PROCESS | 1974 | __end_cc_report 09:43:18 INFO - PROCESS | 1974 | __startTimestamp1490373798188__endTimestamp 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | ------- Summary: start ------- 09:43:18 INFO - PROCESS | 1974 | Number of tests: 6 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | [#0] dojo.html Cycles:165 Average:5999.55 Median:6228.28 stddev:708.98 (11.4%) stddev-sans-first:683.45 09:43:18 INFO - PROCESS | 1974 | Values: 3497.7 3518.7 3531.1 3534.5 3534.8 6136.4 6151.7 6151.9 6177.1 6211.7 6139.3 6213.6 6214.0 6221.6 6227.7 5439.1 5519.7 5527.8 5532.2 5595.6 5592.1 5599.8 5605.1 5606.8 5634.1 4609.3 5366.8 5380.3 5595.3 5601.7 5487.6 5535.8 5548.4 5558.1 5588.5 5384.1 5480.3 5498.9 5517.4 5534.1 5804.2 6130.3 6149.1 6192.7 6204.1 6293.5 6324.8 6367.1 6420.3 6439.3 6648.2 6653.8 6663.7 6675.1 6689.7 5778.8 6189.3 6226.5 6239.1 6286.7 6228.3 6456.5 6641.5 6664.0 6684.7 5622.7 6138.8 6407.3 6428.8 6434.8 6510.8 6555.4 6603.1 6606.5 6607.2 6201.6 6260.3 6397.3 6398.8 6491.7 6210.0 6488.2 6508.3 6527.6 6532.6 4344.2 4369.5 4423.9 5116.9 5234.3 4624.5 4676.1 4704.7 4709.6 4761.7 5227.2 5999.6 6068.5 6255.9 6275.5 6411.0 6425.7 6503.8 6512.8 6572.0 6210.5 6212.5 6219.1 6243.5 6258.0 4848.6 5383.7 5786.2 5817.8 5837.1 6347.6 6414.0 6629.6 6701.2 6830.7 6473.5 6592.2 6598.6 6611.5 6623.3 6832.7 6834.2 6839.9 6840.1 6843.7 6286.4 6321.4 6337.8 6475.0 6509.3 5493.1 6522.2 6580.8 6587.2 6607.1 5330.7 6340.3 6384.0 6394.4 6400.2 6181.2 6268.3 6274.6 6290.8 6385.3 5115.4 6057.7 6263.8 6300.4 6329.5 6346.9 6400.2 6402.8 6419.4 6423.5 5445.5 5970.8 6134.1 6202.7 6311.8 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | [#1] ext.html Cycles:180 Average:59050.62 Median:32372.01 stddev:123993.78 (383.0%) stddev-sans-first:124264.24 09:43:18 INFO - PROCESS | 1974 | Values: 706.2 741.8 828.4 961.9 961.9 39114.4 39592.6 41531.6 41551.8 41554.8 39604.8 39804.8 39812.2 39829.0 39956.4 7767.9 10536.7 10774.0 10874.7 10878.3 10539.1 10638.7 10658.1 10658.9 10662.8 10684.0 10688.7 10694.5 10702.6 10709.3 10620.3 10631.5 10641.3 10666.8 10672.7 10388.2 10427.2 10430.7 10439.8 10457.6 34348.8 34531.0 34567.5 34600.8 34723.8 3228.5 3741.8 3811.5 3815.2 3971.0 25182.5 25414.0 25498.9 26620.9 26728.6 3061.8 3094.2 3116.0 3129.0 3210.5 334761.0 349454.0 368066.0 385352.0 385947.1 43776.0 43838.3 44148.6 44156.3 44187.6 38539.8 44904.3 45729.3 45773.0 45824.5 11000.4 13682.0 13711.6 13742.2 13804.7 12115.9 12117.6 12117.7 12145.6 12160.9 11998.8 12023.5 12051.3 12067.6 12101.6 5076.9 5775.7 5798.4 5819.7 5827.7 965.8 1120.6 1141.7 1161.4 1187.6 26485.9 26536.6 26594.2 26640.0 26778.3 1082.4 1102.8 1241.7 1296.9 1310.2 14580.9 14811.3 15067.4 15178.6 15183.5 519093.0 521669.0 522328.0 522421.0 522584.0 50433.0 50782.7 50896.7 50938.5 51113.0 1315.2 1471.8 1503.6 1508.9 1509.4 27755.7 29954.4 30242.2 30277.1 30370.8 49820.8 49914.0 50060.0 50084.0 50249.0 425916.6 493140.0 515926.0 516851.0 517337.0 28509.1 29182.3 35464.6 35478.9 35701.6 44318.8 44450.7 44684.8 45208.3 45712.3 31497.7 32119.7 32283.0 32799.2 33108.3 36518.5 36662.5 37410.0 37461.4 37514.4 35742.8 36147.2 36521.5 36679.1 36944.3 24631.8 26419.2 32461.0 32840.2 33010.0 21440.0 22609.0 24667.8 25283.7 25302.2 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | [#2] jquery.html Cycles:180 Average:37558.39 Median:25419.49 stddev:96559.11 (379.9%) stddev-sans-first:96789.71 09:43:18 INFO - PROCESS | 1974 | Values: 415.4 430.0 430.9 440.8 441.4 19751.7 20340.1 20818.9 21040.7 21193.7 19768.6 21444.7 21756.1 21973.0 21977.1 5672.7 6171.9 6563.0 6576.3 6649.4 6406.3 6901.7 7230.1 7355.4 7388.1 7131.6 7288.5 7340.9 7355.7 7376.3 7217.6 7291.2 7302.6 7328.5 7332.3 7001.8 7116.3 7146.7 7183.3 7190.0 25127.0 25712.0 25791.2 25892.2 26216.0 2904.1 2963.7 2976.3 2977.7 2978.5 15521.5 16233.0 16350.3 16417.7 16886.5 2094.4 2099.9 2122.5 2133.1 2163.0 112284.0 133702.0 163786.0 164264.0 168493.0 20248.8 20816.8 21031.9 21077.5 21303.5 31347.5 32001.5 32104.8 32122.5 32129.2 10250.3 10288.4 10368.6 10498.3 10616.4 7296.6 8713.4 8724.3 8737.9 8863.0 7739.7 7966.4 8042.4 9602.9 9666.3 3555.6 4148.6 4195.9 4196.2 4221.7 737.3 871.5 889.5 921.6 931.8 18306.5 18530.4 19377.8 20476.1 21038.9 880.9 912.3 935.6 936.8 946.8 9125.3 10387.8 10512.7 10754.6 10813.2 425093.0 428152.0 428970.0 683469.0 760122.0 149718.0 155462.0 160066.0 160337.2 163610.0 1184.1 1250.9 1278.4 1289.8 1294.8 18367.5 19193.8 19501.5 19694.4 19783.3 68185.0 68701.0 68812.6 69272.7 70433.6 79381.0 80093.0 91778.1 98130.5 99534.0 9488.6 11658.8 11668.3 12030.0 12119.2 12952.6 12961.7 13046.3 13311.7 13330.5 9402.9 11006.7 11145.9 11422.7 11578.5 9986.8 10989.5 11158.3 11197.2 11510.7 11446.2 11633.4 11651.9 11751.0 11876.0 10093.8 11574.0 11626.7 11712.8 11919.6 9680.6 11157.3 11302.6 11431.9 11531.8 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | [#3] mootools.html Cycles:180 Average:6737.95 Median:2381.16 stddev:4196.20 (176.2%) stddev-sans-first:4188.31 09:43:18 INFO - PROCESS | 1974 | Values: 1331.3 1348.9 1485.3 1552.9 1562.0 10692.5 11210.7 11369.2 11403.9 11542.4 11137.8 11341.8 11393.5 11416.1 11462.4 2200.9 2245.9 2370.6 2394.7 2395.4 2302.3 2374.7 2380.7 2382.5 2386.0 2331.6 2360.4 2372.7 2385.9 2398.7 2289.1 2349.7 2357.7 2367.4 2372.4 2347.0 2352.3 2377.1 2379.4 2381.6 11028.0 11251.8 11252.4 11256.7 11292.5 5624.6 5800.6 5809.5 5813.6 5817.2 3568.2 3585.6 3667.9 3709.7 3734.8 1175.9 1181.5 1195.6 1231.1 1234.9 10837.1 13102.2 13476.7 15614.0 15783.2 4385.5 4750.0 4937.3 4972.5 4976.5 13028.2 13099.5 13135.3 13149.0 13170.9 5882.3 5960.8 5996.8 6001.9 6003.5 5248.2 5273.8 5304.4 5322.5 5332.9 3841.4 4026.7 4120.4 4182.5 4185.7 1072.6 1133.9 1135.1 1147.2 1160.2 704.6 786.2 799.1 815.8 821.6 6063.0 6301.2 6622.3 6718.8 6908.9 874.8 1042.8 1047.2 1073.5 1080.4 4060.9 4093.9 4240.6 4308.8 4318.9 13104.5 13684.6 13691.0 13705.9 13713.0 12111.3 13405.5 13422.6 13694.6 13705.0 8299.5 10218.7 10222.6 10418.1 10436.2 6483.4 6541.4 6566.0 6685.9 6703.4 12199.6 12305.3 12355.0 12409.1 12471.6 10646.6 11264.9 12453.1 12521.2 13028.4 8212.3 8443.0 8498.7 8539.9 8553.3 10155.1 10193.3 10244.8 10291.2 10387.4 9189.7 9237.7 9258.9 9268.3 9390.2 8917.6 8960.0 8983.6 9089.4 9180.8 7775.3 7886.5 7922.6 7930.2 7953.3 5610.1 5628.0 5774.8 5781.6 5849.7 5821.8 5854.6 5889.1 5929.3 5986.7 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | [#4] prototype.html Cycles:180 Average:4609.67 Median:4864.84 stddev:1325.81 (27.3%) stddev-sans-first:1290.82 09:43:18 INFO - PROCESS | 1974 | Values: 372.1 373.6 384.6 390.6 392.5 4553.1 4658.2 5051.0 5324.6 5395.8 4106.5 4201.9 5086.9 5223.8 5261.4 3873.5 4030.5 4060.8 4066.5 4114.4 3517.5 3541.7 3913.5 3987.5 4032.5 3341.3 4144.7 4171.2 4172.4 4204.8 3990.8 4020.7 4035.4 4084.9 4100.5 3085.3 3635.3 3660.4 3668.3 3675.6 4508.2 4722.0 5108.9 5230.5 5261.4 4508.0 4540.4 4591.5 4758.5 4761.8 5591.9 5641.2 5694.7 5743.0 5743.2 4055.7 4109.8 4112.7 4130.5 4138.8 5603.7 5684.0 5787.9 5860.4 5894.0 3882.4 4109.7 4128.8 4145.3 4221.3 3663.5 4287.1 4294.7 4309.8 4318.5 4234.2 4377.8 4511.0 4819.5 4821.2 5581.9 5584.3 5584.7 5602.4 5695.5 1565.3 1572.4 1605.8 1628.6 1761.2 1220.9 1288.8 1321.7 1385.9 1396.6 4347.7 4429.6 4680.2 4977.0 5135.6 5805.8 5864.4 5878.1 5886.7 5947.2 4511.2 4869.6 4982.7 5142.0 5219.8 2773.7 2860.6 2967.2 3042.8 3079.4 5682.0 6000.9 6106.3 6147.7 6174.2 5196.7 5217.7 5494.5 5881.5 5972.4 5301.1 5594.3 5717.7 5900.6 5971.7 5190.8 5219.4 5295.6 5860.5 5873.6 4804.4 4811.8 5783.0 5804.9 5823.7 4761.7 5390.9 5546.3 5899.8 6288.7 4718.6 4723.3 4730.5 4748.4 4781.9 5689.6 5714.3 5977.5 6009.1 6040.0 5325.5 5348.4 5555.4 5800.9 5806.7 4860.1 5001.2 5571.6 5652.0 5692.8 4924.0 5276.0 5457.6 5516.7 5559.8 4940.3 5230.7 5695.6 5713.9 5713.9 4724.2 4731.5 5559.6 5580.7 5641.9 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - PROCESS | 1974 | [#5] yui.html Cycles:180 Average:20228.99 Median:26381.83 stddev:30009.05 (113.7%) stddev-sans-first:30057.40 09:43:18 INFO - PROCESS | 1974 | Values: 697.0 700.7 762.9 773.9 855.8 15110.6 15472.1 16148.6 16175.1 16197.5 15020.5 15049.5 15222.5 15223.5 15233.6 764.9 881.9 935.9 947.5 971.1 880.1 923.1 934.1 935.7 939.4 979.3 981.1 982.6 983.2 983.6 966.9 980.0 982.1 983.7 990.8 725.3 736.7 738.3 739.8 739.8 15855.8 16228.7 16311.9 16402.1 16747.6 13857.4 14023.6 14068.9 14107.6 14140.9 11696.5 11775.2 11854.6 11860.2 11870.8 3314.4 3565.4 3640.9 3670.4 3816.7 102591.5 116400.3 121394.0 121756.0 122281.4 10520.0 10586.1 10780.9 10949.6 10950.2 22390.4 22398.0 22400.7 22412.2 22419.7 7451.5 7500.4 7719.9 7818.1 7876.4 4203.8 4233.5 4253.4 4294.7 4426.8 3436.7 3519.2 3527.9 3530.3 3541.3 550.8 653.4 656.8 666.9 673.3 668.3 692.2 695.7 709.4 717.2 8685.7 9448.7 9697.2 10164.6 10321.4 631.4 664.3 678.8 697.8 711.7 4739.9 4834.4 4834.8 4848.1 4852.4 104184.0 104395.5 105960.0 106586.0 107070.0 71970.0 78226.0 85456.1 86200.6 87038.6 67873.7 68815.0 72824.2 73710.6 74640.3 8682.0 9210.9 9486.8 9547.9 9590.6 47318.0 48023.8 48858.0 49045.8 49297.8 69643.6 70909.6 70947.6 71403.6 71663.3 10671.9 10725.1 10771.4 11093.0 11444.5 10310.4 12055.4 12256.8 12314.8 12681.9 11373.6 11772.0 11812.6 11870.0 12157.1 9769.8 11353.7 11782.1 11790.2 11790.8 11169.1 11274.4 11573.7 11685.4 12097.6 9625.4 9770.6 10020.5 10365.2 10387.0 7575.9 8883.0 8935.5 9678.6 9678.7 09:43:18 INFO - PROCESS | 1974 | -------- Summary: end -------- 09:43:18 INFO - PROCESS | 1974 | 09:43:18 INFO - TEST-INFO | 1974: exit 0 09:43:18 INFO - TEST-OK | dromaeo_css | took 1117152ms 09:43:18 INFO - TEST-START | kraken 09:43:18 INFO - operating with platform_type : mac_ 09:43:18 INFO - Initialising browser for kraken test... 09:43:18 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpiztswd/profile http://localhost:52772/getInfo.html) 09:43:21 INFO - PROCESS | 1981 | 2017-03-24 09:43:21.942 plugin-container[1982:18447] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 09:43:21 INFO - PROCESS | 1981 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:21 INFO - PROCESS | 1981 | 2017-03-24 09:43:21.945 plugin-container[1982:18447] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 09:43:21 INFO - PROCESS | 1981 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:21 INFO - PROCESS | 1981 | 2017-03-24 09:43:21.945 plugin-container[1982:18447] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:43:22 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 09:43:22 INFO - PROCESS | 1981 | colorDepth:24 09:43:22 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 09:43:22 INFO - PROCESS | 1981 | __metrics 09:43:22 ERROR - PROCESS | 1981 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 09:43:22 INFO - TEST-INFO | 1981: exit 0 09:43:22 INFO - Browser initialized. 09:43:22 INFO - Running cycle 1/1 for kraken test... 09:43:22 INFO - TEST-INFO | started process 1983 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpiztswd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:25 INFO - PROCESS | 1983 | 2017-03-24 09:43:25.563 plugin-container[1984:18570] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 09:43:25 INFO - PROCESS | 1983 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:25 INFO - PROCESS | 1983 | 2017-03-24 09:43:25.564 plugin-container[1984:18570] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441b, name = 'com.apple.CFPasteboardClient' 09:43:25 INFO - PROCESS | 1983 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:43:25 INFO - PROCESS | 1983 | 2017-03-24 09:43:25.564 plugin-container[1984:18570] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:43:35 INFO - PROCESS | 1983 | RSS: Main: 221384704 09:43:35 INFO - PROCESS | 1983 | 09:43:38 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52772/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:39 INFO - PROCESS | 1983 | RSS: Main: 235544576 09:43:39 INFO - PROCESS | 1983 | 09:43:41 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52772/tests/kraken/driver.html?testName=audio-dft) 09:43:42 INFO - PROCESS | 1983 | RSS: Main: 243630080 09:43:42 INFO - PROCESS | 1983 | 09:43:45 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52772/tests/kraken/driver.html?testName=audio-fft) 09:43:46 INFO - PROCESS | 1983 | RSS: Main: 245215232 09:43:46 INFO - PROCESS | 1983 | 09:43:48 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52772/tests/kraken/driver.html?testName=audio-oscillator) 09:43:49 INFO - PROCESS | 1983 | RSS: Main: 247009280 09:43:49 INFO - PROCESS | 1983 | 09:43:51 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:51 INFO - PROCESS | 1983 | RSS: Main: 248774656 09:43:51 INFO - PROCESS | 1983 | 09:43:55 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52772/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:55 INFO - PROCESS | 1983 | RSS: Main: 252952576 09:43:55 INFO - PROCESS | 1983 | 09:43:59 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52772/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:59 INFO - PROCESS | 1983 | RSS: Main: 249802752 09:43:59 INFO - PROCESS | 1983 | 09:44:03 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52772/tests/kraken/driver.html?testName=json-parse-financial) 09:44:03 INFO - PROCESS | 1983 | RSS: Main: 249757696 09:44:03 INFO - PROCESS | 1983 | 09:44:05 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:06 INFO - PROCESS | 1983 | RSS: Main: 251064320 09:44:06 INFO - PROCESS | 1983 | 09:44:08 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:08 INFO - PROCESS | 1983 | RSS: Main: 251514880 09:44:08 INFO - PROCESS | 1983 | 09:44:11 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:11 INFO - PROCESS | 1983 | RSS: Main: 251600896 09:44:11 INFO - PROCESS | 1983 | 09:44:14 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:15 INFO - PROCESS | 1983 | RSS: Main: 252030976 09:44:15 INFO - PROCESS | 1983 | 09:44:18 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:18 INFO - PROCESS | 1983 | RSS: Main: 251883520 09:44:18 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | Cycle 1(1): loaded http://localhost:52772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52772/tests/kraken/driver.html?testName=ai-astar) 09:44:20 INFO - PROCESS | 1983 | RSS: Main: 255463424 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | __start_tp_report 09:44:20 INFO - PROCESS | 1983 | _x_x_mozilla_page_load 09:44:20 INFO - PROCESS | 1983 | _x_x_mozilla_page_load_details 09:44:20 INFO - PROCESS | 1983 | |i|pagename|runs| 09:44:20 INFO - PROCESS | 1983 | |0;ai-astar;110;119;121;120;118;118;120;119;119;120 09:44:20 INFO - PROCESS | 1983 | |1;audio-beat-detection;144;112;110;145;110;123;139;134;130;114 09:44:20 INFO - PROCESS | 1983 | |2;audio-dft;232;231;211;207;172;242;211;193;230;223 09:44:20 INFO - PROCESS | 1983 | |3;audio-fft;78;66;55;76;73;79;72;69;85;52 09:44:20 INFO - PROCESS | 1983 | |4;audio-oscillator;86;71;86;74;72;70;81;71;82;113 09:44:20 INFO - PROCESS | 1983 | |5;imaging-gaussian-blur;90;130;136;102;90;106;128;109;135;132 09:44:20 INFO - PROCESS | 1983 | |6;imaging-darkroom;109;134;154;111;151;111;151;152;122;96 09:44:20 INFO - PROCESS | 1983 | |7;imaging-desaturate;144;141;99;129;96;148;108;81;147;142 09:44:20 INFO - PROCESS | 1983 | |8;json-parse-financial;64;64;78;97;102;102;100;84;68;68 09:44:20 INFO - PROCESS | 1983 | |9;json-stringify-tinderbox;61;58;55;63;61;57;62;72;83;61 09:44:20 INFO - PROCESS | 1983 | |10;stanford-crypto-aes;88;86;86;86;82;88;87;75;104;113 09:44:20 INFO - PROCESS | 1983 | |11;stanford-crypto-ccm;140;138;136;137;141;144;157;164;184;141 09:44:20 INFO - PROCESS | 1983 | |12;stanford-crypto-pbkdf2;165;170;170;169;170;166;167;168;167;168 09:44:20 INFO - PROCESS | 1983 | |13;stanford-crypto-sha256-iterative;67;66;68;78;74;66;66;68;70;64 09:44:20 INFO - PROCESS | 1983 | __end_tp_report 09:44:20 INFO - PROCESS | 1983 | __start_cc_report 09:44:20 INFO - PROCESS | 1983 | _x_x_mozilla_cycle_collect,1013 09:44:20 INFO - PROCESS | 1983 | __end_cc_report 09:44:20 INFO - PROCESS | 1983 | __startTimestamp1490373860882__endTimestamp 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | ------- Summary: start ------- 09:44:20 INFO - PROCESS | 1983 | Number of tests: 14 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#0] ai-astar Cycles:10 Average:118.40 Median:119.50 stddev:3.10 (2.6%) stddev-sans-first:1.00 09:44:20 INFO - PROCESS | 1983 | Values: 110.0 119.0 121.0 120.0 118.0 118.0 120.0 119.0 119.0 120.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:132.00 stddev:14.12 (10.7%) stddev-sans-first:13.41 09:44:20 INFO - PROCESS | 1983 | Values: 144.0 112.0 110.0 145.0 110.0 123.0 139.0 134.0 130.0 114.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#2] audio-dft Cycles:10 Average:215.20 Median:226.50 stddev:21.06 (9.3%) stddev-sans-first:21.44 09:44:20 INFO - PROCESS | 1983 | Values: 232.0 231.0 211.0 207.0 172.0 242.0 211.0 193.0 230.0 223.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#3] audio-fft Cycles:10 Average:70.50 Median:74.50 stddev:10.45 (14.0%) stddev-sans-first:10.72 09:44:20 INFO - PROCESS | 1983 | Values: 78.0 66.0 55.0 76.0 73.0 79.0 72.0 69.0 85.0 52.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:77.50 stddev:13.01 (16.8%) stddev-sans-first:13.66 09:44:20 INFO - PROCESS | 1983 | Values: 86.0 71.0 86.0 74.0 72.0 70.0 81.0 71.0 82.0 113.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:133.50 stddev:18.42 (13.8%) stddev-sans-first:17.01 09:44:20 INFO - PROCESS | 1983 | Values: 90.0 130.0 136.0 102.0 90.0 106.0 128.0 109.0 135.0 132.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#6] imaging-darkroom Cycles:10 Average:129.10 Median:151.00 stddev:21.94 (14.5%) stddev-sans-first:22.03 09:44:20 INFO - PROCESS | 1983 | Values: 109.0 134.0 154.0 111.0 151.0 111.0 151.0 152.0 122.0 96.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#7] imaging-desaturate Cycles:10 Average:123.50 Median:147.50 stddev:25.07 (17.0%) stddev-sans-first:25.46 09:44:20 INFO - PROCESS | 1983 | Values: 144.0 141.0 99.0 129.0 96.0 148.0 108.0 81.0 147.0 142.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#8] json-parse-financial Cycles:10 Average:82.70 Median:68.00 stddev:16.34 (24.0%) stddev-sans-first:15.87 09:44:20 INFO - PROCESS | 1983 | Values: 64.0 64.0 78.0 97.0 102.0 102.0 100.0 84.0 68.0 68.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:61.50 stddev:8.29 (13.5%) stddev-sans-first:8.75 09:44:20 INFO - PROCESS | 1983 | Values: 61.0 58.0 55.0 63.0 61.0 57.0 62.0 72.0 83.0 61.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:86.00 stddev:10.94 (12.7%) stddev-sans-first:11.59 09:44:20 INFO - PROCESS | 1983 | Values: 88.0 86.0 86.0 86.0 82.0 88.0 87.0 75.0 104.0 113.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#11] stanford-crypto-ccm Cycles:10 Average:148.20 Median:142.50 stddev:15.55 (10.9%) stddev-sans-first:16.21 09:44:20 INFO - PROCESS | 1983 | Values: 140.0 138.0 136.0 137.0 141.0 144.0 157.0 164.0 184.0 141.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:1.76 (1.0%) stddev-sans-first:1.50 09:44:20 INFO - PROCESS | 1983 | Values: 165.0 170.0 170.0 169.0 170.0 166.0 167.0 168.0 167.0 168.0 09:44:20 INFO - PROCESS | 1983 | 09:44:20 INFO - PROCESS | 1983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:4.27 (6.3%) stddev-sans-first:4.48 09:44:20 INFO - PROCESS | 1983 | Values: 67.0 66.0 68.0 78.0 74.0 66.0 66.0 68.0 70.0 64.0 09:44:20 INFO - PROCESS | 1983 | -------- Summary: end -------- 09:44:20 INFO - PROCESS | 1983 | 09:44:21 INFO - TEST-INFO | 1983: exit 0 09:44:21 INFO - TEST-OK | kraken | took 62874ms 09:44:21 INFO - SUITE-END | took 1180s 09:44:22 INFO - Completed test suite (00:19:40) 09:44:22 INFO - javascript benchmark 09:44:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7694.701227205117, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3497.6677215664513, 3518.683318501333, 3531.0995696097493, 3534.5405097337343, 3534.7525673202886, 6136.417040381168, 6151.661658608775, 6151.938480615193, 6177.104319873616, 6211.658358790265, 6139.293981192153, 6213.565050446459, 6214.005759078548, 6221.626702397859, 6227.657478838662, 5439.102548079562, 5519.69641669708, 5527.778888844441, 5532.170174473841, 5595.552355811546, 5592.133219351007, 5599.832005039855, 5605.081622821615, 5606.803761868336, 5634.098544232903, 4609.262517997121, 5366.838994830161, 5380.3274590676165, 5595.328560572737, 5601.691906945116, 5487.6158668892995, 5535.833924982217, 5548.361938377098, 5558.082916318803, 5588.469095435927, 5384.138537833967, 5480.342358916955, 5498.862528436781, 5517.36550296717, 5534.059209934321, 5804.245448091763, 6130.264368275835, 6149.13912052313, 6192.690365481753, 6204.100405441186, 6293.46505547029, 6324.841878953063, 6367.140436041122, 6420.293767685551, 6439.291677915426, 6648.202215734143, 6653.7671181508895, 6663.700133493956, 6675.065490831287, 6689.665516724193, 5778.768849245983, 6189.288231853305, 6226.470749986257, 6239.126522286883, 6286.654234017173, 6228.283747369111, 6456.515761317826, 6641.468682505388, 6663.966680166568, 6684.732610695615, 5622.690752008597, 6138.754449821957, 6407.295197528269, 6428.774992875227, 6434.80695579124, 6510.804675859732, 6555.442787363032, 6603.075569420285, 6606.537542371988, 6607.174103237096, 6201.56589038772, 6260.342664020303, 6397.264314603787, 6398.840028999219, 6491.7078731457195, 6210.037444196157, 6488.188976377953, 6508.349165083454, 6527.640979746159, 6532.5753826001155, 4344.23975804233, 4369.453818272716, 4423.933640995388, 5116.872078198, 5234.26720259164, 4624.491305956342, 4676.111538807616, 4704.670673052853, 4709.552592503706, 4761.738104404221, 5227.215917612389, 5999.5500337473995, 6068.4538391544975, 6255.937440625627, 6275.529335299871, 6411.038344248307, 6425.74297028123, 6503.837404064841, 6512.804615861532, 6572.0, 6210.472109870711, 6212.47193988516, 6219.098230756515, 6243.500519958392, 6258.030005349178, 4848.636352273594, 5383.650062745909, 5786.218860453869, 5817.825465236049, 5837.124431335334, 6347.619142851444, 6414.0, 6629.635370054693, 6701.229358623626, 6830.726770929206, 6473.546851720334, 6592.24189218246, 6598.571092878948, 6611.537192396486, 6623.304553021863, 6832.658367081725, 6834.2482326943, 6839.863202736017, 6840.110785597841, 6843.726250950105, 6286.4342209201395, 6321.399467050623, 6337.809865704036, 6474.9963755617955, 6509.251436084911, 5493.148561972901, 6522.21733391996, 6580.8354791130605, 6587.209534855848, 6607.141071660845, 5330.680159190461, 6340.334264902303, 6384.010478375859, 6394.392532709385, 6400.23197216337, 6181.165542651865, 6268.310485846644, 6274.623522588659, 6290.842728931813, 6385.265694445013, 5115.4373018967135, 6057.727402266997, 6263.812085637438, 6300.432961033529, 6329.46199573023, 6346.873062538816, 6400.199975003125, 6402.839929001812, 6419.422251997343, 6423.4861211103935, 5445.50990410849, 5970.791022314198, 6134.14122022926, 6202.72087756043, 6311.842203944938], "value": 5954.524275929415, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.1808302369253, 741.792298156516, 828.353883970503, 961.8990006049364, 961.9326647134703, 39114.413283800764, 39592.60407395925, 41531.58468415319, 41551.79224103883, 41554.75335739933, 39604.80197599008, 39804.8058558243, 39812.203755924864, 39829.004274893145, 39956.40065399021, 7767.883481747765, 10536.736581585445, 10774.0, 10874.72813179669, 10878.292910960801, 10539.104176144998, 10638.734031649194, 10658.0940620047, 10658.946705266462, 10662.78674426511, 10684.0, 10688.732781680443, 10694.51874665638, 10702.625408110718, 10709.25035247533, 10620.309679870783, 10631.52158152885, 10641.255112142191, 10666.839997400046, 10672.733181670443, 10388.168946484264, 10427.165826733919, 10430.739231519197, 10439.79120417595, 10457.633982810641, 34348.79779207716, 34530.964071077906, 34567.4814877777, 34600.826995865114, 34723.82638086793, 3228.531862879869, 3741.8129093545213, 3811.4663947047434, 3815.236952609489, 3971.007248187953, 25182.49635007308, 25414.0, 25498.87250563735, 26620.935162593472, 26728.59907101395, 3061.785675002751, 3094.226443389153, 3116.0340294508774, 3128.99872040947, 3210.486322188462, 334761.0, 349454.0, 368066.0, 385352.0, 385947.0702646469, 43776.0, 43838.34242486365, 44148.55851441509, 44156.3376549352, 44187.55812441834, 38539.807300963876, 44904.3264351035, 45729.31406028912, 45773.0, 45824.54175458203, 11000.394978276112, 13682.0, 13711.588652340446, 13742.244176570384, 13804.654883627989, 12115.878841211652, 12117.575884843987, 12117.69705757363, 12145.574904878464, 12160.939195304143, 11998.760024799456, 12023.458944347525, 12051.337176455203, 12067.637970860887, 12101.576444824388, 5076.949230507722, 5775.653460792282, 5798.420157984252, 5819.73811178498, 5827.679477628772, 965.8213230552229, 1120.618989543559, 1141.7374003979132, 1161.35544772652, 1187.6080893305189, 26485.940562377287, 26536.60195097075, 26594.202173934813, 26640.0, 26778.330541736614, 1082.4154956323655, 1102.8365074845954, 1241.7268200995766, 1296.9114074661607, 1310.2073245686413, 14580.927095364455, 14811.333489992976, 15067.397304107932, 15178.620534486727, 15183.468578599917, 519093.0, 521669.0, 522328.0, 522421.0, 522584.0, 50433.0, 50782.74608626933, 50896.74551627218, 50938.490615093375, 51113.0, 1315.2174456198547, 1471.8078356531244, 1503.5789978805951, 1508.9094654320556, 1509.433962264151, 27755.722442775314, 29954.400911982073, 30242.24394390158, 30277.091687249416, 30370.848145760014, 49820.750896245285, 49914.0, 50060.0, 50084.0, 50249.0, 425916.6112508377, 493140.0, 515926.0, 516851.0, 517337.0, 28509.144725658265, 29182.27044323909, 35464.64535354613, 35478.93563193108, 35701.64298356983, 44318.77840610776, 44450.66648000565, 44684.776576116914, 45208.32187517124, 45712.31431528596, 31497.685023149475, 32119.678803212602, 32283.0, 32799.18002049872, 33108.33783324272, 36518.45222321614, 36662.450063248536, 37410.0, 37461.43807842939, 37514.437283441315, 35742.7867576712, 36147.192640368405, 36521.45217821788, 36679.08302292357, 36944.26111477809, 24631.753682463663, 26419.207423777316, 32461.02616921496, 32840.178995525304, 33010.0, 21440.0, 22609.0, 24667.753322467262, 25283.74716252814, 25302.240932772045], "value": 18949.61112562321, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.39145152351836, 429.9974908613234, 430.87289249671335, 440.78181300256375, 441.3908805847929, 19751.703724444127, 20340.08469618867, 20818.89590552049, 21040.684389734168, 21193.682094768592, 19768.60462790747, 21444.678329825067, 21756.129754809826, 21973.011214495345, 21977.120915163374, 5672.744726487318, 6171.938280617182, 6563.048357988089, 6576.342365763409, 6649.368310010565, 6406.263279722845, 6901.723931042752, 7230.096237970254, 7355.411567074621, 7388.113426388814, 7131.572105673677, 7288.453365997545, 7340.853182936365, 7355.668994895243, 7376.299251571092, 7217.603031833247, 7291.197968223491, 7302.598357090358, 7328.450366222554, 7332.266773322678, 7001.82495437613, 7116.323949224816, 7146.749863754743, 7183.281671832827, 7189.964050179716, 25127.0, 25711.97152113913, 25791.226263212135, 25892.22323330303, 26216.0, 2904.12876137158, 2963.6888126746812, 2976.285691434062, 2977.702229777027, 2978.4638765022287, 15521.456749013843, 16233.0, 16350.264238109314, 16417.67164656712, 16886.493405197863, 2094.371688493461, 2099.895005249731, 2122.5330427305967, 2133.1467413034757, 2163.0266380129005, 112284.0, 133702.0, 163785.9999999988, 164264.0, 168493.0, 20248.785072895673, 20816.791832081486, 21031.94840257981, 21077.47306317324, 21303.46741331448, 31347.529787053212, 32001.51997720036, 32104.83947580294, 32122.518162227585, 32129.196770080936, 10250.282480226313, 10288.434136122585, 10368.585256589802, 10498.265121441578, 10616.363018218932, 7296.562206267641, 8713.390062695551, 8724.258438032712, 8737.859224490041, 8862.955685221661, 7739.651715672809, 7966.442349035628, 8042.396820238506, 9602.855957160647, 9666.323357365058, 3555.5733312002726, 4148.62662360389, 4195.91608167835, 4196.181744559782, 4221.7255878367805, 737.2627372627372, 871.4553404122423, 889.5107690770051, 921.6313474610209, 931.7810314576069, 18306.542336441697, 18530.44408667742, 19377.80622193788, 20476.078576464093, 21038.894805525873, 880.9427387219811, 912.2610685344891, 935.6023689931752, 936.7517607833929, 946.7822400847843, 9125.269978401711, 10387.84418233727, 10512.737181570523, 10754.623588174376, 10813.18901082422, 425093.0, 428152.0, 428970.0, 683469.0, 760122.0, 149718.0, 155462.0, 160066.0, 160337.19831401002, 163610.0, 1184.1474138620179, 1250.9061820363509, 1278.4438769135456, 1289.8387701537308, 1294.779887419141, 18367.54081147982, 19193.80806191976, 19501.51246218856, 19694.409167724993, 19783.307584234484, 68185.0, 68701.0, 68812.62374752577, 69272.6536367335, 70433.6478317605, 79381.0154746136, 80093.0, 91778.08221917695, 98130.50934745281, 99534.00465995248, 9488.573014214238, 11658.76682466329, 11668.30809532596, 12030.0, 12119.151659383759, 12952.611421657366, 12961.675958100746, 13046.282454465096, 13311.733765324832, 13330.533431330245, 9402.905970940477, 11006.669799906016, 11145.888541114486, 11422.657320280405, 11578.478968446272, 9986.800263994824, 10989.505472253608, 11158.330500170016, 11197.160212983896, 11510.712232193928, 11446.198766086294, 11633.418329083343, 11651.88348116508, 11751.0, 11876.0, 10093.798124037332, 11574.0, 11626.709332266422, 11712.824307635221, 11919.582814601446, 9680.612775488902, 11157.27477713946, 11302.587176602925, 11431.885681143081, 11531.8270225945], "value": 11479.48975009537, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.3343328335832, 1348.878600925917, 1485.3167542930264, 1552.860242578168, 1561.9687606247876, 10692.465376731161, 11210.66368008959, 11369.204155709092, 11403.885961140386, 11542.422878856045, 11137.777244455106, 11341.773164536704, 11393.48729307181, 11416.086713062956, 11462.426878656075, 2200.9449763755874, 2245.8546141467887, 2370.5614461324667, 2394.676718642987, 2395.4490467192554, 2302.2747834432184, 2374.7031621047367, 2380.702412198475, 2382.5473160099614, 2386.0455817672896, 2331.5803155432013, 2360.398098484884, 2372.6678265042906, 2385.916492922748, 2398.736139024706, 2289.072925465173, 2349.706286714161, 2357.7406485286606, 2367.4199821043953, 2372.395039264985, 2346.988265058681, 2352.259038402915, 2377.1442280778906, 2379.4170428245016, 2381.618940969454, 11028.0, 11251.774964500746, 11252.437378131142, 11256.718582035515, 11292.491837867316, 5624.606277560572, 5800.564957628195, 5809.535237181015, 5813.563982701272, 5817.185594016841, 3568.2149927016017, 3585.6055833858254, 3667.889963301105, 3709.7403181777286, 3734.775913445202, 1175.8941695247383, 1181.4742439614374, 1195.593498210604, 1231.0828432817518, 1234.8950339221176, 10837.078848297904, 13102.213867167906, 13476.730465390638, 15614.0, 15783.210839457981, 4385.451818522684, 4750.026244619845, 4937.259411088366, 4972.5276098770555, 4976.477469865612, 13028.153170043917, 13099.476020959246, 13135.343232838512, 13149.0, 13170.868291317156, 5882.294124705063, 5960.791372301948, 5996.760129594767, 6001.939980600138, 6003.459688628044, 5248.239005344204, 5273.762680679379, 5304.389995150607, 5322.520973112439, 5332.92000619991, 3841.4237864320576, 4026.6979976501293, 4120.443740095049, 4182.53992060873, 4185.748855068706, 1072.5602502973743, 1133.9036181924628, 1135.074913945132, 1147.20269412759, 1160.2458402038742, 704.6476761619191, 786.2491320788633, 799.0770659887838, 815.804206990318, 821.593311310893, 6063.029915213545, 6301.180846489927, 6622.304658010936, 6718.764843230463, 6908.896366554506, 874.807542340684, 1042.781015986636, 1047.2041248650928, 1073.5061871539024, 1080.36258607422, 4060.939085913714, 4093.91812163761, 4240.597143271384, 4308.849190278325, 4318.892027699333, 13104.541341053018, 13684.589462316146, 13691.041627086208, 13705.862941370458, 13713.0400871938, 12111.273323600612, 13405.463781448632, 13422.597322080353, 13694.589162324946, 13705.0, 8299.502029878227, 10218.744531386776, 10222.591096356062, 10418.062374386342, 10436.16510679159, 6483.416492515507, 6541.411272985454, 6566.0, 6685.8997115044285, 6703.363180497845, 12199.634010979686, 12305.323207223331, 12355.011599072232, 12409.06931980087, 12471.625851224479, 10646.574137034431, 11264.887351126385, 12453.06602004835, 12521.186122901981, 13028.41372138275, 8212.343012558862, 8443.0, 8498.70254541088, 8539.8719019216, 8553.315734741082, 10155.086042256233, 10193.286469947032, 10244.846327305246, 10291.22815788804, 10387.428691422045, 9189.678361257324, 9237.722868313962, 9258.861117083114, 9268.304877134107, 9390.248780097712, 8917.643294268157, 8960.0, 8983.640654374014, 9089.409188402733, 9180.770480738034, 7775.339096176662, 7886.526808391515, 7922.643481043482, 7930.167332430243, 7953.32396746283, 5610.102383618601, 5628.0, 5774.769009239583, 5781.595288329777, 5849.736761845642, 5821.79623713168, 5854.5609079320075, 5889.087191485327, 5929.288485381781, 5986.6707331097205], "value": 5127.400035110966, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.1143678046253, 373.60771190250233, 384.6326757946161, 390.61719514875404, 392.5093632958802, 4553.112143132086, 4658.16002678942, 5050.964552266791, 5324.600654950875, 5395.838124856261, 4106.548279689239, 4201.852935147271, 5086.949130508694, 5223.843284701456, 5261.447872877501, 3873.477080594126, 4030.455888455065, 4060.837566497344, 4066.512018557777, 4114.362273847559, 3517.4723791431234, 3541.707276843946, 3913.4912461380122, 3987.484755792809, 4032.4556184914954, 3341.298327351259, 4144.735855564052, 4171.228322760284, 4172.436721042651, 4204.789760511978, 3990.8403663853555, 4020.7386519876113, 4035.4148648446103, 4084.8570300039655, 4100.528439229482, 3085.305806193611, 3635.2547727715755, 3660.359437098524, 3668.3396988542054, 3675.5956844747056, 4508.211063063951, 4721.976390118028, 5108.897822043538, 5230.495567969431, 5261.394939581959, 4508.0, 4540.432445944257, 4591.517890621503, 4758.547937945889, 4761.809547613097, 5591.944080559183, 5641.210230567724, 5694.743736531866, 5742.97128514359, 5743.157137217063, 4055.6958228133008, 4109.767069879024, 4112.732672376286, 4130.542327315273, 4138.8344466221315, 5603.7430445200125, 5683.976884160849, 5787.942120578782, 5860.413958604148, 5893.970530147321, 3882.4176373544196, 4109.73964319623, 4128.793560321972, 4145.2952997990415, 4221.324588065895, 3663.4796559428073, 4287.121140166259, 4294.677899157576, 4309.7932578877335, 4318.481782186158, 4234.179676922251, 4377.759223242689, 4510.977445112753, 4819.542143496362, 4821.180399332122, 5581.944180558143, 5584.329880414376, 5584.692841893653, 5602.411746766612, 5695.5443564514735, 1565.3269094289565, 1572.4339237874356, 1605.7912471378645, 1628.6335574495645, 1761.1595882302768, 1220.854404142571, 1288.8388951381078, 1321.7422602592403, 1385.9376328065262, 1396.57404491629, 4347.7173983690955, 4429.645628349725, 4680.180968330528, 4976.968655389146, 5135.563477104413, 5805.793798356682, 5864.44287792659, 5878.118282257696, 5886.676232807236, 5947.156381521742, 4511.233090374644, 4869.610431165498, 4982.6512144149565, 5141.974290128525, 5219.799446127412, 2773.7240869200396, 2860.6424196975377, 2967.1840243933093, 3042.8243805679044, 3079.39951709419, 5682.0, 6000.859836631026, 6106.328303886569, 6147.7273295060395, 6174.228221472316, 5196.662216955886, 5217.68693878361, 5494.532964698045, 5881.529617595601, 5972.431854302691, 5301.098813201842, 5594.293740409133, 5717.714114294268, 5900.551271222481, 5971.701414929236, 5190.766415511235, 5219.425863154974, 5295.602829787705, 5860.472557469848, 5873.559483038704, 4804.447488538863, 4811.831585894477, 5783.0, 5804.883902322014, 5823.7379317929945, 4761.714297142183, 5390.865228369322, 5546.306711661043, 5899.823005309848, 6288.748450062129, 4718.575328220477, 4723.284111635754, 4730.526947305242, 4748.358971538936, 4781.947971446276, 5689.630174038674, 5714.314282286152, 5977.462028417463, 6009.128676341818, 6040.0, 5325.520703136736, 5348.438413966477, 5555.416681248411, 5800.854978625399, 5806.68063256525, 4860.063348687433, 5001.24981252815, 5571.554275658019, 5652.0, 5692.7722891083895, 4923.950760492493, 5276.0, 5457.645253058538, 5516.696581688046, 5559.803877468458, 4940.333055037668, 5230.704656066654, 5695.629784064023, 5713.857153571194, 5713.914291285717, 4724.173269677862, 4731.526847315241, 5559.555235581225, 5580.693061881473, 5641.9435805641415], "value": 4238.523553573965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.9825754356137, 700.7232143303395, 762.9122650895149, 773.9264769846865, 855.7946092937693, 15110.622234444145, 15472.149031803247, 16148.59628509285, 16175.11036892972, 16197.514074577766, 15020.474283400083, 15049.548513544583, 15222.467213647524, 15223.54329370118, 15233.619159521017, 764.8814433762776, 881.8544940084878, 935.9204467620226, 947.526236881561, 971.0968799016912, 880.1286726141138, 923.1045885491063, 934.1125930366179, 935.7005758157393, 939.3706216834703, 979.2606582030556, 981.0679854138561, 982.6167794560128, 983.1986930651532, 983.6016413352604, 966.9323147379686, 980.0248752491245, 982.0670363154995, 983.7196399026315, 990.7572644702058, 725.3218240944681, 736.686908064076, 738.2764890407377, 739.7558805594194, 739.8089076586691, 15855.762163567555, 16228.675426491522, 16311.91844040784, 16402.09788461634, 16747.581310467212, 13857.4457021719, 14023.579292621238, 14068.859311406857, 14107.647308817259, 14140.929295353457, 11696.532138714441, 11775.175737698364, 11854.585089521825, 11860.169788114836, 11870.762584748343, 3314.419976504126, 3565.447355659877, 3640.854365825364, 3670.4127339625798, 3816.732828701992, 102591.46112808239, 116400.25399619012, 121394.0, 121756.0, 122281.38859305647, 10520.02093040643, 10586.10018148466, 10780.892191078146, 10949.616763413242, 10950.178736594788, 22390.440238994157, 22398.0, 22400.663990040164, 22412.215572454887, 22419.663705044437, 7451.515651482637, 7500.437467189873, 7719.922800772033, 7818.061832580127, 7876.448648594658, 4203.831846726158, 4233.470816147981, 4253.404523366731, 4294.656427485794, 4426.84506042287, 3436.6735160159747, 3519.1905861651962, 3527.9294414112087, 3530.3115892400733, 3541.327147841902, 550.7906995341824, 653.4315145823165, 656.7701304543372, 666.8866292730247, 673.3064943108606, 668.2815972829131, 692.2313489035462, 695.7112798188796, 709.3899246647878, 717.2110678253879, 8685.739427817176, 9448.669296574724, 9697.175740062174, 10164.593416263267, 10321.432321222255, 631.3686313686313, 664.3223911610131, 678.8472593666386, 697.7557854750796, 711.6868577825741, 4739.905201895943, 4834.419869615669, 4834.806607735652, 4848.0788650156355, 4852.441969173519, 104184.0, 104395.4780226094, 105960.0, 106586.0, 107070.0, 71970.0, 78226.0, 85456.14543854607, 86200.56899715461, 87038.56480717556, 67873.66063169751, 68815.0, 72824.17939551553, 73710.63144684242, 74640.25359746441, 8682.044975052866, 9210.879618119277, 9486.810263794823, 9547.856782148134, 9590.568424420779, 47318.0, 48023.75988120037, 48858.02283954372, 49045.75477122592, 49297.753511232215, 69643.56247531313, 70909.6454517724, 70947.64526177336, 71403.64298178475, 71663.28336716775, 10671.89328106709, 10725.088367488539, 10771.407572583583, 11093.001629853352, 11444.484998174936, 10310.381377117397, 12055.397230138633, 12256.816147757969, 12314.75370492603, 12681.873181268069, 11373.601923932623, 11772.0, 11812.586559470377, 11869.991050760436, 12157.1489995703, 9769.755756106155, 11353.659390218307, 11782.116341274268, 11790.23363481371, 11790.764184716087, 11169.106471482424, 11274.436278185894, 11573.652790416301, 11685.415729213675, 12097.57658481949, 9625.374350667184, 9770.56032478526, 10020.498975051363, 10365.170786337225, 10387.0, 7575.924240757522, 8883.0, 8935.508547029976, 9678.564464598969, 9678.70963871085], "value": 7372.719459804569, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1599.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 119.0, 121.0, 120.0, 118.0, 118.0, 120.0, 119.0, 119.0, 120.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 112.0, 110.0, 145.0, 110.0, 123.0, 139.0, 134.0, 130.0, 114.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [232.0, 231.0, 211.0, 207.0, 172.0, 242.0, 211.0, 193.0, 230.0, 223.0], "value": 215.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 66.0, 55.0, 76.0, 73.0, 79.0, 72.0, 69.0, 85.0, 52.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 86.0, 74.0, 72.0, 70.0, 81.0, 71.0, 82.0, 113.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 130.0, 136.0, 102.0, 90.0, 106.0, 128.0, 109.0, 135.0, 132.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 134.0, 154.0, 111.0, 151.0, 111.0, 151.0, 152.0, 122.0, 96.0], "value": 129.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 99.0, 129.0, 96.0, 148.0, 108.0, 81.0, 147.0, 142.0], "value": 123.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 78.0, 97.0, 102.0, 102.0, 100.0, 84.0, 68.0, 68.0], "value": 82.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 55.0, 63.0, 61.0, 57.0, 62.0, 72.0, 83.0, 61.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 86.0, 82.0, 88.0, 87.0, 75.0, 104.0, 113.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 136.0, 137.0, 141.0, 144.0, 157.0, 164.0, 184.0, 141.0], "value": 148.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 170.0, 169.0, 170.0, 166.0, 167.0, 168.0, 167.0, 168.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 78.0, 74.0, 66.0, 66.0, 68.0, 70.0, 64.0], "value": 68.7, "unit": "score"}]}]} 09:44:22 INFO - Return code: 0 09:44:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:22 ERROR - # TBPL SUCCESS # 09:44:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:22 INFO - 2017-03-24 09:44:22.244 screenresolution[1988:18962] starting screenresolution argv=screenresolution get 09:44:22 INFO - 2017-03-24 09:44:22.247 screenresolution[1988:18962] Display 0: 1600x1200x32@60 09:44:22 INFO - 2017-03-24 09:44:22.253 screenresolution[1989:18965] starting screenresolution argv=screenresolution list 09:44:22 INFO - Available Modes on Display 0 09:44:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:22 INFO - Intel Iris: 09:44:22 INFO - Chipset Model: Intel Iris 09:44:22 INFO - Type: GPU 09:44:22 INFO - Bus: Built-In 09:44:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:22 INFO - Vendor: Intel (0x8086) 09:44:22 INFO - Device ID: 0x0a2e 09:44:22 INFO - Revision ID: 0x0009 09:44:22 INFO - Displays: 09:44:22 INFO - Display: 09:44:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:22 INFO - Display Serial Number: 1600x1200 60 09:44:22 INFO - Main Display: Yes 09:44:22 INFO - Mirror: Off 09:44:22 INFO - Online: Yes 09:44:22 INFO - Rotation: Supported 09:44:22 INFO - Return code: 0 09:44:22 INFO - Running post-action listener: _resource_record_post_action 09:44:22 INFO - [mozharness: 2017-03-24 16:44:22.489676Z] Finished run-tests step (success) 09:44:22 INFO - Running post-run listener: _resource_record_post_run 09:44:22 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 921600; Write bytes: 512891904; Read time: 12; Write time: 1651 09:44:22 INFO - TinderboxPrint: CPU usage
54.6% 09:44:22 INFO - TinderboxPrint: I/O read bytes / time
921,600 / 12 09:44:22 INFO - TinderboxPrint: I/O write bytes / time
512,891,904 / 1,651 09:44:22 INFO - TinderboxPrint: CPU idle
2,181.2 (45.4%) 09:44:22 INFO - TinderboxPrint: CPU system
966.4 (20.1%) 09:44:22 INFO - TinderboxPrint: CPU user
1,658.3 (34.5%) 09:44:22 INFO - TinderboxPrint: Swap in / out
208,957,440 / 0 09:44:22 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203448832; Write bytes: 202033152; Read time: 15656; Write time: 434 09:44:22 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 884736; Write bytes: 299811840; Read time: 11; Write time: 1177 09:44:22 INFO - Running post-run listener: _upload_blobber_files 09:44:22 INFO - Blob upload gear active. 09:44:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:22 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 09:44:22 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44:22 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:23 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:24 INFO - (blobuploader) - INFO - Done attempting. 09:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:25 INFO - (blobuploader) - INFO - Done attempting. 09:44:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:44:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:44:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:26 INFO - (blobuploader) - INFO - Done attempting. 09:44:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:28 INFO - (blobuploader) - INFO - Done attempting. 09:44:28 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:28 INFO - Return code: 0 09:44:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df6aa136bd6c556b2ae7de8209230d1e1b0ea349f1aaba340c239fc53fc27ac55344fddd8b3b2f4ff3cfc6210adc27026a51dc9f07a9d41f76a82823717fe03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5be4b5812f73c83a78cb9b1d4a40b05b8516118e91a54bf24d566062e1509d82d4bdcc01b5fb1a11d2c83a1a2f981e2613eff80a49171515af25971ed833698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b194f24a7785da18a190288fd18e0a90303e2001bec20582472e90a2d4165da2c4c56bb75a4820a05c851f7964b5f42ed7a83568440800379dee6a1077dc54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8400e1b4a63bdb2f0a1046d4b157712c026d0b98434ace477c29f55dc4af4d2bce37c56b314ef5ece286a7eb17d1b14d88ca1a9684beb3c5631cee20547b90bf"} 09:44:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:28 INFO - Contents: 09:44:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df6aa136bd6c556b2ae7de8209230d1e1b0ea349f1aaba340c239fc53fc27ac55344fddd8b3b2f4ff3cfc6210adc27026a51dc9f07a9d41f76a82823717fe03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5be4b5812f73c83a78cb9b1d4a40b05b8516118e91a54bf24d566062e1509d82d4bdcc01b5fb1a11d2c83a1a2f981e2613eff80a49171515af25971ed833698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b194f24a7785da18a190288fd18e0a90303e2001bec20582472e90a2d4165da2c4c56bb75a4820a05c851f7964b5f42ed7a83568440800379dee6a1077dc54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8400e1b4a63bdb2f0a1046d4b157712c026d0b98434ace477c29f55dc4af4d2bce37c56b314ef5ece286a7eb17d1b14d88ca1a9684beb3c5631cee20547b90bf"} 09:44:28 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:28 INFO - Copying logs to upload dir... 09:44:28 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.260575 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-24 09:44:28.137905) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 09:44:28.141673) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgCfNMV1cM/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df6aa136bd6c556b2ae7de8209230d1e1b0ea349f1aaba340c239fc53fc27ac55344fddd8b3b2f4ff3cfc6210adc27026a51dc9f07a9d41f76a82823717fe03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5be4b5812f73c83a78cb9b1d4a40b05b8516118e91a54bf24d566062e1509d82d4bdcc01b5fb1a11d2c83a1a2f981e2613eff80a49171515af25971ed833698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b194f24a7785da18a190288fd18e0a90303e2001bec20582472e90a2d4165da2c4c56bb75a4820a05c851f7964b5f42ed7a83568440800379dee6a1077dc54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8400e1b4a63bdb2f0a1046d4b157712c026d0b98434ace477c29f55dc4af4d2bce37c56b314ef5ece286a7eb17d1b14d88ca1a9684beb3c5631cee20547b90bf"} build_url:https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011199 build_url: 'https://queue.taskcluster.net/v1/task/RNF-MPaSSK-6WBJOtDvxGg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3df6aa136bd6c556b2ae7de8209230d1e1b0ea349f1aaba340c239fc53fc27ac55344fddd8b3b2f4ff3cfc6210adc27026a51dc9f07a9d41f76a82823717fe03", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a5be4b5812f73c83a78cb9b1d4a40b05b8516118e91a54bf24d566062e1509d82d4bdcc01b5fb1a11d2c83a1a2f981e2613eff80a49171515af25971ed833698", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2b194f24a7785da18a190288fd18e0a90303e2001bec20582472e90a2d4165da2c4c56bb75a4820a05c851f7964b5f42ed7a83568440800379dee6a1077dc54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8400e1b4a63bdb2f0a1046d4b157712c026d0b98434ace477c29f55dc4af4d2bce37c56b314ef5ece286a7eb17d1b14d88ca1a9684beb3c5631cee20547b90bf"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 09:44:28.190607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 09:44:28.190937) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgCfNMV1cM/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.HCMotr8Pbh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005111 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 09:44:28.279640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 09:44:28.279959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 09:44:28.280304) ========= ========= Total master_lag: 0.23 =========