builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0226 starttime: 1485684461.82 results: success (0) buildid: 20170129004005 builduid: c59f6ba3194143789db73d4981548c48 revision: 87c8697b2039d816c1531e5a1edd698933b38663 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:41.820580) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:41.821630) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:41.822387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:41.849644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:41.850425) ========= 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.iIuaYkXVIF/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.PjjDsmduTH/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-01-29 02:07:41-- 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% 8.36M=0.001s 2017-01-29 02:07:42 (8.36 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.205462 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:42.152426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:42.153215) ========= 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.iIuaYkXVIF/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.PjjDsmduTH/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.020072 ========= master_lag: 0.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:42.292949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-29 02:07:42.293293) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87c8697b2039d816c1531e5a1edd698933b38663 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 87c8697b2039d816c1531e5a1edd698933b38663 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iIuaYkXVIF/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.PjjDsmduTH/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-01-29 02:07:42,385 truncating revision to first 12 chars 2017-01-29 02:07:42,386 Setting DEBUG logging. 2017-01-29 02:07:42,386 attempt 1/10 2017-01-29 02:07:42,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/87c8697b2039?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-29 02:07:43,390 unpacking tar archive at: mozilla-aurora-87c8697b2039/testing/mozharness/ program finished with exit code 0 elapsedTime=1.271662 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-29 02:07:43.591054) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:43.592197) ========= script_repo_revision: 87c8697b2039d816c1531e5a1edd698933b38663 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:43.593282) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:43.594170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-29 02:07:43.625783) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-29 02:07:43.626109) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iIuaYkXVIF/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.PjjDsmduTH/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:07:43 INFO - MultiFileLogger online at 20170129 02:07:43 in /builds/slave/test 02:07:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:07:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:43 INFO - {'append_to_log': False, 02:07:43 INFO - 'base_work_dir': '/builds/slave/test', 02:07:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:07:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:43 INFO - 'branch': 'Mozilla-Aurora', 02:07:43 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:43 INFO - 'config_files': ('talos/mac_config.py',), 02:07:43 INFO - 'default_actions': ('clobber', 02:07:43 INFO - 'read-buildbot-config', 02:07:43 INFO - 'download-and-extract', 02:07:43 INFO - 'populate-webroot', 02:07:43 INFO - 'create-virtualenv', 02:07:43 INFO - 'install', 02:07:43 INFO - 'run-tests'), 02:07:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:43 INFO - 'download_minidump_stackwalk': True, 02:07:43 INFO - 'download_symbols': 'ondemand', 02:07:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:43 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:43 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:43 INFO - 'installer_path': 'installer.exe', 02:07:43 INFO - 'log_level': 'info', 02:07:43 INFO - 'log_name': 'talos', 02:07:43 INFO - 'log_to_console': True, 02:07:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:07:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:07:43 INFO - 'opt_config_files': (), 02:07:43 INFO - 'pip_index': False, 02:07:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:43 INFO - 'cmd': ('bash', 02:07:43 INFO - '-c', 02:07:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:43 INFO - 'enabled': True, 02:07:43 INFO - 'halt_on_failure': False, 02:07:43 INFO - 'name': 'check_screen_resolution'},), 02:07:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:07:43 INFO - 'cmd': ('bash', 02:07:43 INFO - '-c', 02:07:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:07:43 INFO - 'enabled': True, 02:07:43 INFO - 'halt_on_failure': False, 02:07:43 INFO - 'name': 'check_screen_resolution'},), 02:07:43 INFO - 'run_cmd_checks_enabled': True, 02:07:43 INFO - 'sps_profile': False, 02:07:43 INFO - 'sps_profile_interval': 0, 02:07:43 INFO - 'suite': 'dromaeojs', 02:07:43 INFO - 'system_bits': '32', 02:07:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:43 INFO - 'title': 't-yosemite-r7-0226', 02:07:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:43 INFO - 'use_talos_json': True, 02:07:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:43 INFO - 'work_dir': 'build'} 02:07:43 INFO - [mozharness: 2017-01-29 10:07:43.818733Z] Running clobber step. 02:07:43 INFO - Running pre-action listener: _resource_record_pre_action 02:07:43 INFO - Running main action method: clobber 02:07:43 INFO - rmtree: /builds/slave/test/build 02:07:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:45 INFO - Running post-action listener: _resource_record_post_action 02:07:45 INFO - [mozharness: 2017-01-29 10:07:45.549947Z] Finished clobber step (success) 02:07:45 INFO - [mozharness: 2017-01-29 10:07:45.550174Z] Running read-buildbot-config step. 02:07:45 INFO - Running pre-action listener: _resource_record_pre_action 02:07:45 INFO - Running main action method: read_buildbot_config 02:07:45 INFO - Using buildbot properties: 02:07:45 INFO - { 02:07:45 INFO - "project": "", 02:07:45 INFO - "product": "firefox", 02:07:45 INFO - "script_repo_revision": "production", 02:07:45 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:07:45 INFO - "repository": "", 02:07:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:07:45 INFO - "buildid": "20170129004005", 02:07:45 INFO - "stage_platform": "macosx64", 02:07:45 INFO - "basedir": "/builds/slave/test", 02:07:45 INFO - "nightly_build": "True", 02:07:45 INFO - "buildnumber": 31, 02:07:45 INFO - "slavename": "t-yosemite-r7-0226", 02:07:45 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 02:07:45 INFO - "platform": "yosemite_r7", 02:07:45 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:07:45 INFO - "branch": "mozilla-aurora", 02:07:45 INFO - "repo_path": "releases/mozilla-aurora", 02:07:45 INFO - "revision": "87c8697b2039d816c1531e5a1edd698933b38663", 02:07:45 INFO - "pgo_build": "False", 02:07:45 INFO - "builduid": "c59f6ba3194143789db73d4981548c48", 02:07:45 INFO - "slavebuilddir": "test" 02:07:45 INFO - } 02:07:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 02:07:45 INFO - Running post-action listener: _resource_record_post_action 02:07:45 INFO - [mozharness: 2017-01-29 10:07:45.554404Z] Finished read-buildbot-config step (success) 02:07:45 INFO - [mozharness: 2017-01-29 10:07:45.554530Z] Running download-and-extract step. 02:07:45 INFO - Running pre-action listener: _resource_record_pre_action 02:07:45 INFO - Running main action method: download_and_extract 02:07:45 INFO - mkdir: /builds/slave/test/build/tests 02:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:07:45 INFO - trying https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 02:07:45 INFO - Downloading https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:07:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 02:07:46 INFO - Downloaded 1199 bytes. 02:07:46 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 02:07:46 INFO - Using the following test package requirements: 02:07:46 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:07:46 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 02:07:46 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 02:07:46 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'jsshell-mac.zip'], 02:07:46 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 02:07:46 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 02:07:46 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 02:07:46 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 02:07:46 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 02:07:46 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 02:07:46 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 02:07:46 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:07:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:07:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:07:46 INFO - Fetch https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:07:48 INFO - Expected file size: 16351888 02:07:48 INFO - Obtained file size: 16351888 02:07:54 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:07:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 02:07:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:07:54 INFO - Fetch https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 02:07:55 INFO - Expected file size: 16351888 02:07:55 INFO - Obtained file size: 16351888 02:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 02:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 02:08:03 INFO - Expected file size: 14403485 02:08:03 INFO - Obtained file size: 14403485 02:08:03 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')]} 02:08:03 INFO - trying https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:08:03 INFO - Downloading https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 02:08:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 02:08:05 INFO - Downloaded 73974162 bytes. 02:08:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:08:05 INFO - mkdir: /builds/slave/test/properties 02:08:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:08:05 INFO - Writing to file /builds/slave/test/properties/build_url 02:08:05 INFO - Contents: 02:08:05 INFO - build_url:https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 02:08:06 INFO - Running post-action listener: _resource_record_post_action 02:08:06 INFO - Running post-action listener: set_extra_try_arguments 02:08:06 INFO - [mozharness: 2017-01-29 10:08:06.184993Z] Finished download-and-extract step (success) 02:08:06 INFO - [mozharness: 2017-01-29 10:08:06.185123Z] Running populate-webroot step. 02:08:06 INFO - Running pre-action listener: _resource_record_pre_action 02:08:06 INFO - Running main action method: populate_webroot 02:08:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:08:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:08:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:08:06 INFO - '--tppagecycles', 02:08:06 INFO - '7'], 02:08:06 INFO - 'tests': ['tsvgm']}}, 02:08:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:08:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:08:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:08:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:08:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:08:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['damp', 'tps']}, 02:08:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'tests': ['damp', 'tps']}, 02:08:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['dromaeo_dom']}, 02:08:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:08:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['basic_compositor_video']}, 02:08:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:08:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['a11yr', 02:08:06 INFO - 'ts_paint', 02:08:06 INFO - 'tpaint', 02:08:06 INFO - 'sessionrestore', 02:08:06 INFO - 'sessionrestore_no_auto_restore', 02:08:06 INFO - 'tabpaint']}, 02:08:06 INFO - 'other-e10s': {'tests': ['a11yr', 02:08:06 INFO - 'ts_paint', 02:08:06 INFO - 'tpaint', 02:08:06 INFO - 'sessionrestore', 02:08:06 INFO - 'sessionrestore_no_auto_restore', 02:08:06 INFO - 'tabpaint']}, 02:08:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:08:06 INFO - 'ts_paint', 02:08:06 INFO - 'tpaint', 02:08:06 INFO - 'sessionrestore', 02:08:06 INFO - 'sessionrestore_no_auto_restore', 02:08:06 INFO - 'tabpaint']}, 02:08:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:08:06 INFO - 'ts_paint', 02:08:06 INFO - 'tpaint', 02:08:06 INFO - 'sessionrestore', 02:08:06 INFO - 'sessionrestore_no_auto_restore', 02:08:06 INFO - 'tabpaint']}, 02:08:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['a11yr', 02:08:06 INFO - 'ts_paint', 02:08:06 INFO - 'tpaint', 02:08:06 INFO - 'sessionrestore', 02:08:06 INFO - 'sessionrestore_no_auto_restore', 02:08:06 INFO - 'tabpaint']}, 02:08:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['a11yr', 02:08:06 INFO - 'ts_paint', 02:08:06 INFO - 'tpaint', 02:08:06 INFO - 'sessionrestore', 02:08:06 INFO - 'sessionrestore_no_auto_restore', 02:08:06 INFO - 'tabpaint']}, 02:08:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['tsvgx', 02:08:06 INFO - 'tsvgr_opacity', 02:08:06 INFO - 'tart', 02:08:06 INFO - 'tscrollx', 02:08:06 INFO - 'cart', 02:08:06 INFO - 'tsvg_static']}, 02:08:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:08:06 INFO - 'tsvgr_opacity', 02:08:06 INFO - 'tart', 02:08:06 INFO - 'tscrollx', 02:08:06 INFO - 'cart', 02:08:06 INFO - 'tsvg_static']}, 02:08:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'talos_options': ['--disable-e10s'], 02:08:06 INFO - 'tests': ['tp5o']}, 02:08:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:08:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'talos_options': ['--disable-e10s', 02:08:06 INFO - '--xperf_path', 02:08:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:06 INFO - 'tests': ['tp5n']}, 02:08:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:08:06 INFO - 'talos_options': ['--xperf_path', 02:08:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:08:06 INFO - 'tests': ['tp5n']}}, 02:08:06 INFO - 'talos.zip': {'path': '', 02:08:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:08:06 INFO - Running post-action listener: _resource_record_post_action 02:08:06 INFO - [mozharness: 2017-01-29 10:08:06.203696Z] Finished populate-webroot step (success) 02:08:06 INFO - [mozharness: 2017-01-29 10:08:06.203831Z] Running create-virtualenv step. 02:08:06 INFO - Running pre-action listener: _resource_record_pre_action 02:08:06 INFO - Running main action method: create_virtualenv 02:08:06 INFO - Creating virtualenv /builds/slave/test/build/venv 02:08:06 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 02:08:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:08:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:08:06 INFO - Using real prefix '/tools/python27' 02:08:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:08:07 INFO - Installing distribute.............................................................................................................................................................................................done. 02:08:09 INFO - Installing pip.................done. 02:08:09 INFO - Return code: 0 02:08:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:08:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:08:10 INFO - Reading from file tmpfile_stdout 02:08:10 INFO - Output received: 02:08:10 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) 02:08:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:10 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 02:08:10 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 02:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:10 INFO - 'HOME': '/Users/cltbld', 02:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:10 INFO - 'LOGNAME': 'cltbld', 02:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:10 INFO - 'MOZ_NO_REMOTE': '1', 02:08:10 INFO - 'NO_EM_RESTART': '1', 02:08:10 INFO - 'PAGER': '/bin/cat', 02:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:10 INFO - 'PWD': '/builds/slave/test', 02:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:10 INFO - 'SHELL': '/bin/bash', 02:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:10 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:10 INFO - 'USER': 'cltbld', 02:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:10 INFO - 'XPC_FLAGS': '0x0', 02:08:10 INFO - 'XPC_SERVICE_NAME': '0', 02:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:10 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 02:08:10 INFO - Cleaning up... 02:08:10 INFO - Return code: 0 02:08:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:10 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 02:08:10 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 02:08:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:10 INFO - 'HOME': '/Users/cltbld', 02:08:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:10 INFO - 'LOGNAME': 'cltbld', 02:08:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:10 INFO - 'MOZ_NO_REMOTE': '1', 02:08:10 INFO - 'NO_EM_RESTART': '1', 02:08:10 INFO - 'PAGER': '/bin/cat', 02:08:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:10 INFO - 'PWD': '/builds/slave/test', 02:08:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:10 INFO - 'SHELL': '/bin/bash', 02:08:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:10 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:10 INFO - 'USER': 'cltbld', 02:08:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:10 INFO - 'XPC_FLAGS': '0x0', 02:08:10 INFO - 'XPC_SERVICE_NAME': '0', 02:08:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:10 INFO - Downloading/unpacking psutil>=3.1.1 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:10 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 02:08:10 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 02:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:08:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:14 INFO - Installing collected packages: psutil 02:08:14 INFO - Running setup.py install for psutil 02:08:14 INFO - building 'psutil._psutil_osx' extension 02:08:14 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 02:08:15 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 02:08:15 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 02:08:15 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 02:08:15 INFO - building 'psutil._psutil_posix' extension 02:08:15 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 02:08:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:08:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:08:15 INFO - ^ 02:08:15 INFO - 1 warning generated. 02:08:15 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 02:08:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:08:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:08:15 INFO - Successfully installed psutil 02:08:15 INFO - Cleaning up... 02:08:15 INFO - Return code: 0 02:08:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:08:15 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')]} 02:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:15 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')]} 02:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:15 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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:15 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 02:08:15 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 02:08:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:15 INFO - 'HOME': '/Users/cltbld', 02:08:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:15 INFO - 'LOGNAME': 'cltbld', 02:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:15 INFO - 'MOZ_NO_REMOTE': '1', 02:08:15 INFO - 'NO_EM_RESTART': '1', 02:08:15 INFO - 'PAGER': '/bin/cat', 02:08:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:15 INFO - 'PWD': '/builds/slave/test', 02:08:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:15 INFO - 'SHELL': '/bin/bash', 02:08:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:15 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:15 INFO - 'USER': 'cltbld', 02:08:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:15 INFO - 'XPC_FLAGS': '0x0', 02:08:15 INFO - 'XPC_SERVICE_NAME': '0', 02:08:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:08:15 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 02:08:15 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 02:08:15 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 02:08:15 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 02:08:15 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 02:08:15 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 02:08:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:08:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:08:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:08:22 INFO - Installing collected packages: mozsystemmonitor 02:08:22 INFO - Running setup.py install for mozsystemmonitor 02:08:22 INFO - Successfully installed mozsystemmonitor 02:08:22 INFO - Cleaning up... 02:08:22 INFO - Return code: 0 02:08:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:08:22 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')]} 02:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:22 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')]} 02:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:22 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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:22 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 02:08:22 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 02:08:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:22 INFO - 'HOME': '/Users/cltbld', 02:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:22 INFO - 'LOGNAME': 'cltbld', 02:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:22 INFO - 'MOZ_NO_REMOTE': '1', 02:08:22 INFO - 'NO_EM_RESTART': '1', 02:08:22 INFO - 'PAGER': '/bin/cat', 02:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:22 INFO - 'PWD': '/builds/slave/test', 02:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:22 INFO - 'SHELL': '/bin/bash', 02:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:22 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:22 INFO - 'USER': 'cltbld', 02:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:22 INFO - 'XPC_FLAGS': '0x0', 02:08:22 INFO - 'XPC_SERVICE_NAME': '0', 02:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:22 INFO - Downloading/unpacking jsonschema==2.5.1 02:08:22 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 02:08:22 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 02:08:22 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 02:08:22 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 02:08:22 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 02:08:22 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 02:08:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:08:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:08:28 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 02:08:28 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 02:08:28 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 02:08:28 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 02:08:28 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 02:08:28 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 02:08:28 INFO - Downloading functools32-3.2.3-2.tar.gz 02:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:08:28 INFO - warning: no files found matching '*.txt' 02:08:28 INFO - no previously-included directories found matching 'build' 02:08:28 INFO - no previously-included directories found matching 'dist' 02:08:28 INFO - no previously-included directories found matching '.git*' 02:08:28 INFO - Installing collected packages: jsonschema, functools32 02:08:28 INFO - Running setup.py install for functools32 02:08:28 INFO - warning: no files found matching '*.txt' 02:08:28 INFO - no previously-included directories found matching 'build' 02:08:28 INFO - no previously-included directories found matching 'dist' 02:08:28 INFO - no previously-included directories found matching '.git*' 02:08:28 INFO - Successfully installed jsonschema functools32 02:08:28 INFO - Cleaning up... 02:08:28 INFO - Return code: 0 02:08:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:08:28 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')]} 02:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:28 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')]} 02:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:28 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 02:08:28 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 02:08:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:29 INFO - 'HOME': '/Users/cltbld', 02:08:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:29 INFO - 'LOGNAME': 'cltbld', 02:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:29 INFO - 'MOZ_NO_REMOTE': '1', 02:08:29 INFO - 'NO_EM_RESTART': '1', 02:08:29 INFO - 'PAGER': '/bin/cat', 02:08:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:29 INFO - 'PWD': '/builds/slave/test', 02:08:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:29 INFO - 'SHELL': '/bin/bash', 02:08:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:29 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:29 INFO - 'USER': 'cltbld', 02:08:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:29 INFO - 'XPC_FLAGS': '0x0', 02:08:29 INFO - 'XPC_SERVICE_NAME': '0', 02:08:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:08:29 INFO - Cleaning up... 02:08:29 INFO - Return code: 0 02:08:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:08:29 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')]} 02:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:29 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')]} 02:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:29 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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:29 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 02:08:29 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 02:08:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:29 INFO - 'HOME': '/Users/cltbld', 02:08:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:29 INFO - 'LOGNAME': 'cltbld', 02:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:29 INFO - 'MOZ_NO_REMOTE': '1', 02:08:29 INFO - 'NO_EM_RESTART': '1', 02:08:29 INFO - 'PAGER': '/bin/cat', 02:08:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:29 INFO - 'PWD': '/builds/slave/test', 02:08:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:29 INFO - 'SHELL': '/bin/bash', 02:08:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:29 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:29 INFO - 'USER': 'cltbld', 02:08:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:29 INFO - 'XPC_FLAGS': '0x0', 02:08:29 INFO - 'XPC_SERVICE_NAME': '0', 02:08:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:29 INFO - Downloading/unpacking blobuploader==1.2.4 02:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:29 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 02:08:29 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 02:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:32 INFO - Downloading blobuploader-1.2.4.tar.gz 02:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:08:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:32 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 02:08:32 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 02:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:08:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:32 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 02:08:32 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 02:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:33 INFO - Downloading docopt-0.6.1.tar.gz 02:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:08:33 INFO - Installing collected packages: blobuploader, requests, docopt 02:08:33 INFO - Running setup.py install for blobuploader 02:08:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:08:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:08:33 INFO - Running setup.py install for requests 02:08:34 INFO - Running setup.py install for docopt 02:08:34 INFO - Successfully installed blobuploader requests docopt 02:08:34 INFO - Cleaning up... 02:08:34 INFO - Return code: 0 02:08:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:34 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')]} 02:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:34 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')]} 02:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:34 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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:34 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 02:08:34 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 02:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:34 INFO - 'HOME': '/Users/cltbld', 02:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:34 INFO - 'LOGNAME': 'cltbld', 02:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:34 INFO - 'MOZ_NO_REMOTE': '1', 02:08:34 INFO - 'NO_EM_RESTART': '1', 02:08:34 INFO - 'PAGER': '/bin/cat', 02:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:34 INFO - 'PWD': '/builds/slave/test', 02:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:34 INFO - 'SHELL': '/bin/bash', 02:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:34 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:34 INFO - 'USER': 'cltbld', 02:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:34 INFO - 'XPC_FLAGS': '0x0', 02:08:34 INFO - 'XPC_SERVICE_NAME': '0', 02:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-hKV3OX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-N54wxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-0OgdUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-lakj_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-DY8HVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-K527oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-b1oN5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ayc7hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-5CG5Pb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Gbab1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-B_Kv2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-0EoVjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-C7iDgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-qDGQbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-TzacRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-YTXqCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:36 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-OQAWyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:08:36 INFO - Running setup.py install for manifestparser 02:08:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:08:36 INFO - Running setup.py install for mozcrash 02:08:36 INFO - Running setup.py install for mozdebug 02:08:36 INFO - Running setup.py install for mozdevice 02:08:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for mozfile 02:08:37 INFO - Running setup.py install for mozhttpd 02:08:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for mozinfo 02:08:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for mozInstall 02:08:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for mozleak 02:08:37 INFO - Running setup.py install for mozlog 02:08:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:08:37 INFO - Running setup.py install for moznetwork 02:08:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:08:38 INFO - Running setup.py install for mozprocess 02:08:38 INFO - Running setup.py install for mozprofile 02:08:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:08:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:08:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:08:38 INFO - Running setup.py install for mozrunner 02:08:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:08:38 INFO - Running setup.py install for mozscreenshot 02:08:38 INFO - Running setup.py install for moztest 02:08:38 INFO - Running setup.py install for mozversion 02:08:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:08:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:08:38 INFO - Cleaning up... 02:08:39 INFO - Return code: 0 02:08:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08: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')]} 02:08:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08: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')]} 02:08:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 02:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 02:08:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:39 INFO - 'HOME': '/Users/cltbld', 02:08:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:39 INFO - 'LOGNAME': 'cltbld', 02:08:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:39 INFO - 'MOZ_NO_REMOTE': '1', 02:08:39 INFO - 'NO_EM_RESTART': '1', 02:08:39 INFO - 'PAGER': '/bin/cat', 02:08:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:39 INFO - 'PWD': '/builds/slave/test', 02:08:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:39 INFO - 'SHELL': '/bin/bash', 02:08:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:39 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:39 INFO - 'USER': 'cltbld', 02:08:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:39 INFO - 'XPC_FLAGS': '0x0', 02:08:39 INFO - 'XPC_SERVICE_NAME': '0', 02:08:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-hp7gNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:08:39 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)) 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-VDtvfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:08:39 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)) 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-NbQiDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:08:39 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)) 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-nXsQwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:08:39 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)) 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-jiF0A7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:08:39 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)) 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-K66T4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:08:39 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)) 02:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:08:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-p5AK3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:08:40 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-LDerTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:08:40 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ZPdq_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-5Ps949-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:08:40 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-6HpLIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-BeFRgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:08:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-V8MZyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:08:40 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-XMSqgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:08:40 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-lC3rrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:08:40 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)) 02:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:08:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-FpGFLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:08:41 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-7C8VC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:08:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:41 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 02:08:41 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 02:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:08:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:44 INFO - Downloading blessings-1.6.tar.gz 02:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:08:44 INFO - Installing collected packages: blessings 02:08:44 INFO - Running setup.py install for blessings 02:08:45 INFO - Successfully installed blessings 02:08:45 INFO - Cleaning up... 02:08:45 INFO - Return code: 0 02:08:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:45 INFO - Reading from file tmpfile_stdout 02:08:45 INFO - Current package versions: 02:08:45 INFO - blessings == 1.6 02:08:45 INFO - blobuploader == 1.2.4 02:08:45 INFO - docopt == 0.6.1 02:08:45 INFO - functools32 == 3.2.3-2 02:08:45 INFO - jsonschema == 2.5.1 02:08:45 INFO - manifestparser == 1.1 02:08:45 INFO - mozInstall == 1.12 02:08:45 INFO - mozcrash == 1.0 02:08:45 INFO - mozdebug == 0.1 02:08:45 INFO - mozdevice == 0.49 02:08:45 INFO - mozfile == 1.2 02:08:45 INFO - mozhttpd == 0.7 02:08:45 INFO - mozinfo == 0.9 02:08:45 INFO - mozleak == 0.1 02:08:45 INFO - mozlog == 3.4 02:08:45 INFO - moznetwork == 0.27 02:08:45 INFO - mozprocess == 0.24 02:08:45 INFO - mozprofile == 0.28 02:08:45 INFO - mozrunner == 6.13 02:08:45 INFO - mozscreenshot == 0.1 02:08:45 INFO - mozsystemmonitor == 0.3 02:08:45 INFO - moztest == 0.8 02:08:45 INFO - mozversion == 1.4 02:08:45 INFO - psutil == 3.1.1 02:08:45 INFO - requests == 1.2.3 02:08:45 INFO - wsgiref == 0.1.2 02:08:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:45 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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:45 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 02:08:45 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 02:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:45 INFO - 'HOME': '/Users/cltbld', 02:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:45 INFO - 'LOGNAME': 'cltbld', 02:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:45 INFO - 'MOZ_NO_REMOTE': '1', 02:08:45 INFO - 'NO_EM_RESTART': '1', 02:08:45 INFO - 'PAGER': '/bin/cat', 02:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:45 INFO - 'PWD': '/builds/slave/test', 02:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:45 INFO - 'SHELL': '/bin/bash', 02:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:45 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:45 INFO - 'USER': 'cltbld', 02:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:45 INFO - 'XPC_FLAGS': '0x0', 02:08:45 INFO - 'XPC_SERVICE_NAME': '0', 02:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 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)) 02:08:45 INFO - Cleaning up... 02:08:45 INFO - Return code: 0 02:08:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x103422b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103425768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1a1663f30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, '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.iIuaYkXVIF/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.PjjDsmduTH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 02:08:45 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 02:08:45 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 02:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:08:45 INFO - 'HOME': '/Users/cltbld', 02:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:08:45 INFO - 'LOGNAME': 'cltbld', 02:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:45 INFO - 'MOZ_NO_REMOTE': '1', 02:08:45 INFO - 'NO_EM_RESTART': '1', 02:08:45 INFO - 'PAGER': '/bin/cat', 02:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:45 INFO - 'PWD': '/builds/slave/test', 02:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:08:45 INFO - 'SHELL': '/bin/bash', 02:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:08:45 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:08:45 INFO - 'USER': 'cltbld', 02:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:45 INFO - 'XPC_FLAGS': '0x0', 02:08:45 INFO - 'XPC_SERVICE_NAME': '0', 02:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:08:46 INFO - Cleaning up... 02:08:46 INFO - Return code: 0 02:08:46 INFO - Running post-action listener: _resource_record_post_action 02:08:46 INFO - Running post-action listener: _start_resource_monitoring 02:08:46 INFO - Starting resource monitoring. 02:08:46 INFO - [mozharness: 2017-01-29 10:08:46.077765Z] Finished create-virtualenv step (success) 02:08:46 INFO - [mozharness: 2017-01-29 10:08:46.078738Z] Running install step. 02:08:46 INFO - Running pre-action listener: _resource_record_pre_action 02:08:46 INFO - Running main action method: install 02:08:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:46 INFO - Reading from file tmpfile_stdout 02:08:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:46 INFO - Reading from file tmpfile_stdout 02:08:46 INFO - Output received: 02:08:46 INFO - Usage: mozinstall [options] installer 02:08:46 INFO - Options: 02:08:46 INFO - -h, --help show this help message and exit 02:08:46 INFO - -d DEST, --destination=DEST 02:08:46 INFO - Directory to install application into. [default: 02:08:46 INFO - "/builds/slave/test"] 02:08:46 INFO - --app=APP Application being installed. [default: firefox] 02:08:46 INFO - mkdir: /builds/slave/test/build/application 02:08:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:09:06 INFO - Reading from file tmpfile_stdout 02:09:06 INFO - Output received: 02:09:06 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:09:06 INFO - Running post-action listener: _resource_record_post_action 02:09:06 INFO - [mozharness: 2017-01-29 10:09:06.534245Z] Finished install step (success) 02:09:06 INFO - [mozharness: 2017-01-29 10:09:06.534390Z] Running run-tests step. 02:09:06 INFO - Running pre-action listener: _resource_record_pre_action 02:09:06 INFO - Running main action method: run_tests 02:09:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:06 INFO - 2017-01-29 02:09:06.549 screenresolution[1920:22497] starting screenresolution argv=screenresolution get 02:09:06 INFO - 2017-01-29 02:09:06.551 screenresolution[1920:22497] Display 0: 1600x1200x32@60 02:09:06 INFO - 2017-01-29 02:09:06.557 screenresolution[1921:22500] starting screenresolution argv=screenresolution list 02:09:06 INFO - Available Modes on Display 0 02:09:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:06 INFO - Intel Iris: 02:09:06 INFO - Chipset Model: Intel Iris 02:09:06 INFO - Type: GPU 02:09:06 INFO - Bus: Built-In 02:09:06 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:06 INFO - Vendor: Intel (0x8086) 02:09:06 INFO - Device ID: 0x0a2e 02:09:06 INFO - Revision ID: 0x0009 02:09:06 INFO - Displays: 02:09:06 INFO - Display: 02:09:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:06 INFO - Display Serial Number: 1600x1200 60 02:09:06 INFO - Main Display: Yes 02:09:06 INFO - Mirror: Off 02:09:06 INFO - Online: Yes 02:09:06 INFO - Rotation: Supported 02:09:06 INFO - Return code: 0 02:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:09:06 INFO - Python 2.7.3 02:09:06 INFO - Return code: 0 02:09:06 INFO - grabbing minidump binary from tooltool 02:09:06 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')]} 02:09:06 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 0x103200d30>, '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 0x103127db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1031f5be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:09:06 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 02:09:06 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 02:09:06 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 02:09:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:09:06 INFO - Return code: 0 02:09:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:09:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:09:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:09:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:09:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0226 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iIuaYkXVIF/Render', 02:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:09:06 INFO - 'HOME': '/Users/cltbld', 02:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:09:06 INFO - 'LOGNAME': 'cltbld', 02:09:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:09:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:09:06 INFO - 'MOZ_NO_REMOTE': '1', 02:09:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:09:06 INFO - 'NO_EM_RESTART': '1', 02:09:06 INFO - 'PAGER': '/bin/cat', 02:09:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:09:06 INFO - 'PWD': '/builds/slave/test', 02:09:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:09:06 INFO - 'SHELL': '/bin/bash', 02:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PjjDsmduTH/Listeners', 02:09:06 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 02:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:09:06 INFO - 'USER': 'cltbld', 02:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:09:06 INFO - 'XPC_FLAGS': '0x0', 02:09:06 INFO - 'XPC_SERVICE_NAME': '0', 02:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:09:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:09:07 INFO - mozversion application_buildid: 20170129004005 02:09:07 INFO - mozversion application_changeset: 87c8697b2039d816c1531e5a1edd698933b38663 02:09:07 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:09:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:09:07 INFO - mozversion application_name: Firefox 02:09:07 INFO - mozversion application_remotingname: firefox-dev 02:09:07 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:09:07 INFO - mozversion application_vendor: Mozilla 02:09:07 INFO - mozversion application_version: 53.0a2 02:09:07 INFO - mozversion platform_buildid: 20170129004005 02:09:07 INFO - mozversion platform_changeset: 87c8697b2039d816c1531e5a1edd698933b38663 02:09:07 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:09:07 INFO - mozversion platform_version: 53.0a2 02:09:07 INFO - using testdate: 1485684547 02:09:07 INFO - actual date: 1485684547 02:09:07 INFO - starting webserver on 'localhost:56053' 02:09:07 INFO - SUITE-START | Running 2 tests 02:09:07 INFO - TEST-START | dromaeo_css 02:09:07 INFO - operating with platform_type : mac_ 02:09:07 INFO - Initialising browser for dromaeo_css test... 02:09:07 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpc7nQ8q/profile http://localhost:56053/getInfo.html) 02:09:09 INFO - PROCESS | 1931 | __metrics Screen width/height:1600/1200 02:09:09 INFO - PROCESS | 1931 | colorDepth:24 02:09:09 INFO - PROCESS | 1931 | Browser inner width/height: 1024/689 02:09:09 INFO - PROCESS | 1931 | __metrics 02:09:09 INFO - PROCESS | 1931 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:09:09 INFO - PROCESS | 1931 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:09:10 INFO - TEST-INFO | 1931: exit 0 02:09:10 INFO - Browser initialized. 02:09:10 INFO - Running cycle 1/1 for dromaeo_css test... 02:09:10 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpc7nQ8q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:09:22 INFO - PROCESS | 1934 | RSS: Main: 231997440 02:09:22 INFO - PROCESS | 1934 | 02:12:26 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:56053/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56053/tests/dromaeo/cssquery-ext.html) 02:12:27 INFO - PROCESS | 1934 | RSS: Main: 374161408 02:12:27 INFO - PROCESS | 1934 | 02:14:12 INFO - PROCESS | 1934 | ************************* 02:14:12 INFO - PROCESS | 1934 | A coding exception was thrown and uncaught in a Task. 02:14:12 INFO - PROCESS | 1934 | 02:14:12 ERROR - PROCESS | 1934 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:14:12 INFO - PROCESS | 1934 | Full stack: 02:14:12 INFO - PROCESS | 1934 | ************************* 02:15:30 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:56053/tests/dromaeo/cssquery-ext.html (next: http://localhost:56053/tests/dromaeo/cssquery-jquery.html) 02:15:31 INFO - PROCESS | 1934 | RSS: Main: 363401216 02:15:31 INFO - PROCESS | 1934 | 02:18:33 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:56053/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56053/tests/dromaeo/cssquery-mootools.html) 02:18:33 INFO - PROCESS | 1934 | RSS: Main: 341258240 02:18:33 INFO - PROCESS | 1934 | 02:21:35 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:56053/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56053/tests/dromaeo/cssquery-prototype.html) 02:21:36 INFO - PROCESS | 1934 | RSS: Main: 336465920 02:21:36 INFO - PROCESS | 1934 | 02:24:39 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:56053/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56053/tests/dromaeo/cssquery-yui.html) 02:24:40 INFO - PROCESS | 1934 | RSS: Main: 330018816 02:24:40 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:56053/tests/dromaeo/cssquery-yui.html (next: http://localhost:56053/tests/dromaeo/cssquery-dojo.html) 02:27:43 INFO - PROCESS | 1934 | RSS: Main: 389537792 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | __start_tp_report 02:27:43 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 02:27:43 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 02:27:43 INFO - PROCESS | 1934 | |i|pagename|runs| 02:27:43 INFO - PROCESS | 1934 | |0;dojo.html;3305.5372247885302;3323.401787678217;3353.3796247694163;3380.847861846217;3396.728261739061;4784.851635607455;5762.740676669549;5774.740136693848;5819.650820950736;5855.121731740241;5759.913601295984;5836.095405212199;5840.883182336351;5865.149553314777;5871.794487192949;5262.368515778112;5262.368515778112;5297.841064768054;5298.496642818926;5359.5712343012465;5206.557442617382;5218.712970786605;5356;5380.031594313022;5389.110796718537;5289;5341.278927344817;5349.384820745606;5350.785968561253;5356.705381204032;5339.5461385782255;5347.438518955492;5348.491893270172;5350.5184533391985;5354.892902141974;5211.947880521184;5288.942211557704;5294.947050529484;5299.655522391032;5327.147656374961;5909;5913.024350982083;5918.082697181943;5923.526117910556;5927.555433342516;6226.657533835637;6239.095331176954;6240.095186197976;6256.937430625727;6289.0252010938375;6300.527460440485;6324.873502529969;6331.39851714091;6343.111964324999;6361.61830290184;5855;5917.674527900964;5934.406559344075;5950.7322170502;6012.338642749294;6273.372662733781;6275.246970363585;6284.748610055546;6289.150964619809;6292.339304372975;6166.260048794084;6242.625442473466;6245.6252624841745;6268.373162683695;6302.4958003359625;6344.968275158687;6346.30190679025;6348.523860710373;6353.745850165941;6373.71318290678;6101.368489499298;6369.363063693686;6382.234131904202;6385.904211436832;6403.839904002344;6132.814448934737;6201.441870231701;6204.286507051746;6294.527910406738;6311.652859092794;4974.328465657162;5059.62052846038;5076.898462030738;5092.236164575269;5096.719680417538;4472.530384309601;4509.120721459284;4521.570450807168;4535.070310586322;4536.6143877770755;5716.371199168088;5821.767129314865;5843.912341314884;5859.355470898283;5862.8534286642325;6292.842678933063;6310.684465776692;6327.96836015817;6330.68346582669;6396.680165991682;5897.144913987448;5909.763609455574;5914.526837852962;5922.230110085661;5942.64344139353;5524.806631767869;5534.501894829485;5581.804636837691;5586.301712285965;5591.189277554732;6265.122882796321;6291.96854015727;6297.52768542352;6301.338359472189;6382.712777924911;6315.905261421174;6316.463100636497;6328.683565821782;6330.430261276507;6351.71417286214;6382.234131904202;6388.648624325707;6390.4248617624635;6391.904121438275;6394.968025159845;6127.0673618518995;6191.566590338633;6250.593711408744;6261.843453913689;6337.90493142594;5217.452167522356;6302.842428939313;6321.5574909757715;6379.362063793584;6389.073584330153;6141.570090093651;6274.937250627618;6290.559660823881;6304.842378940563;6315.431611155018;5992.101184822312;6177.2587289525545;6190.226221722285;6236.875262494634;6248.656323902229;5955.791547295824;6001.729922153426;6056.697165141637;6078.331383547895;6091.0558863376245;6119.2350956130485;6266.905996410149;6275.02737075754;6301.243850737941;6304.84237894038;6062.211912451353;6110.572259941761;6115.082737589397;6120.265568131675;6121.632702037892 02:27:43 INFO - PROCESS | 1934 | |1;ext.html;440.37466797148045;449.05249922663194;494.06374919527474;518.6395455158666;523.7381309345327;32550.837245813767;41501;43352.56647433529;43498;45312.093758124814;43868.56131438685;44090.99999999992;44185.33721994165;44216.11567768643;44219.557804421944;9403.059694030611;9598.760030999247;9607.66373176939;9623.56693948774;9635.22918166545;8508.319334453228;8745.956270218672;11354.091672666209;11546.134039946995;11576.247543909662;11412.714682132972;11485.425728713573;11559.422028898563;11571.132165087653;11584.47869845859;8520.233179013856;11368.488418021208;11437.199396042239;11445.484953177127;11471.541138354456;8491.278241349493;9197.67808126719;11409.315441073562;11419.429028548539;11593.478293476814;40632;40686.59313406887;41143.7942810284;41360.793196033825;41707.374389383884;3548.591911930135;4003.4795476588147;4068.613481719232;4114.403411505345;4287.442632457792;25532.617010744852;30905.381892362027;31187.84406077978;31200.37599248002;31250.53124203139;3107.4095921775015;3193.1857376368876;3319.369319829249;3320.941265585594;3389.034125274285;479867;482593;483243;483276;485216.72174917406;65325.67337163379;65598.68802623921;65794.01308980369;65817.01274480886;66075.66962165255;67060;69381;69406.65296673586;69683.65158174177;69934.3006569938;13729.656758581115;17029.82970170307;17082.829171708374;17103.74344384835;17114.486565402807;11669.474873630706;12071.818922716166;13057.608271751862;13141.211527308393;13148.342582870819;16288.42990495327;17993.820061799215;18411.631767364845;18560.907195463937;18870.90564547196;6375.776847810304;6491.415772580491;6519.218853065211;6519.674016299166;6520.282768895418;872.520113937332;887.2148148888281;888.5424006636588;892.8035832116924;919.1360121485782;29218.415631687247;29931;30112.84943575268;30393;30772.846135769625;1050.7058023753361;1055.2244100586217;1058.5289546152042;1079.1474734959452;1088.2219213262556;14590.708185836223;14670.119792812466;14802.777958330633;14933.178675172752;14975.251237438084;559591;559718;560600;560848;564115;53663;53735;53792.19311710328;53970;54170.7291463548;1419.9574012779633;1428.607133038402;1447.8479759625088;1454.7090581883665;1460.5180290504109;26206.73793262043;27250.182494525197;27609.723902761518;28154.577681334387;28234.035426279945;46866.76566617145;47357;47430.76284618555;47564.762176188895;47580.2862957049;510352;516229;520222;520580;522733;21939.451513712283;23621.64567531454;24818.25545233646;25083.498330032933;25142.74857251404;33896.830515847265;42695.5730442704;43373.78313108414;43950.340744889494;43963.56036439595;30946.916857909866;34205.828970854986;36143.45784813283;36282;36897.44653830141;35041.29917401689;35111;36493;36639.63360366362;37839.810800945816;35407.760728374386;36490.635093649784;36577.268454630226;37149;37874;30651.2337191572;32527.512087318235;32634;32739;32828.835855820565;24587.89354479017;24691.135810246557;24834.379140521633;24844.906644289036;25036.74963250344 02:27:43 INFO - PROCESS | 1934 | |2;jquery.html;389.3070334804048;392.1627325659716;397.91842672252193;403.41907652979705;423.7923417525412;19152.904235478836;19396.51508712281;20510;20668;20739.792602073994;20750.377488675327;20960.26639067633;21615.027323770428;21986.340409787732;21998.900054997266;4658.650601204906;5454.34547854256;5503.7798488060425;5566.332040155187;5568.387477377485;5303.337082864642;5470.288862447876;5501.724913754317;5507.642003269794;5510.586705997066;5341.813036543722;5423.240746295522;5445.727713614323;5493.285872836525;5494.587905907053;5279.788808447657;5419.132938729785;5487.533559647435;5488.396276409591;5491.7254137292975;5355.410904800468;5385.919211211835;5391.703456309901;5394.433584473613;5401.540869026137;11223.663290101229;13727.176369417866;23559.528809423886;24011.639825402457;24513.65174915379;2649.5893136563864;2650.2844232057237;2655.9734402655918;2657.800664950117;2671.612616170664;8446.324294056461;9711;10513.211509136769;10680.62617808373;10684.465776711211;1746.4149509914193;1827.4608990347747;1833.449965010505;1841.4291569613329;1848.4639454558162;129318.35340823236;135729;137667;137863;137881;11889.28664280146;11962.700932476584;12123.696907577381;12124.515019399301;12125.151239413157;16035.599110022344;16070.357185712674;16076.919615401848;16095.114768687601;16101.677966440606;8677.783055423664;8782.077881822317;8812.867806982773;8814.118588141135;8945.01604823469;8544.786380340416;8548.615312310962;8553.74338769838;8694.26098781598;8725.301975842045;4754.07295577366;4797.2564252540915;4813.518648135158;4819.132556139928;4884.535969082932;1985.9205631774855;2041.0917141872021;2044.5093177637557;2044.8568600197843;2050.2516581447962;969.9485587981369;986.7681094942683;991.2813210422386;991.3506653142204;1010.5351538292321;19049.7142542862;20697.27559535409;20715.482112946996;20766.58466830655;21052.368428947157;904.615538396179;988.8220120378257;1001.3191030099603;1005.2109094360892;1016.3850870223556;10133.13868321201;10546.894531054744;10632.989865962722;10643.73390665224;10645.680629581126;420194;426243;712162.8783712096;741922;769314.3068569243;97634.51182744041;136542;137960.31019844837;144053;149982;935.6304259817334;974.7611835100446;1008.6973907827622;1009.2985375164337;1019.5361110694616;15571.29929153168;19503.219871204994;20325.898370508054;20329.79670203279;20430;56356;57533.56166095881;57635;58962;59204.70397647984;66985;81991.59004204941;83963;84249.73625395747;86397;7065.929340706527;7341.412686985135;7455.589942553212;7929.643166057656;8518.275946544612;10752.784944301227;12328.691782705504;12672.6831829205;12799.87200128024;12972.870271297166;8663.393562450568;10726.463676816284;10739.624113156002;11281.097512199169;11316.321020738782;10790.730231743955;10992.450377481255;11044.116470682487;11127.109831213646;11352.602658906899;8964.417312874642;11284.830727539258;11579.073674105883;11612.825807613062;11635.767284654428;8198.83602327962;8222.054463736507;8435.789105272417;8523.95738021306;8702;9420.293477989042;10895.976647920743;10972;11058.447077646246;11196.216264861707 02:27:43 INFO - PROCESS | 1934 | |3;mootools.html;1450.079199708185;1454.149322646252;1455.6797504549;1470.411835265894;1475.9778603320951;8099.230573095554;8524.360672949522;8557.443766155204;8561.101084386135;8565.871511927326;7491.5505069695855;7721.72973945912;7732;8053.879191812113;8304.377171712116;2321.537431418204;2364.598018336887;2366.1245339224424;2369.099742098;2370.9051637934463;2347.108098922407;2362.4093976505874;2373.5134297468976;2380.36920216142;2383.2373640435067;2304.124432715574;2310.214527060799;2337.544178885118;2346.5189636124555;2356.1871154451774;2307.3654744945106;2310.861348319106;2329.941751456227;2334.3347146063375;2335.346103091137;2305.5849947009533;2371.727251366098;2380.0479808076734;2380.797632201265;2384.6184610462415;8411.116832732536;8459.53472559009;8481.830363392759;8490.066092729794;8496.980362356495;5048.848534543969;5212.061828870802;5216.165413533817;5216.165413533854;5231.163013917793;3129.389768995047;3329.433996220648;3485.6688614581576;3514.8769793057377;3520.3135388599235;1224.877512248768;1244.2766768026258;1251.730877861255;1255.8367412236441;1269.7968325067945;10668.933106689346;10723.30298530593;10806.675799726021;10822.18833587484;10905.83641245382;4490.977545112253;4645.814167433265;4724.976375118103;4736.3369128322065;4737.2183589708;9509.90490095104;9512.2865785065;9516.85724714116;9519.952400237955;9527.666531671359;5243;5285.154375299933;5285.312909321764;5286.788528458896;5289.3917199521775;3976.6619837313574;4206.8737937861915;4683.95316046842;4761.785719642555;4789.592884604778;3826.196498735241;3884.3979183226643;3957.722959392815;3958.287508248543;3987.7407968481957;1125.8817824128512;1276.3107921722167;1292.2052937443593;1296.7406518696298;1305.4060402516832;914.1257741781764;923.6259314977444;927.9118483744033;934.6775362499926;961.1397798969883;5414.269073675082;5435.824711380939;5511.972440137773;5751;5759.366469688331;533.773146412773;536.3751229817219;569.4447913284597;578.2251782611321;588.1119509540539;3661.139632186434;3661.688756455678;3682.668559829628;3692.7599706019023;3728.440733889938;9735.902640973642;9810.80378392428;10052.346597471142;10054.899451005542;10087.949560252298;9641.27690423221;9716.076972687584;9940.751481212883;9979.750506237402;10026.849597256047;7701.499402538817;7811.218878112143;7824.334931530883;7829.41279404047;7848.293653571091;5334.3865455473115;5392.137258038695;5464.672119672832;5550.500454959073;5559.24950131727;9028.09719028092;9330.720078397659;9354.158125768714;9356.111169438893;9373.578188981375;8952.373333866566;9305.581248843682;9327.486988215713;9344.345895787501;9346;6684.966575167093;6905.516613836983;6910.101686780888;7108.644567771487;7277.2722727726805;7625.809354765954;7787;7908.485948413335;7996.24035716606;7999.9600001999615;7003.229644739176;7097.25478824716;7129.572225666477;7147.964260178665;7233.819154521179;6777.254502004677;6787.355201255873;7008.182849861774;7008.5094043416475;7034.120734908137;6372.808815735535;6374.713137908712;6450.48396128318;6454.128692626436;6463;4898.779554919965;4911.50884911506;4941.160002799605;4948.554630083309;4983.775730092082;4892.119418504703;4904.4605093440405;4915.574483399917;5051.469595692546;5054.115529782347 02:27:43 INFO - PROCESS | 1934 | |4;prototype.html;361.94389869570216;370.1228089428056;374.1394791978449;381.5916968843339;383.5665697761529;4784.856454306368;5119.771254898826;5309.469053094688;5574.944250557493;5597.524210442118;4680.204365257906;5069.366329208849;5218.712970786605;5322.494363035516;5526.861828454291;3541.6989555887653;3745.1386181178345;3975.622315879994;4283.271843786564;4318.5033721122;3675.044488433;3743.128435782109;3881.10734531058;4157.979210103946;4264.42430271914;3750.6624403803653;3766.6610005099537;3943.6510325142535;4173.061061261223;4196.286631272676;3875.9418608720894;3909.6090390960962;4025.194961007781;4105.856295029675;4317.201317756225;3723.5345581802276;3724.3854763963914;3732.9066773330615;3737.4767532545466;3763.153290509641;4791.520847915215;5277.8416647500635;5342.6910406950155;5349.732513374316;5351.892962140774;4007.97996010021;4895.730734809584;4910.428662827897;4962.908160204749;4979.983106841735;4776.617870570381;4893.828715994923;5775.884482310373;5794.913076303858;5814.011618024946;3156.6369867465305;4169.56219596941;4173.1862286854075;4173.91652166958;4182.8288079337835;5112.134071064072;5325.337331334333;5557.888842223133;5749.9425005750245;6041.6979151042715;3503.386907291214;3578.9284214315567;3603.558576569341;4217.334153009544;4244.917546025744;4303.526612072669;4310.534418297794;4317.266064768997;4323.935140972888;4329.870103896888;4666.789994450258;4882.487338829443;4901.705897646153;4926.778294976663;4948.925766113512;5120.899006713575;5166.535011848877;5493.478119578634;5810.215620891126;5823.292169141369;1230.8399908011902;1277.4223833565538;1355.8407561534943;1391.6660001599544;1406.4093080906043;872.5942436766934;925.780637062601;925.8287216864901;948.5684013773716;973.1144658360857;4448;4530.750808705553;4589.931151032737;4979.925301120486;5127.2052831811125;4915.43472500667;5135.563477104413;5707.315122185364;5729.512991395778;5757.424257574209;4558.452985641744;4912.771807048238;5000.149974504343;5122.410922743858;5232.2413250078525;2594.4681340325187;2666.4800363929235;2731.7814574833965;2764.6958834528186;2806.5369214079856;4992.950070499249;5254.244908357942;5555.916661250085;5727.363124416026;5792.292932523189;4800.591949684246;5190.480951904855;5226.503482169188;5765.740541675635;5814.709264536757;5018.737820416758;5351.438098999627;5824.475797178275;5844.620099693507;5844.620099693507;5278.4721527846905;5301.496357845998;5623.381428042994;5700.942990570207;5722.799702010409;5132.435432102391;5349.089256371653;5578.665280083045;5582.916256256241;5603.80386686464;5254.710990895537;5498.560115190695;5579.8884022320135;5820;5848.830233953311;3186.824724640167;3461.9307613848086;3992.7604343739467;4013.578574249662;4037.7886634010265;5005.6996580205305;5224.231157486538;5930.406959304035;5967.791127310524;5977.5217982560425;4453.933191002202;4863.95136048635;5592;5719.256496655408;5807.245058142415;4569.428821397325;5305.283786688748;5475.342958844964;5734.996375634164;5746.482816546363;4671.43942726875;4948;5189.6886186828915;5634.690092044977;5641.8589535261945;5366.953444078367;5622.297212848394;5748.798792042258;5765.94234057654;5796.9420305798085;5058.1401161803315;5608.214849921096;5630.662160270397;5635.520980716685;5639.971800140973 02:27:43 INFO - PROCESS | 1934 | |5;yui.html;666.6566718140157;672;691.1774987764563;694.9930500694992;778.3267473635303;14000.929995350034;14029.298535073243;14328;14535;14593.270336483172;13552;13760.798272276437;13836.962227832902;13979.23114228717;14018.15891046538;861.9439736417113;880.6521424037502;882.5851849630664;882.6072397782989;884.8805411269493;697.2922483679044;718.7699936020475;721.7582109993159;858.7380848841101;879.4679219072465;935.0369119806576;935.96724114656;937.2127412973101;939.5912777941583;940.2759874896326;928.3408779766306;932.9673461428818;933.1788026536605;933.6732143749701;935.6257497001186;542.1271752478507;554.0802268234751;673.9359760822714;692.840646651268;694.7360003198752;14159.716805663931;14684.559463216121;14692.853071469255;14697.853021469862;14707.485238016725;13115.803262951064;13145.211287322696;13329.733405331936;13361.66595835112;13369.398377072957;12085.335306558136;12290.324032178227;12429.937850310782;12482.563110291096;12795;4319.805608747614;4339.761313127777;4343.457067866517;4358.978205108954;4381.496127945264;91291;94443;96589;103145.99999999924;108264.4586777061;10657.786844263226;11026.558937642565;11048.392338421463;11106.833397499044;11467.08263338931;20545;20642.896785516277;20865;20868.582628347347;20882;7684.462087653922;7746.961265193638;7765.72819951299;7771.261730135628;7932.801679957932;4186.91626167475;4229.873103806891;4246.915061698749;4297.269464191095;4312.072904325585;3322;3380.678835510623;3386.8306584670668;3391.9491207631904;3401.727861771052;629.7512482569451;636.8821767972939;637.2703254773259;639.5427269502328;640.2349192714661;572.977080916767;583.9503642190462;591.4913174669781;598.2850493660035;600.24366326925;8978.281737460988;9063.501507417024;9554.713358599114;9923.023857144966;9927.703659536466;647.2491909385091;650.3821369698805;656.9211694596679;681.9386255236954;686.1388956859109;4730;4856.4415092264135;4859.878503037452;4872.78072486739;4886.780094895738;103046.48476757568;104031;104638.47680761547;105873.47063264788;106011.46994265134;87643.56178219068;88728.669069964;89277;91108.63337049949;91440;78871.60564197143;80062.59968700119;81667;81917.18082819096;82855.585722071;9264.675736349465;9413.7291465654;9427.481488517922;9454.14912657864;9474;52148.95702085861;52464;52816;53449;54695;67395.98527470947;69131.61736765337;70010.64994674994;71339.64330178316;72357;11111.166662500507;11368.772624547628;11389.886101139215;11401.657950261506;11593;12130.514779408724;12180.269183848997;12199.146059776085;12225.388730563258;12691.175073620185;11915.046796256105;12077.27536347822;12111.515539378326;12402.81395779046;12546.247225166519;9943.552540135566;11989.940050299692;12510.437030333838;12769.8084528734;12965.481380744664;12900;12981.545645902348;13021.283829389475;13168.868311317148;13183.274919879499;9520.761980950532;11151.55393784272;11218.943905280421;11673.533058677558;11715.941420292844;10760.085392741705;10788.190885683762;10849.45752712377;10872.510737016695;10902.890971090188 02:27:43 INFO - PROCESS | 1934 | __end_tp_report 02:27:43 INFO - PROCESS | 1934 | __start_cc_report 02:27:43 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,1366 02:27:43 INFO - PROCESS | 1934 | __end_cc_report 02:27:43 INFO - PROCESS | 1934 | __startTimestamp1485685663679__endTimestamp 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | ------- Summary: start ------- 02:27:43 INFO - PROCESS | 1934 | Number of tests: 6 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | [#0] dojo.html Cycles:165 Average:5838.10 Median:6091.06 stddev:647.77 (10.6%) stddev-sans-first:618.54 02:27:43 INFO - PROCESS | 1934 | Values: 3305.5 3323.4 3353.4 3380.8 3396.7 4784.9 5762.7 5774.7 5819.7 5855.1 5759.9 5836.1 5840.9 5865.1 5871.8 5262.4 5262.4 5297.8 5298.5 5359.6 5206.6 5218.7 5356.0 5380.0 5389.1 5289.0 5341.3 5349.4 5350.8 5356.7 5339.5 5347.4 5348.5 5350.5 5354.9 5211.9 5288.9 5294.9 5299.7 5327.1 5909.0 5913.0 5918.1 5923.5 5927.6 6226.7 6239.1 6240.1 6256.9 6289.0 6300.5 6324.9 6331.4 6343.1 6361.6 5855.0 5917.7 5934.4 5950.7 6012.3 6273.4 6275.2 6284.7 6289.2 6292.3 6166.3 6242.6 6245.6 6268.4 6302.5 6345.0 6346.3 6348.5 6353.7 6373.7 6101.4 6369.4 6382.2 6385.9 6403.8 6132.8 6201.4 6204.3 6294.5 6311.7 4974.3 5059.6 5076.9 5092.2 5096.7 4472.5 4509.1 4521.6 4535.1 4536.6 5716.4 5821.8 5843.9 5859.4 5862.9 6292.8 6310.7 6328.0 6330.7 6396.7 5897.1 5909.8 5914.5 5922.2 5942.6 5524.8 5534.5 5581.8 5586.3 5591.2 6265.1 6292.0 6297.5 6301.3 6382.7 6315.9 6316.5 6328.7 6330.4 6351.7 6382.2 6388.6 6390.4 6391.9 6395.0 6127.1 6191.6 6250.6 6261.8 6337.9 5217.5 6302.8 6321.6 6379.4 6389.1 6141.6 6274.9 6290.6 6304.8 6315.4 5992.1 6177.3 6190.2 6236.9 6248.7 5955.8 6001.7 6056.7 6078.3 6091.1 6119.2 6266.9 6275.0 6301.2 6304.8 6062.2 6110.6 6115.1 6120.3 6121.6 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | [#1] ext.html Cycles:180 Average:65964.77 Median:36491.82 stddev:138949.89 (380.8%) stddev-sans-first:139252.59 02:27:43 INFO - PROCESS | 1934 | Values: 440.4 449.1 494.1 518.6 523.7 32550.8 41501.0 43352.6 43498.0 45312.1 43868.6 44091.0 44185.3 44216.1 44219.6 9403.1 9598.8 9607.7 9623.6 9635.2 8508.3 8746.0 11354.1 11546.1 11576.2 11412.7 11485.4 11559.4 11571.1 11584.5 8520.2 11368.5 11437.2 11445.5 11471.5 8491.3 9197.7 11409.3 11419.4 11593.5 40632.0 40686.6 41143.8 41360.8 41707.4 3548.6 4003.5 4068.6 4114.4 4287.4 25532.6 30905.4 31187.8 31200.4 31250.5 3107.4 3193.2 3319.4 3320.9 3389.0 479867.0 482593.0 483243.0 483276.0 485216.7 65325.7 65598.7 65794.0 65817.0 66075.7 67060.0 69381.0 69406.7 69683.7 69934.3 13729.7 17029.8 17082.8 17103.7 17114.5 11669.5 12071.8 13057.6 13141.2 13148.3 16288.4 17993.8 18411.6 18560.9 18870.9 6375.8 6491.4 6519.2 6519.7 6520.3 872.5 887.2 888.5 892.8 919.1 29218.4 29931.0 30112.8 30393.0 30772.8 1050.7 1055.2 1058.5 1079.1 1088.2 14590.7 14670.1 14802.8 14933.2 14975.3 559591.0 559718.0 560600.0 560848.0 564115.0 53663.0 53735.0 53792.2 53970.0 54170.7 1420.0 1428.6 1447.8 1454.7 1460.5 26206.7 27250.2 27609.7 28154.6 28234.0 46866.8 47357.0 47430.8 47564.8 47580.3 510352.0 516229.0 520222.0 520580.0 522733.0 21939.5 23621.6 24818.3 25083.5 25142.7 33896.8 42695.6 43373.8 43950.3 43963.6 30946.9 34205.8 36143.5 36282.0 36897.4 35041.3 35111.0 36493.0 36639.6 37839.8 35407.8 36490.6 36577.3 37149.0 37874.0 30651.2 32527.5 32634.0 32739.0 32828.8 24587.9 24691.1 24834.4 24844.9 25036.7 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | [#2] jquery.html Cycles:180 Average:36159.40 Median:13581.62 stddev:106320.42 (782.8%) stddev-sans-first:106584.75 02:27:43 INFO - PROCESS | 1934 | Values: 389.3 392.2 397.9 403.4 423.8 19152.9 19396.5 20510.0 20668.0 20739.8 20750.4 20960.3 21615.0 21986.3 21998.9 4658.7 5454.3 5503.8 5566.3 5568.4 5303.3 5470.3 5501.7 5507.6 5510.6 5341.8 5423.2 5445.7 5493.3 5494.6 5279.8 5419.1 5487.5 5488.4 5491.7 5355.4 5385.9 5391.7 5394.4 5401.5 11223.7 13727.2 23559.5 24011.6 24513.7 2649.6 2650.3 2656.0 2657.8 2671.6 8446.3 9711.0 10513.2 10680.6 10684.5 1746.4 1827.5 1833.4 1841.4 1848.5 129318.4 135729.0 137667.0 137863.0 137881.0 11889.3 11962.7 12123.7 12124.5 12125.2 16035.6 16070.4 16076.9 16095.1 16101.7 8677.8 8782.1 8812.9 8814.1 8945.0 8544.8 8548.6 8553.7 8694.3 8725.3 4754.1 4797.3 4813.5 4819.1 4884.5 1985.9 2041.1 2044.5 2044.9 2050.3 969.9 986.8 991.3 991.4 1010.5 19049.7 20697.3 20715.5 20766.6 21052.4 904.6 988.8 1001.3 1005.2 1016.4 10133.1 10546.9 10633.0 10643.7 10645.7 420194.0 426243.0 712162.9 741922.0 769314.3 97634.5 136542.0 137960.3 144053.0 149982.0 935.6 974.8 1008.7 1009.3 1019.5 15571.3 19503.2 20325.9 20329.8 20430.0 56356.0 57533.6 57635.0 58962.0 59204.7 66985.0 81991.6 83963.0 84249.7 86397.0 7065.9 7341.4 7455.6 7929.6 8518.3 10752.8 12328.7 12672.7 12799.9 12972.9 8663.4 10726.5 10739.6 11281.1 11316.3 10790.7 10992.5 11044.1 11127.1 11352.6 8964.4 11284.8 11579.1 11612.8 11635.8 8198.8 8222.1 8435.8 8524.0 8702.0 9420.3 10896.0 10972.0 11058.4 11196.2 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | [#3] mootools.html Cycles:180 Average:5425.59 Median:5285.23 stddev:2958.28 (56.0%) stddev-sans-first:2951.49 02:27:43 INFO - PROCESS | 1934 | Values: 1450.1 1454.1 1455.7 1470.4 1476.0 8099.2 8524.4 8557.4 8561.1 8565.9 7491.6 7721.7 7732.0 8053.9 8304.4 2321.5 2364.6 2366.1 2369.1 2370.9 2347.1 2362.4 2373.5 2380.4 2383.2 2304.1 2310.2 2337.5 2346.5 2356.2 2307.4 2310.9 2329.9 2334.3 2335.3 2305.6 2371.7 2380.0 2380.8 2384.6 8411.1 8459.5 8481.8 8490.1 8497.0 5048.8 5212.1 5216.2 5216.2 5231.2 3129.4 3329.4 3485.7 3514.9 3520.3 1224.9 1244.3 1251.7 1255.8 1269.8 10668.9 10723.3 10806.7 10822.2 10905.8 4491.0 4645.8 4725.0 4736.3 4737.2 9509.9 9512.3 9516.9 9520.0 9527.7 5243.0 5285.2 5285.3 5286.8 5289.4 3976.7 4206.9 4684.0 4761.8 4789.6 3826.2 3884.4 3957.7 3958.3 3987.7 1125.9 1276.3 1292.2 1296.7 1305.4 914.1 923.6 927.9 934.7 961.1 5414.3 5435.8 5512.0 5751.0 5759.4 533.8 536.4 569.4 578.2 588.1 3661.1 3661.7 3682.7 3692.8 3728.4 9735.9 9810.8 10052.3 10054.9 10087.9 9641.3 9716.1 9940.8 9979.8 10026.8 7701.5 7811.2 7824.3 7829.4 7848.3 5334.4 5392.1 5464.7 5550.5 5559.2 9028.1 9330.7 9354.2 9356.1 9373.6 8952.4 9305.6 9327.5 9344.3 9346.0 6685.0 6905.5 6910.1 7108.6 7277.3 7625.8 7787.0 7908.5 7996.2 8000.0 7003.2 7097.3 7129.6 7148.0 7233.8 6777.3 6787.4 7008.2 7008.5 7034.1 6372.8 6374.7 6450.5 6454.1 6463.0 4898.8 4911.5 4941.2 4948.6 4983.8 4892.1 4904.5 4915.6 5051.5 5054.1 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | [#4] prototype.html Cycles:180 Average:4538.76 Median:5012.22 stddev:1360.84 (27.2%) stddev-sans-first:1328.05 02:27:43 INFO - PROCESS | 1934 | Values: 361.9 370.1 374.1 381.6 383.6 4784.9 5119.8 5309.5 5574.9 5597.5 4680.2 5069.4 5218.7 5322.5 5526.9 3541.7 3745.1 3975.6 4283.3 4318.5 3675.0 3743.1 3881.1 4158.0 4264.4 3750.7 3766.7 3943.7 4173.1 4196.3 3875.9 3909.6 4025.2 4105.9 4317.2 3723.5 3724.4 3732.9 3737.5 3763.2 4791.5 5277.8 5342.7 5349.7 5351.9 4008.0 4895.7 4910.4 4962.9 4980.0 4776.6 4893.8 5775.9 5794.9 5814.0 3156.6 4169.6 4173.2 4173.9 4182.8 5112.1 5325.3 5557.9 5749.9 6041.7 3503.4 3578.9 3603.6 4217.3 4244.9 4303.5 4310.5 4317.3 4323.9 4329.9 4666.8 4882.5 4901.7 4926.8 4948.9 5120.9 5166.5 5493.5 5810.2 5823.3 1230.8 1277.4 1355.8 1391.7 1406.4 872.6 925.8 925.8 948.6 973.1 4448.0 4530.8 4589.9 4979.9 5127.2 4915.4 5135.6 5707.3 5729.5 5757.4 4558.5 4912.8 5000.1 5122.4 5232.2 2594.5 2666.5 2731.8 2764.7 2806.5 4993.0 5254.2 5555.9 5727.4 5792.3 4800.6 5190.5 5226.5 5765.7 5814.7 5018.7 5351.4 5824.5 5844.6 5844.6 5278.5 5301.5 5623.4 5700.9 5722.8 5132.4 5349.1 5578.7 5582.9 5603.8 5254.7 5498.6 5579.9 5820.0 5848.8 3186.8 3461.9 3992.8 4013.6 4037.8 5005.7 5224.2 5930.4 5967.8 5977.5 4453.9 4864.0 5592.0 5719.3 5807.2 4569.4 5305.3 5475.3 5735.0 5746.5 4671.4 4948.0 5189.7 5634.7 5641.9 5367.0 5622.3 5748.8 5765.9 5796.9 5058.1 5608.2 5630.7 5635.5 5640.0 02:27:43 INFO - PROCESS | 1934 | 02:27:43 INFO - PROCESS | 1934 | [#5] yui.html Cycles:180 Average:20295.89 Median:4793.22 stddev:29457.73 (614.6%) stddev-sans-first:29503.49 02:27:43 INFO - PROCESS | 1934 | Values: 666.7 672.0 691.2 695.0 778.3 14000.9 14029.3 14328.0 14535.0 14593.3 13552.0 13760.8 13837.0 13979.2 14018.2 861.9 880.7 882.6 882.6 884.9 697.3 718.8 721.8 858.7 879.5 935.0 936.0 937.2 939.6 940.3 928.3 933.0 933.2 933.7 935.6 542.1 554.1 673.9 692.8 694.7 14159.7 14684.6 14692.9 14697.9 14707.5 13115.8 13145.2 13329.7 13361.7 13369.4 12085.3 12290.3 12429.9 12482.6 12795.0 4319.8 4339.8 4343.5 4359.0 4381.5 91291.0 94443.0 96589.0 103146.0 108264.5 10657.8 11026.6 11048.4 11106.8 11467.1 20545.0 20642.9 20865.0 20868.6 20882.0 7684.5 7747.0 7765.7 7771.3 7932.8 4186.9 4229.9 4246.9 4297.3 4312.1 3322.0 3380.7 3386.8 3391.9 3401.7 629.8 636.9 637.3 639.5 640.2 573.0 584.0 591.5 598.3 600.2 8978.3 9063.5 9554.7 9923.0 9927.7 647.2 650.4 656.9 681.9 686.1 4730.0 4856.4 4859.9 4872.8 4886.8 103046.5 104031.0 104638.5 105873.5 106011.5 87643.6 88728.7 89277.0 91108.6 91440.0 78871.6 80062.6 81667.0 81917.2 82855.6 9264.7 9413.7 9427.5 9454.1 9474.0 52149.0 52464.0 52816.0 53449.0 54695.0 67396.0 69131.6 70010.6 71339.6 72357.0 11111.2 11368.8 11389.9 11401.7 11593.0 12130.5 12180.3 12199.1 12225.4 12691.2 11915.0 12077.3 12111.5 12402.8 12546.2 9943.6 11989.9 12510.4 12769.8 12965.5 12900.0 12981.5 13021.3 13168.9 13183.3 9520.8 11151.6 11218.9 11673.5 11715.9 10760.1 10788.2 10849.5 10872.5 10902.9 02:27:43 INFO - PROCESS | 1934 | -------- Summary: end -------- 02:27:43 INFO - PROCESS | 1934 | 02:27:44 INFO - TEST-INFO | 1934: exit 0 02:27:44 INFO - TEST-OK | dromaeo_css | took 1117168ms 02:27:44 INFO - TEST-START | kraken 02:27:44 INFO - operating with platform_type : mac_ 02:27:44 INFO - Initialising browser for kraken test... 02:27:44 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpKqDCZu/profile http://localhost:56053/getInfo.html) 02:27:46 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 02:27:46 INFO - PROCESS | 1937 | colorDepth:24 02:27:46 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 02:27:46 INFO - PROCESS | 1937 | __metrics 02:27:46 INFO - PROCESS | 1937 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:27:46 INFO - PROCESS | 1937 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:27:47 INFO - TEST-INFO | 1937: exit 0 02:27:47 INFO - Browser initialized. 02:27:47 INFO - Running cycle 1/1 for kraken test... 02:27:47 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpKqDCZu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:59 INFO - PROCESS | 1939 | RSS: Main: 231723008 02:27:59 INFO - PROCESS | 1939 | 02:28:02 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56053/tests/kraken/driver.html?testName=audio-beat-detection) 02:28:03 INFO - PROCESS | 1939 | RSS: Main: 279785472 02:28:03 INFO - PROCESS | 1939 | 02:28:05 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56053/tests/kraken/driver.html?testName=audio-dft) 02:28:06 INFO - PROCESS | 1939 | RSS: Main: 293527552 02:28:06 INFO - PROCESS | 1939 | 02:28:09 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56053/tests/kraken/driver.html?testName=audio-fft) 02:28:10 INFO - PROCESS | 1939 | RSS: Main: 387616768 02:28:10 INFO - PROCESS | 1939 | 02:28:12 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56053/tests/kraken/driver.html?testName=audio-oscillator) 02:28:12 INFO - PROCESS | 1939 | RSS: Main: 290648064 02:28:12 INFO - PROCESS | 1939 | 02:28:15 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56053/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:28:15 INFO - PROCESS | 1939 | RSS: Main: 291799040 02:28:15 INFO - PROCESS | 1939 | 02:28:18 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56053/tests/kraken/driver.html?testName=imaging-darkroom) 02:28:19 INFO - PROCESS | 1939 | RSS: Main: 332963840 02:28:19 INFO - PROCESS | 1939 | 02:28:21 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56053/tests/kraken/driver.html?testName=imaging-desaturate) 02:28:22 INFO - PROCESS | 1939 | RSS: Main: 332890112 02:28:22 INFO - PROCESS | 1939 | 02:28:25 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56053/tests/kraken/driver.html?testName=json-parse-financial) 02:28:26 INFO - PROCESS | 1939 | RSS: Main: 327278592 02:28:26 INFO - PROCESS | 1939 | 02:28:27 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56053/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:28:28 INFO - PROCESS | 1939 | RSS: Main: 306667520 02:28:28 INFO - PROCESS | 1939 | 02:28:30 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:28:30 INFO - PROCESS | 1939 | RSS: Main: 309747712 02:28:30 INFO - PROCESS | 1939 | 02:28:33 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:28:33 INFO - PROCESS | 1939 | RSS: Main: 312934400 02:28:33 INFO - PROCESS | 1939 | 02:28:36 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:28:37 INFO - PROCESS | 1939 | RSS: Main: 326864896 02:28:37 INFO - PROCESS | 1939 | 02:28:40 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:28:41 INFO - PROCESS | 1939 | RSS: Main: 321167360 02:28:41 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:56053/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56053/tests/kraken/driver.html?testName=ai-astar) 02:28:42 INFO - PROCESS | 1939 | RSS: Main: 365625344 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | __start_tp_report 02:28:42 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 02:28:42 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 02:28:42 INFO - PROCESS | 1939 | |i|pagename|runs| 02:28:42 INFO - PROCESS | 1939 | |0;ai-astar;112;114;115;113;111;115;113;114;114;116 02:28:42 INFO - PROCESS | 1939 | |1;audio-beat-detection;141;108;109;140;110;110;111;109;128;109 02:28:42 INFO - PROCESS | 1939 | |2;audio-dft;249;247;186;184;185;186;185;184;184;183 02:28:42 INFO - PROCESS | 1939 | |3;audio-fft;81;57;62;109;76;59;57;58;74;57 02:28:42 INFO - PROCESS | 1939 | |4;audio-oscillator;88;70;87;75;66;70;104;97;84;83 02:28:42 INFO - PROCESS | 1939 | |5;imaging-gaussian-blur;88;85;88;85;87;85;89;85;89;84 02:28:42 INFO - PROCESS | 1939 | |6;imaging-darkroom;98;98;100;98;98;99;99;99;98;97 02:28:42 INFO - PROCESS | 1939 | |7;imaging-desaturate;88;88;87;87;87;88;87;87;87;87 02:28:42 INFO - PROCESS | 1939 | |8;json-parse-financial;56;55;55;56;58;58;56;56;57;57 02:28:42 INFO - PROCESS | 1939 | |9;json-stringify-tinderbox;65;73;73;76;75;97;99;101;76;73 02:28:42 INFO - PROCESS | 1939 | |10;stanford-crypto-aes;84;86;85;87;83;86;83;84;83;89 02:28:42 INFO - PROCESS | 1939 | |11;stanford-crypto-ccm;138;139;139;140;138;142;144;146;213;149 02:28:42 INFO - PROCESS | 1939 | |12;stanford-crypto-pbkdf2;220;173;168;168;168;206;169;169;163;169 02:28:42 INFO - PROCESS | 1939 | |13;stanford-crypto-sha256-iterative;66;67;66;65;66;65;63;66;65;65 02:28:42 INFO - PROCESS | 1939 | __end_tp_report 02:28:42 INFO - PROCESS | 1939 | __start_cc_report 02:28:42 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,2010 02:28:42 INFO - PROCESS | 1939 | __end_cc_report 02:28:42 INFO - PROCESS | 1939 | __startTimestamp1485685722970__endTimestamp 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | ------- Summary: start ------- 02:28:42 INFO - PROCESS | 1939 | Number of tests: 14 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.00 stddev:1.49 (1.3%) stddev-sans-first:1.45 02:28:42 INFO - PROCESS | 1939 | Values: 112.0 114.0 115.0 113.0 111.0 115.0 113.0 114.0 114.0 116.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:110.50 stddev:13.46 (12.2%) stddev-sans-first:11.27 02:28:42 INFO - PROCESS | 1939 | Values: 141.0 108.0 109.0 140.0 110.0 110.0 111.0 109.0 128.0 109.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#2] audio-dft Cycles:10 Average:197.30 Median:185.50 stddev:26.74 (14.4%) stddev-sans-first:20.82 02:28:42 INFO - PROCESS | 1939 | Values: 249.0 247.0 186.0 184.0 185.0 186.0 185.0 184.0 184.0 183.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#3] audio-fft Cycles:10 Average:69.00 Median:60.50 stddev:16.73 (27.7%) stddev-sans-first:17.18 02:28:42 INFO - PROCESS | 1939 | Values: 81.0 57.0 62.0 109.0 76.0 59.0 57.0 58.0 74.0 57.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#4] audio-oscillator Cycles:10 Average:82.40 Median:83.50 stddev:12.32 (14.8%) stddev-sans-first:12.90 02:28:42 INFO - PROCESS | 1939 | Values: 88.0 70.0 87.0 75.0 66.0 70.0 104.0 97.0 84.0 83.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:1.90 (2.2%) stddev-sans-first:1.94 02:28:42 INFO - PROCESS | 1939 | Values: 88.0 85.0 88.0 85.0 87.0 85.0 89.0 85.0 89.0 84.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:98.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 02:28:42 INFO - PROCESS | 1939 | Values: 98.0 98.0 100.0 98.0 98.0 99.0 99.0 99.0 98.0 97.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#7] imaging-desaturate Cycles:10 Average:87.30 Median:87.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 02:28:42 INFO - PROCESS | 1939 | Values: 88.0 88.0 87.0 87.0 87.0 88.0 87.0 87.0 87.0 87.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:56.50 stddev:1.07 (1.9%) stddev-sans-first:1.13 02:28:42 INFO - PROCESS | 1939 | Values: 56.0 55.0 55.0 56.0 58.0 58.0 56.0 56.0 57.0 57.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#9] json-stringify-tinderbox Cycles:10 Average:80.80 Median:75.50 stddev:12.97 (17.2%) stddev-sans-first:12.43 02:28:42 INFO - PROCESS | 1939 | Values: 65.0 73.0 73.0 76.0 75.0 97.0 99.0 101.0 76.0 73.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:2.09 02:28:42 INFO - PROCESS | 1939 | Values: 84.0 86.0 85.0 87.0 83.0 86.0 83.0 84.0 83.0 89.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#11] stanford-crypto-ccm Cycles:10 Average:148.80 Median:143.00 stddev:22.86 (16.0%) stddev-sans-first:23.91 02:28:42 INFO - PROCESS | 1939 | Values: 138.0 139.0 139.0 140.0 138.0 142.0 144.0 146.0 213.0 149.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:169.00 stddev:19.25 (11.4%) stddev-sans-first:12.80 02:28:42 INFO - PROCESS | 1939 | Values: 220.0 173.0 168.0 168.0 168.0 206.0 169.0 169.0 163.0 169.0 02:28:42 INFO - PROCESS | 1939 | 02:28:42 INFO - PROCESS | 1939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 02:28:42 INFO - PROCESS | 1939 | Values: 66.0 67.0 66.0 65.0 66.0 65.0 63.0 66.0 65.0 65.0 02:28:42 INFO - PROCESS | 1939 | -------- Summary: end -------- 02:28:42 INFO - PROCESS | 1939 | 02:28:43 INFO - TEST-INFO | 1939: exit 0 02:28:43 INFO - TEST-OK | kraken | took 59673ms 02:28:43 INFO - SUITE-END | took 1176s 02:28:44 INFO - Completed test suite (00:19:36) 02:28:44 INFO - javascript benchmark 02:28:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3305.5372247885302, 3323.401787678217, 3353.3796247694163, 3380.847861846217, 3396.728261739061, 4784.851635607455, 5762.740676669549, 5774.740136693848, 5819.650820950736, 5855.121731740241, 5759.913601295984, 5836.095405212199, 5840.883182336351, 5865.149553314777, 5871.794487192949, 5262.368515778112, 5262.368515778112, 5297.841064768054, 5298.496642818926, 5359.5712343012465, 5206.557442617382, 5218.712970786605, 5356.0, 5380.031594313022, 5389.110796718537, 5289.0, 5341.278927344817, 5349.384820745606, 5350.785968561253, 5356.705381204032, 5339.5461385782255, 5347.438518955492, 5348.491893270172, 5350.5184533391985, 5354.892902141974, 5211.947880521184, 5288.942211557704, 5294.947050529484, 5299.655522391032, 5327.147656374961, 5909.0, 5913.024350982083, 5918.082697181943, 5923.526117910556, 5927.555433342516, 6226.657533835637, 6239.095331176954, 6240.095186197976, 6256.937430625727, 6289.0252010938375, 6300.527460440485, 6324.873502529969, 6331.39851714091, 6343.111964324999, 6361.61830290184, 5855.0, 5917.674527900964, 5934.406559344075, 5950.7322170502, 6012.338642749294, 6273.372662733781, 6275.246970363585, 6284.748610055546, 6289.150964619809, 6292.339304372975, 6166.260048794084, 6242.625442473466, 6245.6252624841745, 6268.373162683695, 6302.4958003359625, 6344.968275158687, 6346.30190679025, 6348.523860710373, 6353.745850165941, 6373.71318290678, 6101.368489499298, 6369.363063693686, 6382.234131904202, 6385.904211436832, 6403.839904002344, 6132.814448934737, 6201.441870231701, 6204.286507051746, 6294.527910406738, 6311.652859092794, 4974.328465657162, 5059.62052846038, 5076.898462030738, 5092.236164575269, 5096.719680417538, 4472.530384309601, 4509.120721459284, 4521.570450807168, 4535.070310586322, 4536.6143877770755, 5716.371199168088, 5821.767129314865, 5843.912341314884, 5859.355470898283, 5862.8534286642325, 6292.842678933063, 6310.684465776692, 6327.96836015817, 6330.68346582669, 6396.680165991682, 5897.144913987448, 5909.763609455574, 5914.526837852962, 5922.230110085661, 5942.64344139353, 5524.806631767869, 5534.501894829485, 5581.804636837691, 5586.301712285965, 5591.189277554732, 6265.122882796321, 6291.96854015727, 6297.52768542352, 6301.338359472189, 6382.712777924911, 6315.905261421174, 6316.463100636497, 6328.683565821782, 6330.430261276507, 6351.71417286214, 6382.234131904202, 6388.648624325707, 6390.4248617624635, 6391.904121438275, 6394.968025159845, 6127.0673618518995, 6191.566590338633, 6250.593711408744, 6261.843453913689, 6337.90493142594, 5217.452167522356, 6302.842428939313, 6321.5574909757715, 6379.362063793584, 6389.073584330153, 6141.570090093651, 6274.937250627618, 6290.559660823881, 6304.842378940563, 6315.431611155018, 5992.101184822312, 6177.2587289525545, 6190.226221722285, 6236.875262494634, 6248.656323902229, 5955.791547295824, 6001.729922153426, 6056.697165141637, 6078.331383547895, 6091.0558863376245, 6119.2350956130485, 6266.905996410149, 6275.02737075754, 6301.243850737941, 6304.84237894038, 6062.211912451353, 6110.572259941761, 6115.082737589397, 6120.265568131675, 6121.632702037892], "value": 5796.102313348885, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.37466797148045, 449.05249922663194, 494.06374919527474, 518.6395455158666, 523.7381309345327, 32550.837245813767, 41501.0, 43352.56647433529, 43498.0, 45312.093758124814, 43868.56131438685, 44090.99999999992, 44185.33721994165, 44216.11567768643, 44219.557804421944, 9403.059694030611, 9598.760030999247, 9607.66373176939, 9623.56693948774, 9635.22918166545, 8508.319334453228, 8745.956270218672, 11354.091672666209, 11546.134039946995, 11576.247543909662, 11412.714682132972, 11485.425728713573, 11559.422028898563, 11571.132165087653, 11584.47869845859, 8520.233179013856, 11368.488418021208, 11437.199396042239, 11445.484953177127, 11471.541138354456, 8491.278241349493, 9197.67808126719, 11409.315441073562, 11419.429028548539, 11593.478293476814, 40632.0, 40686.59313406887, 41143.7942810284, 41360.793196033825, 41707.374389383884, 3548.591911930135, 4003.4795476588147, 4068.613481719232, 4114.403411505345, 4287.442632457792, 25532.617010744852, 30905.381892362027, 31187.84406077978, 31200.37599248002, 31250.53124203139, 3107.4095921775015, 3193.1857376368876, 3319.369319829249, 3320.941265585594, 3389.034125274285, 479867.0, 482593.0, 483243.0, 483276.0, 485216.72174917406, 65325.67337163379, 65598.68802623921, 65794.01308980369, 65817.01274480886, 66075.66962165255, 67060.0, 69381.0, 69406.65296673586, 69683.65158174177, 69934.3006569938, 13729.656758581115, 17029.82970170307, 17082.829171708374, 17103.74344384835, 17114.486565402807, 11669.474873630706, 12071.818922716166, 13057.608271751862, 13141.211527308393, 13148.342582870819, 16288.42990495327, 17993.820061799215, 18411.631767364845, 18560.907195463937, 18870.90564547196, 6375.776847810304, 6491.415772580491, 6519.218853065211, 6519.674016299166, 6520.282768895418, 872.520113937332, 887.2148148888281, 888.5424006636588, 892.8035832116924, 919.1360121485782, 29218.415631687247, 29931.0, 30112.84943575268, 30393.0, 30772.846135769625, 1050.7058023753361, 1055.2244100586217, 1058.5289546152042, 1079.1474734959452, 1088.2219213262556, 14590.708185836223, 14670.119792812466, 14802.777958330633, 14933.178675172752, 14975.251237438084, 559591.0, 559718.0, 560600.0, 560848.0, 564115.0, 53663.0, 53735.0, 53792.19311710328, 53970.0, 54170.7291463548, 1419.9574012779633, 1428.607133038402, 1447.8479759625088, 1454.7090581883665, 1460.5180290504109, 26206.73793262043, 27250.182494525197, 27609.723902761518, 28154.577681334387, 28234.035426279945, 46866.76566617145, 47357.0, 47430.76284618555, 47564.762176188895, 47580.2862957049, 510352.0, 516229.0, 520222.0, 520580.0, 522733.0, 21939.451513712283, 23621.64567531454, 24818.25545233646, 25083.498330032933, 25142.74857251404, 33896.830515847265, 42695.5730442704, 43373.78313108414, 43950.340744889494, 43963.56036439595, 30946.916857909866, 34205.828970854986, 36143.45784813283, 36282.0, 36897.44653830141, 35041.29917401689, 35111.0, 36493.0, 36639.63360366362, 37839.810800945816, 35407.760728374386, 36490.635093649784, 36577.268454630226, 37149.0, 37874.0, 30651.2337191572, 32527.512087318235, 32634.0, 32739.0, 32828.835855820565, 24587.89354479017, 24691.135810246557, 24834.379140521633, 24844.906644289036, 25036.74963250344], "value": 19771.52588367147, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.3070334804048, 392.1627325659716, 397.91842672252193, 403.41907652979705, 423.7923417525412, 19152.904235478836, 19396.51508712281, 20510.0, 20668.0, 20739.792602073994, 20750.377488675327, 20960.26639067633, 21615.027323770428, 21986.340409787732, 21998.900054997266, 4658.650601204906, 5454.34547854256, 5503.7798488060425, 5566.332040155187, 5568.387477377485, 5303.337082864642, 5470.288862447876, 5501.724913754317, 5507.642003269794, 5510.586705997066, 5341.813036543722, 5423.240746295522, 5445.727713614323, 5493.285872836525, 5494.587905907053, 5279.788808447657, 5419.132938729785, 5487.533559647435, 5488.396276409591, 5491.7254137292975, 5355.410904800468, 5385.919211211835, 5391.703456309901, 5394.433584473613, 5401.540869026137, 11223.663290101229, 13727.176369417866, 23559.528809423886, 24011.639825402457, 24513.65174915379, 2649.5893136563864, 2650.2844232057237, 2655.9734402655918, 2657.800664950117, 2671.612616170664, 8446.324294056461, 9711.0, 10513.211509136769, 10680.62617808373, 10684.465776711211, 1746.4149509914193, 1827.4608990347747, 1833.449965010505, 1841.4291569613329, 1848.4639454558162, 129318.35340823236, 135729.0, 137667.0, 137863.0, 137881.0, 11889.28664280146, 11962.700932476584, 12123.696907577381, 12124.515019399301, 12125.151239413157, 16035.599110022344, 16070.357185712674, 16076.919615401848, 16095.114768687601, 16101.677966440606, 8677.783055423664, 8782.077881822317, 8812.867806982773, 8814.118588141135, 8945.01604823469, 8544.786380340416, 8548.615312310962, 8553.74338769838, 8694.26098781598, 8725.301975842045, 4754.07295577366, 4797.2564252540915, 4813.518648135158, 4819.132556139928, 4884.535969082932, 1985.9205631774855, 2041.0917141872021, 2044.5093177637557, 2044.8568600197843, 2050.2516581447962, 969.9485587981369, 986.7681094942683, 991.2813210422386, 991.3506653142204, 1010.5351538292321, 19049.7142542862, 20697.27559535409, 20715.482112946996, 20766.58466830655, 21052.368428947157, 904.615538396179, 988.8220120378257, 1001.3191030099603, 1005.2109094360892, 1016.3850870223556, 10133.13868321201, 10546.894531054744, 10632.989865962722, 10643.73390665224, 10645.680629581126, 420194.0, 426243.0, 712162.8783712096, 741922.0, 769314.3068569243, 97634.51182744041, 136542.0, 137960.31019844837, 144053.0, 149982.0, 935.6304259817334, 974.7611835100446, 1008.6973907827622, 1009.2985375164337, 1019.5361110694616, 15571.29929153168, 19503.219871204994, 20325.898370508054, 20329.79670203279, 20430.0, 56356.0, 57533.56166095881, 57635.0, 58962.0, 59204.70397647984, 66985.0, 81991.59004204941, 83963.0, 84249.73625395747, 86397.0, 7065.929340706527, 7341.412686985135, 7455.589942553212, 7929.643166057656, 8518.275946544612, 10752.784944301227, 12328.691782705504, 12672.6831829205, 12799.87200128024, 12972.870271297166, 8663.393562450568, 10726.463676816284, 10739.624113156002, 11281.097512199169, 11316.321020738782, 10790.730231743955, 10992.450377481255, 11044.116470682487, 11127.109831213646, 11352.602658906899, 8964.417312874642, 11284.830727539258, 11579.073674105883, 11612.825807613062, 11635.767284654428, 8198.83602327962, 8222.054463736507, 8435.789105272417, 8523.95738021306, 8702.0, 9420.293477989042, 10895.976647920743, 10972.0, 11058.447077646246, 11196.216264861707], "value": 9618.86644493847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.079199708185, 1454.149322646252, 1455.6797504549, 1470.411835265894, 1475.9778603320951, 8099.230573095554, 8524.360672949522, 8557.443766155204, 8561.101084386135, 8565.871511927326, 7491.5505069695855, 7721.72973945912, 7732.0, 8053.879191812113, 8304.377171712116, 2321.537431418204, 2364.598018336887, 2366.1245339224424, 2369.099742098, 2370.9051637934463, 2347.108098922407, 2362.4093976505874, 2373.5134297468976, 2380.36920216142, 2383.2373640435067, 2304.124432715574, 2310.214527060799, 2337.544178885118, 2346.5189636124555, 2356.1871154451774, 2307.3654744945106, 2310.861348319106, 2329.941751456227, 2334.3347146063375, 2335.346103091137, 2305.5849947009533, 2371.727251366098, 2380.0479808076734, 2380.797632201265, 2384.6184610462415, 8411.116832732536, 8459.53472559009, 8481.830363392759, 8490.066092729794, 8496.980362356495, 5048.848534543969, 5212.061828870802, 5216.165413533817, 5216.165413533854, 5231.163013917793, 3129.389768995047, 3329.433996220648, 3485.6688614581576, 3514.8769793057377, 3520.3135388599235, 1224.877512248768, 1244.2766768026258, 1251.730877861255, 1255.8367412236441, 1269.7968325067945, 10668.933106689346, 10723.30298530593, 10806.675799726021, 10822.18833587484, 10905.83641245382, 4490.977545112253, 4645.814167433265, 4724.976375118103, 4736.3369128322065, 4737.2183589708, 9509.90490095104, 9512.2865785065, 9516.85724714116, 9519.952400237955, 9527.666531671359, 5243.0, 5285.154375299933, 5285.312909321764, 5286.788528458896, 5289.3917199521775, 3976.6619837313574, 4206.8737937861915, 4683.95316046842, 4761.785719642555, 4789.592884604778, 3826.196498735241, 3884.3979183226643, 3957.722959392815, 3958.287508248543, 3987.7407968481957, 1125.8817824128512, 1276.3107921722167, 1292.2052937443593, 1296.7406518696298, 1305.4060402516832, 914.1257741781764, 923.6259314977444, 927.9118483744033, 934.6775362499926, 961.1397798969883, 5414.269073675082, 5435.824711380939, 5511.972440137773, 5751.0, 5759.366469688331, 533.773146412773, 536.3751229817219, 569.4447913284597, 578.2251782611321, 588.1119509540539, 3661.139632186434, 3661.688756455678, 3682.668559829628, 3692.7599706019023, 3728.440733889938, 9735.902640973642, 9810.80378392428, 10052.346597471142, 10054.899451005542, 10087.949560252298, 9641.27690423221, 9716.076972687584, 9940.751481212883, 9979.750506237402, 10026.849597256047, 7701.499402538817, 7811.218878112143, 7824.334931530883, 7829.41279404047, 7848.293653571091, 5334.3865455473115, 5392.137258038695, 5464.672119672832, 5550.500454959073, 5559.24950131727, 9028.09719028092, 9330.720078397659, 9354.158125768714, 9356.111169438893, 9373.578188981375, 8952.373333866566, 9305.581248843682, 9327.486988215713, 9344.345895787501, 9346.0, 6684.966575167093, 6905.516613836983, 6910.101686780888, 7108.644567771487, 7277.2722727726805, 7625.809354765954, 7787.0, 7908.485948413335, 7996.24035716606, 7999.9600001999615, 7003.229644739176, 7097.25478824716, 7129.572225666477, 7147.964260178665, 7233.819154521179, 6777.254502004677, 6787.355201255873, 7008.182849861774, 7008.5094043416475, 7034.120734908137, 6372.808815735535, 6374.713137908712, 6450.48396128318, 6454.128692626436, 6463.0, 4898.779554919965, 4911.50884911506, 4941.160002799605, 4948.554630083309, 4983.775730092082, 4892.119418504703, 4904.4605093440405, 4915.574483399917, 5051.469595692546, 5054.115529782347], "value": 4375.818124954937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.94389869570216, 370.1228089428056, 374.1394791978449, 381.5916968843339, 383.5665697761529, 4784.856454306368, 5119.771254898826, 5309.469053094688, 5574.944250557493, 5597.524210442118, 4680.204365257906, 5069.366329208849, 5218.712970786605, 5322.494363035516, 5526.861828454291, 3541.6989555887653, 3745.1386181178345, 3975.622315879994, 4283.271843786564, 4318.5033721122, 3675.044488433, 3743.128435782109, 3881.10734531058, 4157.979210103946, 4264.42430271914, 3750.6624403803653, 3766.6610005099537, 3943.6510325142535, 4173.061061261223, 4196.286631272676, 3875.9418608720894, 3909.6090390960962, 4025.194961007781, 4105.856295029675, 4317.201317756225, 3723.5345581802276, 3724.3854763963914, 3732.9066773330615, 3737.4767532545466, 3763.153290509641, 4791.520847915215, 5277.8416647500635, 5342.6910406950155, 5349.732513374316, 5351.892962140774, 4007.97996010021, 4895.730734809584, 4910.428662827897, 4962.908160204749, 4979.983106841735, 4776.617870570381, 4893.828715994923, 5775.884482310373, 5794.913076303858, 5814.011618024946, 3156.6369867465305, 4169.56219596941, 4173.1862286854075, 4173.91652166958, 4182.8288079337835, 5112.134071064072, 5325.337331334333, 5557.888842223133, 5749.9425005750245, 6041.6979151042715, 3503.386907291214, 3578.9284214315567, 3603.558576569341, 4217.334153009544, 4244.917546025744, 4303.526612072669, 4310.534418297794, 4317.266064768997, 4323.935140972888, 4329.870103896888, 4666.789994450258, 4882.487338829443, 4901.705897646153, 4926.778294976663, 4948.925766113512, 5120.899006713575, 5166.535011848877, 5493.478119578634, 5810.215620891126, 5823.292169141369, 1230.8399908011902, 1277.4223833565538, 1355.8407561534943, 1391.6660001599544, 1406.4093080906043, 872.5942436766934, 925.780637062601, 925.8287216864901, 948.5684013773716, 973.1144658360857, 4448.0, 4530.750808705553, 4589.931151032737, 4979.925301120486, 5127.2052831811125, 4915.43472500667, 5135.563477104413, 5707.315122185364, 5729.512991395778, 5757.424257574209, 4558.452985641744, 4912.771807048238, 5000.149974504343, 5122.410922743858, 5232.2413250078525, 2594.4681340325187, 2666.4800363929235, 2731.7814574833965, 2764.6958834528186, 2806.5369214079856, 4992.950070499249, 5254.244908357942, 5555.916661250085, 5727.363124416026, 5792.292932523189, 4800.591949684246, 5190.480951904855, 5226.503482169188, 5765.740541675635, 5814.709264536757, 5018.737820416758, 5351.438098999627, 5824.475797178275, 5844.620099693507, 5844.620099693507, 5278.4721527846905, 5301.496357845998, 5623.381428042994, 5700.942990570207, 5722.799702010409, 5132.435432102391, 5349.089256371653, 5578.665280083045, 5582.916256256241, 5603.80386686464, 5254.710990895537, 5498.560115190695, 5579.8884022320135, 5820.0, 5848.830233953311, 3186.824724640167, 3461.9307613848086, 3992.7604343739467, 4013.578574249662, 4037.7886634010265, 5005.6996580205305, 5224.231157486538, 5930.406959304035, 5967.791127310524, 5977.5217982560425, 4453.933191002202, 4863.95136048635, 5592.0, 5719.256496655408, 5807.245058142415, 4569.428821397325, 5305.283786688748, 5475.342958844964, 5734.996375634164, 5746.482816546363, 4671.43942726875, 4948.0, 5189.6886186828915, 5634.690092044977, 5641.8589535261945, 5366.953444078367, 5622.297212848394, 5748.798792042258, 5765.94234057654, 5796.9420305798085, 5058.1401161803315, 5608.214849921096, 5630.662160270397, 5635.520980716685, 5639.971800140973], "value": 4126.23721808799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.6566718140157, 672.0, 691.1774987764563, 694.9930500694992, 778.3267473635303, 14000.929995350034, 14029.298535073243, 14328.0, 14535.0, 14593.270336483172, 13552.0, 13760.798272276437, 13836.962227832902, 13979.23114228717, 14018.15891046538, 861.9439736417113, 880.6521424037502, 882.5851849630664, 882.6072397782989, 884.8805411269493, 697.2922483679044, 718.7699936020475, 721.7582109993159, 858.7380848841101, 879.4679219072465, 935.0369119806576, 935.96724114656, 937.2127412973101, 939.5912777941583, 940.2759874896326, 928.3408779766306, 932.9673461428818, 933.1788026536605, 933.6732143749701, 935.6257497001186, 542.1271752478507, 554.0802268234751, 673.9359760822714, 692.840646651268, 694.7360003198752, 14159.716805663931, 14684.559463216121, 14692.853071469255, 14697.853021469862, 14707.485238016725, 13115.803262951064, 13145.211287322696, 13329.733405331936, 13361.66595835112, 13369.398377072957, 12085.335306558136, 12290.324032178227, 12429.937850310782, 12482.563110291096, 12795.0, 4319.805608747614, 4339.761313127777, 4343.457067866517, 4358.978205108954, 4381.496127945264, 91291.0, 94443.0, 96589.0, 103145.99999999924, 108264.4586777061, 10657.786844263226, 11026.558937642565, 11048.392338421463, 11106.833397499044, 11467.08263338931, 20545.0, 20642.896785516277, 20865.0, 20868.582628347347, 20882.0, 7684.462087653922, 7746.961265193638, 7765.72819951299, 7771.261730135628, 7932.801679957932, 4186.91626167475, 4229.873103806891, 4246.915061698749, 4297.269464191095, 4312.072904325585, 3322.0, 3380.678835510623, 3386.8306584670668, 3391.9491207631904, 3401.727861771052, 629.7512482569451, 636.8821767972939, 637.2703254773259, 639.5427269502328, 640.2349192714661, 572.977080916767, 583.9503642190462, 591.4913174669781, 598.2850493660035, 600.24366326925, 8978.281737460988, 9063.501507417024, 9554.713358599114, 9923.023857144966, 9927.703659536466, 647.2491909385091, 650.3821369698805, 656.9211694596679, 681.9386255236954, 686.1388956859109, 4730.0, 4856.4415092264135, 4859.878503037452, 4872.78072486739, 4886.780094895738, 103046.48476757568, 104031.0, 104638.47680761547, 105873.47063264788, 106011.46994265134, 87643.56178219068, 88728.669069964, 89277.0, 91108.63337049949, 91440.0, 78871.60564197143, 80062.59968700119, 81667.0, 81917.18082819096, 82855.585722071, 9264.675736349465, 9413.7291465654, 9427.481488517922, 9454.14912657864, 9474.0, 52148.95702085861, 52464.0, 52816.0, 53449.0, 54695.0, 67395.98527470947, 69131.61736765337, 70010.64994674994, 71339.64330178316, 72357.0, 11111.166662500507, 11368.772624547628, 11389.886101139215, 11401.657950261506, 11593.0, 12130.514779408724, 12180.269183848997, 12199.146059776085, 12225.388730563258, 12691.175073620185, 11915.046796256105, 12077.27536347822, 12111.515539378326, 12402.81395779046, 12546.247225166519, 9943.552540135566, 11989.940050299692, 12510.437030333838, 12769.8084528734, 12965.481380744664, 12900.0, 12981.545645902348, 13021.283829389475, 13168.868311317148, 13183.274919879499, 9520.761980950532, 11151.55393784272, 11218.943905280421, 11673.533058677558, 11715.941420292844, 10760.085392741705, 10788.190885683762, 10849.45752712377, 10872.510737016695, 10902.890971090188], "value": 7326.020032866241, "unit": "score"}], "name": "dromaeo_css", "value": 7255.010656105028, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 113.0, 111.0, 115.0, 113.0, 114.0, 114.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 109.0, 140.0, 110.0, 110.0, 111.0, 109.0, 128.0, 109.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [249.0, 247.0, 186.0, 184.0, 185.0, 186.0, 185.0, 184.0, 184.0, 183.0], "value": 197.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 62.0, 109.0, 76.0, 59.0, 57.0, 58.0, 74.0, 57.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 87.0, 75.0, 66.0, 70.0, 104.0, 97.0, 84.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 87.0, 85.0, 89.0, 85.0, 89.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 98.0, 100.0, 98.0, 98.0, 99.0, 99.0, 99.0, 98.0, 97.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 87.0, 87.0, 88.0, 87.0, 87.0, 87.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 58.0, 58.0, 56.0, 56.0, 57.0, 57.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 73.0, 73.0, 76.0, 75.0, 97.0, 99.0, 101.0, 76.0, 73.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 85.0, 87.0, 83.0, 86.0, 83.0, 84.0, 83.0, 89.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 139.0, 140.0, 138.0, 142.0, 144.0, 146.0, 213.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 173.0, 168.0, 168.0, 168.0, 206.0, 169.0, 169.0, 163.0, 169.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 63.0, 66.0, 65.0, 65.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1465.7999999999997, "alertThreshold": 2.0}]} 02:28:44 INFO - Return code: 0 02:28:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:28:44 ERROR - # TBPL SUCCESS # 02:28:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:28:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:28:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:28:44 INFO - 2017-01-29 02:28:44.291 screenresolution[1943:24806] starting screenresolution argv=screenresolution get 02:28:44 INFO - 2017-01-29 02:28:44.294 screenresolution[1943:24806] Display 0: 1600x1200x32@60 02:28:44 INFO - 2017-01-29 02:28:44.300 screenresolution[1944:24809] starting screenresolution argv=screenresolution list 02:28:44 INFO - Available Modes on Display 0 02:28:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:28:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:28:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:28:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:28:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:28:44 INFO - Intel Iris: 02:28:44 INFO - Chipset Model: Intel Iris 02:28:44 INFO - Type: GPU 02:28:44 INFO - Bus: Built-In 02:28:44 INFO - VRAM (Dynamic, Max): 1536 MB 02:28:44 INFO - Vendor: Intel (0x8086) 02:28:44 INFO - Device ID: 0x0a2e 02:28:44 INFO - Revision ID: 0x0009 02:28:44 INFO - Displays: 02:28:44 INFO - Display: 02:28:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:28:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:28:44 INFO - Display Serial Number: 1600x1200 60 02:28:44 INFO - Main Display: Yes 02:28:44 INFO - Mirror: Off 02:28:44 INFO - Online: Yes 02:28:44 INFO - Rotation: Supported 02:28:44 INFO - Return code: 0 02:28:44 INFO - Running post-action listener: _resource_record_post_action 02:28:44 INFO - [mozharness: 2017-01-29 10:28:44.543758Z] Finished run-tests step (success) 02:28:44 INFO - Running post-run listener: _resource_record_post_run 02:28:44 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 647168; Write bytes: 509447680; Read time: 6; Write time: 1623 02:28:44 INFO - TinderboxPrint: CPU usage
53.8% 02:28:44 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 6 02:28:44 INFO - TinderboxPrint: I/O write bytes / time
509,447,680 / 1,623 02:28:44 INFO - TinderboxPrint: CPU idle
2,212.9 (46.2%) 02:28:44 INFO - TinderboxPrint: CPU system
965.9 (20.1%) 02:28:44 INFO - TinderboxPrint: CPU user
1,614.9 (33.7%) 02:28:44 INFO - TinderboxPrint: Swap in / out
207,609,856 / 0 02:28:44 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 202947072; Write bytes: 198668288; Read time: 15740; Write time: 429 02:28:44 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 647168; Write bytes: 300035584; Read time: 6; Write time: 1159 02:28:45 INFO - Running post-run listener: _upload_blobber_files 02:28:45 INFO - Blob upload gear active. 02:28:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:28:45 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 02:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:28:45 INFO - (blobuploader) - INFO - Open directory for files ... 02:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:46 INFO - (blobuploader) - INFO - Done attempting. 02:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:47 INFO - (blobuploader) - INFO - Done attempting. 02:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:48 INFO - (blobuploader) - INFO - Done attempting. 02:28:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:28:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:28:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:28:50 INFO - (blobuploader) - INFO - Done attempting. 02:28:50 INFO - (blobuploader) - INFO - Iteration through files over. 02:28:50 INFO - Return code: 0 02:28:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:28:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:28:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd2e64faa66426542880ca7da677fe8348e67bf72802be2d44a7d859a7b4d2a91de3fd87b51d5cb4ade0a539aa7e6956ca956c4002f191b023208a53538fb5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd6c25a6cbdf5eec0f891e6e3b24c8c92518e36222967f9e2aa0e9f978bef74ab77150b0c88a2d555c2838fd64bb9aa9bb7c13f831678783a76c8059b6e66962", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2060c8ee95298e539e0a3bb060e8d5cea5bb4e334b5e76de711dcd2f906fa9eba7485c71d5fc164f0193a3d9af0eff2ca6f9bff80951697abbdcf1689fb7628b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc61b66b8ab1a55c7ee4d3b6972cde70f5c183854deadd1bc48cfb9dcbb2376f4b6343185e8b8afffb177c4648ff93e66d786837e18b17f2e365cd72f86e61ab"} 02:28:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:28:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:28:50 INFO - Contents: 02:28:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd2e64faa66426542880ca7da677fe8348e67bf72802be2d44a7d859a7b4d2a91de3fd87b51d5cb4ade0a539aa7e6956ca956c4002f191b023208a53538fb5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd6c25a6cbdf5eec0f891e6e3b24c8c92518e36222967f9e2aa0e9f978bef74ab77150b0c88a2d555c2838fd64bb9aa9bb7c13f831678783a76c8059b6e66962", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2060c8ee95298e539e0a3bb060e8d5cea5bb4e334b5e76de711dcd2f906fa9eba7485c71d5fc164f0193a3d9af0eff2ca6f9bff80951697abbdcf1689fb7628b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc61b66b8ab1a55c7ee4d3b6972cde70f5c183854deadd1bc48cfb9dcbb2376f4b6343185e8b8afffb177c4648ff93e66d786837e18b17f2e365cd72f86e61ab"} 02:28:50 INFO - Running post-run listener: copy_logs_to_upload_dir 02:28:50 INFO - Copying logs to upload dir... 02:28:50 INFO - mkdir: /builds/slave/test/build/upload/logs 02:28:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.282345 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-01-29 02:28:50.951783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 02:28:50.955899) ========= 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.iIuaYkXVIF/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.PjjDsmduTH/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd2e64faa66426542880ca7da677fe8348e67bf72802be2d44a7d859a7b4d2a91de3fd87b51d5cb4ade0a539aa7e6956ca956c4002f191b023208a53538fb5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd6c25a6cbdf5eec0f891e6e3b24c8c92518e36222967f9e2aa0e9f978bef74ab77150b0c88a2d555c2838fd64bb9aa9bb7c13f831678783a76c8059b6e66962", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2060c8ee95298e539e0a3bb060e8d5cea5bb4e334b5e76de711dcd2f906fa9eba7485c71d5fc164f0193a3d9af0eff2ca6f9bff80951697abbdcf1689fb7628b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc61b66b8ab1a55c7ee4d3b6972cde70f5c183854deadd1bc48cfb9dcbb2376f4b6343185e8b8afffb177c4648ff93e66d786837e18b17f2e365cd72f86e61ab"} build_url:https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/AWybPNQfTJKaXFjmkacDcg/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6fd2e64faa66426542880ca7da677fe8348e67bf72802be2d44a7d859a7b4d2a91de3fd87b51d5cb4ade0a539aa7e6956ca956c4002f191b023208a53538fb5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd6c25a6cbdf5eec0f891e6e3b24c8c92518e36222967f9e2aa0e9f978bef74ab77150b0c88a2d555c2838fd64bb9aa9bb7c13f831678783a76c8059b6e66962", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2060c8ee95298e539e0a3bb060e8d5cea5bb4e334b5e76de711dcd2f906fa9eba7485c71d5fc164f0193a3d9af0eff2ca6f9bff80951697abbdcf1689fb7628b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc61b66b8ab1a55c7ee4d3b6972cde70f5c183854deadd1bc48cfb9dcbb2376f4b6343185e8b8afffb177c4648ff93e66d786837e18b17f2e365cd72f86e61ab"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-29 02:28:50.995005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 02:28:50.995821) ========= 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.iIuaYkXVIF/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.PjjDsmduTH/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.005270 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-29 02:28:51.054360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 02:28:51.054711) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-29 02:28:51.055050) ========= ========= Total master_lag: 0.37 =========