builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0377 starttime: 1489595697.74 results: success (0) buildid: 20170315081336 builduid: 4e78861c70784e54aa2d3b3ffbc9fe40 revision: 8c89d1991786625a64d868798281610872a2bc26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.741573) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.742039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.742336) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.767169) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.767611) ========= 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.pf49hZGG6J/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.sDVxBloLSv/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-15 09:34:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2017-03-15 09:34:58 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.204496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.995823) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:57.996156) ========= 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.pf49hZGG6J/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.sDVxBloLSv/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.021720 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:58.044831) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 09:34:58.045188) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c89d1991786625a64d868798281610872a2bc26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8c89d1991786625a64d868798281610872a2bc26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pf49hZGG6J/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.sDVxBloLSv/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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-15 09:34:58,261 truncating revision to first 12 chars 2017-03-15 09:34:58,262 Setting DEBUG logging. 2017-03-15 09:34:58,262 attempt 1/10 2017-03-15 09:34:58,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c89d1991786?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 09:34:59,815 unpacking tar archive at: mozilla-central-8c89d1991786/testing/mozharness/ program finished with exit code 0 elapsedTime=1.828185 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 09:34:59.897479) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:59.897812) ========= script_repo_revision: 8c89d1991786625a64d868798281610872a2bc26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:59.898225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:59.898496) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 09:34:59.918976) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-15 09:34:59.919404) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pf49hZGG6J/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.sDVxBloLSv/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35:00 INFO - MultiFileLogger online at 20170315 09:35:00 in /builds/slave/test 09:35:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:35:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:35:00 INFO - {'append_to_log': False, 09:35:00 INFO - 'base_work_dir': '/builds/slave/test', 09:35:00 INFO - 'blob_upload_branch': 'Firefox', 09:35:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:35:00 INFO - 'branch': 'Firefox', 09:35:00 INFO - 'buildbot_json_path': 'buildprops.json', 09:35:00 INFO - 'config_files': ('talos/mac_config.py',), 09:35:00 INFO - 'default_actions': ('clobber', 09:35:00 INFO - 'read-buildbot-config', 09:35:00 INFO - 'download-and-extract', 09:35:00 INFO - 'populate-webroot', 09:35:00 INFO - 'create-virtualenv', 09:35:00 INFO - 'install', 09:35:00 INFO - 'run-tests'), 09:35:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:35:00 INFO - 'download_minidump_stackwalk': True, 09:35:00 INFO - 'download_symbols': 'ondemand', 09:35:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:35:00 INFO - 'tooltool.py': '/tools/tooltool.py', 09:35:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:35:00 INFO - '/tools/misc-python/virtualenv.py')}, 09:35:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:35:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:35:00 INFO - 'gecko_profile': False, 09:35:00 INFO - 'gecko_profile_interval': 0, 09:35:00 INFO - 'installer_path': 'installer.exe', 09:35:00 INFO - 'log_level': 'info', 09:35:00 INFO - 'log_name': 'talos', 09:35:00 INFO - 'log_to_console': True, 09:35:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:35:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:35:00 INFO - 'opt_config_files': (), 09:35:00 INFO - 'pip_index': False, 09:35:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:35:00 INFO - 'cmd': ('bash', 09:35:00 INFO - '-c', 09:35:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:35:00 INFO - 'enabled': True, 09:35:00 INFO - 'halt_on_failure': False, 09:35:00 INFO - 'name': 'check_screen_resolution'},), 09:35:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:35:00 INFO - 'cmd': ('bash', 09:35:00 INFO - '-c', 09:35:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:35:00 INFO - 'enabled': True, 09:35:00 INFO - 'halt_on_failure': False, 09:35:00 INFO - 'name': 'check_screen_resolution'},), 09:35:00 INFO - 'run_cmd_checks_enabled': True, 09:35:00 INFO - 'suite': 'dromaeojs-e10s', 09:35:00 INFO - 'system_bits': '32', 09:35:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:35:00 INFO - 'title': 't-yosemite-r7-0377', 09:35:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:35:00 INFO - 'use_talos_json': True, 09:35:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:35:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:35:00 INFO - 'work_dir': 'build'} 09:35:00 INFO - [mozharness: 2017-03-15 16:35:00.257337Z] Running clobber step. 09:35:00 INFO - Running pre-action listener: _resource_record_pre_action 09:35:00 INFO - Running main action method: clobber 09:35:00 INFO - rmtree: /builds/slave/test/build 09:35:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:35:01 INFO - Running post-action listener: _resource_record_post_action 09:35:01 INFO - [mozharness: 2017-03-15 16:35:01.943845Z] Finished clobber step (success) 09:35:01 INFO - [mozharness: 2017-03-15 16:35:01.943986Z] Running read-buildbot-config step. 09:35:01 INFO - Running pre-action listener: _resource_record_pre_action 09:35:01 INFO - Running main action method: read_buildbot_config 09:35:01 INFO - Using buildbot properties: 09:35:01 INFO - { 09:35:01 INFO - "project": "", 09:35:01 INFO - "product": "firefox", 09:35:01 INFO - "script_repo_revision": "production", 09:35:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:35:01 INFO - "repository": "", 09:35:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:35:01 INFO - "buildid": "20170315081336", 09:35:01 INFO - "pgo_build": "False", 09:35:01 INFO - "basedir": "/builds/slave/test", 09:35:01 INFO - "buildnumber": 124, 09:35:01 INFO - "slavename": "t-yosemite-r7-0377", 09:35:01 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:35:01 INFO - "platform": "yosemite_r7", 09:35:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:35:01 INFO - "branch": "mozilla-central", 09:35:01 INFO - "repo_path": "mozilla-central", 09:35:01 INFO - "revision": "8c89d1991786625a64d868798281610872a2bc26", 09:35:01 INFO - "stage_platform": "macosx64", 09:35:01 INFO - "builduid": "4e78861c70784e54aa2d3b3ffbc9fe40", 09:35:01 INFO - "slavebuilddir": "test" 09:35:01 INFO - } 09:35:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:35:01 INFO - Running post-action listener: _resource_record_post_action 09:35:01 INFO - [mozharness: 2017-03-15 16:35:01.947399Z] Finished read-buildbot-config step (success) 09:35:01 INFO - [mozharness: 2017-03-15 16:35:01.947508Z] Running download-and-extract step. 09:35:01 INFO - Running pre-action listener: _resource_record_pre_action 09:35:01 INFO - Running main action method: download_and_extract 09:35:01 INFO - mkdir: /builds/slave/test/build/tests 09:35:01 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:35:01 INFO - trying https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:35:01 INFO - Downloading https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:35:02 INFO - Downloaded 1199 bytes. 09:35:02 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:35:02 INFO - Using the following test package requirements: 09:35:02 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:35:02 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:02 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:35:02 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:02 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:35:02 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:02 INFO - u'jsshell-mac.zip'], 09:35:02 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:02 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:35:02 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:35:02 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:02 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:35:03 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:03 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:35:03 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:03 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:35:03 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:35:03 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:35:03 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:35:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:35:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:35:03 INFO - Fetch https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:35:04 INFO - Expected file size: 52472487 09:35:04 INFO - Obtained file size: 52472487 09:35:20 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:35:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:35:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:35:20 INFO - Fetch https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:35:22 INFO - Expected file size: 52472487 09:35:22 INFO - Obtained file size: 52472487 09:35:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:35:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:35:38 INFO - Fetch https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:35:39 INFO - Expected file size: 14404452 09:35:39 INFO - Obtained file size: 14404452 09:35:39 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:35:39 INFO - trying https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:35:39 INFO - Downloading https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:35:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:35:41 INFO - Downloaded 75083990 bytes. 09:35:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:35:41 INFO - mkdir: /builds/slave/test/properties 09:35:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:35:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:35:41 INFO - Contents: 09:35:41 INFO - build_url:https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:35:42 INFO - Running post-action listener: _resource_record_post_action 09:35:42 INFO - Running post-action listener: set_extra_try_arguments 09:35:42 INFO - [mozharness: 2017-03-15 16:35:42.377663Z] Finished download-and-extract step (success) 09:35:42 INFO - [mozharness: 2017-03-15 16:35:42.377782Z] Running populate-webroot step. 09:35:42 INFO - Running pre-action listener: _resource_record_pre_action 09:35:42 INFO - Running main action method: populate_webroot 09:35:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:35:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:35:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:35:42 INFO - '--tppagecycles', 09:35:42 INFO - '7'], 09:35:42 INFO - 'tests': ['tsvgm']}}, 09:35:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:35:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:35:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:35:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:35:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:35:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['damp', 'tps']}, 09:35:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'tests': ['damp', 'tps']}, 09:35:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['dromaeo_dom']}, 09:35:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:35:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['basic_compositor_video']}, 09:35:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:35:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['a11yr', 09:35:42 INFO - 'ts_paint', 09:35:42 INFO - 'tpaint', 09:35:42 INFO - 'sessionrestore', 09:35:42 INFO - 'sessionrestore_no_auto_restore', 09:35:42 INFO - 'tabpaint']}, 09:35:42 INFO - 'other-e10s': {'tests': ['a11yr', 09:35:42 INFO - 'ts_paint', 09:35:42 INFO - 'tpaint', 09:35:42 INFO - 'sessionrestore', 09:35:42 INFO - 'sessionrestore_no_auto_restore', 09:35:42 INFO - 'tabpaint']}, 09:35:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:35:42 INFO - 'ts_paint', 09:35:42 INFO - 'tpaint', 09:35:42 INFO - 'sessionrestore', 09:35:42 INFO - 'sessionrestore_no_auto_restore', 09:35:42 INFO - 'tabpaint']}, 09:35:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:35:42 INFO - 'ts_paint', 09:35:42 INFO - 'tpaint', 09:35:42 INFO - 'sessionrestore', 09:35:42 INFO - 'sessionrestore_no_auto_restore', 09:35:42 INFO - 'tabpaint']}, 09:35:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['a11yr', 09:35:42 INFO - 'ts_paint', 09:35:42 INFO - 'tpaint', 09:35:42 INFO - 'sessionrestore', 09:35:42 INFO - 'sessionrestore_no_auto_restore', 09:35:42 INFO - 'tabpaint']}, 09:35:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['a11yr', 09:35:42 INFO - 'ts_paint', 09:35:42 INFO - 'tpaint', 09:35:42 INFO - 'sessionrestore', 09:35:42 INFO - 'sessionrestore_no_auto_restore', 09:35:42 INFO - 'tabpaint']}, 09:35:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['tsvgx', 09:35:42 INFO - 'tsvgr_opacity', 09:35:42 INFO - 'tart', 09:35:42 INFO - 'tscrollx', 09:35:42 INFO - 'cart', 09:35:42 INFO - 'tsvg_static']}, 09:35:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:35:42 INFO - 'tsvgr_opacity', 09:35:42 INFO - 'tart', 09:35:42 INFO - 'tscrollx', 09:35:42 INFO - 'cart', 09:35:42 INFO - 'tsvg_static']}, 09:35:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'talos_options': ['--disable-e10s'], 09:35:42 INFO - 'tests': ['tp5o']}, 09:35:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:35:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'talos_options': ['--disable-e10s', 09:35:42 INFO - '--xperf_path', 09:35:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:42 INFO - 'tests': ['tp5n']}, 09:35:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:35:42 INFO - 'talos_options': ['--xperf_path', 09:35:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:35:42 INFO - 'tests': ['tp5n']}}, 09:35:42 INFO - 'talos.zip': {'path': '', 09:35:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:35:42 INFO - Running post-action listener: _resource_record_post_action 09:35:42 INFO - [mozharness: 2017-03-15 16:35:42.396207Z] Finished populate-webroot step (success) 09:35:42 INFO - [mozharness: 2017-03-15 16:35:42.396298Z] Running create-virtualenv step. 09:35:42 INFO - Running pre-action listener: _resource_record_pre_action 09:35:42 INFO - Running main action method: create_virtualenv 09:35:42 INFO - Creating virtualenv /builds/slave/test/build/venv 09:35:42 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:35:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:35:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:35:42 INFO - Using real prefix '/tools/python27' 09:35:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:35:43 INFO - Installing distribute.............................................................................................................................................................................................done. 09:35:46 INFO - Installing pip.................done. 09:35:46 INFO - Return code: 0 09:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:35:46 INFO - Reading from file tmpfile_stdout 09:35:46 INFO - Output received: 09:35:46 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:35:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:35:46 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:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:46 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:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:46 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35:46 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:35:46 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:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:46 INFO - 'HOME': '/Users/cltbld', 09:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:46 INFO - 'LOGNAME': 'cltbld', 09:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:46 INFO - 'MOZ_NO_REMOTE': '1', 09:35:46 INFO - 'NO_EM_RESTART': '1', 09:35:46 INFO - 'PAGER': '/bin/cat', 09:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:46 INFO - 'PWD': '/builds/slave/test', 09:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:46 INFO - 'SHELL': '/bin/bash', 09:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:35:46 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:46 INFO - 'USER': 'cltbld', 09:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:46 INFO - 'XPC_FLAGS': '0x0', 09:35:46 INFO - 'XPC_SERVICE_NAME': '0', 09:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:46 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:35:46 INFO - Cleaning up... 09:35:46 INFO - Return code: 0 09:35:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:35:46 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:35:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:46 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:35:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:46 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35:46 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:35:46 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:35:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:35:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:46 INFO - 'HOME': '/Users/cltbld', 09:35:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:46 INFO - 'LOGNAME': 'cltbld', 09:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:46 INFO - 'MOZ_NO_REMOTE': '1', 09:35:46 INFO - 'NO_EM_RESTART': '1', 09:35:46 INFO - 'PAGER': '/bin/cat', 09:35:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:46 INFO - 'PWD': '/builds/slave/test', 09:35:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:46 INFO - 'SHELL': '/bin/bash', 09:35:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:35:46 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:35:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:46 INFO - 'USER': 'cltbld', 09:35:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:46 INFO - 'XPC_FLAGS': '0x0', 09:35:46 INFO - 'XPC_SERVICE_NAME': '0', 09:35:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:46 INFO - Downloading/unpacking psutil>=3.1.1 09:35:46 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:35:46 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:35:46 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:35:46 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:35:46 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:35:46 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:35:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:35:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:50 INFO - Installing collected packages: psutil 09:35:50 INFO - Running setup.py install for psutil 09:35:50 INFO - building 'psutil._psutil_osx' extension 09:35:50 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:35:50 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:35:50 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:35:50 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:35:51 INFO - building 'psutil._psutil_posix' extension 09:35:51 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:35:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:35:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:35:51 INFO - ^ 09:35:51 INFO - 1 warning generated. 09:35:51 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:35:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:35:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:35:51 INFO - Successfully installed psutil 09:35:51 INFO - Cleaning up... 09:35:51 INFO - Return code: 0 09:35:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:35:51 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:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:51 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:35:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:35: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 mozsystemmonitor==0.3 09:35:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:35:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:52 INFO - 'HOME': '/Users/cltbld', 09:35:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:52 INFO - 'LOGNAME': 'cltbld', 09:35:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:52 INFO - 'MOZ_NO_REMOTE': '1', 09:35:52 INFO - 'NO_EM_RESTART': '1', 09:35:52 INFO - 'PAGER': '/bin/cat', 09:35:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:52 INFO - 'PWD': '/builds/slave/test', 09:35:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:52 INFO - 'SHELL': '/bin/bash', 09:35:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:35:52 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:35:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:52 INFO - 'USER': 'cltbld', 09:35:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:52 INFO - 'XPC_FLAGS': '0x0', 09:35:52 INFO - 'XPC_SERVICE_NAME': '0', 09:35:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:35: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:35: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:35: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:35: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:35: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:35: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:35:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:35:55 INFO - Installing collected packages: mozsystemmonitor 09:35:55 INFO - Running setup.py install for mozsystemmonitor 09:35:55 INFO - Successfully installed mozsystemmonitor 09:35:55 INFO - Cleaning up... 09:35:55 INFO - Return code: 0 09:35:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:35:55 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:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 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:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35:55 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:35:55 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:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:55 INFO - 'HOME': '/Users/cltbld', 09:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:55 INFO - 'LOGNAME': 'cltbld', 09:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:55 INFO - 'MOZ_NO_REMOTE': '1', 09:35:55 INFO - 'NO_EM_RESTART': '1', 09:35:55 INFO - 'PAGER': '/bin/cat', 09:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:55 INFO - 'PWD': '/builds/slave/test', 09:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:55 INFO - 'SHELL': '/bin/bash', 09:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:35:55 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:55 INFO - 'USER': 'cltbld', 09:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:55 INFO - 'XPC_FLAGS': '0x0', 09:35:55 INFO - 'XPC_SERVICE_NAME': '0', 09:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:55 INFO - Downloading/unpacking jsonschema==2.5.1 09:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:55 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:35:55 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:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:35:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:35:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:35:58 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:35:58 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:35:58 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:35:58 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:35:58 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:35:58 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:35:58 INFO - Downloading functools32-3.2.3-2.tar.gz 09:35:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:35:58 INFO - warning: no files found matching '*.txt' 09:35:58 INFO - no previously-included directories found matching 'build' 09:35:58 INFO - no previously-included directories found matching 'dist' 09:35:58 INFO - no previously-included directories found matching '.git*' 09:35:58 INFO - Installing collected packages: jsonschema, functools32 09:35:58 INFO - Running setup.py install for functools32 09:35:59 INFO - warning: no files found matching '*.txt' 09:35:59 INFO - no previously-included directories found matching 'build' 09:35:59 INFO - no previously-included directories found matching 'dist' 09:35:59 INFO - no previously-included directories found matching '.git*' 09:35:59 INFO - Successfully installed jsonschema functools32 09:35:59 INFO - Cleaning up... 09:35:59 INFO - Return code: 0 09:35:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:35:59 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:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:59 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:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:59 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35:59 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:35:59 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:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:59 INFO - 'HOME': '/Users/cltbld', 09:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:59 INFO - 'LOGNAME': 'cltbld', 09:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:59 INFO - 'MOZ_NO_REMOTE': '1', 09:35:59 INFO - 'NO_EM_RESTART': '1', 09:35:59 INFO - 'PAGER': '/bin/cat', 09:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:59 INFO - 'PWD': '/builds/slave/test', 09:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:59 INFO - 'SHELL': '/bin/bash', 09:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:35:59 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:59 INFO - 'USER': 'cltbld', 09:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:59 INFO - 'XPC_FLAGS': '0x0', 09:35:59 INFO - 'XPC_SERVICE_NAME': '0', 09:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:35:59 INFO - Cleaning up... 09:35:59 INFO - Return code: 0 09:35:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:35:59 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:35:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:35:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:59 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:35:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:35:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:35:59 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:35:59 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:35:59 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:35:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:35:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:35:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:35:59 INFO - 'HOME': '/Users/cltbld', 09:35:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:35:59 INFO - 'LOGNAME': 'cltbld', 09:35:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:35:59 INFO - 'MOZ_NO_REMOTE': '1', 09:35:59 INFO - 'NO_EM_RESTART': '1', 09:35:59 INFO - 'PAGER': '/bin/cat', 09:35:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:35:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:35:59 INFO - 'PWD': '/builds/slave/test', 09:35:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:35:59 INFO - 'SHELL': '/bin/bash', 09:35:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:35:59 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:35:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:35:59 INFO - 'USER': 'cltbld', 09:35:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:35:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:35:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:35:59 INFO - 'XPC_FLAGS': '0x0', 09:35:59 INFO - 'XPC_SERVICE_NAME': '0', 09:35:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:35:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:35:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:35:59 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:35:59 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:35:59 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:35:59 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:35:59 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:35:59 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:36:02 INFO - Downloading blobuploader-1.2.4.tar.gz 09:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:36:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:36:02 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:36:02 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:36:02 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:36:02 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:36:02 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:36:02 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:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:36:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:36: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:36: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:36: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:36: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:36: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:36: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:36:03 INFO - Downloading docopt-0.6.1.tar.gz 09:36:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:36:03 INFO - Installing collected packages: blobuploader, requests, docopt 09:36:03 INFO - Running setup.py install for blobuploader 09:36:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:36:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:36:03 INFO - Running setup.py install for requests 09:36:04 INFO - Running setup.py install for docopt 09:36:04 INFO - Successfully installed blobuploader requests docopt 09:36:04 INFO - Cleaning up... 09:36:04 INFO - Return code: 0 09:36:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36: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:36:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:04 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:36:04 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:36:04 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:36:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:36:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:04 INFO - 'HOME': '/Users/cltbld', 09:36:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:04 INFO - 'LOGNAME': 'cltbld', 09:36:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:04 INFO - 'MOZ_NO_REMOTE': '1', 09:36:04 INFO - 'NO_EM_RESTART': '1', 09:36:04 INFO - 'PAGER': '/bin/cat', 09:36:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:04 INFO - 'PWD': '/builds/slave/test', 09:36:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:04 INFO - 'SHELL': '/bin/bash', 09:36:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:36:04 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:36:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:04 INFO - 'USER': 'cltbld', 09:36:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:04 INFO - 'XPC_FLAGS': '0x0', 09:36:04 INFO - 'XPC_SERVICE_NAME': '0', 09:36:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:04 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-hY5l8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:04 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-qrl5OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-YeX_Af-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-Q9rZHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-1ly19M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-KnxxfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-kIBEJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-rPVwCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-X0tCBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-pxkSyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-UmJ5h0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:05 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-LCjSWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-COnFAy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-W8FwPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-FZIwTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-SJcjnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:06 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-9CMC1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:36:06 INFO - Running setup.py install for manifestparser 09:36:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:36:06 INFO - Running setup.py install for mozcrash 09:36:06 INFO - Running setup.py install for mozdebug 09:36:06 INFO - Running setup.py install for mozdevice 09:36:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Running setup.py install for mozfile 09:36:07 INFO - Running setup.py install for mozhttpd 09:36:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Running setup.py install for mozinfo 09:36:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Running setup.py install for mozInstall 09:36:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:36:07 INFO - Running setup.py install for mozleak 09:36:07 INFO - Running setup.py install for mozlog 09:36:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:36:08 INFO - Running setup.py install for moznetwork 09:36:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:36:08 INFO - Running setup.py install for mozprocess 09:36:08 INFO - Running setup.py install for mozprofile 09:36:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:36:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:36:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:36:08 INFO - Running setup.py install for mozrunner 09:36:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:36:08 INFO - Running setup.py install for mozscreenshot 09:36:08 INFO - Running setup.py install for moztest 09:36:08 INFO - Running setup.py install for mozversion 09:36:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:36:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:36:09 INFO - Cleaning up... 09:36:09 INFO - Return code: 0 09:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36:09 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:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:09 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:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:09 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:36:09 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:36:09 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:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:09 INFO - 'HOME': '/Users/cltbld', 09:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:09 INFO - 'LOGNAME': 'cltbld', 09:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:09 INFO - 'MOZ_NO_REMOTE': '1', 09:36:09 INFO - 'NO_EM_RESTART': '1', 09:36:09 INFO - 'PAGER': '/bin/cat', 09:36:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:09 INFO - 'PWD': '/builds/slave/test', 09:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:09 INFO - 'SHELL': '/bin/bash', 09:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:36:09 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:09 INFO - 'USER': 'cltbld', 09:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:09 INFO - 'XPC_FLAGS': '0x0', 09:36:09 INFO - 'XPC_SERVICE_NAME': '0', 09:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:36:09 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-7BNlgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:36:09 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-JMq8Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:36:09 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-oY8YpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:36:09 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-JO9JdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:36:09 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-6ycO6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:36:09 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:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:36:09 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-eZhVz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-yq7I_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-zs9f3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-inv65a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-NVsn7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-saMYY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-9HGtTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-5Z8lYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-eTU1Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:10 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-sw2qxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:36:10 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:36:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:36:11 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-BrmNkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:36:11 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:36:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:36:11 INFO - Running setup.py (path:/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/pip-1aFOU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:36:11 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:36:11 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:36:11 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:36:11 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:36:11 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:36:11 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:36:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:11 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:36:11 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:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:36:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:36:13 INFO - Downloading blessings-1.6.tar.gz 09:36:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:36:13 INFO - Installing collected packages: blessings 09:36:13 INFO - Running setup.py install for blessings 09:36:14 INFO - Successfully installed blessings 09:36:14 INFO - Cleaning up... 09:36:14 INFO - Return code: 0 09:36:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:36:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:14 INFO - Reading from file tmpfile_stdout 09:36:14 INFO - Current package versions: 09:36:14 INFO - blessings == 1.6 09:36:14 INFO - blobuploader == 1.2.4 09:36:14 INFO - docopt == 0.6.1 09:36:14 INFO - functools32 == 3.2.3-2 09:36:14 INFO - jsonschema == 2.5.1 09:36:14 INFO - manifestparser == 1.1 09:36:14 INFO - mozInstall == 1.12 09:36:14 INFO - mozcrash == 1.0 09:36:14 INFO - mozdebug == 0.1 09:36:14 INFO - mozdevice == 0.49 09:36:14 INFO - mozfile == 1.2 09:36:14 INFO - mozhttpd == 0.7 09:36:14 INFO - mozinfo == 0.9 09:36:14 INFO - mozleak == 0.1 09:36:14 INFO - mozlog == 3.4 09:36:14 INFO - moznetwork == 0.27 09:36:14 INFO - mozprocess == 0.25 09:36:14 INFO - mozprofile == 0.28 09:36:14 INFO - mozrunner == 6.13 09:36:14 INFO - mozscreenshot == 0.1 09:36:14 INFO - mozsystemmonitor == 0.3 09:36:14 INFO - moztest == 0.8 09:36:14 INFO - mozversion == 1.4 09:36:14 INFO - psutil == 3.1.1 09:36:14 INFO - requests == 1.2.3 09:36:14 INFO - wsgiref == 0.1.2 09:36:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:36: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:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:36:14 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:36:14 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:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:14 INFO - 'HOME': '/Users/cltbld', 09:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PAGER': '/bin/cat', 09:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test', 09:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:36:14 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - 'XPC_FLAGS': '0x0', 09:36:14 INFO - 'XPC_SERVICE_NAME': '0', 09:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 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:36:14 INFO - Cleaning up... 09:36:14 INFO - Return code: 0 09:36:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:36: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:36:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36: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:36:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:36:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:36:14 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 0x106ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9669d67d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, '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.pf49hZGG6J/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.sDVxBloLSv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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:36:14 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:36:14 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:36:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:36:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:14 INFO - 'HOME': '/Users/cltbld', 09:36:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:14 INFO - 'LOGNAME': 'cltbld', 09:36:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:14 INFO - 'MOZ_NO_REMOTE': '1', 09:36:14 INFO - 'NO_EM_RESTART': '1', 09:36:14 INFO - 'PAGER': '/bin/cat', 09:36:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:14 INFO - 'PWD': '/builds/slave/test', 09:36:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:14 INFO - 'SHELL': '/bin/bash', 09:36:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:36:14 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:36:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:14 INFO - 'USER': 'cltbld', 09:36:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:14 INFO - 'XPC_FLAGS': '0x0', 09:36:14 INFO - 'XPC_SERVICE_NAME': '0', 09:36:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:36:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:36:15 INFO - Cleaning up... 09:36:15 INFO - Return code: 0 09:36:15 INFO - Running post-action listener: _resource_record_post_action 09:36:15 INFO - Running post-action listener: _start_resource_monitoring 09:36:15 INFO - Starting resource monitoring. 09:36:15 INFO - [mozharness: 2017-03-15 16:36:15.040891Z] Finished create-virtualenv step (success) 09:36:15 INFO - [mozharness: 2017-03-15 16:36:15.041886Z] Running install step. 09:36:15 INFO - Running pre-action listener: _resource_record_pre_action 09:36:15 INFO - Running main action method: install 09:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:36:15 INFO - Reading from file tmpfile_stdout 09:36:15 INFO - Detecting whether we're running mozinstall >=1.0... 09:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:36:15 INFO - Reading from file tmpfile_stdout 09:36:15 INFO - Output received: 09:36:15 INFO - Usage: mozinstall [options] installer 09:36:15 INFO - Options: 09:36:15 INFO - -h, --help show this help message and exit 09:36:15 INFO - -d DEST, --destination=DEST 09:36:15 INFO - Directory to install application into. [default: 09:36:15 INFO - "/builds/slave/test"] 09:36:15 INFO - --app=APP Application being installed. [default: firefox] 09:36:15 INFO - mkdir: /builds/slave/test/build/application 09:36:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:36:35 INFO - Reading from file tmpfile_stdout 09:36:35 INFO - Output received: 09:36:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:36:35 INFO - Running post-action listener: _resource_record_post_action 09:36:35 INFO - [mozharness: 2017-03-15 16:36:35.542447Z] Finished install step (success) 09:36:35 INFO - [mozharness: 2017-03-15 16:36:35.542558Z] Running run-tests step. 09:36:35 INFO - Running pre-action listener: _resource_record_pre_action 09:36:35 INFO - Running main action method: run_tests 09:36:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:36:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:36:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:36:35 INFO - 2017-03-15 09:36:35.557 screenresolution[1914:17345] starting screenresolution argv=screenresolution get 09:36:35 INFO - 2017-03-15 09:36:35.560 screenresolution[1914:17345] Display 0: 1600x1200x32@60 09:36:35 INFO - 2017-03-15 09:36:35.565 screenresolution[1915:17347] starting screenresolution argv=screenresolution list 09:36:35 INFO - Available Modes on Display 0 09:36:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:36:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:36:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:36:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:36:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:36:35 INFO - Intel Iris: 09:36:35 INFO - Chipset Model: Intel Iris 09:36:35 INFO - Type: GPU 09:36:35 INFO - Bus: Built-In 09:36:35 INFO - VRAM (Dynamic, Max): 1536 MB 09:36:35 INFO - Vendor: Intel (0x8086) 09:36:35 INFO - Device ID: 0x0a2e 09:36:35 INFO - Revision ID: 0x0009 09:36:35 INFO - Displays: 09:36:35 INFO - Display: 09:36:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:36:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:36:35 INFO - Display Serial Number: 1600x1200 60 09:36:35 INFO - Main Display: Yes 09:36:35 INFO - Mirror: Off 09:36:35 INFO - Online: Yes 09:36:35 INFO - Rotation: Supported 09:36:35 INFO - Return code: 0 09:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:36:35 INFO - Python 2.7.3 09:36:35 INFO - Return code: 0 09:36:35 INFO - grabbing minidump binary from tooltool 09:36:35 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:36:35 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 0x106a84d30>, '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 0x1069abdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a79be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:36:35 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:36:35 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:36:35 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:36:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:36:35 INFO - Return code: 0 09:36:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:36:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:36:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:36:35 INFO - ENV: RUST_BACKTRACE is now 1 09:36:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:36:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0377 --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:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pf49hZGG6J/Render', 09:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:36:35 INFO - 'HOME': '/Users/cltbld', 09:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:36:35 INFO - 'LOGNAME': 'cltbld', 09:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:36:35 INFO - 'MOZ_NO_REMOTE': '1', 09:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:36:35 INFO - 'NO_EM_RESTART': '1', 09:36:35 INFO - 'PAGER': '/bin/cat', 09:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:36:35 INFO - 'PWD': '/builds/slave/test', 09:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:36:35 INFO - 'RUST_BACKTRACE': '1', 09:36:35 INFO - 'SHELL': '/bin/bash', 09:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sDVxBloLSv/Listeners', 09:36:35 INFO - 'TMPDIR': '/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/', 09:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:36:35 INFO - 'USER': 'cltbld', 09:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:36:35 INFO - 'XPC_FLAGS': '0x0', 09:36:35 INFO - 'XPC_SERVICE_NAME': '0', 09:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:36:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0377', '--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:36:36 INFO - mozversion application_buildid: 20170315081336 09:36:36 INFO - mozversion application_changeset: 8c89d1991786625a64d868798281610872a2bc26 09:36:36 INFO - mozversion application_display_name: Nightly 09:36:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:36:36 INFO - mozversion application_name: Firefox 09:36:36 INFO - mozversion application_remotingname: firefox 09:36:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:36:36 INFO - mozversion application_vendor: Mozilla 09:36:36 INFO - mozversion application_version: 55.0a1 09:36:36 INFO - mozversion platform_buildid: 20170315081336 09:36:36 INFO - mozversion platform_changeset: 8c89d1991786625a64d868798281610872a2bc26 09:36:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:36:36 INFO - mozversion platform_version: 55.0a1 09:36:36 INFO - using testdate: 1489595796 09:36:36 INFO - actual date: 1489595796 09:36:36 INFO - starting webserver on 'localhost:53367' 09:36:36 INFO - SUITE-START | Running 2 tests 09:36:36 INFO - TEST-START | dromaeo_css 09:36:36 INFO - operating with platform_type : mac_ 09:36:36 INFO - Initialising browser for dromaeo_css test... 09:36:36 INFO - TEST-INFO | started process 1925 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmp9NZduN/profile http://localhost:53367/getInfo.html) 09:36:38 INFO - PID 1925 | 2017-03-15 09:36:38.818 plugin-container[1927:17517] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f43, name = 'com.apple.tsm.portname' 09:36:38 INFO - PID 1925 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:38 INFO - PID 1925 | 2017-03-15 09:36:38.820 plugin-container[1927:17517] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 09:36:38 INFO - PID 1925 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:38 INFO - PID 1925 | 2017-03-15 09:36:38.820 plugin-container[1927:17517] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:36:38 INFO - PID 1925 | __metrics Screen width/height:1600/1200 09:36:38 INFO - PID 1925 | colorDepth:24 09:36:38 INFO - PID 1925 | Browser inner width/height: 1024/689 09:36:38 INFO - PID 1925 | __metrics 09:36:38 ERROR - PID 1925 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:36:39 INFO - TEST-INFO | 1925: exit 0 09:36:39 INFO - Browser initialized. 09:36:39 INFO - Running cycle 1/1 for dromaeo_css test... 09:36:39 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmp9NZduN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:42 INFO - PID 1928 | 2017-03-15 09:36:42.300 plugin-container[1929:17646] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 09:36:42 INFO - PID 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:42 INFO - PID 1928 | 2017-03-15 09:36:42.301 plugin-container[1929:17646] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 09:36:42 INFO - PID 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:36:42 INFO - PID 1928 | 2017-03-15 09:36:42.301 plugin-container[1929:17646] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:36:51 INFO - PID 1928 | RSS: Main: 228478976 09:36:51 INFO - PID 1928 | 09:39:55 INFO - PID 1928 | Cycle 1(1): loaded http://localhost:53367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53367/tests/dromaeo/cssquery-ext.html) 09:39:57 INFO - PID 1928 | RSS: Main: 250908672 09:39:57 INFO - PID 1928 | 09:41:40 INFO - PID 1928 | ************************* 09:41:40 INFO - PID 1928 | A coding exception was thrown and uncaught in a Task. 09:41:40 INFO - PID 1928 | 09:41:40 ERROR - PID 1928 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:41:40 INFO - PID 1928 | Full stack: 09:41:40 INFO - PID 1928 | ************************* 09:42:59 INFO - PID 1928 | Cycle 1(1): loaded http://localhost:53367/tests/dromaeo/cssquery-ext.html (next: http://localhost:53367/tests/dromaeo/cssquery-jquery.html) 09:43:00 INFO - PID 1928 | RSS: Main: 260100096 09:43:00 INFO - PID 1928 | 09:46:02 INFO - PID 1928 | Cycle 1(1): loaded http://localhost:53367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53367/tests/dromaeo/cssquery-mootools.html) 09:46:03 INFO - PID 1928 | RSS: Main: 271216640 09:46:03 INFO - PID 1928 | 09:49:05 INFO - PID 1928 | Cycle 1(1): loaded http://localhost:53367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53367/tests/dromaeo/cssquery-prototype.html) 09:49:05 INFO - PID 1928 | RSS: Main: 264560640 09:49:05 INFO - PID 1928 | 09:52:08 INFO - PID 1928 | Cycle 1(1): loaded http://localhost:53367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53367/tests/dromaeo/cssquery-yui.html) 09:52:09 INFO - PID 1928 | RSS: Main: 275714048 09:52:09 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | Cycle 1(1): loaded http://localhost:53367/tests/dromaeo/cssquery-yui.html (next: http://localhost:53367/tests/dromaeo/cssquery-dojo.html) 09:55:12 INFO - PID 1928 | RSS: Main: 269471744 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | __start_tp_report 09:55:12 INFO - PID 1928 | _x_x_mozilla_page_load 09:55:12 INFO - PID 1928 | _x_x_mozilla_page_load_details 09:55:12 INFO - PID 1928 | |i|pagename|runs| 09:55:12 INFO - PID 1928 | |0;dojo.html;3010.8344041077744;3312.2713003139306;3413.8904855921833;3476.235228249786;3476.3568739783127;5832.125181222818;5930.169776231331;5991.640501569904;6022.126791615224;6022.427869352416;4814.446338671054;4902.313676085342;6010.27876654802;6084.72618732157;6118.223266370672;4294.4202532658;5391.838244852641;5417.756200970956;5433.1850222466555;5514.3658479275;5386.326709161355;5445.754941027663;5487.780488780444;5507.118860982244;5530.446955304477;5343.706096164709;5376.1129413647095;5432.619716619838;5458.426865179178;5468;5406.053940560426;5407.297051383334;5427.104527752916;5433.8369848904595;5467.17992301154;4508.256137737302;5299.940011997616;5372.785088596452;5387.380451248078;5418.0789265824515;5804.2744656917885;5824.912626310609;5845.7369418376275;5866.178734977107;6029.969850150765;5387.326584176978;6248.687565621746;6327.683615819236;6389.808305750835;6416.7433302668305;6434.067060276234;6464;6468.74125034998;6470.967645161792;6479.740810367627;6155.446009859134;6163.630182188993;6177.289611694712;6188;6195.628262304276;6282.623042617366;6388.776392826228;6557.442617377481;6595.175603049619;6609.768658096944;6219.346968568326;6243.157173781481;6249.250089989139;6268.09112678659;6331.986882098842;6371.904421433682;6377.107204991305;6464.385883341075;6466.385693359123;6478.255000674889;6334.714937827809;6369.777057802955;6375.776847810304;6396.1684980953105;6400.679966001681;6225.408586184305;6281.309056003836;6286.15136956505;6308;6375.968120159369;5176.534111929869;5182.2485739567555;5193.143131383355;5224.268602395668;5262;4610.239310513728;4610.95389046112;4629.791659375336;4638.350630911675;4663.300504924288;4508.616767574793;6169.2288463942;6192.256929168439;6192.535559832941;6198.194234749544;5711.428857114255;5955.13650520672;6333.429991300805;6372.840678983062;6430.324815894357;6109.495762817132;6121.418465245794;6189.659568723673;6190.783322583688;6196.256449226122;5690.374058853523;5734.283214598176;5734.627249228787;5742.310922689304;5768.596198266081;5452.6183167177915;6433.774817881539;6533.281339052605;6584.7366105356205;6703.664816759045;6379.234491861006;6435.22777266731;6455.386738259858;6463.15978922737;6473.320301368289;6594.406503414716;6641.535092543476;6650.20197576294;6665.500087493554;6666.133402657623;4867.610591152628;6217.595856269328;6305.8108256752375;6378.2983871774995;6416.711247993758;6358.650274234777;6375.808725738235;6406.551541392244;6413.903791443039;6535.705893234721;6041.607295525777;6268.467180289544;6276.278228003655;6287.874242515216;6359.268684101387;6172.814815555541;6175.2589689237575;6214.1921550198185;6251.281102673069;6270;5522.282103326703;6158.753649853956;6236.314005459305;6242.875142497034;6247.156633854372;6163.476104531165;6180.165677633642;6208.25500939872;6220.968895155495;6261;6208.317085120543;6226.346233645402;6250.312465628686;6252.937470625236;6264.279607844974 09:55:12 INFO - PID 1928 | |1;ext.html;688.9173299204094;701.1025886864815;759.3583422008401;800.8278220182659;944.914957653811;37415.064623384395;38506.229875402474;38562.228755424876;38608.80695596518;38613.80693096537;37278.25443491129;37658.87023389303;37712.811435942785;37788.24423511528;37804.43293350595;7760.883586746189;7933.523988560705;10776.245662803607;11032.44837758113;11048.06091482225;10972.945135274313;11089.445527723621;11112.888871111307;11114.666560003172;11133.276337038107;11055.834162487568;11106.111511079134;11142.944285278561;11162.274452160624;11185.496652650609;11030.944845275802;11037.779244415107;11129.554817807279;11239.100871930308;11262.943685281603;10999.175061870392;11087.2238943274;11087.944560277228;11095.056920161796;11095.611653592166;39137.217255655014;39274;39282.41076383857;39421.80289098565;39429;3811.313963486571;3815.2560250751117;3817.8472861085525;3843.2121415109837;3847.826847791828;27846.582301265295;28014.579781303295;28117;28420;28957.131286061453;3136.6863313668678;3140.0893740815136;3144.8584813683437;3172.74618030557;3252.1381833814057;181653;233302;285165.5741721299;344708;345570;40022;47748.761256193495;47775.283370749465;47780;47867.28199077016;51747.74126129345;52061.7396913013;52180.95638087293;52183.73908130511;52329;14338.784918226234;14435.278236088154;14437.35031923545;14452.855471445362;14456.710865782625;11801.468933897995;11846.585369512026;11875.584354547549;11879.762404751857;11913.22564033335;13830.585082447342;13876.571599969964;13917.956153288544;13931.930340348435;14003.089799163226;6011;6053.244559077906;6066.636001839815;6110.541709371815;6164;1049.41757324684;1070.0209308482806;1114.2478826792046;1129.1644183304295;1185.6365180042847;22419.43951401228;25675.614865777028;26167.345816354744;26289.73710262911;26598.335041624116;1202.8255902894207;1246.214884622682;1253.6176466177903;1254.8494180698374;1267.9556215532411;11388.544458221744;12815;13558.864411355957;15662.530124096294;15977.121258330902;470202;474685.62657187186;476420;476796;478539;58169.70915145397;58751;58889.70555147197;58924;59084.409155908754;1358.5041459867275;1361.4145917255478;1396;1410.5063227870164;1437.2669938331526;28458.861645534776;29067.7093229065;29161.70838291675;29760;29866.850665746533;40225.597744023355;45888.54111458976;46606.30090548712;46626;46737;384586;448372.75813620724;454348;456163;456585;26012.08957686472;26510;29929.70070299269;30468;32576.674233257363;40706;40795.796021019705;41556.37665435082;41608.167836643705;41628.79185604052;27247.86376068107;34240.486392704624;34336.656633434344;35103;35425.468617971266;34098.659013409546;34133;34889;35025.474617881264;35110.64889351074;32938;34231;34882.30235395227;34909.301813964084;35053.47419788654;29242;30495.390092197587;30523.032005839097;30572.388552229277;30697.846510767304;19325.916819095004;22929.53160058024;22995.770042299362;22996.770032300134;23029.539409211386 09:55:12 INFO - PID 1928 | |2;jquery.html;351.9102628829649;387.35312028911716;391.3627601783523;410.50124099219454;413.42946733507756;13319.866801331984;14739.336729847157;20180.4954876128;20935.057922393473;21025.47436314091;20860.8956955215;21001.68497472539;21269.83015934123;21494;22455.101795928185;5783.87214493174;6247.125402443661;6352.904706429407;6560.475161987029;6563.606183628974;6371.235451745797;6530.118434011419;6620.801375958705;6680.632565208912;6686;6528.445082168021;6542.41118299353;6592.967035164817;6596.076549283104;6598.505112116586;5598.580106492009;6489.675516224217;6519.376676204611;6547.803565893031;6572.835679108012;6351.904721429182;6357.364263573651;6364.554481186319;6380.553361264713;6383.904241436382;24490.63264051041;25367.731613419255;25712.228633141036;26674.733252667615;26938.595921061198;2785.387214812738;2936.3686807336526;3025.3495498467714;3278.557394751702;3283.1463819406886;15807.446739364066;16322.918385408117;16424.87200562474;16703;17114.14429278531;2006.2476571285767;2056.7531896172554;2086.3115171993204;2094.7695753467106;2102.4428526440506;104787.95212047859;121957;141328;150212;160533.394666053;21884.343469695934;22016.373108409825;22174.445638858833;22332.776672233394;22704.31887043391;35554.93335199948;35760.821195893855;35886.64113358833;35997;36009.639903600626;10269.229807764448;10554.894451055392;10719.249652524404;10724;10823.350598964087;8467.872981905277;8629.741107766777;8644.610992505226;8763.561821909007;8795.824083518422;8604.569771511524;8915.42049766763;10808.94595527033;10920.836187457195;10945.83581246282;3807.4098514730263;4422.513523512475;4509.413776209072;4522.389477420506;4543.704659197141;964.9903500965041;989.4656885282011;997.4763249294178;1001.5927621691535;1045.4197920154236;20385.592288154156;21912.89043554772;21921;21939;21975.780242197372;998.7752755629925;1004.8944860789658;1028.2956175020136;1037.8391349340864;1049.8162821506205;10977.780444391068;11313.03839173663;11357.318560886373;11388.259763115371;11388.886111138949;370532;531774.3411282919;597120;598634;620466;122300;142171.28914355361;144048.27975860055;146527.2673636625;148919;1227.6194379742308;1260.8676089010705;1288.4781663426327;1316.835395575553;1320.1155225998605;20065.899670501552;20870.582588347843;21090.65113351394;21411.8929405352;21487.925603720065;48601.54195374144;59059;60269.698651506464;60665.69667151636;62244.37755622386;66067;79194.60402697949;79691.60154199191;79829.60085199769;80309.59845200737;9544.904550954401;10468.738281542717;12210.26738395699;12309.769023097619;12478;10752.784944301227;11081.445927703422;11891.821622675494;12984.091113622333;13422.194668319931;9903.55434005486;10323.70953630796;10875.673729788119;11178.217524773512;11502.42487875586;10589.841152382567;11056.336619802838;11306.830397544209;11501.82747258775;11564.421778910853;11601.825972610586;11604.454997963152;11821.290722556674;11825.586104486301;11830.585929492427;10097.646582369582;11175.217734758815;12164;12221.205621634565;12239.938800305941;9477.715668529956;11246.381449020055;11276.60531881413;11340.659780206606;11769.705757355792 09:55:12 INFO - PID 1928 | |3;mootools.html;1243.4342374219732;1493.7609982402819;1522.467136502224;1537.846615038721;1572.9606759831;9462.81074378512;9756.756081097976;10528.42093684847;10878.564857405705;10987.725306867333;10194.439305838176;10545.78908421833;10565.260431769779;10567.313124646893;10581.470926453685;2296.5980953333183;2339.5671800716923;2352.3413444235644;2352.3766201956496;2356.4815740537056;2289.713785776778;2324.535092981402;2334.7781960713705;2341.8594884306995;2347.95304093918;2307.4462129088984;2317.3048085574346;2319.072371051576;2324.0239099578134;2325.7557956414585;2279.8632082074964;2282.315305408379;2292.988535057331;2298.482841360689;2301.5742087713825;2245.4723140062074;2312.7455979842202;2316.8957396917012;2317.0384290519414;2325.6395258734924;10946.014858662678;10956.726081847937;11011.504482298316;11029.779404411867;11056.502457389357;4624.699394539378;5711.885762284731;5764;5767.6539407635255;5775.537956963432;2854.9286267843263;3519.0324152816343;3531.134871956387;3577.4276115821344;3687.465317528943;1127.9097672186206;1141.1384404774342;1215.392303848076;1231.2981600487726;1235.1600911380258;13719.862801372059;15363.15502647354;15447.691046179127;15467.458638947583;15501.689966200725;4688;4822.590079843182;4860.756962151878;4934.18585933317;4950.2079667253065;12690.175138615961;12729.363531823372;12738.80891786624;12743.299118548384;12748.171368860994;5798.59409841307;5880.2943646761805;5882.411758824169;5887.1463637772285;5901.940980590225;4480.775961201927;4997.825076122318;5137.306463627438;5205.895882082337;5256;3829.7702137871815;3946.1121247719607;3991.1419044905483;4019.979900100481;4032.778197199182;1133.8469306643497;1140.749035212252;1143.0969534068158;1154.9826752598717;1158.3918442817587;776.5224387001953;779.8869163971192;797.5095316380384;802.2659266770839;817.8773184022444;6204.348543402968;6218.31598524162;6334.144890439732;6522.184726909137;6534.803955881332;875.4484674655054;996.8255555277942;997.5162046407487;1010.525053224983;1031.9380837149795;3796.37359835624;3933.567307596162;3949.7827619481204;4080.4083407906282;4090.775007374623;11946.223495472766;12229.082818788627;12308.26150430959;12332.81500777489;12334;10335.63825266127;12252.938735306267;12717.427715752814;13043.152195107288;13055.21668699881;9690.224782017563;9725.756856078513;9892.901070989343;9964.757929465812;10054.09513143806;5346.946530534645;5705.115707065412;5901.911471327848;6420.518461115342;6486.481081513562;11766.352850593299;12003.759924801281;12108.212966157524;12155.817662735242;12164.574239901562;11942.34317112567;12099.33453660022;12324.075694322783;12382.380880955736;12496.31270280107;7203.315685009916;8105.675772969251;9116.680916167903;9127.132922372364;9319.906800932175;10085.495725213857;10165.593376264867;10216.233782466195;10320.948395257976;10342.120919721909;8963.546316477183;8975.865362019706;9085.36402451822;9101.77245568866;9228.95385523068;7762.7671169865;7855.567943763148;8716.215540601122;8961.283097352065;9015.008349081727;6784.864302714017;7573;7728.652210650646;7777.377809775091;7853.528788272722;5725.828225153252;5874.618149820248;5898.587098903035;5936.079907614327;5938.317093534299;5804.158397032491;5835.44563266489;5902.1441890926435;6095.1466794647895;6149.385061493994 09:55:12 INFO - PID 1928 | |4;prototype.html;356.4136994643811;382.6651679780192;388.76868263383284;391.670996363055;392.9351656976598;4778.569928706415;6087.3303936567;6197.8760424791535;6216.896848080268;6343.746250149994;5782.913256301148;5951.494122999539;6002.789902353418;6009.909851352233;6077.756889724416;4069;4663.34713140159;4666.673332866701;4666.856620128074;4728.716277023373;4088.4480595119576;4689.109069276844;4714.787834547436;4727.399930038465;4743.644226682995;4604.5165257647795;4666.276727107287;4666.719996800203;4840.540148685869;4958.157113290749;3539.681428671432;4893.975530122344;4900.950990490103;4916.58209052231;5068;3775.848366248293;4510.075434535912;4510.706804057759;4514.7291162530355;4529.773511324421;5584.4136365681425;5592.748326325325;5866.354700982888;5885.764569417218;6002.579819412643;5276.947230527684;5795.768169273224;5826.2134611827705;5836.723677765674;5860.736266868002;5622.297212848394;5928.229330187091;6227.87544249117;6511.4465270452065;6518.78497202241;4252.957470425287;4633.72197668141;5062.822801201977;5082.847514574569;5103.1324674805;5866.735996880108;6581.243157036906;6648.601083934979;6794.694238759268;6972.58164510131;4060.614241647039;4935.7048972228085;5086.593072554261;5271.6309858310315;5295.443978382292;5391.821338462644;5401.244595506476;5403.675779453245;5430.755615997289;5433.755481003364;4570.885727856764;5046.84859454217;5511.346596021178;5808.593398462067;5835.244275915115;5596.356419011784;6526.510511711545;6529.967350163314;6537.052127441494;6543.9345606544275;1548.7134880047226;1762.2158139627743;1774.5031391210482;1846.621442604263;1854.7403363529118;1317.6691541542918;1337.5118081900232;1356.6879617687987;1371.9794203086963;1378.710470801123;5447.874809693747;5891.764329426775;6096.542759293071;6120.908186377208;6180.258368995749;6106.473381654587;6715.918065399742;6724.562903411263;6741.224759152662;6757.425618822357;4813.542713442217;6103.908441373383;6149.077638354193;6193.411625895623;6233.265395835842;2666.7733242674203;3533.505309256706;3565.8751943682364;3573.6962358199326;3574.7488379067117;6366.331535188831;6660.534682369871;6856.314368563104;6990;7057.18842333128;5926.318473375531;6693.966530167416;6917.792466226021;6939.410150137194;6950.652467376611;6271.905921411182;6639.668016599151;6902.482313826483;6927.480438966997;6990.755323563651;6707.932920670926;6715.4963377747845;6717.596944183169;6742.764003259862;6754.596322941529;5836.474717275466;6076.331603523698;6314.494840412848;6636.838553253065;6668.866622667617;5778.27771528559;6912.723491060502;6916.896246556205;6940.93059069423;7033.312005118837;4029.3553031514816;4852.641260447081;5264.78940842362;5265.368155821326;5286.471352864683;4885.413750349981;6336.58812177207;6610.768623098168;6640.966795165993;6651.467882569286;5656.688882111359;5829.59192856496;5888.941110588839;5997.130416089555;6461.64460954652;5564.33228012641;5830.717242206708;5872.970635146797;5875.9423303805725;6172.814815555541;6292.552712876156;6305.1172835803945;6319.146915166394;6330;6375.489960803217;5106.591472682102;5687.488126068673;5771.297467247088;6427.775027874189;6512.525240408614;5572.582056345709;5591.741858082061;6302.306746257999;6332.461740752087;6402.90395644075 09:55:12 INFO - PID 1928 | |5;yui.html;679.6363945289271;705.1221229569184;718.4001358865347;761.9276168763965;820.790698371915;14896.627584310385;15232.390704371812;15402.61493462664;15685;15694.52916412508;13615.25116118613;15007.399704011854;15341.84658153418;15360;15408.998415103011;922.6217250927104;952.7808604021079;953.9046095390474;954.3844220477788;955.9713208603753;932.9346945713803;949.6818565780437;959.5538074795219;961.8749562556893;968.8546717992288;980.2207245240052;989.0208693393561;989.7278248481654;991.7867658453467;999.3953658036892;983.0906411569306;983.1790454970109;984.6406061787396;985.329975616584;995.2088089968493;726.1431510817233;736.977890663281;744.6239648977286;744.7207297263526;745.117036311972;13441.924646028294;16069.919650401673;16362.263698133613;16716.916415417967;16999.23503442348;13586.93206533961;14765.409383624643;14877.553673389815;15008.324625391884;15027.474038408604;11618.76762464746;11645.18483706141;11896.84733545611;11959.282443053358;12068.275903445821;3628.455731640249;3676.8529258829612;3754.155315054118;3758.4926034985474;3767.3595488766973;102359.21719360641;103537;104549.47725261402;105055.94944050538;106212.40681389708;11369.204155709187;11381.317120972768;11517.48171332292;11712.180147389772;11883.58407455735;24456.388590285384;24564.140255090984;25117.4976500469;25137.120200792884;25245.495090098095;7622.00913881203;7730.613469326511;7795.181505941794;7800.648970796327;7880.054393472706;3839.846406143779;4152.1280531088205;4182.8288079337835;4247.320428731388;4301.903014731223;3393.575803024622;3417.128632198823;3466.7399945004227;3485.4074807282313;3486.1110416843544;555.5999680230228;563.6646195513663;634.22307673101;638.3680156644981;659.2385794407467;616.8797084568466;640.3404493371835;673.7641825361183;683.1221879884325;684.8424862281703;8921.643134274556;9091.590878410487;10134.493275336352;10300.484975751182;10421.322614030063;666.213867636194;692.9064576282137;696.9407600353925;697.4315932514984;708.9118203557515;3912.3349030664854;4832.492588278251;4878.829240976549;4990.17662085759;4992.326035985096;70744.29255707377;83549;84016.57991710003;85147.14852851516;86336.70494942581;35509.82245088758;58809.41190588125;65538;74024.62987685027;75738;50945;67363.97908062766;67486.98769518461;68506;69138.65430672815;9376.921654009877;10190;10478.161747060369;10768.623098191525;10913.945430272797;30063.849680751457;43419.56580434155;45171.774141129084;46736.065278694914;50670.23994640157;56007;68029;70998.93501597377;71030.93453598097;71353.64323178558;13533.796993044914;13599.184048957095;13634.93182534081;13783.931080344533;14251.857481425053;14417.279136042946;14613.415463381345;14671.55985320442;14673.460486141266;14793.556193314218;13530;13627.931860340635;13657;13662.043656943919;14333.211673358066;13177.73644527085;13284.734305314032;13286.53497127596;13740.862591373958;13862.584122476343;13161.53934612284;13425.66435839112;13550.254735989614;13676.863231367957;13714.38285277145;9435.57539910692;10872.945635271773;11041.779164416506;11077.833832492357;11488.138389620644;8574.22831945103;10688.679339619825;11062.976013415744;11248.26886252391;11308.434578271219 09:55:12 INFO - PID 1928 | __end_tp_report 09:55:12 INFO - PID 1928 | __start_cc_report 09:55:12 INFO - PID 1928 | _x_x_mozilla_cycle_collect,420 09:55:12 INFO - PID 1928 | __end_cc_report 09:55:12 INFO - PID 1928 | __startTimestamp1489596912378__endTimestamp 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | ------- Summary: start ------- 09:55:12 INFO - PID 1928 | Number of tests: 6 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | [#0] dojo.html Cycles:165 Average:5901.41 Median:6192.26 stddev:698.80 (11.3%) stddev-sans-first:663.13 09:55:12 INFO - PID 1928 | Values: 3010.8 3312.3 3413.9 3476.2 3476.4 5832.1 5930.2 5991.6 6022.1 6022.4 4814.4 4902.3 6010.3 6084.7 6118.2 4294.4 5391.8 5417.8 5433.2 5514.4 5386.3 5445.8 5487.8 5507.1 5530.4 5343.7 5376.1 5432.6 5458.4 5468.0 5406.1 5407.3 5427.1 5433.8 5467.2 4508.3 5299.9 5372.8 5387.4 5418.1 5804.3 5824.9 5845.7 5866.2 6030.0 5387.3 6248.7 6327.7 6389.8 6416.7 6434.1 6464.0 6468.7 6471.0 6479.7 6155.4 6163.6 6177.3 6188.0 6195.6 6282.6 6388.8 6557.4 6595.2 6609.8 6219.3 6243.2 6249.3 6268.1 6332.0 6371.9 6377.1 6464.4 6466.4 6478.3 6334.7 6369.8 6375.8 6396.2 6400.7 6225.4 6281.3 6286.2 6308.0 6376.0 5176.5 5182.2 5193.1 5224.3 5262.0 4610.2 4611.0 4629.8 4638.4 4663.3 4508.6 6169.2 6192.3 6192.5 6198.2 5711.4 5955.1 6333.4 6372.8 6430.3 6109.5 6121.4 6189.7 6190.8 6196.3 5690.4 5734.3 5734.6 5742.3 5768.6 5452.6 6433.8 6533.3 6584.7 6703.7 6379.2 6435.2 6455.4 6463.2 6473.3 6594.4 6641.5 6650.2 6665.5 6666.1 4867.6 6217.6 6305.8 6378.3 6416.7 6358.7 6375.8 6406.6 6413.9 6535.7 6041.6 6268.5 6276.3 6287.9 6359.3 6172.8 6175.3 6214.2 6251.3 6270.0 5522.3 6158.8 6236.3 6242.9 6247.2 6163.5 6180.2 6208.3 6221.0 6261.0 6208.3 6226.3 6250.3 6252.9 6264.3 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | [#1] ext.html Cycles:180 Average:54029.70 Median:16917.27 stddev:108649.69 (642.2%) stddev-sans-first:108880.67 09:55:12 INFO - PID 1928 | Values: 688.9 701.1 759.4 800.8 944.9 37415.1 38506.2 38562.2 38608.8 38613.8 37278.3 37658.9 37712.8 37788.2 37804.4 7760.9 7933.5 10776.2 11032.4 11048.1 10972.9 11089.4 11112.9 11114.7 11133.3 11055.8 11106.1 11142.9 11162.3 11185.5 11030.9 11037.8 11129.6 11239.1 11262.9 10999.2 11087.2 11087.9 11095.1 11095.6 39137.2 39274.0 39282.4 39421.8 39429.0 3811.3 3815.3 3817.8 3843.2 3847.8 27846.6 28014.6 28117.0 28420.0 28957.1 3136.7 3140.1 3144.9 3172.7 3252.1 181653.0 233302.0 285165.6 344708.0 345570.0 40022.0 47748.8 47775.3 47780.0 47867.3 51747.7 52061.7 52181.0 52183.7 52329.0 14338.8 14435.3 14437.4 14452.9 14456.7 11801.5 11846.6 11875.6 11879.8 11913.2 13830.6 13876.6 13918.0 13931.9 14003.1 6011.0 6053.2 6066.6 6110.5 6164.0 1049.4 1070.0 1114.2 1129.2 1185.6 22419.4 25675.6 26167.3 26289.7 26598.3 1202.8 1246.2 1253.6 1254.8 1268.0 11388.5 12815.0 13558.9 15662.5 15977.1 470202.0 474685.6 476420.0 476796.0 478539.0 58169.7 58751.0 58889.7 58924.0 59084.4 1358.5 1361.4 1396.0 1410.5 1437.3 28458.9 29067.7 29161.7 29760.0 29866.9 40225.6 45888.5 46606.3 46626.0 46737.0 384586.0 448372.8 454348.0 456163.0 456585.0 26012.1 26510.0 29929.7 30468.0 32576.7 40706.0 40795.8 41556.4 41608.2 41628.8 27247.9 34240.5 34336.7 35103.0 35425.5 34098.7 34133.0 34889.0 35025.5 35110.6 32938.0 34231.0 34882.3 34909.3 35053.5 29242.0 30495.4 30523.0 30572.4 30697.8 19325.9 22929.5 22995.8 22996.8 23029.5 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | [#2] jquery.html Cycles:180 Average:36210.48 Median:21689.17 stddev:93190.41 (429.7%) stddev-sans-first:93412.94 09:55:12 INFO - PID 1928 | Values: 351.9 387.4 391.4 410.5 413.4 13319.9 14739.3 20180.5 20935.1 21025.5 20860.9 21001.7 21269.8 21494.0 22455.1 5783.9 6247.1 6352.9 6560.5 6563.6 6371.2 6530.1 6620.8 6680.6 6686.0 6528.4 6542.4 6593.0 6596.1 6598.5 5598.6 6489.7 6519.4 6547.8 6572.8 6351.9 6357.4 6364.6 6380.6 6383.9 24490.6 25367.7 25712.2 26674.7 26938.6 2785.4 2936.4 3025.3 3278.6 3283.1 15807.4 16322.9 16424.9 16703.0 17114.1 2006.2 2056.8 2086.3 2094.8 2102.4 104788.0 121957.0 141328.0 150212.0 160533.4 21884.3 22016.4 22174.4 22332.8 22704.3 35554.9 35760.8 35886.6 35997.0 36009.6 10269.2 10554.9 10719.2 10724.0 10823.4 8467.9 8629.7 8644.6 8763.6 8795.8 8604.6 8915.4 10808.9 10920.8 10945.8 3807.4 4422.5 4509.4 4522.4 4543.7 965.0 989.5 997.5 1001.6 1045.4 20385.6 21912.9 21921.0 21939.0 21975.8 998.8 1004.9 1028.3 1037.8 1049.8 10977.8 11313.0 11357.3 11388.3 11388.9 370532.0 531774.3 597120.0 598634.0 620466.0 122300.0 142171.3 144048.3 146527.3 148919.0 1227.6 1260.9 1288.5 1316.8 1320.1 20065.9 20870.6 21090.7 21411.9 21487.9 48601.5 59059.0 60269.7 60665.7 62244.4 66067.0 79194.6 79691.6 79829.6 80309.6 9544.9 10468.7 12210.3 12309.8 12478.0 10752.8 11081.4 11891.8 12984.1 13422.2 9903.6 10323.7 10875.7 11178.2 11502.4 10589.8 11056.3 11306.8 11501.8 11564.4 11601.8 11604.5 11821.3 11825.6 11830.6 10097.6 11175.2 12164.0 12221.2 12239.9 9477.7 11246.4 11276.6 11340.7 11769.7 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | [#3] mootools.html Cycles:180 Average:6559.87 Median:2605.71 stddev:4095.16 (157.2%) stddev-sans-first:4087.16 09:55:12 INFO - PID 1928 | Values: 1243.4 1493.8 1522.5 1537.8 1573.0 9462.8 9756.8 10528.4 10878.6 10987.7 10194.4 10545.8 10565.3 10567.3 10581.5 2296.6 2339.6 2352.3 2352.4 2356.5 2289.7 2324.5 2334.8 2341.9 2348.0 2307.4 2317.3 2319.1 2324.0 2325.8 2279.9 2282.3 2293.0 2298.5 2301.6 2245.5 2312.7 2316.9 2317.0 2325.6 10946.0 10956.7 11011.5 11029.8 11056.5 4624.7 5711.9 5764.0 5767.7 5775.5 2854.9 3519.0 3531.1 3577.4 3687.5 1127.9 1141.1 1215.4 1231.3 1235.2 13719.9 15363.2 15447.7 15467.5 15501.7 4688.0 4822.6 4860.8 4934.2 4950.2 12690.2 12729.4 12738.8 12743.3 12748.2 5798.6 5880.3 5882.4 5887.1 5901.9 4480.8 4997.8 5137.3 5205.9 5256.0 3829.8 3946.1 3991.1 4020.0 4032.8 1133.8 1140.7 1143.1 1155.0 1158.4 776.5 779.9 797.5 802.3 817.9 6204.3 6218.3 6334.1 6522.2 6534.8 875.4 996.8 997.5 1010.5 1031.9 3796.4 3933.6 3949.8 4080.4 4090.8 11946.2 12229.1 12308.3 12332.8 12334.0 10335.6 12252.9 12717.4 13043.2 13055.2 9690.2 9725.8 9892.9 9964.8 10054.1 5346.9 5705.1 5901.9 6420.5 6486.5 11766.4 12003.8 12108.2 12155.8 12164.6 11942.3 12099.3 12324.1 12382.4 12496.3 7203.3 8105.7 9116.7 9127.1 9319.9 10085.5 10165.6 10216.2 10320.9 10342.1 8963.5 8975.9 9085.4 9101.8 9229.0 7762.8 7855.6 8716.2 8961.3 9015.0 6784.9 7573.0 7728.7 7777.4 7853.5 5725.8 5874.6 5898.6 5936.1 5938.3 5804.2 5835.4 5902.1 6095.1 6149.4 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | [#4] prototype.html Cycles:180 Average:5347.00 Median:5832.98 stddev:1544.72 (26.5%) stddev-sans-first:1502.95 09:55:12 INFO - PID 1928 | Values: 356.4 382.7 388.8 391.7 392.9 4778.6 6087.3 6197.9 6216.9 6343.7 5782.9 5951.5 6002.8 6009.9 6077.8 4069.0 4663.3 4666.7 4666.9 4728.7 4088.4 4689.1 4714.8 4727.4 4743.6 4604.5 4666.3 4666.7 4840.5 4958.2 3539.7 4894.0 4901.0 4916.6 5068.0 3775.8 4510.1 4510.7 4514.7 4529.8 5584.4 5592.7 5866.4 5885.8 6002.6 5276.9 5795.8 5826.2 5836.7 5860.7 5622.3 5928.2 6227.9 6511.4 6518.8 4253.0 4633.7 5062.8 5082.8 5103.1 5866.7 6581.2 6648.6 6794.7 6972.6 4060.6 4935.7 5086.6 5271.6 5295.4 5391.8 5401.2 5403.7 5430.8 5433.8 4570.9 5046.8 5511.3 5808.6 5835.2 5596.4 6526.5 6530.0 6537.1 6543.9 1548.7 1762.2 1774.5 1846.6 1854.7 1317.7 1337.5 1356.7 1372.0 1378.7 5447.9 5891.8 6096.5 6120.9 6180.3 6106.5 6715.9 6724.6 6741.2 6757.4 4813.5 6103.9 6149.1 6193.4 6233.3 2666.8 3533.5 3565.9 3573.7 3574.7 6366.3 6660.5 6856.3 6990.0 7057.2 5926.3 6694.0 6917.8 6939.4 6950.7 6271.9 6639.7 6902.5 6927.5 6990.8 6707.9 6715.5 6717.6 6742.8 6754.6 5836.5 6076.3 6314.5 6636.8 6668.9 5778.3 6912.7 6916.9 6940.9 7033.3 4029.4 4852.6 5264.8 5265.4 5286.5 4885.4 6336.6 6610.8 6641.0 6651.5 5656.7 5829.6 5888.9 5997.1 6461.6 5564.3 5830.7 5873.0 5875.9 6172.8 6292.6 6305.1 6319.1 6330.0 6375.5 5106.6 5687.5 5771.3 6427.8 6512.5 5572.6 5591.7 6302.3 6332.5 6402.9 09:55:12 INFO - PID 1928 | 09:55:12 INFO - PID 1928 | [#5] yui.html Cycles:180 Average:18737.59 Median:3762.93 stddev:25417.84 (675.5%) stddev-sans-first:25452.98 09:55:12 INFO - PID 1928 | Values: 679.6 705.1 718.4 761.9 820.8 14896.6 15232.4 15402.6 15685.0 15694.5 13615.3 15007.4 15341.8 15360.0 15409.0 922.6 952.8 953.9 954.4 956.0 932.9 949.7 959.6 961.9 968.9 980.2 989.0 989.7 991.8 999.4 983.1 983.2 984.6 985.3 995.2 726.1 737.0 744.6 744.7 745.1 13441.9 16069.9 16362.3 16716.9 16999.2 13586.9 14765.4 14877.6 15008.3 15027.5 11618.8 11645.2 11896.8 11959.3 12068.3 3628.5 3676.9 3754.2 3758.5 3767.4 102359.2 103537.0 104549.5 105055.9 106212.4 11369.2 11381.3 11517.5 11712.2 11883.6 24456.4 24564.1 25117.5 25137.1 25245.5 7622.0 7730.6 7795.2 7800.6 7880.1 3839.8 4152.1 4182.8 4247.3 4301.9 3393.6 3417.1 3466.7 3485.4 3486.1 555.6 563.7 634.2 638.4 659.2 616.9 640.3 673.8 683.1 684.8 8921.6 9091.6 10134.5 10300.5 10421.3 666.2 692.9 696.9 697.4 708.9 3912.3 4832.5 4878.8 4990.2 4992.3 70744.3 83549.0 84016.6 85147.1 86336.7 35509.8 58809.4 65538.0 74024.6 75738.0 50945.0 67364.0 67487.0 68506.0 69138.7 9376.9 10190.0 10478.2 10768.6 10913.9 30063.8 43419.6 45171.8 46736.1 50670.2 56007.0 68029.0 70998.9 71030.9 71353.6 13533.8 13599.2 13634.9 13783.9 14251.9 14417.3 14613.4 14671.6 14673.5 14793.6 13530.0 13627.9 13657.0 13662.0 14333.2 13177.7 13284.7 13286.5 13740.9 13862.6 13161.5 13425.7 13550.3 13676.9 13714.4 9435.6 10872.9 11041.8 11077.8 11488.1 8574.2 10688.7 11063.0 11248.3 11308.4 09:55:12 INFO - PID 1928 | -------- Summary: end -------- 09:55:12 INFO - PID 1928 | 09:55:13 INFO - TEST-INFO | 1928: exit 0 09:55:13 INFO - TEST-OK | dromaeo_css | took 1116933ms 09:55:13 INFO - TEST-START | kraken 09:55:13 INFO - operating with platform_type : mac_ 09:55:13 INFO - Initialising browser for kraken test... 09:55:13 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpfywPQu/profile http://localhost:53367/getInfo.html) 09:55:15 INFO - PID 1934 | 2017-03-15 09:55:15.840 plugin-container[1935:19761] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 09:55:15 INFO - PID 1934 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:15 INFO - PID 1934 | 2017-03-15 09:55:15.844 plugin-container[1935:19761] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 09:55:15 INFO - PID 1934 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:15 INFO - PID 1934 | 2017-03-15 09:55:15.844 plugin-container[1935:19761] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:55:15 INFO - PID 1934 | __metrics Screen width/height:1600/1200 09:55:15 INFO - PID 1934 | colorDepth:24 09:55:15 INFO - PID 1934 | Browser inner width/height: 1024/689 09:55:15 INFO - PID 1934 | __metrics 09:55:16 ERROR - PID 1934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 09:55:16 INFO - TEST-INFO | 1934: exit 0 09:55:16 INFO - Browser initialized. 09:55:16 INFO - Running cycle 1/1 for kraken test... 09:55:16 INFO - TEST-INFO | started process 1936 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/T/tmpfywPQu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:55:19 INFO - PID 1936 | 2017-03-15 09:55:19.278 plugin-container[1937:19882] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 09:55:19 INFO - PID 1936 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:19 INFO - PID 1936 | 2017-03-15 09:55:19.278 plugin-container[1937:19882] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 09:55:19 INFO - PID 1936 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:55:19 INFO - PID 1936 | 2017-03-15 09:55:19.278 plugin-container[1937:19882] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:55:29 INFO - PID 1936 | RSS: Main: 228945920 09:55:29 INFO - PID 1936 | 09:55:31 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53367/tests/kraken/driver.html?testName=audio-beat-detection) 09:55:32 INFO - PID 1936 | RSS: Main: 242212864 09:55:32 INFO - PID 1936 | 09:55:35 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53367/tests/kraken/driver.html?testName=audio-dft) 09:55:36 INFO - PID 1936 | RSS: Main: 250351616 09:55:36 INFO - PID 1936 | 09:55:39 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53367/tests/kraken/driver.html?testName=audio-fft) 09:55:40 INFO - PID 1936 | RSS: Main: 252739584 09:55:40 INFO - PID 1936 | 09:55:42 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53367/tests/kraken/driver.html?testName=audio-oscillator) 09:55:42 INFO - PID 1936 | RSS: Main: 255033344 09:55:42 INFO - PID 1936 | 09:55:44 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:55:45 INFO - PID 1936 | RSS: Main: 255709184 09:55:45 INFO - PID 1936 | 09:55:48 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53367/tests/kraken/driver.html?testName=imaging-darkroom) 09:55:49 INFO - PID 1936 | RSS: Main: 261177344 09:55:49 INFO - PID 1936 | 09:55:52 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53367/tests/kraken/driver.html?testName=imaging-desaturate) 09:55:52 INFO - PID 1936 | RSS: Main: 261287936 09:55:52 INFO - PID 1936 | 09:55:56 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53367/tests/kraken/driver.html?testName=json-parse-financial) 09:55:56 INFO - PID 1936 | RSS: Main: 261480448 09:55:56 INFO - PID 1936 | 09:55:58 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:55:59 INFO - PID 1936 | RSS: Main: 261201920 09:55:59 INFO - PID 1936 | 09:56:01 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:56:01 INFO - PID 1936 | RSS: Main: 261181440 09:56:01 INFO - PID 1936 | 09:56:04 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:56:04 INFO - PID 1936 | RSS: Main: 261267456 09:56:04 INFO - PID 1936 | 09:56:07 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:56:08 INFO - PID 1936 | RSS: Main: 261853184 09:56:08 INFO - PID 1936 | 09:56:11 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:56:12 INFO - PID 1936 | RSS: Main: 259100672 09:56:12 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | Cycle 1(1): loaded http://localhost:53367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53367/tests/kraken/driver.html?testName=ai-astar) 09:56:14 INFO - PID 1936 | RSS: Main: 262197248 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | __start_tp_report 09:56:14 INFO - PID 1936 | _x_x_mozilla_page_load 09:56:14 INFO - PID 1936 | _x_x_mozilla_page_load_details 09:56:14 INFO - PID 1936 | |i|pagename|runs| 09:56:14 INFO - PID 1936 | |0;ai-astar;109;123;120;120;121;120;119;119;126;120 09:56:14 INFO - PID 1936 | |1;audio-beat-detection;144;122;145;176;117;148;147;117;138;151 09:56:14 INFO - PID 1936 | |2;audio-dft;203;213;209;230;201;200;229;266;192;193 09:56:14 INFO - PID 1936 | |3;audio-fft;85;67;91;116;70;64;65;59;73;52 09:56:14 INFO - PID 1936 | |4;audio-oscillator;87;72;87;59;74;83;125;56;100;110 09:56:14 INFO - PID 1936 | |5;imaging-gaussian-blur;137;133;90;102;89;80;137;135;90;89 09:56:14 INFO - PID 1936 | |6;imaging-darkroom;96;98;96;96;97;96;97;96;98;98 09:56:14 INFO - PID 1936 | |7;imaging-desaturate;89;108;91;145;144;133;90;90;93;90 09:56:14 INFO - PID 1936 | |8;json-parse-financial;57;74;103;104;105;106;79;67;69;83 09:56:14 INFO - PID 1936 | |9;json-stringify-tinderbox;58;60;59;63;63;57;70;83;83;58 09:56:14 INFO - PID 1936 | |10;stanford-crypto-aes;85;89;82;87;80;107;114;104;99;86 09:56:14 INFO - PID 1936 | |11;stanford-crypto-ccm;155;155;149;171;158;162;148;141;218;142 09:56:14 INFO - PID 1936 | |12;stanford-crypto-pbkdf2;237;234;188;191;234;234;194;217;242;217 09:56:14 INFO - PID 1936 | |13;stanford-crypto-sha256-iterative;68;70;71;69;69;70;70;67;68;75 09:56:14 INFO - PID 1936 | __end_tp_report 09:56:14 INFO - PID 1936 | __start_cc_report 09:56:14 INFO - PID 1936 | _x_x_mozilla_cycle_collect,1011 09:56:14 INFO - PID 1936 | __end_cc_report 09:56:14 INFO - PID 1936 | __startTimestamp1489596974566__endTimestamp 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | ------- Summary: start ------- 09:56:14 INFO - PID 1936 | Number of tests: 14 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#0] ai-astar Cycles:10 Average:119.70 Median:120.00 stddev:4.32 (3.6%) stddev-sans-first:2.26 09:56:14 INFO - PID 1936 | Values: 109.0 123.0 120.0 120.0 121.0 120.0 119.0 119.0 126.0 120.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:146.00 stddev:18.12 (12.4%) stddev-sans-first:19.17 09:56:14 INFO - PID 1936 | Values: 144.0 122.0 145.0 176.0 117.0 148.0 147.0 117.0 138.0 151.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#2] audio-dft Cycles:10 Average:213.60 Median:211.00 stddev:22.66 (10.7%) stddev-sans-first:23.71 09:56:14 INFO - PID 1936 | Values: 203.0 213.0 209.0 230.0 201.0 200.0 229.0 266.0 192.0 193.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#3] audio-fft Cycles:10 Average:74.20 Median:68.50 stddev:18.65 (27.2%) stddev-sans-first:19.36 09:56:14 INFO - PID 1936 | Values: 85.0 67.0 91.0 116.0 70.0 64.0 65.0 59.0 73.0 52.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:73.00 stddev:21.78 (29.8%) stddev-sans-first:23.09 09:56:14 INFO - PID 1936 | Values: 87.0 72.0 87.0 59.0 74.0 83.0 125.0 56.0 100.0 110.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#5] imaging-gaussian-blur Cycles:10 Average:108.20 Median:84.50 stddev:24.10 (28.5%) stddev-sans-first:23.19 09:56:14 INFO - PID 1936 | Values: 137.0 133.0 90.0 102.0 89.0 80.0 137.0 135.0 90.0 89.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:97.00 stddev:0.92 (0.9%) stddev-sans-first:0.93 09:56:14 INFO - PID 1936 | Values: 96.0 98.0 96.0 96.0 97.0 96.0 97.0 96.0 98.0 98.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#7] imaging-desaturate Cycles:10 Average:107.30 Median:90.00 stddev:23.88 (26.5%) stddev-sans-first:24.39 09:56:14 INFO - PID 1936 | Values: 89.0 108.0 91.0 145.0 144.0 133.0 90.0 90.0 93.0 90.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#8] json-parse-financial Cycles:10 Average:84.70 Median:68.00 stddev:18.41 (27.1%) stddev-sans-first:16.57 09:56:14 INFO - PID 1936 | Values: 57.0 74.0 103.0 104.0 105.0 106.0 79.0 67.0 69.0 83.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:63.00 stddev:10.01 (15.9%) stddev-sans-first:10.26 09:56:14 INFO - PID 1936 | Values: 58.0 60.0 59.0 63.0 63.0 57.0 70.0 83.0 83.0 58.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:85.50 stddev:11.78 (13.8%) stddev-sans-first:12.10 09:56:14 INFO - PID 1936 | Values: 85.0 89.0 82.0 87.0 80.0 107.0 114.0 104.0 99.0 86.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#11] stanford-crypto-ccm Cycles:10 Average:159.90 Median:156.50 stddev:22.34 (14.3%) stddev-sans-first:23.63 09:56:14 INFO - PID 1936 | Values: 155.0 155.0 149.0 171.0 158.0 162.0 148.0 141.0 218.0 142.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.80 Median:234.00 stddev:20.83 (8.9%) stddev-sans-first:21.03 09:56:14 INFO - PID 1936 | Values: 237.0 234.0 188.0 191.0 234.0 234.0 194.0 217.0 242.0 217.0 09:56:14 INFO - PID 1936 | 09:56:14 INFO - PID 1936 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:2.21 (3.2%) stddev-sans-first:2.26 09:56:14 INFO - PID 1936 | Values: 68.0 70.0 71.0 69.0 69.0 70.0 70.0 67.0 68.0 75.0 09:56:14 INFO - PID 1936 | -------- Summary: end -------- 09:56:14 INFO - PID 1936 | 09:56:15 INFO - TEST-INFO | 1936: exit 0 09:56:15 INFO - TEST-OK | kraken | took 62356ms 09:56:15 INFO - SUITE-END | took 1179s 09:56:15 INFO - Completed test suite (00:19:39) 09:56:15 INFO - javascript benchmark 09:56:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7826.335487744022, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.8344041077744, 3312.2713003139306, 3413.8904855921833, 3476.235228249786, 3476.3568739783127, 5832.125181222818, 5930.169776231331, 5991.640501569904, 6022.126791615224, 6022.427869352416, 4814.446338671054, 4902.313676085342, 6010.27876654802, 6084.72618732157, 6118.223266370672, 4294.4202532658, 5391.838244852641, 5417.756200970956, 5433.1850222466555, 5514.3658479275, 5386.326709161355, 5445.754941027663, 5487.780488780444, 5507.118860982244, 5530.446955304477, 5343.706096164709, 5376.1129413647095, 5432.619716619838, 5458.426865179178, 5468.0, 5406.053940560426, 5407.297051383334, 5427.104527752916, 5433.8369848904595, 5467.17992301154, 4508.256137737302, 5299.940011997616, 5372.785088596452, 5387.380451248078, 5418.0789265824515, 5804.2744656917885, 5824.912626310609, 5845.7369418376275, 5866.178734977107, 6029.969850150765, 5387.326584176978, 6248.687565621746, 6327.683615819236, 6389.808305750835, 6416.7433302668305, 6434.067060276234, 6464.0, 6468.74125034998, 6470.967645161792, 6479.740810367627, 6155.446009859134, 6163.630182188993, 6177.289611694712, 6188.0, 6195.628262304276, 6282.623042617366, 6388.776392826228, 6557.442617377481, 6595.175603049619, 6609.768658096944, 6219.346968568326, 6243.157173781481, 6249.250089989139, 6268.09112678659, 6331.986882098842, 6371.904421433682, 6377.107204991305, 6464.385883341075, 6466.385693359123, 6478.255000674889, 6334.714937827809, 6369.777057802955, 6375.776847810304, 6396.1684980953105, 6400.679966001681, 6225.408586184305, 6281.309056003836, 6286.15136956505, 6308.0, 6375.968120159369, 5176.534111929869, 5182.2485739567555, 5193.143131383355, 5224.268602395668, 5262.0, 4610.239310513728, 4610.95389046112, 4629.791659375336, 4638.350630911675, 4663.300504924288, 4508.616767574793, 6169.2288463942, 6192.256929168439, 6192.535559832941, 6198.194234749544, 5711.428857114255, 5955.13650520672, 6333.429991300805, 6372.840678983062, 6430.324815894357, 6109.495762817132, 6121.418465245794, 6189.659568723673, 6190.783322583688, 6196.256449226122, 5690.374058853523, 5734.283214598176, 5734.627249228787, 5742.310922689304, 5768.596198266081, 5452.6183167177915, 6433.774817881539, 6533.281339052605, 6584.7366105356205, 6703.664816759045, 6379.234491861006, 6435.22777266731, 6455.386738259858, 6463.15978922737, 6473.320301368289, 6594.406503414716, 6641.535092543476, 6650.20197576294, 6665.500087493554, 6666.133402657623, 4867.610591152628, 6217.595856269328, 6305.8108256752375, 6378.2983871774995, 6416.711247993758, 6358.650274234777, 6375.808725738235, 6406.551541392244, 6413.903791443039, 6535.705893234721, 6041.607295525777, 6268.467180289544, 6276.278228003655, 6287.874242515216, 6359.268684101387, 6172.814815555541, 6175.2589689237575, 6214.1921550198185, 6251.281102673069, 6270.0, 5522.282103326703, 6158.753649853956, 6236.314005459305, 6242.875142497034, 6247.156633854372, 6163.476104531165, 6180.165677633642, 6208.25500939872, 6220.968895155495, 6261.0, 6208.317085120543, 6226.346233645402, 6250.312465628686, 6252.937470625236, 6264.279607844974], "value": 5857.813907299161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.9173299204094, 701.1025886864815, 759.3583422008401, 800.8278220182659, 944.914957653811, 37415.064623384395, 38506.229875402474, 38562.228755424876, 38608.80695596518, 38613.80693096537, 37278.25443491129, 37658.87023389303, 37712.811435942785, 37788.24423511528, 37804.43293350595, 7760.883586746189, 7933.523988560705, 10776.245662803607, 11032.44837758113, 11048.06091482225, 10972.945135274313, 11089.445527723621, 11112.888871111307, 11114.666560003172, 11133.276337038107, 11055.834162487568, 11106.111511079134, 11142.944285278561, 11162.274452160624, 11185.496652650609, 11030.944845275802, 11037.779244415107, 11129.554817807279, 11239.100871930308, 11262.943685281603, 10999.175061870392, 11087.2238943274, 11087.944560277228, 11095.056920161796, 11095.611653592166, 39137.217255655014, 39274.0, 39282.41076383857, 39421.80289098565, 39429.0, 3811.313963486571, 3815.2560250751117, 3817.8472861085525, 3843.2121415109837, 3847.826847791828, 27846.582301265295, 28014.579781303295, 28117.0, 28420.0, 28957.131286061453, 3136.6863313668678, 3140.0893740815136, 3144.8584813683437, 3172.74618030557, 3252.1381833814057, 181653.0, 233302.0, 285165.5741721299, 344708.0, 345570.0, 40022.0, 47748.761256193495, 47775.283370749465, 47780.0, 47867.28199077016, 51747.74126129345, 52061.7396913013, 52180.95638087293, 52183.73908130511, 52329.0, 14338.784918226234, 14435.278236088154, 14437.35031923545, 14452.855471445362, 14456.710865782625, 11801.468933897995, 11846.585369512026, 11875.584354547549, 11879.762404751857, 11913.22564033335, 13830.585082447342, 13876.571599969964, 13917.956153288544, 13931.930340348435, 14003.089799163226, 6011.0, 6053.244559077906, 6066.636001839815, 6110.541709371815, 6164.0, 1049.41757324684, 1070.0209308482806, 1114.2478826792046, 1129.1644183304295, 1185.6365180042847, 22419.43951401228, 25675.614865777028, 26167.345816354744, 26289.73710262911, 26598.335041624116, 1202.8255902894207, 1246.214884622682, 1253.6176466177903, 1254.8494180698374, 1267.9556215532411, 11388.544458221744, 12815.0, 13558.864411355957, 15662.530124096294, 15977.121258330902, 470202.0, 474685.62657187186, 476420.0, 476796.0, 478539.0, 58169.70915145397, 58751.0, 58889.70555147197, 58924.0, 59084.409155908754, 1358.5041459867275, 1361.4145917255478, 1396.0, 1410.5063227870164, 1437.2669938331526, 28458.861645534776, 29067.7093229065, 29161.70838291675, 29760.0, 29866.850665746533, 40225.597744023355, 45888.54111458976, 46606.30090548712, 46626.0, 46737.0, 384586.0, 448372.75813620724, 454348.0, 456163.0, 456585.0, 26012.08957686472, 26510.0, 29929.70070299269, 30468.0, 32576.674233257363, 40706.0, 40795.796021019705, 41556.37665435082, 41608.167836643705, 41628.79185604052, 27247.86376068107, 34240.486392704624, 34336.656633434344, 35103.0, 35425.468617971266, 34098.659013409546, 34133.0, 34889.0, 35025.474617881264, 35110.64889351074, 32938.0, 34231.0, 34882.30235395227, 34909.301813964084, 35053.47419788654, 29242.0, 30495.390092197587, 30523.032005839097, 30572.388552229277, 30697.846510767304, 19325.916819095004, 22929.53160058024, 22995.770042299362, 22996.770032300134, 23029.539409211386], "value": 18822.691061854395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9102628829649, 387.35312028911716, 391.3627601783523, 410.50124099219454, 413.42946733507756, 13319.866801331984, 14739.336729847157, 20180.4954876128, 20935.057922393473, 21025.47436314091, 20860.8956955215, 21001.68497472539, 21269.83015934123, 21494.0, 22455.101795928185, 5783.87214493174, 6247.125402443661, 6352.904706429407, 6560.475161987029, 6563.606183628974, 6371.235451745797, 6530.118434011419, 6620.801375958705, 6680.632565208912, 6686.0, 6528.445082168021, 6542.41118299353, 6592.967035164817, 6596.076549283104, 6598.505112116586, 5598.580106492009, 6489.675516224217, 6519.376676204611, 6547.803565893031, 6572.835679108012, 6351.904721429182, 6357.364263573651, 6364.554481186319, 6380.553361264713, 6383.904241436382, 24490.63264051041, 25367.731613419255, 25712.228633141036, 26674.733252667615, 26938.595921061198, 2785.387214812738, 2936.3686807336526, 3025.3495498467714, 3278.557394751702, 3283.1463819406886, 15807.446739364066, 16322.918385408117, 16424.87200562474, 16703.0, 17114.14429278531, 2006.2476571285767, 2056.7531896172554, 2086.3115171993204, 2094.7695753467106, 2102.4428526440506, 104787.95212047859, 121957.0, 141328.0, 150212.0, 160533.394666053, 21884.343469695934, 22016.373108409825, 22174.445638858833, 22332.776672233394, 22704.31887043391, 35554.93335199948, 35760.821195893855, 35886.64113358833, 35997.0, 36009.639903600626, 10269.229807764448, 10554.894451055392, 10719.249652524404, 10724.0, 10823.350598964087, 8467.872981905277, 8629.741107766777, 8644.610992505226, 8763.561821909007, 8795.824083518422, 8604.569771511524, 8915.42049766763, 10808.94595527033, 10920.836187457195, 10945.83581246282, 3807.4098514730263, 4422.513523512475, 4509.413776209072, 4522.389477420506, 4543.704659197141, 964.9903500965041, 989.4656885282011, 997.4763249294178, 1001.5927621691535, 1045.4197920154236, 20385.592288154156, 21912.89043554772, 21921.0, 21939.0, 21975.780242197372, 998.7752755629925, 1004.8944860789658, 1028.2956175020136, 1037.8391349340864, 1049.8162821506205, 10977.780444391068, 11313.03839173663, 11357.318560886373, 11388.259763115371, 11388.886111138949, 370532.0, 531774.3411282919, 597120.0, 598634.0, 620466.0, 122300.0, 142171.28914355361, 144048.27975860055, 146527.2673636625, 148919.0, 1227.6194379742308, 1260.8676089010705, 1288.4781663426327, 1316.835395575553, 1320.1155225998605, 20065.899670501552, 20870.582588347843, 21090.65113351394, 21411.8929405352, 21487.925603720065, 48601.54195374144, 59059.0, 60269.698651506464, 60665.69667151636, 62244.37755622386, 66067.0, 79194.60402697949, 79691.60154199191, 79829.60085199769, 80309.59845200737, 9544.904550954401, 10468.738281542717, 12210.26738395699, 12309.769023097619, 12478.0, 10752.784944301227, 11081.445927703422, 11891.821622675494, 12984.091113622333, 13422.194668319931, 9903.55434005486, 10323.70953630796, 10875.673729788119, 11178.217524773512, 11502.42487875586, 10589.841152382567, 11056.336619802838, 11306.830397544209, 11501.82747258775, 11564.421778910853, 11601.825972610586, 11604.454997963152, 11821.290722556674, 11825.586104486301, 11830.585929492427, 10097.646582369582, 11175.217734758815, 12164.0, 12221.205621634565, 12239.938800305941, 9477.715668529956, 11246.381449020055, 11276.60531881413, 11340.659780206606, 11769.705757355792], "value": 11400.60701514726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.4342374219732, 1493.7609982402819, 1522.467136502224, 1537.846615038721, 1572.9606759831, 9462.81074378512, 9756.756081097976, 10528.42093684847, 10878.564857405705, 10987.725306867333, 10194.439305838176, 10545.78908421833, 10565.260431769779, 10567.313124646893, 10581.470926453685, 2296.5980953333183, 2339.5671800716923, 2352.3413444235644, 2352.3766201956496, 2356.4815740537056, 2289.713785776778, 2324.535092981402, 2334.7781960713705, 2341.8594884306995, 2347.95304093918, 2307.4462129088984, 2317.3048085574346, 2319.072371051576, 2324.0239099578134, 2325.7557956414585, 2279.8632082074964, 2282.315305408379, 2292.988535057331, 2298.482841360689, 2301.5742087713825, 2245.4723140062074, 2312.7455979842202, 2316.8957396917012, 2317.0384290519414, 2325.6395258734924, 10946.014858662678, 10956.726081847937, 11011.504482298316, 11029.779404411867, 11056.502457389357, 4624.699394539378, 5711.885762284731, 5764.0, 5767.6539407635255, 5775.537956963432, 2854.9286267843263, 3519.0324152816343, 3531.134871956387, 3577.4276115821344, 3687.465317528943, 1127.9097672186206, 1141.1384404774342, 1215.392303848076, 1231.2981600487726, 1235.1600911380258, 13719.862801372059, 15363.15502647354, 15447.691046179127, 15467.458638947583, 15501.689966200725, 4688.0, 4822.590079843182, 4860.756962151878, 4934.18585933317, 4950.2079667253065, 12690.175138615961, 12729.363531823372, 12738.80891786624, 12743.299118548384, 12748.171368860994, 5798.59409841307, 5880.2943646761805, 5882.411758824169, 5887.1463637772285, 5901.940980590225, 4480.775961201927, 4997.825076122318, 5137.306463627438, 5205.895882082337, 5256.0, 3829.7702137871815, 3946.1121247719607, 3991.1419044905483, 4019.979900100481, 4032.778197199182, 1133.8469306643497, 1140.749035212252, 1143.0969534068158, 1154.9826752598717, 1158.3918442817587, 776.5224387001953, 779.8869163971192, 797.5095316380384, 802.2659266770839, 817.8773184022444, 6204.348543402968, 6218.31598524162, 6334.144890439732, 6522.184726909137, 6534.803955881332, 875.4484674655054, 996.8255555277942, 997.5162046407487, 1010.525053224983, 1031.9380837149795, 3796.37359835624, 3933.567307596162, 3949.7827619481204, 4080.4083407906282, 4090.775007374623, 11946.223495472766, 12229.082818788627, 12308.26150430959, 12332.81500777489, 12334.0, 10335.63825266127, 12252.938735306267, 12717.427715752814, 13043.152195107288, 13055.21668699881, 9690.224782017563, 9725.756856078513, 9892.901070989343, 9964.757929465812, 10054.09513143806, 5346.946530534645, 5705.115707065412, 5901.911471327848, 6420.518461115342, 6486.481081513562, 11766.352850593299, 12003.759924801281, 12108.212966157524, 12155.817662735242, 12164.574239901562, 11942.34317112567, 12099.33453660022, 12324.075694322783, 12382.380880955736, 12496.31270280107, 7203.315685009916, 8105.675772969251, 9116.680916167903, 9127.132922372364, 9319.906800932175, 10085.495725213857, 10165.593376264867, 10216.233782466195, 10320.948395257976, 10342.120919721909, 8963.546316477183, 8975.865362019706, 9085.36402451822, 9101.77245568866, 9228.95385523068, 7762.7671169865, 7855.567943763148, 8716.215540601122, 8961.283097352065, 9015.008349081727, 6784.864302714017, 7573.0, 7728.652210650646, 7777.377809775091, 7853.528788272722, 5725.828225153252, 5874.618149820248, 5898.587098903035, 5936.079907614327, 5938.317093534299, 5804.158397032491, 5835.44563266489, 5902.1441890926435, 6095.1466794647895, 6149.385061493994], "value": 5005.485862330484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.4136994643811, 382.6651679780192, 388.76868263383284, 391.670996363055, 392.9351656976598, 4778.569928706415, 6087.3303936567, 6197.8760424791535, 6216.896848080268, 6343.746250149994, 5782.913256301148, 5951.494122999539, 6002.789902353418, 6009.909851352233, 6077.756889724416, 4069.0, 4663.34713140159, 4666.673332866701, 4666.856620128074, 4728.716277023373, 4088.4480595119576, 4689.109069276844, 4714.787834547436, 4727.399930038465, 4743.644226682995, 4604.5165257647795, 4666.276727107287, 4666.719996800203, 4840.540148685869, 4958.157113290749, 3539.681428671432, 4893.975530122344, 4900.950990490103, 4916.58209052231, 5068.0, 3775.848366248293, 4510.075434535912, 4510.706804057759, 4514.7291162530355, 4529.773511324421, 5584.4136365681425, 5592.748326325325, 5866.354700982888, 5885.764569417218, 6002.579819412643, 5276.947230527684, 5795.768169273224, 5826.2134611827705, 5836.723677765674, 5860.736266868002, 5622.297212848394, 5928.229330187091, 6227.87544249117, 6511.4465270452065, 6518.78497202241, 4252.957470425287, 4633.72197668141, 5062.822801201977, 5082.847514574569, 5103.1324674805, 5866.735996880108, 6581.243157036906, 6648.601083934979, 6794.694238759268, 6972.58164510131, 4060.614241647039, 4935.7048972228085, 5086.593072554261, 5271.6309858310315, 5295.443978382292, 5391.821338462644, 5401.244595506476, 5403.675779453245, 5430.755615997289, 5433.755481003364, 4570.885727856764, 5046.84859454217, 5511.346596021178, 5808.593398462067, 5835.244275915115, 5596.356419011784, 6526.510511711545, 6529.967350163314, 6537.052127441494, 6543.9345606544275, 1548.7134880047226, 1762.2158139627743, 1774.5031391210482, 1846.621442604263, 1854.7403363529118, 1317.6691541542918, 1337.5118081900232, 1356.6879617687987, 1371.9794203086963, 1378.710470801123, 5447.874809693747, 5891.764329426775, 6096.542759293071, 6120.908186377208, 6180.258368995749, 6106.473381654587, 6715.918065399742, 6724.562903411263, 6741.224759152662, 6757.425618822357, 4813.542713442217, 6103.908441373383, 6149.077638354193, 6193.411625895623, 6233.265395835842, 2666.7733242674203, 3533.505309256706, 3565.8751943682364, 3573.6962358199326, 3574.7488379067117, 6366.331535188831, 6660.534682369871, 6856.314368563104, 6990.0, 7057.18842333128, 5926.318473375531, 6693.966530167416, 6917.792466226021, 6939.410150137194, 6950.652467376611, 6271.905921411182, 6639.668016599151, 6902.482313826483, 6927.480438966997, 6990.755323563651, 6707.932920670926, 6715.4963377747845, 6717.596944183169, 6742.764003259862, 6754.596322941529, 5836.474717275466, 6076.331603523698, 6314.494840412848, 6636.838553253065, 6668.866622667617, 5778.27771528559, 6912.723491060502, 6916.896246556205, 6940.93059069423, 7033.312005118837, 4029.3553031514816, 4852.641260447081, 5264.78940842362, 5265.368155821326, 5286.471352864683, 4885.413750349981, 6336.58812177207, 6610.768623098168, 6640.966795165993, 6651.467882569286, 5656.688882111359, 5829.59192856496, 5888.941110588839, 5997.130416089555, 6461.64460954652, 5564.33228012641, 5830.717242206708, 5872.970635146797, 5875.9423303805725, 6172.814815555541, 6292.552712876156, 6305.1172835803945, 6319.146915166394, 6330.0, 6375.489960803217, 5106.591472682102, 5687.488126068673, 5771.297467247088, 6427.775027874189, 6512.525240408614, 5572.582056345709, 5591.741858082061, 6302.306746257999, 6332.461740752087, 6402.90395644075], "value": 4886.1162905677475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6363945289271, 705.1221229569184, 718.4001358865347, 761.9276168763965, 820.790698371915, 14896.627584310385, 15232.390704371812, 15402.61493462664, 15685.0, 15694.52916412508, 13615.25116118613, 15007.399704011854, 15341.84658153418, 15360.0, 15408.998415103011, 922.6217250927104, 952.7808604021079, 953.9046095390474, 954.3844220477788, 955.9713208603753, 932.9346945713803, 949.6818565780437, 959.5538074795219, 961.8749562556893, 968.8546717992288, 980.2207245240052, 989.0208693393561, 989.7278248481654, 991.7867658453467, 999.3953658036892, 983.0906411569306, 983.1790454970109, 984.6406061787396, 985.329975616584, 995.2088089968493, 726.1431510817233, 736.977890663281, 744.6239648977286, 744.7207297263526, 745.117036311972, 13441.924646028294, 16069.919650401673, 16362.263698133613, 16716.916415417967, 16999.23503442348, 13586.93206533961, 14765.409383624643, 14877.553673389815, 15008.324625391884, 15027.474038408604, 11618.76762464746, 11645.18483706141, 11896.84733545611, 11959.282443053358, 12068.275903445821, 3628.455731640249, 3676.8529258829612, 3754.155315054118, 3758.4926034985474, 3767.3595488766973, 102359.21719360641, 103537.0, 104549.47725261402, 105055.94944050538, 106212.40681389708, 11369.204155709187, 11381.317120972768, 11517.48171332292, 11712.180147389772, 11883.58407455735, 24456.388590285384, 24564.140255090984, 25117.4976500469, 25137.120200792884, 25245.495090098095, 7622.00913881203, 7730.613469326511, 7795.181505941794, 7800.648970796327, 7880.054393472706, 3839.846406143779, 4152.1280531088205, 4182.8288079337835, 4247.320428731388, 4301.903014731223, 3393.575803024622, 3417.128632198823, 3466.7399945004227, 3485.4074807282313, 3486.1110416843544, 555.5999680230228, 563.6646195513663, 634.22307673101, 638.3680156644981, 659.2385794407467, 616.8797084568466, 640.3404493371835, 673.7641825361183, 683.1221879884325, 684.8424862281703, 8921.643134274556, 9091.590878410487, 10134.493275336352, 10300.484975751182, 10421.322614030063, 666.213867636194, 692.9064576282137, 696.9407600353925, 697.4315932514984, 708.9118203557515, 3912.3349030664854, 4832.492588278251, 4878.829240976549, 4990.17662085759, 4992.326035985096, 70744.29255707377, 83549.0, 84016.57991710003, 85147.14852851516, 86336.70494942581, 35509.82245088758, 58809.41190588125, 65538.0, 74024.62987685027, 75738.0, 50945.0, 67363.97908062766, 67486.98769518461, 68506.0, 69138.65430672815, 9376.921654009877, 10190.0, 10478.161747060369, 10768.623098191525, 10913.945430272797, 30063.849680751457, 43419.56580434155, 45171.774141129084, 46736.065278694914, 50670.23994640157, 56007.0, 68029.0, 70998.93501597377, 71030.93453598097, 71353.64323178558, 13533.796993044914, 13599.184048957095, 13634.93182534081, 13783.931080344533, 14251.857481425053, 14417.279136042946, 14613.415463381345, 14671.55985320442, 14673.460486141266, 14793.556193314218, 13530.0, 13627.931860340635, 13657.0, 13662.043656943919, 14333.211673358066, 13177.73644527085, 13284.734305314032, 13286.53497127596, 13740.862591373958, 13862.584122476343, 13161.53934612284, 13425.66435839112, 13550.254735989614, 13676.863231367957, 13714.38285277145, 9435.57539910692, 10872.945635271773, 11041.779164416506, 11077.833832492357, 11488.138389620644, 8574.22831945103, 10688.679339619825, 11062.976013415744, 11248.26886252391, 11308.434578271219], "value": 7474.107894456391, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1637.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 123.0, 120.0, 120.0, 121.0, 120.0, 119.0, 119.0, 126.0, 120.0], "value": 119.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 145.0, 176.0, 117.0, 148.0, 147.0, 117.0, 138.0, 151.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 213.0, 209.0, 230.0, 201.0, 200.0, 229.0, 266.0, 192.0, 193.0], "value": 213.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 67.0, 91.0, 116.0, 70.0, 64.0, 65.0, 59.0, 73.0, 52.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 87.0, 59.0, 74.0, 83.0, 125.0, 56.0, 100.0, 110.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 90.0, 102.0, 89.0, 80.0, 137.0, 135.0, 90.0, 89.0], "value": 108.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 98.0, 98.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 108.0, 91.0, 145.0, 144.0, 133.0, 90.0, 90.0, 93.0, 90.0], "value": 107.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 74.0, 103.0, 104.0, 105.0, 106.0, 79.0, 67.0, 69.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 63.0, 63.0, 57.0, 70.0, 83.0, 83.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 82.0, 87.0, 80.0, 107.0, 114.0, 104.0, 99.0, 86.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 149.0, 171.0, 158.0, 162.0, 148.0, 141.0, 218.0, 142.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [237.0, 234.0, 188.0, 191.0, 234.0, 234.0, 194.0, 217.0, 242.0, 217.0], "value": 218.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 69.0, 69.0, 70.0, 70.0, 67.0, 68.0, 75.0], "value": 69.7, "unit": "score"}]}]} 09:56:15 INFO - Return code: 0 09:56:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:56:15 ERROR - # TBPL SUCCESS # 09:56:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:56:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:56:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:56:15 INFO - 2017-03-15 09:56:15.911 screenresolution[1941:20273] starting screenresolution argv=screenresolution get 09:56:15 INFO - 2017-03-15 09:56:15.914 screenresolution[1941:20273] Display 0: 1600x1200x32@60 09:56:15 INFO - 2017-03-15 09:56:15.920 screenresolution[1942:20276] starting screenresolution argv=screenresolution list 09:56:15 INFO - Available Modes on Display 0 09:56:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:56:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:56:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:56:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:56:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:56:16 INFO - Intel Iris: 09:56:16 INFO - Chipset Model: Intel Iris 09:56:16 INFO - Type: GPU 09:56:16 INFO - Bus: Built-In 09:56:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:56:16 INFO - Vendor: Intel (0x8086) 09:56:16 INFO - Device ID: 0x0a2e 09:56:16 INFO - Revision ID: 0x0009 09:56:16 INFO - Displays: 09:56:16 INFO - Display: 09:56:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:56:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:56:16 INFO - Display Serial Number: 1600x1200 60 09:56:16 INFO - Main Display: Yes 09:56:16 INFO - Mirror: Off 09:56:16 INFO - Online: Yes 09:56:16 INFO - Rotation: Supported 09:56:16 INFO - Return code: 0 09:56:16 INFO - Running post-action listener: _resource_record_post_action 09:56:16 INFO - [mozharness: 2017-03-15 16:56:16.154980Z] Finished run-tests step (success) 09:56:16 INFO - Running post-run listener: _resource_record_post_run 09:56:16 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 647168; Write bytes: 515512832; Read time: 10; Write time: 1653 09:56:16 INFO - TinderboxPrint: CPU usage
53.9% 09:56:16 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 10 09:56:16 INFO - TinderboxPrint: I/O write bytes / time
515,512,832 / 1,653 09:56:16 INFO - TinderboxPrint: CPU idle
2,211.3 (46.1%) 09:56:16 INFO - TinderboxPrint: CPU system
959.0 (20.0%) 09:56:16 INFO - TinderboxPrint: CPU user
1,631.3 (34.0%) 09:56:16 INFO - TinderboxPrint: Swap in / out
211,144,704 / 0 09:56:16 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205621760; Write bytes: 203933184; Read time: 15670; Write time: 459 09:56:16 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 647168; Write bytes: 300770304; Read time: 10; Write time: 1155 09:56:16 INFO - Running post-run listener: _upload_blobber_files 09:56:16 INFO - Blob upload gear active. 09:56:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:56:16 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:56:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:56:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:56:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:17 INFO - (blobuploader) - INFO - Done attempting. 09:56:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:56:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:56:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:18 INFO - (blobuploader) - INFO - Done attempting. 09:56:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:56:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:56:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:19 INFO - (blobuploader) - INFO - Done attempting. 09:56:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:56:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:56:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:56:22 INFO - (blobuploader) - INFO - Done attempting. 09:56:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:56:22 INFO - Return code: 0 09:56:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:56:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:56:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/612e8943a6fb3389a9f2c8df65f80df084ae8bfdd82073dacc71ac3aa8d9a68a148d7e67a338f88a40ed3a43ebfdb60274d72f6ca56723638bce592e7bcdc265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c39b9cad978a41bbdc2cb34a74cf23395889e44b74dac6e564493f7b4455fa0b5013ad337283d3105906894a773155c991288a1e97589a5b159b2e6cd2bdbcfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8efb31ad51cc01c3e46339373926993e368a5445315b5d53a7b6e8c9aa297c94b31a7c48bee7b965b8266b10aa8d71c4c98b571109b7b855665a213468d5bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c489a6ba4ef17dcec22fd957c7944568c2e6dd4edc2f00b2991deadc9406d61e60f117d3b2b24b2935df531c4c61a267005b272a0311bf2457b0af52ff87024d"} 09:56:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:56:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:56:22 INFO - Contents: 09:56:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/612e8943a6fb3389a9f2c8df65f80df084ae8bfdd82073dacc71ac3aa8d9a68a148d7e67a338f88a40ed3a43ebfdb60274d72f6ca56723638bce592e7bcdc265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c39b9cad978a41bbdc2cb34a74cf23395889e44b74dac6e564493f7b4455fa0b5013ad337283d3105906894a773155c991288a1e97589a5b159b2e6cd2bdbcfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8efb31ad51cc01c3e46339373926993e368a5445315b5d53a7b6e8c9aa297c94b31a7c48bee7b965b8266b10aa8d71c4c98b571109b7b855665a213468d5bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c489a6ba4ef17dcec22fd957c7944568c2e6dd4edc2f00b2991deadc9406d61e60f117d3b2b24b2935df531c4c61a267005b272a0311bf2457b0af52ff87024d"} 09:56:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:56:22 INFO - Copying logs to upload dir... 09:56:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:56:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.274648 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-15 09:56:22.262868) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:56:22.266508) ========= 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.pf49hZGG6J/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.sDVxBloLSv/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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/Firefox/sha512/612e8943a6fb3389a9f2c8df65f80df084ae8bfdd82073dacc71ac3aa8d9a68a148d7e67a338f88a40ed3a43ebfdb60274d72f6ca56723638bce592e7bcdc265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c39b9cad978a41bbdc2cb34a74cf23395889e44b74dac6e564493f7b4455fa0b5013ad337283d3105906894a773155c991288a1e97589a5b159b2e6cd2bdbcfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8efb31ad51cc01c3e46339373926993e368a5445315b5d53a7b6e8c9aa297c94b31a7c48bee7b965b8266b10aa8d71c4c98b571109b7b855665a213468d5bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c489a6ba4ef17dcec22fd957c7944568c2e6dd4edc2f00b2991deadc9406d61e60f117d3b2b24b2935df531c4c61a267005b272a0311bf2457b0af52ff87024d"} build_url:https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010460 build_url: 'https://queue.taskcluster.net/v1/task/UWaX8sfHT1GND3e4nqPZuw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/612e8943a6fb3389a9f2c8df65f80df084ae8bfdd82073dacc71ac3aa8d9a68a148d7e67a338f88a40ed3a43ebfdb60274d72f6ca56723638bce592e7bcdc265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c39b9cad978a41bbdc2cb34a74cf23395889e44b74dac6e564493f7b4455fa0b5013ad337283d3105906894a773155c991288a1e97589a5b159b2e6cd2bdbcfa", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bb8efb31ad51cc01c3e46339373926993e368a5445315b5d53a7b6e8c9aa297c94b31a7c48bee7b965b8266b10aa8d71c4c98b571109b7b855665a213468d5bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c489a6ba4ef17dcec22fd957c7944568c2e6dd4edc2f00b2991deadc9406d61e60f117d3b2b24b2935df531c4c61a267005b272a0311bf2457b0af52ff87024d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:56:22.300087) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:56:22.300378) ========= 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.pf49hZGG6J/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.sDVxBloLSv/Listeners TMPDIR=/var/folders/yn/qkptzzdx4_q5h519lzspx_l800000w/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.004897 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:56:22.347872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:56:22.348185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:56:22.348595) ========= ========= Total master_lag: 0.21 =========