builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1488329624.97 results: success (0) buildid: 20170228153103 builduid: ff9560d6583c404ca8018a9694f0f1db revision: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:44.968107) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:44.968584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:44.968873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:44.995979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:44.996359) ========= 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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-02-28 16:53:45-- 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% 14.1M=0.001s 2017-02-28 16:53:45 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:45.181634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:45.181963) ========= 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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.027053 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:45.231434) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-28 16:53:45.231813) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 --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 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.a7KcGW8ulP/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.SD2nFzmbbK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-02-28 16:53:45,334 truncating revision to first 12 chars 2017-02-28 16:53:45,334 Setting DEBUG logging. 2017-02-28 16:53:45,334 attempt 1/10 2017-02-28 16:53:45,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/397bf222b4d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-28 16:53:47,018 unpacking tar archive at: mozilla-aurora-397bf222b4d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.955382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-28 16:53:47.210958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.211299) ========= script_repo_revision: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.211746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.212039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-28 16:53:47.232261) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-28 16:53:47.232694) ========= /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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:53:47 INFO - MultiFileLogger online at 20170228 16:53:47 in /builds/slave/test 16:53:47 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 16:53:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:47 INFO - {'append_to_log': False, 16:53:47 INFO - 'base_work_dir': '/builds/slave/test', 16:53:47 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:53:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:47 INFO - 'branch': 'Mozilla-Aurora', 16:53:47 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:47 INFO - 'config_files': ('talos/mac_config.py',), 16:53:47 INFO - 'default_actions': ('clobber', 16:53:47 INFO - 'read-buildbot-config', 16:53:47 INFO - 'download-and-extract', 16:53:47 INFO - 'populate-webroot', 16:53:47 INFO - 'create-virtualenv', 16:53:47 INFO - 'install', 16:53:47 INFO - 'run-tests'), 16:53:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:47 INFO - 'download_minidump_stackwalk': True, 16:53:47 INFO - 'download_symbols': 'ondemand', 16:53:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:47 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:47 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:47 INFO - 'installer_path': 'installer.exe', 16:53:47 INFO - 'log_level': 'info', 16:53:47 INFO - 'log_name': 'talos', 16:53:47 INFO - 'log_to_console': True, 16:53:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:53:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:53:47 INFO - 'opt_config_files': (), 16:53:47 INFO - 'pip_index': False, 16:53:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:47 INFO - 'cmd': ('bash', 16:53:47 INFO - '-c', 16:53:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:47 INFO - 'enabled': True, 16:53:47 INFO - 'halt_on_failure': False, 16:53:47 INFO - 'name': 'check_screen_resolution'},), 16:53:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:47 INFO - 'cmd': ('bash', 16:53:47 INFO - '-c', 16:53:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:47 INFO - 'enabled': True, 16:53:47 INFO - 'halt_on_failure': False, 16:53:47 INFO - 'name': 'check_screen_resolution'},), 16:53:47 INFO - 'run_cmd_checks_enabled': True, 16:53:47 INFO - 'sps_profile': False, 16:53:47 INFO - 'sps_profile_interval': 0, 16:53:47 INFO - 'suite': 'dromaeojs', 16:53:47 INFO - 'system_bits': '32', 16:53:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:47 INFO - 'title': 't-yosemite-r7-0102', 16:53:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:47 INFO - 'use_talos_json': True, 16:53:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:47 INFO - 'work_dir': 'build'} 16:53:47 INFO - [mozharness: 2017-03-01 00:53:47.448535Z] Running clobber step. 16:53:47 INFO - Running pre-action listener: _resource_record_pre_action 16:53:47 INFO - Running main action method: clobber 16:53:47 INFO - rmtree: /builds/slave/test/build 16:53:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:50 INFO - Running post-action listener: _resource_record_post_action 16:53:50 INFO - [mozharness: 2017-03-01 00:53:50.084972Z] Finished clobber step (success) 16:53:50 INFO - [mozharness: 2017-03-01 00:53:50.085108Z] Running read-buildbot-config step. 16:53:50 INFO - Running pre-action listener: _resource_record_pre_action 16:53:50 INFO - Running main action method: read_buildbot_config 16:53:50 INFO - Using buildbot properties: 16:53:50 INFO - { 16:53:50 INFO - "project": "", 16:53:50 INFO - "product": "firefox", 16:53:50 INFO - "script_repo_revision": "production", 16:53:50 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:53:50 INFO - "repository": "", 16:53:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:53:50 INFO - "buildid": "20170228153103", 16:53:50 INFO - "pgo_build": "False", 16:53:50 INFO - "basedir": "/builds/slave/test", 16:53:50 INFO - "buildnumber": 4, 16:53:50 INFO - "slavename": "t-yosemite-r7-0102", 16:53:50 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:53:50 INFO - "platform": "yosemite_r7", 16:53:50 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:53:50 INFO - "branch": "mozilla-aurora", 16:53:50 INFO - "repo_path": "releases/mozilla-aurora", 16:53:50 INFO - "revision": "397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4", 16:53:50 INFO - "stage_platform": "macosx64", 16:53:50 INFO - "builduid": "ff9560d6583c404ca8018a9694f0f1db", 16:53:50 INFO - "slavebuilddir": "test" 16:53:50 INFO - } 16:53:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 16:53:50 INFO - Running post-action listener: _resource_record_post_action 16:53:50 INFO - [mozharness: 2017-03-01 00:53:50.088421Z] Finished read-buildbot-config step (success) 16:53:50 INFO - [mozharness: 2017-03-01 00:53:50.088522Z] Running download-and-extract step. 16:53:50 INFO - Running pre-action listener: _resource_record_pre_action 16:53:50 INFO - Running main action method: download_and_extract 16:53:50 INFO - mkdir: /builds/slave/test/build/tests 16:53:50 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')]} 16:53:50 INFO - trying https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 16:53:50 INFO - Downloading https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/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 16:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/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 16:53:51 INFO - Downloaded 1199 bytes. 16:53:51 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:53:51 INFO - Using the following test package requirements: 16:53:51 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:53:51 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 16:53:51 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 16:53:51 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'jsshell-mac.zip'], 16:53:51 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 16:53:51 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:53:51 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 16:53:51 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 16:53:51 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 16:53:51 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:53:51 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 16:53:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:53:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:53:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:53:51 INFO - Fetch https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:53:51 INFO - Expected file size: 16357774 16:53:51 INFO - Obtained file size: 16357774 16:53:58 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 16:53:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:53:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:53:58 INFO - Fetch https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:53:59 INFO - Expected file size: 16357774 16:53:59 INFO - Obtained file size: 16357774 16:54:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 16:54:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:54:06 INFO - Fetch https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 16:54:07 INFO - Expected file size: 14403472 16:54:07 INFO - Obtained file size: 14403472 16:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:07 INFO - trying https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:54:07 INFO - Downloading https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 16:54:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/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 16:54:09 INFO - Downloaded 73908741 bytes. 16:54:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:54:09 INFO - mkdir: /builds/slave/test/properties 16:54:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:09 INFO - Contents: 16:54:09 INFO - build_url:https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:54:10 INFO - Running post-action listener: _resource_record_post_action 16:54:10 INFO - Running post-action listener: set_extra_try_arguments 16:54:10 INFO - [mozharness: 2017-03-01 00:54:10.488829Z] Finished download-and-extract step (success) 16:54:10 INFO - [mozharness: 2017-03-01 00:54:10.488954Z] Running populate-webroot step. 16:54:10 INFO - Running pre-action listener: _resource_record_pre_action 16:54:10 INFO - Running main action method: populate_webroot 16:54:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:10 INFO - '--tppagecycles', 16:54:10 INFO - '7'], 16:54:10 INFO - 'tests': ['tsvgm']}}, 16:54:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['damp', 'tps']}, 16:54:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'tests': ['damp', 'tps']}, 16:54:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['dromaeo_dom']}, 16:54:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['basic_compositor_video']}, 16:54:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:54:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['a11yr', 16:54:10 INFO - 'ts_paint', 16:54:10 INFO - 'tpaint', 16:54:10 INFO - 'sessionrestore', 16:54:10 INFO - 'sessionrestore_no_auto_restore', 16:54:10 INFO - 'tabpaint']}, 16:54:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:10 INFO - 'ts_paint', 16:54:10 INFO - 'tpaint', 16:54:10 INFO - 'sessionrestore', 16:54:10 INFO - 'sessionrestore_no_auto_restore', 16:54:10 INFO - 'tabpaint']}, 16:54:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:10 INFO - 'ts_paint', 16:54:10 INFO - 'tpaint', 16:54:10 INFO - 'sessionrestore', 16:54:10 INFO - 'sessionrestore_no_auto_restore', 16:54:10 INFO - 'tabpaint']}, 16:54:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:10 INFO - 'ts_paint', 16:54:10 INFO - 'tpaint', 16:54:10 INFO - 'sessionrestore', 16:54:10 INFO - 'sessionrestore_no_auto_restore', 16:54:10 INFO - 'tabpaint']}, 16:54:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['a11yr', 16:54:10 INFO - 'ts_paint', 16:54:10 INFO - 'tpaint', 16:54:10 INFO - 'sessionrestore', 16:54:10 INFO - 'sessionrestore_no_auto_restore', 16:54:10 INFO - 'tabpaint']}, 16:54:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['a11yr', 16:54:10 INFO - 'ts_paint', 16:54:10 INFO - 'tpaint', 16:54:10 INFO - 'sessionrestore', 16:54:10 INFO - 'sessionrestore_no_auto_restore', 16:54:10 INFO - 'tabpaint']}, 16:54:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['tsvgx', 16:54:10 INFO - 'tsvgr_opacity', 16:54:10 INFO - 'tart', 16:54:10 INFO - 'tscrollx', 16:54:10 INFO - 'cart', 16:54:10 INFO - 'tsvg_static']}, 16:54:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:10 INFO - 'tsvgr_opacity', 16:54:10 INFO - 'tart', 16:54:10 INFO - 'tscrollx', 16:54:10 INFO - 'cart', 16:54:10 INFO - 'tsvg_static']}, 16:54:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'talos_options': ['--disable-e10s'], 16:54:10 INFO - 'tests': ['tp5o']}, 16:54:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:54:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'talos_options': ['--disable-e10s', 16:54:10 INFO - '--xperf_path', 16:54:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:10 INFO - 'tests': ['tp5n']}, 16:54:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:54:10 INFO - 'talos_options': ['--xperf_path', 16:54:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:10 INFO - 'tests': ['tp5n']}}, 16:54:10 INFO - 'talos.zip': {'path': '', 16:54:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:10 INFO - Running post-action listener: _resource_record_post_action 16:54:10 INFO - [mozharness: 2017-03-01 00:54:10.507244Z] Finished populate-webroot step (success) 16:54:10 INFO - [mozharness: 2017-03-01 00:54:10.507349Z] Running create-virtualenv step. 16:54:10 INFO - Running pre-action listener: _resource_record_pre_action 16:54:10 INFO - Running main action method: create_virtualenv 16:54:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:10 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 16:54:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:10 INFO - Using real prefix '/tools/python27' 16:54:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:14 INFO - Installing pip.................done. 16:54:14 INFO - Return code: 0 16:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:54:14 INFO - Reading from file tmpfile_stdout 16:54:14 INFO - Output received: 16:54:14 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) 16:54:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:14 INFO - 'HOME': '/Users/cltbld', 16:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:14 INFO - 'LOGNAME': 'cltbld', 16:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:14 INFO - 'MOZ_NO_REMOTE': '1', 16:54:14 INFO - 'NO_EM_RESTART': '1', 16:54:14 INFO - 'PAGER': '/bin/cat', 16:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:14 INFO - 'PWD': '/builds/slave/test', 16:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:14 INFO - 'SHELL': '/bin/bash', 16:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:14 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:14 INFO - 'USER': 'cltbld', 16:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:14 INFO - 'XPC_FLAGS': '0x0', 16:54:14 INFO - 'XPC_SERVICE_NAME': '0', 16:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:14 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 16:54:14 INFO - Cleaning up... 16:54:14 INFO - Return code: 0 16:54:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:54:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:14 INFO - 'HOME': '/Users/cltbld', 16:54:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:14 INFO - 'LOGNAME': 'cltbld', 16:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:14 INFO - 'MOZ_NO_REMOTE': '1', 16:54:14 INFO - 'NO_EM_RESTART': '1', 16:54:14 INFO - 'PAGER': '/bin/cat', 16:54:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:14 INFO - 'PWD': '/builds/slave/test', 16:54:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:14 INFO - 'SHELL': '/bin/bash', 16:54:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:14 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:14 INFO - 'USER': 'cltbld', 16:54:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:14 INFO - 'XPC_FLAGS': '0x0', 16:54:14 INFO - 'XPC_SERVICE_NAME': '0', 16:54:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:14 INFO - Downloading/unpacking psutil>=3.1.1 16:54:14 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 16:54:14 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 16:54:14 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 16:54:14 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 16:54:14 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 16:54:14 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 16:54:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:18 INFO - Installing collected packages: psutil 16:54:18 INFO - Running setup.py install for psutil 16:54:19 INFO - building 'psutil._psutil_osx' extension 16:54:19 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 16:54:19 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 16:54:19 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 16:54:19 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 16:54:19 INFO - building 'psutil._psutil_posix' extension 16:54:19 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 16:54:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:54:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:54:19 INFO - ^ 16:54:19 INFO - 1 warning generated. 16:54:19 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 16:54:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:20 INFO - Successfully installed psutil 16:54:20 INFO - Cleaning up... 16:54:20 INFO - Return code: 0 16:54:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:54:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:54:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:20 INFO - 'HOME': '/Users/cltbld', 16:54:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:20 INFO - 'LOGNAME': 'cltbld', 16:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:20 INFO - 'MOZ_NO_REMOTE': '1', 16:54:20 INFO - 'NO_EM_RESTART': '1', 16:54:20 INFO - 'PAGER': '/bin/cat', 16:54:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:20 INFO - 'PWD': '/builds/slave/test', 16:54:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:20 INFO - 'SHELL': '/bin/bash', 16:54:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:20 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:20 INFO - 'USER': 'cltbld', 16:54:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:20 INFO - 'XPC_FLAGS': '0x0', 16:54:20 INFO - 'XPC_SERVICE_NAME': '0', 16:54:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54:20 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 16:54:20 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 16:54:20 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 16:54:20 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 16:54:20 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 16:54:20 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 16:54:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:23 INFO - Installing collected packages: mozsystemmonitor 16:54:23 INFO - Running setup.py install for mozsystemmonitor 16:54:23 INFO - Successfully installed mozsystemmonitor 16:54:23 INFO - Cleaning up... 16:54:23 INFO - Return code: 0 16:54:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54:23 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')]} 16:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:23 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')]} 16:54:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:23 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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:23 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 16:54:23 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 16:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:23 INFO - 'HOME': '/Users/cltbld', 16:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:23 INFO - 'LOGNAME': 'cltbld', 16:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:23 INFO - 'MOZ_NO_REMOTE': '1', 16:54:23 INFO - 'NO_EM_RESTART': '1', 16:54:23 INFO - 'PAGER': '/bin/cat', 16:54:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:23 INFO - 'PWD': '/builds/slave/test', 16:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:23 INFO - 'SHELL': '/bin/bash', 16:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:23 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:23 INFO - 'USER': 'cltbld', 16:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:23 INFO - 'XPC_FLAGS': '0x0', 16:54:23 INFO - 'XPC_SERVICE_NAME': '0', 16:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:23 INFO - Downloading/unpacking jsonschema==2.5.1 16:54:23 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 16:54:23 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 16:54:23 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 16:54:23 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 16:54:23 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 16:54:23 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 16:54:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54:26 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 16:54:26 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 16:54:26 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 16:54:26 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 16:54:26 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 16:54:26 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 16:54:26 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:26 INFO - warning: no files found matching '*.txt' 16:54:26 INFO - no previously-included directories found matching 'build' 16:54:26 INFO - no previously-included directories found matching 'dist' 16:54:26 INFO - no previously-included directories found matching '.git*' 16:54:26 INFO - Installing collected packages: jsonschema, functools32 16:54:26 INFO - Running setup.py install for functools32 16:54:27 INFO - warning: no files found matching '*.txt' 16:54:27 INFO - no previously-included directories found matching 'build' 16:54:27 INFO - no previously-included directories found matching 'dist' 16:54:27 INFO - no previously-included directories found matching '.git*' 16:54:27 INFO - Successfully installed jsonschema functools32 16:54:27 INFO - Cleaning up... 16:54:27 INFO - Return code: 0 16:54:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:54:27 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')]} 16:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:27 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')]} 16:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:27 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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:27 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 16:54:27 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 16:54:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:27 INFO - 'HOME': '/Users/cltbld', 16:54:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:27 INFO - 'LOGNAME': 'cltbld', 16:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:27 INFO - 'MOZ_NO_REMOTE': '1', 16:54:27 INFO - 'NO_EM_RESTART': '1', 16:54:27 INFO - 'PAGER': '/bin/cat', 16:54:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:27 INFO - 'PWD': '/builds/slave/test', 16:54:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:27 INFO - 'SHELL': '/bin/bash', 16:54:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:27 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:27 INFO - 'USER': 'cltbld', 16:54:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:27 INFO - 'XPC_FLAGS': '0x0', 16:54:27 INFO - 'XPC_SERVICE_NAME': '0', 16:54:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:54:27 INFO - Cleaning up... 16:54:27 INFO - Return code: 0 16:54:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:27 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')]} 16:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:27 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')]} 16:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:27 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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:27 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 16:54:27 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 16:54:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:27 INFO - 'HOME': '/Users/cltbld', 16:54:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:27 INFO - 'LOGNAME': 'cltbld', 16:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:27 INFO - 'MOZ_NO_REMOTE': '1', 16:54:27 INFO - 'NO_EM_RESTART': '1', 16:54:27 INFO - 'PAGER': '/bin/cat', 16:54:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:27 INFO - 'PWD': '/builds/slave/test', 16:54:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:27 INFO - 'SHELL': '/bin/bash', 16:54:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:27 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:27 INFO - 'USER': 'cltbld', 16:54:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:27 INFO - 'XPC_FLAGS': '0x0', 16:54:27 INFO - 'XPC_SERVICE_NAME': '0', 16:54:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:27 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:27 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 16:54:27 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 16:54:27 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 16:54:27 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 16:54:27 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 16:54:27 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 16:54:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:31 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 16:54:31 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 16:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:31 INFO - Downloading docopt-0.6.1.tar.gz 16:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:31 INFO - Running setup.py install for blobuploader 16:54:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:31 INFO - Running setup.py install for requests 16:54:32 INFO - Running setup.py install for docopt 16:54:32 INFO - Successfully installed blobuploader requests docopt 16:54:32 INFO - Cleaning up... 16:54:32 INFO - Return code: 0 16:54:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:32 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')]} 16:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:32 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')]} 16:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:32 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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:32 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 16:54:32 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 16:54:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:32 INFO - 'HOME': '/Users/cltbld', 16:54:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:32 INFO - 'LOGNAME': 'cltbld', 16:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:32 INFO - 'MOZ_NO_REMOTE': '1', 16:54:32 INFO - 'NO_EM_RESTART': '1', 16:54:32 INFO - 'PAGER': '/bin/cat', 16:54:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:32 INFO - 'PWD': '/builds/slave/test', 16:54:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:32 INFO - 'SHELL': '/bin/bash', 16:54:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:32 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:32 INFO - 'USER': 'cltbld', 16:54:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:32 INFO - 'XPC_FLAGS': '0x0', 16:54:32 INFO - 'XPC_SERVICE_NAME': '0', 16:54:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-XzoEPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ekJU1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Dr376b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Lq7JEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-TvaA5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-aIPPnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-hzeMQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ROYAHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JyFHSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-BONjyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-fvLKF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-weT4Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-tEJXr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-h1HusO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4L42x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wfBeNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:34 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-YpnVxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:34 INFO - Running setup.py install for manifestparser 16:54:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:34 INFO - Running setup.py install for mozcrash 16:54:35 INFO - Running setup.py install for mozdebug 16:54:35 INFO - Running setup.py install for mozdevice 16:54:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozfile 16:54:35 INFO - Running setup.py install for mozhttpd 16:54:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozinfo 16:54:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozInstall 16:54:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:35 INFO - Running setup.py install for mozleak 16:54:36 INFO - Running setup.py install for mozlog 16:54:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for moznetwork 16:54:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozprocess 16:54:36 INFO - Running setup.py install for mozprofile 16:54:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozrunner 16:54:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:36 INFO - Running setup.py install for mozscreenshot 16:54:37 INFO - Running setup.py install for moztest 16:54:37 INFO - Running setup.py install for mozversion 16:54:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:37 INFO - Cleaning up... 16:54:37 INFO - Return code: 0 16:54:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:37 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')]} 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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')]} 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:37 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 16:54:37 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 16:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:37 INFO - 'HOME': '/Users/cltbld', 16:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:37 INFO - 'LOGNAME': 'cltbld', 16:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:37 INFO - 'MOZ_NO_REMOTE': '1', 16:54:37 INFO - 'NO_EM_RESTART': '1', 16:54:37 INFO - 'PAGER': '/bin/cat', 16:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:37 INFO - 'PWD': '/builds/slave/test', 16:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:37 INFO - 'SHELL': '/bin/bash', 16:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:37 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:37 INFO - 'USER': 'cltbld', 16:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:37 INFO - 'XPC_FLAGS': '0x0', 16:54:37 INFO - 'XPC_SERVICE_NAME': '0', 16:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JN7keN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-cfHmJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zXJnQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:37 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)) 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:37 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-nXHMC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-icGMkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-m8JqyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-KBf1uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-CVzGFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xTR6IA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zD6a_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-402yEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-2l5aot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:38 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)) 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:38 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-4pNdpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kKwp8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-RAq7yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-JvPr1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:39 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)) 16:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:39 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Qf63Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 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)) 16:54:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:39 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 16:54:39 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 16:54:39 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 16:54:39 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 16:54:39 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 16:54:39 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 16:54:42 INFO - Downloading blessings-1.6.tar.gz 16:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:42 INFO - Installing collected packages: blessings 16:54:42 INFO - Running setup.py install for blessings 16:54:42 INFO - Successfully installed blessings 16:54:42 INFO - Cleaning up... 16:54:42 INFO - Return code: 0 16:54:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:42 INFO - Reading from file tmpfile_stdout 16:54:42 INFO - Current package versions: 16:54:42 INFO - blessings == 1.6 16:54:42 INFO - blobuploader == 1.2.4 16:54:42 INFO - docopt == 0.6.1 16:54:42 INFO - functools32 == 3.2.3-2 16:54:42 INFO - jsonschema == 2.5.1 16:54:42 INFO - manifestparser == 1.1 16:54:42 INFO - mozInstall == 1.12 16:54:42 INFO - mozcrash == 1.0 16:54:42 INFO - mozdebug == 0.1 16:54:42 INFO - mozdevice == 0.49 16:54:42 INFO - mozfile == 1.2 16:54:42 INFO - mozhttpd == 0.7 16:54:42 INFO - mozinfo == 0.9 16:54:42 INFO - mozleak == 0.1 16:54:42 INFO - mozlog == 3.4 16:54:42 INFO - moznetwork == 0.27 16:54:42 INFO - mozprocess == 0.24 16:54:42 INFO - mozprofile == 0.28 16:54:42 INFO - mozrunner == 6.13 16:54:42 INFO - mozscreenshot == 0.1 16:54:42 INFO - mozsystemmonitor == 0.3 16:54:42 INFO - moztest == 0.8 16:54:42 INFO - mozversion == 1.4 16:54:42 INFO - psutil == 3.1.1 16:54:42 INFO - requests == 1.2.3 16:54:42 INFO - wsgiref == 0.1.2 16:54:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:42 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')]} 16:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:42 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')]} 16:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 16:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 16:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:42 INFO - 'HOME': '/Users/cltbld', 16:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:42 INFO - 'LOGNAME': 'cltbld', 16:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:42 INFO - 'MOZ_NO_REMOTE': '1', 16:54:42 INFO - 'NO_EM_RESTART': '1', 16:54:42 INFO - 'PAGER': '/bin/cat', 16:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:42 INFO - 'PWD': '/builds/slave/test', 16:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:42 INFO - 'SHELL': '/bin/bash', 16:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:42 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:42 INFO - 'USER': 'cltbld', 16:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:42 INFO - 'XPC_FLAGS': '0x0', 16:54:42 INFO - 'XPC_SERVICE_NAME': '0', 16:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 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)) 16:54:42 INFO - Cleaning up... 16:54:43 INFO - Return code: 0 16:54:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54:43 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')]} 16:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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')]} 16:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:43 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 0x10a853b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a856768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbb85cd940>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, '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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 16:54:43 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 16:54:43 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 16:54:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:54:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:43 INFO - 'HOME': '/Users/cltbld', 16:54:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:43 INFO - 'LOGNAME': 'cltbld', 16:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:43 INFO - 'MOZ_NO_REMOTE': '1', 16:54:43 INFO - 'NO_EM_RESTART': '1', 16:54:43 INFO - 'PAGER': '/bin/cat', 16:54:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:43 INFO - 'PWD': '/builds/slave/test', 16:54:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:43 INFO - 'SHELL': '/bin/bash', 16:54:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:54:43 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:54:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:43 INFO - 'USER': 'cltbld', 16:54:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:43 INFO - 'XPC_FLAGS': '0x0', 16:54:43 INFO - 'XPC_SERVICE_NAME': '0', 16:54:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:54:43 INFO - Cleaning up... 16:54:43 INFO - Return code: 0 16:54:43 INFO - Running post-action listener: _resource_record_post_action 16:54:43 INFO - Running post-action listener: _start_resource_monitoring 16:54:43 INFO - Starting resource monitoring. 16:54:43 INFO - [mozharness: 2017-03-01 00:54:43.304597Z] Finished create-virtualenv step (success) 16:54:43 INFO - [mozharness: 2017-03-01 00:54:43.305562Z] Running install step. 16:54:43 INFO - Running pre-action listener: _resource_record_pre_action 16:54:43 INFO - Running main action method: install 16:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:43 INFO - Reading from file tmpfile_stdout 16:54:43 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:43 INFO - Reading from file tmpfile_stdout 16:54:43 INFO - Output received: 16:54:43 INFO - Usage: mozinstall [options] installer 16:54:43 INFO - Options: 16:54:43 INFO - -h, --help show this help message and exit 16:54:43 INFO - -d DEST, --destination=DEST 16:54:43 INFO - Directory to install application into. [default: 16:54:43 INFO - "/builds/slave/test"] 16:54:43 INFO - --app=APP Application being installed. [default: firefox] 16:54:43 INFO - mkdir: /builds/slave/test/build/application 16:54:43 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'] 16:54:43 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 16:55:03 INFO - Reading from file tmpfile_stdout 16:55:03 INFO - Output received: 16:55:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:55:03 INFO - Running post-action listener: _resource_record_post_action 16:55:03 INFO - [mozharness: 2017-03-01 00:55:03.894392Z] Finished install step (success) 16:55:03 INFO - [mozharness: 2017-03-01 00:55:03.894517Z] Running run-tests step. 16:55:03 INFO - Running pre-action listener: _resource_record_pre_action 16:55:03 INFO - Running main action method: run_tests 16:55:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:03 INFO - 2017-02-28 16:55:03.908 screenresolution[1631:7633] starting screenresolution argv=screenresolution get 16:55:03 INFO - 2017-02-28 16:55:03.911 screenresolution[1631:7633] Display 0: 1600x1200x32@60 16:55:03 INFO - 2017-02-28 16:55:03.916 screenresolution[1632:7635] starting screenresolution argv=screenresolution list 16:55:03 INFO - Available Modes on Display 0 16:55:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:04 INFO - Intel Iris: 16:55:04 INFO - Chipset Model: Intel Iris 16:55:04 INFO - Type: GPU 16:55:04 INFO - Bus: Built-In 16:55:04 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:04 INFO - Vendor: Intel (0x8086) 16:55:04 INFO - Device ID: 0x0a2e 16:55:04 INFO - Revision ID: 0x0009 16:55:04 INFO - Displays: 16:55:04 INFO - Display: 16:55:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:04 INFO - Display Serial Number: 1600x1200 60 16:55:04 INFO - Main Display: Yes 16:55:04 INFO - Mirror: Off 16:55:04 INFO - Online: Yes 16:55:04 INFO - Rotation: Supported 16:55:04 INFO - Return code: 0 16:55:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:04 INFO - Python 2.7.3 16:55:04 INFO - Return code: 0 16:55:04 INFO - grabbing minidump binary from tooltool 16:55:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:04 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 0x10a631d30>, '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 0x10a558db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a626be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:04 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 16:55:04 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 16:55:04 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 16:55:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:04 INFO - Return code: 0 16:55:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:55:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:55:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:04 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/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 16:55:04 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/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 16:55:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.a7KcGW8ulP/Render', 16:55:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:04 INFO - 'HOME': '/Users/cltbld', 16:55:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:04 INFO - 'LOGNAME': 'cltbld', 16:55:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:55:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:04 INFO - 'MOZ_NO_REMOTE': '1', 16:55:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:04 INFO - 'NO_EM_RESTART': '1', 16:55:04 INFO - 'PAGER': '/bin/cat', 16:55:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:04 INFO - 'PWD': '/builds/slave/test', 16:55:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:04 INFO - 'SHELL': '/bin/bash', 16:55:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SD2nFzmbbK/Listeners', 16:55:04 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 16:55:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:04 INFO - 'USER': 'cltbld', 16:55:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:04 INFO - 'XPC_FLAGS': '0x0', 16:55:04 INFO - 'XPC_SERVICE_NAME': '0', 16:55:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:04 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/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 16:55:04 INFO - mozversion application_buildid: 20170228153103 16:55:04 INFO - mozversion application_changeset: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 16:55:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:55:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:04 INFO - mozversion application_name: Firefox 16:55:04 INFO - mozversion application_remotingname: firefox-dev 16:55:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:04 INFO - mozversion application_vendor: Mozilla 16:55:04 INFO - mozversion application_version: 53.0a2 16:55:04 INFO - mozversion platform_buildid: 20170228153103 16:55:04 INFO - mozversion platform_changeset: 397bf222b4d46cdac5fb4c2531cdc9d11f0a96f4 16:55:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:55:04 INFO - mozversion platform_version: 53.0a2 16:55:04 INFO - using testdate: 1488329704 16:55:04 INFO - actual date: 1488329704 16:55:04 INFO - starting webserver on 'localhost:49249' 16:55:04 INFO - SUITE-START | Running 2 tests 16:55:04 INFO - TEST-START | dromaeo_css 16:55:04 INFO - operating with platform_type : mac_ 16:55:04 INFO - Initialising browser for dromaeo_css test... 16:55:04 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpnL3c_x/profile http://localhost:49249/getInfo.html) 16:55:06 INFO - PROCESS | 1642 | __metrics Screen width/height:1600/1200 16:55:06 INFO - PROCESS | 1642 | colorDepth:24 16:55:06 INFO - PROCESS | 1642 | Browser inner width/height: 1024/689 16:55:06 INFO - PROCESS | 1642 | __metrics 16:55:07 INFO - PROCESS | 1642 | 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" 16:55:07 INFO - PROCESS | 1642 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:07 INFO - TEST-INFO | 1642: exit 0 16:55:07 INFO - Browser initialized. 16:55:07 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:07 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpnL3c_x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:19 INFO - PROCESS | 1644 | RSS: Main: 212926464 16:55:19 INFO - PROCESS | 1644 | 16:58:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 16:58:25 INFO - PROCESS | 1644 | RSS: Main: 372256768 16:58:25 INFO - PROCESS | 1644 | 17:00:09 INFO - PROCESS | 1644 | ************************* 17:00:09 INFO - PROCESS | 1644 | A coding exception was thrown and uncaught in a Task. 17:00:09 INFO - PROCESS | 1644 | 17:00:09 ERROR - PROCESS | 1644 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:00:09 INFO - PROCESS | 1644 | Full stack: 17:00:09 INFO - PROCESS | 1644 | ************************* 17:01:28 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 17:01:28 INFO - PROCESS | 1644 | RSS: Main: 353628160 17:01:28 INFO - PROCESS | 1644 | 17:04:31 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 17:04:31 INFO - PROCESS | 1644 | RSS: Main: 321466368 17:04:31 INFO - PROCESS | 1644 | 17:07:34 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 17:07:34 INFO - PROCESS | 1644 | RSS: Main: 330874880 17:07:34 INFO - PROCESS | 1644 | 17:10:38 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 17:10:38 INFO - PROCESS | 1644 | RSS: Main: 312459264 17:10:38 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 17:13:42 INFO - PROCESS | 1644 | RSS: Main: 363253760 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | __start_tp_report 17:13:42 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 17:13:42 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 17:13:42 INFO - PROCESS | 1644 | |i|pagename|runs| 17:13:42 INFO - PROCESS | 1644 | |0;dojo.html;3327.0351598036564;3341.8329083545823;3354.4129777288967;3377;3414;5605.607607467479;5650.830475085749;5656.406077361879;5674.744636491358;5684.573656975733;5613.129964855444;5678.205051292823;5686.9146962795485;5687.601867869251;5691.743871525781;5139.331886854713;5189.636725429222;5202.167653175493;5219.034478621467;5249.973750131244;4535.160995215879;5015.871428928498;5171.250168725533;5269.8946021079555;5274.498922602346;5202.271681964528;5230.503102205284;5231.947680523203;5269.499397557226;5321.920171197435;5279.340082489689;5280.445553216895;5282.26048353227;5289.338832645919;5297.920531192035;5102.795888164469;5136.768845401966;5240.082985477527;5245.606579506552;5267.26258323835;5561.332640083216;5597.160425936101;5690.174924635905;5711.314642242916;5719.170720245541;6250;6291.465225455841;6296.96851515744;6297;6310.432061114476;5160.819371321985;6311.589746666498;6320.683965801692;6341.080543321239;6352.523560732963;5706.087026075808;5769.85575360611;5859.677717725481;5883.205767221413;5941.970290148565;6220.720067596969;6257.7184026718905;6262.12330273762;6292.339304373067;6303.9684801575695;6190.102435146879;6194.938050619527;6211.254649442096;6214.658193799384;6222.502199824004;6177.722002509808;6315.778947736807;6320.399562041599;6321.747130114836;6328.050792381179;6097.298810636745;6115.949241104752;6135.398101970402;6143.082036032849;6198.442140207313;6247.937520624827;6263.937360626426;6284.528660350401;6288.968555157195;6294.370562943761;4995.000999800054;5028.698278103252;5037.647364684511;5043.5460808527405;5059.56993655536;4441.289393696993;4449.599536041772;4453.554644535585;4484.2376795944765;4527.660425468103;5719.2279042328755;5756.597038207286;5770.105633626795;5795.391483894215;5795.478406943395;5619.578531610146;5837.591368604157;6243.937560624336;6325.620462772156;6331.145295385064;4300.8709738707885;5688.23208866806;5732.455416735404;5740.770369185186;5749.310082790092;5394.78420863161;5455.990641731292;5456.154296084113;5457.645253058538;5461.290032295776;6243.625382477066;6298.685065746694;6306.716197771111;6308.179936608211;6310.116583678288;5248.317718696545;6237.5009999200865;6303.495720342454;6318.399752023551;6329.050642403677;6266;6362.650054246876;6363.90454143179;6378.840528986812;6380.617162970237;6098.481629061579;6107.3405344170405;6186.938130618816;6220.813375598739;6284.151639528605;6329.7468101275435;6330.240371155491;6334.4932405406535;6342.365763423621;6347.809565713036;5799.072148456226;5950.107483877453;6024.216851809237;6189.164462797465;6194.5973511721595;6063.605865618721;6082.756689732361;6105.877882442237;6145.66198859067;6155.169052178077;5970.940290597038;5973.044312909914;5993.310769261417;5993.940060599338;5994.55040871945;5661.377248502579;5979.940200597938;6192.009278515416;6211.2857021443115;6216.937830621636;4845.297431872288;4899.779509921991;5939.16851640762;5958.404159584007;6067.453929146398 17:13:42 INFO - PROCESS | 1644 | |1;ext.html;454.01478791023476;492.2689805638626;502.04110149614246;515.8349328214971;516.6022162934539;30821.691783082162;39469.80265098674;41657.16685666285;41827.79086104573;42004.369934450966;42283;42773.57226427735;42814.357784633256;42836;42843;9208.309376796733;9423.434593924352;9430.29272804539;9447.385919915183;9448.338616296827;8329.83340333193;8556.144385561456;11164.106871450265;11411;11426.37154956477;11415.429228538582;11420.885791142107;11469.942650286737;11475.426228688573;11475.598354057609;11319.151063670175;11371.204015718902;11445.370504622242;11452.427378631119;11480.598179063734;8238.629261683238;8442.197991190827;10592.728872535345;10986.450677466175;11255.943720281428;34307.656923430695;40823.77528674115;40856.570020049454;40857;40918.590814091775;3743.756655817363;3829.9617003830163;3997.160596274786;4055.8643579797704;4073.4500842386196;27120.1863944082;27579.724202757916;27765.444691106066;28607.713922860923;29205.561916571267;3111.2532992081965;3208;3237.7247933925646;3240.141362538929;3300.5709257796575;444394;463922;467081;467735;467796.66101669276;55886;56240.15639765407;56384.71807640936;56389.43610563924;56425.43574564284;58981.70509147512;59057.40942590605;59098.56760742961;59114.70442647759;59137.40862591319;14607.92696036513;15110.244487775568;15137.243137843065;15168.165750883807;15228.619284517976;10471.371717696962;11442.771144577227;11497.712557186138;11516.021138203347;11587.478563464665;15443.30505127272;15867.285972131282;17937.820621793617;18367.72448413275;18391.54021149482;6447.871042579122;8022.438429309892;8039.2764651180505;8098.797530061795;8182.918170818335;858.4806192253722;872.1583671756786;890.0787684746257;895.1809094678426;922.2253307221965;29911.55132672968;29972;30032.399352013275;30420;30444;1064.2390690656218;1102.9172812039128;1103.3931337764197;1106.9003789658968;1122.8154297216515;15193.392264309305;15685.294161762748;15697.058176509447;15760.975536590315;16008.03951762898;604937;604963;605545;606013;608948;58922;59615.80768384608;59652.70173649104;59810;59902.70048649816;1236.7402845402387;1457.6574504991318;1471.0805746408494;1475.7417451945867;1489.6946126044136;28604;29012.274693131996;29154.271143221587;29842.70157298399;30015.54976675308;49058.75470622624;49762.25356619581;50389.49610503994;50420;50433.99132017266;396555.017224912;398423;398559.0072049737;398755;398797;26038.60942085908;26066.087686930867;26071.696415179544;26273.605895911194;26655;38705.03237419087;39377.818665440085;40181;46196.76901615471;46714.83212919568;35748.4637730429;38082;38201.4269785959;39519;40064.99837504086;32286;37481.188910832345;37495;37716.05709857275;38847.805760971016;37501.43747843839;37513.624863752106;38098.42852357272;38445.4233186508;38630.4205436913;30734;32454.83772581122;33750.95934375876;34523.13692157716;34771.82614086913;24910.626340604544;25243.99024039018;25304.873475632503;25320.969332364104;25766.742332577185 17:13:42 INFO - PROCESS | 1644 | |2;jquery.html;309.45844771649615;388.48913678512736;396.7262588813719;408.83033541080454;421.3195688962327;14456.783148252785;15308.387664493406;19099.94950277734;20988.26541071063;21339;16979;20950.26674066408;20956.847373394456;21399.786002139976;21679;5790.536757059435;5901.645901245939;5960.374160713128;6044.2746870375395;6070.453659170674;5888.352281249059;6085.847853803646;6086.026235802273;6090.086487026937;6091.51267898567;4197.538270790211;4412.933805992912;6030.396960303979;6679.899801502981;6686.83282917926;5753.741081651336;6748;6763.222229443579;6765.458763298924;6769.8646027079185;5864.648121112747;5997.22036135304;6016.217891674098;6016.518678505709;6016.639001659914;13236.205827650372;17322.82677173225;18955.526111847175;25798.87100564485;25799.968001279925;2624.6719160104985;2630.8684565771637;2631.460550587125;2657.1497120921313;2745.5226822489262;9898.05968433005;10013.79972400548;10100.191984641211;10521.000504952017;10560.313579617301;1808.8733788634802;1847.6858933981255;1853.9814601853943;1855.053922499535;1856.340998945382;138902;141252;146023;148750;149607.25196374056;9838.803223935623;11786.823197652042;11882;12001.939990299992;12188.085893557842;15795.605109872346;15822.446214382442;15851.048937063813;15857.365705371887;15876.92061539708;7011.649417529103;8264.958675206586;8370.079291277954;8552.786180345542;8662.6101825418;8004.719834805754;8224.876626850602;8246.340292776564;8358.665653373919;8390.664373425117;4729.314249433882;4731.810727570927;4732.2428411454;4733.857984260478;4813.278008298713;1746.6768647800197;1996.4110587376758;2045.2534824789143;2049.272508259576;2058.6191554562156;997.4464172384396;1013.2400699475394;1015.4922538730634;1028.711960651019;1034.818906691341;20740.377788666363;21183.576328473344;21211.575768484854;21351.46621334448;21603.35189944304;858.579296144897;885.406777459104;905.6920646980059;912.0924679943498;927.9536023198813;5787.276590426197;6778.796636100925;6835.555688880307;6940.514164008572;6972.965135174393;613387;694931;756051;765264;800665;156009;156959;158300;159359.17033839892;164128;862.2584577263674;1050.6795427394718;1068.1454836131063;1070.577122036791;1081.091882818452;15769.605759856095;18849.24603015864;19232.519187020436;19815.108320125917;19860.415567347925;41728;58681.70659146677;60372.076806215526;60503.69748151231;60918;68610.65694671495;79577.8063329039;80697.59651201706;83725.58137209275;90292.5485372569;8223.259906608433;8356.164383561596;8390.538520381439;8414.957925210334;8552.80260763506;13014.544490942772;13292.534761283308;13461.596152115451;13556.322183890963;13747;11217.831732523855;11320.433978300887;11455.770884582094;11737.589184378507;11826;11272.83090753623;11413.60052398162;11506.654800356002;11921.165518413627;11946;11295;11803.645890623295;11821.822672659744;11968.820467692818;12053.819192712292;7165.319294666998;7398.96300518494;7534.0582427196605;8143.633536490991;8475.110113438;8108;9142.908570914205;9802.65690700822;11431.256968297033;11748.765024699629 17:13:42 INFO - PROCESS | 1644 | |3;mootools.html;1307.653117289192;1390.2562129260841;1406.5499040307106;1411.6118067531427;1416.9149851008938;8082.474639148451;8490.702825401113;8516.361272904534;8546.40175187737;8565.271951884082;6673.899891501631;7474.476786624925;7728.845423091535;7751.806204844882;8172.2236387543235;2337.8947947342367;2366.408397900525;2366.8698221597806;2376.809855211579;2380.000399832075;2084.1871670048695;2263.864168149908;2311.3759284993043;2338;2343.320437073247;2075.8339332853334;2148.9355319340443;2260.7174103237094;2319.617263151578;2336.2290444153473;2323.5004474038165;2327.627579587266;2330.2193765088714;2338.275134708246;2340.180936672168;2290.6564015397657;2332.3935776698013;2374.786269235777;2378.9048438062628;2378.9167379141645;8413.537255450949;8491.74524764258;8499.575021248913;8507.319414446829;8522.82954340916;5049;5212.478752124795;5214.270002199695;5216.113260745645;5224.03355379256;3316.502524621302;3444.5522082129414;3461.44616861301;3486.267883744417;3497.510348551205;985.7042887133831;1124.7019539821954;1206.009097438349;1216.6714986953473;1224.1492162946756;10947.014768670779;11094.944525277322;11103.777924441465;11121.777564448746;11138.443077846156;3968.3849003404516;4646.581807637329;4758.857234282977;4765.73788441639;4794.376731024944;9605.279604029585;9626.085521875411;9630.759231019141;9631.133198012212;9634.325597208268;5277.050130976384;5281.630285880028;5287.629865909349;5291.444398338196;5303.761330740126;4082.9387559186634;4292.720973136736;4443.000324926866;4716.481187069419;4747.548982846624;3905.37513997759;3909.944315034925;4007.5391329997424;4032.1734044520804;4067.593240675968;1084.414416215235;1300.5318085489216;1301.219268438929;1312.835895513061;1313.159577870164;869.4609342207746;874.9343799215085;877.8405123396516;884.3190743127884;887.2547060469108;5490.945090549043;5493.862653433696;5578.693171875586;5767.769289228384;5822.475977161991;898.8090779716902;934.528118213816;956.9521523923916;984.3109823123842;996.0686757881404;3678.374676304981;3793.317202903504;3802.1825307559006;3802.8288727007352;3950.7827069511454;8021.759347219593;9905.455199964072;10231.488425578691;10266.076053155251;10270.743231419274;9922.255830812717;10187.453136715822;10207;10207.7448063799;10235.283530152818;6699.129113215251;7797.571133587707;7864.882026769603;7939.880901786478;7951.880721789178;4179.937300940549;4839.782209800497;5296.590051526469;5388.973055134699;5565.1374037024325;8076.798080047811;9163;9324.860127097963;9420.62317507292;9472.763180920256;9307.581158847732;9312.674056407994;9553.235741140554;9688.079632434907;9695.515224238901;6377.266614339411;6558.081868538313;6562.573432726857;6725.327467253432;6904.516683832084;7816.296533312029;8036.116027237116;8071.596420179085;8141.7964550884335;8152.388570857328;7074.752383666547;7221.891671624825;7237.203907570269;7289.416846652149;7328.5969271690565;7030.718771249093;7059.258777828254;7075.257098004636;7093.3970612498515;7192.172900116553;6355.586886852339;6488;6495.675216239264;6500.122483464672;6509.837254068686;4288.571142885687;4930.013997200646;5093.668911520739;5099.184130539096;5104.438511763628;3753.680937120266;4973.477784832685;4979.701217926936;4991.50084991498;5158.742062896915 17:13:42 INFO - PROCESS | 1644 | |4;prototype.html;354.88288864674644;356.95181150544676;368.78057555754333;373.52935301520074;374.130147407278;4791.592714619262;4814.807407703687;5201.375834899813;5311;5323.361196656397;4853.7815798289075;5040.949590504103;5045.167547354691;5119.926429795929;5214.582833373331;3466.341395134929;3532.5231093802263;3879.476270703461;4131.8347266109395;4168.937465938014;3228.674465300732;4172.186423647375;4178.6448151907125;4187.895302617429;4208.326667733163;3734.514513113305;3926.3128952433353;4124.628783409493;4126.257273690734;4153.605407486299;3366.612839523462;3704.944090934071;3956.268090403256;4082.83668653252;4083.4079058536495;3630.909227269313;3644.487537671863;3646.507721457596;3652.6164752700847;3653.2328211075705;4394.318880573484;4644.303354496818;4905.386826646669;5009.749512524396;5087.847364579068;4311.892202694927;4497.527759585229;4656.4877863434995;4719.929201061953;4741.933065060368;4240.872773816791;5518.641288316287;5549.058998730679;5550.944490555084;5574.414686457904;3704.407294832814;3925.21495700861;3931.253061918255;3996.780177090259;4047.797610119482;4490.973440799442;4763.54746299101;5598.608097433182;5699.401562835884;5719.568259044581;3858.903527411781;3872.934942890671;4093.119979204426;4096.446979657768;4126.42230087788;4151.086760912594;4161.521425036099;4185.58144185579;4186.016286172747;4197.160567886435;4249.6387807036745;4531.977340113278;4567.657425693086;4581.717119206627;4743.003969166445;4959.908820059582;5586.636868603528;5598.272224610774;5601.719914004283;5614.382417934024;1156.4160099150045;1187.4003628167893;1268.6805722048966;1273.5224290890917;1275.7257189704073;749.9687929097491;817.5666896544841;819.8726750717763;858.4806192253596;864.7059999600166;4882.389701287339;4905.337779399735;4912.557869791736;4926.211806111077;5009.7495125243595;4489.685721999429;4967.925481117786;5351.518363347317;5497.26836046644;5509.862253443696;4000.939750965996;4632.675712700146;4715.618612600683;4764.285357196379;5144.61415393847;2669.2526092694075;2775.6114144019853;2900.303927057491;2907.200519857014;2916.3292442737866;5619.831405057855;5729.799457018984;5734.222391058785;5735.053716136874;5746.454086861741;5396.4873337033705;5627.352854421712;5864.827034593013;5893.823185304448;5918;4957.107720610325;5168;5366.91949620756;5918.307170237532;5922.289325280994;5531.806386776443;5623.3814280428305;5665.915011274917;5747.885042299047;5755.884882302415;5589.552835773047;5622.803201887914;5649.3220813501;5659.660420374791;5704.629199102045;5116.720819795051;5147;5821.534277257724;5871.001929671881;5898.705064746831;3627.528421305213;3818.6945044395825;3885.1258466844733;4124.237016152021;4175.6868234881895;4225.471816022997;5499.395066542597;5685.516731077904;5687.724910035853;5752.913706294493;4275.593818587229;4530;4797.520247975174;4854.975725121351;5447.291852059207;4487.125010622897;5389.556547886741;5461.34463864323;5526.944730552643;5565.944340556543;5395.757190926339;5417.377001644703;5452.809151679672;5453.563714902719;5481.945180548143;5264.604055613606;5312.4156342803035;5428.430014848542;5529.668219906818;5546.916796248141;4942.220800511741;5020.945601423742;5402.730853041653;5443.067710962551;5451.618386712892 17:13:42 INFO - PROCESS | 1644 | |5;yui.html;645.6997496164284;663.2969052804032;668.191488299158;743.9696021010898;747.6971826410303;14716.411343546259;15197.924010379946;15777.684446311066;15782.60543486412;15786.605334866634;14118.223497707622;14282.857171428308;14402.207878566674;14465.63835904103;14576.052556583814;850.9404341696069;860.0195776814405;861.7070196133313;861.7199410191681;866.536403024382;672.9798106056802;695.1102588686464;862.8446879561676;863.3524856357732;870.316801310971;729.0813574895617;874.7813046738315;905.9365844390895;911.9785839859367;917.9908200918005;900.8108297257584;902.2285945516554;904.1771987491417;904.868794024866;908.1780988205718;524.6117872774158;674.1303718203511;674.8852695041854;677.4275737002274;679.9558028728117;11381.829272560835;12619.684507887285;12631.242125472409;12657.493700251978;14511;13593.524226652118;14053.578392648236;14109.012369134165;14190.503332383318;14222.288885555681;10611.893881061167;10669.466526673636;10928.344299341985;10993.780124397546;11002.284851484628;3554.73339499536;3577.266660334651;3746.737728359016;3747.1006958329804;3825.6939444844347;99548;102644.48677756639;106865;107824;107856;10189.54147063384;10370;10624.78750424987;10718.892811071946;10771.138308935266;23218.187363442536;23646.88176559106;23648.290551283488;23695.28914132579;23710.288691339287;7603.125640551297;7624.636362727461;7687.5387476751575;7774.689012439552;7910.248526389983;4091.815868285875;4203.159368126387;4270.274053410928;4328.026194106301;4367.978160109179;3450.9654903451146;3509.7543171978227;3543.5039094526787;3552.289542091592;3567.839447224881;495.9652824302264;579.0503574138417;591.1369400674977;599.9291265091878;602.3645054467491;629.8771739510843;655.4723447624613;662.3608218069586;666.7533012785301;669.2303850571881;9313.254939604816;9797;9811.362261452983;9985.650502232387;10075.244356673278;626.9122322874802;628.1888548744423;653.8463461086641;667.0694381338103;689.837888096297;4517.570830771071;4626.676132670681;4645.790939407735;4655.740981313094;4722.811087556528;95258;100249.49875250577;101425;101555;102164.48917755364;84228.57885710533;87244;87324;87792.5610371944;89965.55017224872;78235.60882195552;80265;80766;81667;83375.58312208521;8909.866352004596;8945.19493245611;9013.684521041994;9024.337820343146;9110.635574577207;53074;53118.203226950856;54514.397023199424;54744;55224.72387638036;53481.465185347646;71033.28966710267;72073.27926720666;72270.27729722846;72354.27645723475;10924.836127458253;10963.287386319864;11152.107831373309;11238.887611123784;11658.300501969909;11914.880851191378;12049.939750301193;12159.148859579744;12194.329311887932;12635.431405586587;11269.830952535882;11299;11810.645680629596;11853.5851245206;12213;11349.602763903224;11674;11693.707657308636;11822.9309870774;11833.70415739579;10734.624288149877;11058.557657693602;11169.72075698114;11176.385298808644;11655.650330490098;9252;9707.757306067404;9853.310268281439;10009.899901001188;10157.949210254197;8753.431026983226;9021.819563608822;9210.907890921273;9333.479303721077;9439.433633981984 17:13:42 INFO - PROCESS | 1644 | __end_tp_report 17:13:42 INFO - PROCESS | 1644 | __start_cc_report 17:13:42 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1588 17:13:42 INFO - PROCESS | 1644 | __end_cc_report 17:13:42 INFO - PROCESS | 1644 | __startTimestamp1488330822502__endTimestamp 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | ------- Summary: start ------- 17:13:42 INFO - PROCESS | 1644 | Number of tests: 6 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5725.24 Median:5939.17 stddev:660.38 (11.1%) stddev-sans-first:635.05 17:13:42 INFO - PROCESS | 1644 | Values: 3327.0 3341.8 3354.4 3377.0 3414.0 5605.6 5650.8 5656.4 5674.7 5684.6 5613.1 5678.2 5686.9 5687.6 5691.7 5139.3 5189.6 5202.2 5219.0 5250.0 4535.2 5015.9 5171.3 5269.9 5274.5 5202.3 5230.5 5231.9 5269.5 5321.9 5279.3 5280.4 5282.3 5289.3 5297.9 5102.8 5136.8 5240.1 5245.6 5267.3 5561.3 5597.2 5690.2 5711.3 5719.2 6250.0 6291.5 6297.0 6297.0 6310.4 5160.8 6311.6 6320.7 6341.1 6352.5 5706.1 5769.9 5859.7 5883.2 5942.0 6220.7 6257.7 6262.1 6292.3 6304.0 6190.1 6194.9 6211.3 6214.7 6222.5 6177.7 6315.8 6320.4 6321.7 6328.1 6097.3 6115.9 6135.4 6143.1 6198.4 6247.9 6263.9 6284.5 6289.0 6294.4 4995.0 5028.7 5037.6 5043.5 5059.6 4441.3 4449.6 4453.6 4484.2 4527.7 5719.2 5756.6 5770.1 5795.4 5795.5 5619.6 5837.6 6243.9 6325.6 6331.1 4300.9 5688.2 5732.5 5740.8 5749.3 5394.8 5456.0 5456.2 5457.6 5461.3 6243.6 6298.7 6306.7 6308.2 6310.1 5248.3 6237.5 6303.5 6318.4 6329.1 6266.0 6362.7 6363.9 6378.8 6380.6 6098.5 6107.3 6186.9 6220.8 6284.2 6329.7 6330.2 6334.5 6342.4 6347.8 5799.1 5950.1 6024.2 6189.2 6194.6 6063.6 6082.8 6105.9 6145.7 6155.2 5970.9 5973.0 5993.3 5993.9 5994.6 5661.4 5979.9 6192.0 6211.3 6216.9 4845.3 4899.8 5939.2 5958.4 6067.5 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:63080.72 Median:37899.03 stddev:132300.57 (349.1%) stddev-sans-first:132588.15 17:13:42 INFO - PROCESS | 1644 | Values: 454.0 492.3 502.0 515.8 516.6 30821.7 39469.8 41657.2 41827.8 42004.4 42283.0 42773.6 42814.4 42836.0 42843.0 9208.3 9423.4 9430.3 9447.4 9448.3 8329.8 8556.1 11164.1 11411.0 11426.4 11415.4 11420.9 11469.9 11475.4 11475.6 11319.2 11371.2 11445.4 11452.4 11480.6 8238.6 8442.2 10592.7 10986.5 11255.9 34307.7 40823.8 40856.6 40857.0 40918.6 3743.8 3830.0 3997.2 4055.9 4073.5 27120.2 27579.7 27765.4 28607.7 29205.6 3111.3 3208.0 3237.7 3240.1 3300.6 444394.0 463922.0 467081.0 467735.0 467796.7 55886.0 56240.2 56384.7 56389.4 56425.4 58981.7 59057.4 59098.6 59114.7 59137.4 14607.9 15110.2 15137.2 15168.2 15228.6 10471.4 11442.8 11497.7 11516.0 11587.5 15443.3 15867.3 17937.8 18367.7 18391.5 6447.9 8022.4 8039.3 8098.8 8182.9 858.5 872.2 890.1 895.2 922.2 29911.6 29972.0 30032.4 30420.0 30444.0 1064.2 1102.9 1103.4 1106.9 1122.8 15193.4 15685.3 15697.1 15761.0 16008.0 604937.0 604963.0 605545.0 606013.0 608948.0 58922.0 59615.8 59652.7 59810.0 59902.7 1236.7 1457.7 1471.1 1475.7 1489.7 28604.0 29012.3 29154.3 29842.7 30015.5 49058.8 49762.3 50389.5 50420.0 50434.0 396555.0 398423.0 398559.0 398755.0 398797.0 26038.6 26066.1 26071.7 26273.6 26655.0 38705.0 39377.8 40181.0 46196.8 46714.8 35748.5 38082.0 38201.4 39519.0 40065.0 32286.0 37481.2 37495.0 37716.1 38847.8 37501.4 37513.6 38098.4 38445.4 38630.4 30734.0 32454.8 33751.0 34523.1 34771.8 24910.6 25244.0 25304.9 25321.0 25766.7 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:40155.64 Median:2644.31 stddev:122043.45 (4615.3%) stddev-sans-first:122349.13 17:13:42 INFO - PROCESS | 1644 | Values: 309.5 388.5 396.7 408.8 421.3 14456.8 15308.4 19099.9 20988.3 21339.0 16979.0 20950.3 20956.8 21399.8 21679.0 5790.5 5901.6 5960.4 6044.3 6070.5 5888.4 6085.8 6086.0 6090.1 6091.5 4197.5 4412.9 6030.4 6679.9 6686.8 5753.7 6748.0 6763.2 6765.5 6769.9 5864.6 5997.2 6016.2 6016.5 6016.6 13236.2 17322.8 18955.5 25798.9 25800.0 2624.7 2630.9 2631.5 2657.1 2745.5 9898.1 10013.8 10100.2 10521.0 10560.3 1808.9 1847.7 1854.0 1855.1 1856.3 138902.0 141252.0 146023.0 148750.0 149607.3 9838.8 11786.8 11882.0 12001.9 12188.1 15795.6 15822.4 15851.0 15857.4 15876.9 7011.6 8265.0 8370.1 8552.8 8662.6 8004.7 8224.9 8246.3 8358.7 8390.7 4729.3 4731.8 4732.2 4733.9 4813.3 1746.7 1996.4 2045.3 2049.3 2058.6 997.4 1013.2 1015.5 1028.7 1034.8 20740.4 21183.6 21211.6 21351.5 21603.4 858.6 885.4 905.7 912.1 928.0 5787.3 6778.8 6835.6 6940.5 6973.0 613387.0 694931.0 756051.0 765264.0 800665.0 156009.0 156959.0 158300.0 159359.2 164128.0 862.3 1050.7 1068.1 1070.6 1081.1 15769.6 18849.2 19232.5 19815.1 19860.4 41728.0 58681.7 60372.1 60503.7 60918.0 68610.7 79577.8 80697.6 83725.6 90292.5 8223.3 8356.2 8390.5 8415.0 8552.8 13014.5 13292.5 13461.6 13556.3 13747.0 11217.8 11320.4 11455.8 11737.6 11826.0 11272.8 11413.6 11506.7 11921.2 11946.0 11295.0 11803.6 11821.8 11968.8 12053.8 7165.3 7399.0 7534.1 8143.6 8475.1 8108.0 9142.9 9802.7 11431.3 11748.8 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5418.96 Median:5215.19 stddev:2984.96 (57.2%) stddev-sans-first:2977.34 17:13:42 INFO - PROCESS | 1644 | Values: 1307.7 1390.3 1406.5 1411.6 1416.9 8082.5 8490.7 8516.4 8546.4 8565.3 6673.9 7474.5 7728.8 7751.8 8172.2 2337.9 2366.4 2366.9 2376.8 2380.0 2084.2 2263.9 2311.4 2338.0 2343.3 2075.8 2148.9 2260.7 2319.6 2336.2 2323.5 2327.6 2330.2 2338.3 2340.2 2290.7 2332.4 2374.8 2378.9 2378.9 8413.5 8491.7 8499.6 8507.3 8522.8 5049.0 5212.5 5214.3 5216.1 5224.0 3316.5 3444.6 3461.4 3486.3 3497.5 985.7 1124.7 1206.0 1216.7 1224.1 10947.0 11094.9 11103.8 11121.8 11138.4 3968.4 4646.6 4758.9 4765.7 4794.4 9605.3 9626.1 9630.8 9631.1 9634.3 5277.1 5281.6 5287.6 5291.4 5303.8 4082.9 4292.7 4443.0 4716.5 4747.5 3905.4 3909.9 4007.5 4032.2 4067.6 1084.4 1300.5 1301.2 1312.8 1313.2 869.5 874.9 877.8 884.3 887.3 5490.9 5493.9 5578.7 5767.8 5822.5 898.8 934.5 957.0 984.3 996.1 3678.4 3793.3 3802.2 3802.8 3950.8 8021.8 9905.5 10231.5 10266.1 10270.7 9922.3 10187.5 10207.0 10207.7 10235.3 6699.1 7797.6 7864.9 7939.9 7951.9 4179.9 4839.8 5296.6 5389.0 5565.1 8076.8 9163.0 9324.9 9420.6 9472.8 9307.6 9312.7 9553.2 9688.1 9695.5 6377.3 6558.1 6562.6 6725.3 6904.5 7816.3 8036.1 8071.6 8141.8 8152.4 7074.8 7221.9 7237.2 7289.4 7328.6 7030.7 7059.3 7075.3 7093.4 7192.2 6355.6 6488.0 6495.7 6500.1 6509.8 4288.6 4930.0 5093.7 5099.2 5104.4 3753.7 4973.5 4979.7 4991.5 5158.7 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4466.39 Median:4905.36 stddev:1344.72 (27.4%) stddev-sans-first:1312.61 17:13:42 INFO - PROCESS | 1644 | Values: 354.9 357.0 368.8 373.5 374.1 4791.6 4814.8 5201.4 5311.0 5323.4 4853.8 5040.9 5045.2 5119.9 5214.6 3466.3 3532.5 3879.5 4131.8 4168.9 3228.7 4172.2 4178.6 4187.9 4208.3 3734.5 3926.3 4124.6 4126.3 4153.6 3366.6 3704.9 3956.3 4082.8 4083.4 3630.9 3644.5 3646.5 3652.6 3653.2 4394.3 4644.3 4905.4 5009.7 5087.8 4311.9 4497.5 4656.5 4719.9 4741.9 4240.9 5518.6 5549.1 5550.9 5574.4 3704.4 3925.2 3931.3 3996.8 4047.8 4491.0 4763.5 5598.6 5699.4 5719.6 3858.9 3872.9 4093.1 4096.4 4126.4 4151.1 4161.5 4185.6 4186.0 4197.2 4249.6 4532.0 4567.7 4581.7 4743.0 4959.9 5586.6 5598.3 5601.7 5614.4 1156.4 1187.4 1268.7 1273.5 1275.7 750.0 817.6 819.9 858.5 864.7 4882.4 4905.3 4912.6 4926.2 5009.7 4489.7 4967.9 5351.5 5497.3 5509.9 4000.9 4632.7 4715.6 4764.3 5144.6 2669.3 2775.6 2900.3 2907.2 2916.3 5619.8 5729.8 5734.2 5735.1 5746.5 5396.5 5627.4 5864.8 5893.8 5918.0 4957.1 5168.0 5366.9 5918.3 5922.3 5531.8 5623.4 5665.9 5747.9 5755.9 5589.6 5622.8 5649.3 5659.7 5704.6 5116.7 5147.0 5821.5 5871.0 5898.7 3627.5 3818.7 3885.1 4124.2 4175.7 4225.5 5499.4 5685.5 5687.7 5752.9 4275.6 4530.0 4797.5 4855.0 5447.3 4487.1 5389.6 5461.3 5526.9 5565.9 5395.8 5417.4 5452.8 5453.6 5481.9 5264.6 5312.4 5428.4 5529.7 5546.9 4942.2 5020.9 5402.7 5443.1 5451.6 17:13:42 INFO - PROCESS | 1644 | 17:13:42 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:20092.21 Median:2609.39 stddev:29467.03 (1129.3%) stddev-sans-first:29513.52 17:13:42 INFO - PROCESS | 1644 | Values: 645.7 663.3 668.2 744.0 747.7 14716.4 15197.9 15777.7 15782.6 15786.6 14118.2 14282.9 14402.2 14465.6 14576.1 850.9 860.0 861.7 861.7 866.5 673.0 695.1 862.8 863.4 870.3 729.1 874.8 905.9 912.0 918.0 900.8 902.2 904.2 904.9 908.2 524.6 674.1 674.9 677.4 680.0 11381.8 12619.7 12631.2 12657.5 14511.0 13593.5 14053.6 14109.0 14190.5 14222.3 10611.9 10669.5 10928.3 10993.8 11002.3 3554.7 3577.3 3746.7 3747.1 3825.7 99548.0 102644.5 106865.0 107824.0 107856.0 10189.5 10370.0 10624.8 10718.9 10771.1 23218.2 23646.9 23648.3 23695.3 23710.3 7603.1 7624.6 7687.5 7774.7 7910.2 4091.8 4203.2 4270.3 4328.0 4368.0 3451.0 3509.8 3543.5 3552.3 3567.8 496.0 579.1 591.1 599.9 602.4 629.9 655.5 662.4 666.8 669.2 9313.3 9797.0 9811.4 9985.7 10075.2 626.9 628.2 653.8 667.1 689.8 4517.6 4626.7 4645.8 4655.7 4722.8 95258.0 100249.5 101425.0 101555.0 102164.5 84228.6 87244.0 87324.0 87792.6 89965.6 78235.6 80265.0 80766.0 81667.0 83375.6 8909.9 8945.2 9013.7 9024.3 9110.6 53074.0 53118.2 54514.4 54744.0 55224.7 53481.5 71033.3 72073.3 72270.3 72354.3 10924.8 10963.3 11152.1 11238.9 11658.3 11914.9 12049.9 12159.1 12194.3 12635.4 11269.8 11299.0 11810.6 11853.6 12213.0 11349.6 11674.0 11693.7 11822.9 11833.7 10734.6 11058.6 11169.7 11176.4 11655.7 9252.0 9707.8 9853.3 10009.9 10157.9 8753.4 9021.8 9210.9 9333.5 9439.4 17:13:42 INFO - PROCESS | 1644 | -------- Summary: end -------- 17:13:42 INFO - PROCESS | 1644 | 17:13:43 INFO - TEST-INFO | 1644: exit 0 17:13:43 INFO - TEST-OK | dromaeo_css | took 1118650ms 17:13:43 INFO - TEST-START | kraken 17:13:43 INFO - operating with platform_type : mac_ 17:13:43 INFO - Initialising browser for kraken test... 17:13:43 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmputhi9n/profile http://localhost:49249/getInfo.html) 17:13:45 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 17:13:45 INFO - PROCESS | 1651 | colorDepth:24 17:13:45 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 17:13:45 INFO - PROCESS | 1651 | __metrics 17:13:45 INFO - PROCESS | 1651 | 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" 17:13:45 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:46 INFO - TEST-INFO | 1651: exit 0 17:13:46 INFO - Browser initialized. 17:13:46 INFO - Running cycle 1/1 for kraken test... 17:13:46 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmputhi9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:58 INFO - PROCESS | 1652 | RSS: Main: 213114880 17:13:58 INFO - PROCESS | 1652 | 17:14:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:02 INFO - PROCESS | 1652 | RSS: Main: 265809920 17:14:02 INFO - PROCESS | 1652 | 17:14:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 17:14:05 INFO - PROCESS | 1652 | RSS: Main: 274821120 17:14:05 INFO - PROCESS | 1652 | 17:14:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 17:14:08 INFO - PROCESS | 1652 | RSS: Main: 372559872 17:14:08 INFO - PROCESS | 1652 | 17:14:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 17:14:11 INFO - PROCESS | 1652 | RSS: Main: 276680704 17:14:11 INFO - PROCESS | 1652 | 17:14:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:14 INFO - PROCESS | 1652 | RSS: Main: 278519808 17:14:14 INFO - PROCESS | 1652 | 17:14:16 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:17 INFO - PROCESS | 1652 | RSS: Main: 318464000 17:14:17 INFO - PROCESS | 1652 | 17:14:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:20 INFO - PROCESS | 1652 | RSS: Main: 318812160 17:14:20 INFO - PROCESS | 1652 | 17:14:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 17:14:24 INFO - PROCESS | 1652 | RSS: Main: 318251008 17:14:24 INFO - PROCESS | 1652 | 17:14:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:26 INFO - PROCESS | 1652 | RSS: Main: 295206912 17:14:26 INFO - PROCESS | 1652 | 17:14:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:29 INFO - PROCESS | 1652 | RSS: Main: 298262528 17:14:29 INFO - PROCESS | 1652 | 17:14:31 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:31 INFO - PROCESS | 1652 | RSS: Main: 300347392 17:14:31 INFO - PROCESS | 1652 | 17:14:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:35 INFO - PROCESS | 1652 | RSS: Main: 317202432 17:14:35 INFO - PROCESS | 1652 | 17:14:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:39 INFO - PROCESS | 1652 | RSS: Main: 311308288 17:14:39 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 17:14:41 INFO - PROCESS | 1652 | RSS: Main: 354947072 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | __start_tp_report 17:14:41 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 17:14:41 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 17:14:41 INFO - PROCESS | 1652 | |i|pagename|runs| 17:14:41 INFO - PROCESS | 1652 | |0;ai-astar;116;114;111;112;110;114;111;112;113;112 17:14:41 INFO - PROCESS | 1652 | |1;audio-beat-detection;129;108;105;139;110;109;108;111;127;104 17:14:41 INFO - PROCESS | 1652 | |2;audio-dft;185;185;182;183;186;181;183;184;185;183 17:14:41 INFO - PROCESS | 1652 | |3;audio-fft;81;58;60;88;62;59;59;58;73;59 17:14:41 INFO - PROCESS | 1652 | |4;audio-oscillator;83;71;86;70;68;68;81;68;69;83 17:14:41 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;85;86;84;86;83;87;84;86;84 17:14:41 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;94;93;94;97;93;93;92;93;93 17:14:41 INFO - PROCESS | 1652 | |7;imaging-desaturate;87;87;87;86;86;86;84;87;85;86 17:14:41 INFO - PROCESS | 1652 | |8;json-parse-financial;51;52;54;52;56;57;57;56;58;57 17:14:41 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;65;72;71;75;72;69;70;68;68;71 17:14:41 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;87;83;85;89;102;93;83;83;83;85 17:14:41 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;144;143;127;139;141;146;160;145;194;177 17:14:41 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;169;195;189;166;167;166;165;164;164;167 17:14:41 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;69;80;83;82;84;82;82;64;63 17:14:41 INFO - PROCESS | 1652 | __end_tp_report 17:14:41 INFO - PROCESS | 1652 | __start_cc_report 17:14:41 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2042 17:14:41 INFO - PROCESS | 1652 | __end_cc_report 17:14:41 INFO - PROCESS | 1652 | __startTimestamp1488330881273__endTimestamp 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | ------- Summary: start ------- 17:14:41 INFO - PROCESS | 1652 | Number of tests: 14 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.50 stddev:1.78 (1.6%) stddev-sans-first:1.36 17:14:41 INFO - PROCESS | 1652 | Values: 116.0 114.0 111.0 112.0 110.0 114.0 111.0 112.0 113.0 112.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:115.00 Median:110.50 stddev:12.07 (10.9%) stddev-sans-first:11.70 17:14:41 INFO - PROCESS | 1652 | Values: 129.0 108.0 105.0 139.0 110.0 109.0 108.0 111.0 127.0 104.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:1.57 (0.8%) stddev-sans-first:1.59 17:14:41 INFO - PROCESS | 1652 | Values: 185.0 185.0 182.0 183.0 186.0 181.0 183.0 184.0 185.0 183.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:65.70 Median:61.00 stddev:10.98 (18.0%) stddev-sans-first:10.15 17:14:41 INFO - PROCESS | 1652 | Values: 81.0 58.0 60.0 88.0 62.0 59.0 59.0 58.0 73.0 59.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:74.70 Median:76.00 stddev:7.51 (9.9%) stddev-sans-first:7.34 17:14:41 INFO - PROCESS | 1652 | Values: 83.0 71.0 86.0 70.0 68.0 68.0 81.0 68.0 69.0 83.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.40 (1.6%) stddev-sans-first:1.32 17:14:41 INFO - PROCESS | 1652 | Values: 87.0 85.0 86.0 84.0 86.0 83.0 87.0 84.0 86.0 84.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:93.50 stddev:1.35 (1.4%) stddev-sans-first:1.42 17:14:41 INFO - PROCESS | 1652 | Values: 94.0 94.0 93.0 94.0 97.0 93.0 93.0 92.0 93.0 93.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:86.10 Median:86.50 stddev:0.99 (1.1%) stddev-sans-first:1.00 17:14:41 INFO - PROCESS | 1652 | Values: 87.0 87.0 87.0 86.0 86.0 86.0 84.0 87.0 85.0 86.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:56.50 stddev:2.54 (4.5%) stddev-sans-first:2.24 17:14:41 INFO - PROCESS | 1652 | Values: 51.0 52.0 54.0 52.0 56.0 57.0 57.0 56.0 58.0 57.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:2.77 (3.9%) stddev-sans-first:2.24 17:14:41 INFO - PROCESS | 1652 | Values: 65.0 72.0 71.0 75.0 72.0 69.0 70.0 68.0 68.0 71.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:85.00 stddev:6.11 (7.2%) stddev-sans-first:6.48 17:14:41 INFO - PROCESS | 1652 | Values: 87.0 83.0 85.0 89.0 102.0 93.0 83.0 83.0 83.0 85.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:145.50 stddev:19.99 (13.7%) stddev-sans-first:21.01 17:14:41 INFO - PROCESS | 1652 | Values: 144.0 143.0 127.0 139.0 141.0 146.0 160.0 145.0 194.0 177.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:167.00 stddev:11.15 (6.7%) stddev-sans-first:11.80 17:14:41 INFO - PROCESS | 1652 | Values: 169.0 195.0 189.0 166.0 167.0 166.0 165.0 164.0 164.0 167.0 17:14:41 INFO - PROCESS | 1652 | 17:14:41 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:82.00 stddev:8.68 (10.6%) stddev-sans-first:8.63 17:14:41 INFO - PROCESS | 1652 | Values: 67.0 69.0 80.0 83.0 82.0 84.0 82.0 82.0 64.0 63.0 17:14:41 INFO - PROCESS | 1652 | -------- Summary: end -------- 17:14:41 INFO - PROCESS | 1652 | 17:14:42 INFO - TEST-INFO | 1652: exit 0 17:14:42 INFO - TEST-OK | kraken | took 59045ms 17:14:42 INFO - SUITE-END | took 1177s 17:14:42 INFO - Completed test suite (00:19:37) 17:14:42 INFO - javascript benchmark 17:14:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.0351598036564, 3341.8329083545823, 3354.4129777288967, 3377.0, 3414.0, 5605.607607467479, 5650.830475085749, 5656.406077361879, 5674.744636491358, 5684.573656975733, 5613.129964855444, 5678.205051292823, 5686.9146962795485, 5687.601867869251, 5691.743871525781, 5139.331886854713, 5189.636725429222, 5202.167653175493, 5219.034478621467, 5249.973750131244, 4535.160995215879, 5015.871428928498, 5171.250168725533, 5269.8946021079555, 5274.498922602346, 5202.271681964528, 5230.503102205284, 5231.947680523203, 5269.499397557226, 5321.920171197435, 5279.340082489689, 5280.445553216895, 5282.26048353227, 5289.338832645919, 5297.920531192035, 5102.795888164469, 5136.768845401966, 5240.082985477527, 5245.606579506552, 5267.26258323835, 5561.332640083216, 5597.160425936101, 5690.174924635905, 5711.314642242916, 5719.170720245541, 6250.0, 6291.465225455841, 6296.96851515744, 6297.0, 6310.432061114476, 5160.819371321985, 6311.589746666498, 6320.683965801692, 6341.080543321239, 6352.523560732963, 5706.087026075808, 5769.85575360611, 5859.677717725481, 5883.205767221413, 5941.970290148565, 6220.720067596969, 6257.7184026718905, 6262.12330273762, 6292.339304373067, 6303.9684801575695, 6190.102435146879, 6194.938050619527, 6211.254649442096, 6214.658193799384, 6222.502199824004, 6177.722002509808, 6315.778947736807, 6320.399562041599, 6321.747130114836, 6328.050792381179, 6097.298810636745, 6115.949241104752, 6135.398101970402, 6143.082036032849, 6198.442140207313, 6247.937520624827, 6263.937360626426, 6284.528660350401, 6288.968555157195, 6294.370562943761, 4995.000999800054, 5028.698278103252, 5037.647364684511, 5043.5460808527405, 5059.56993655536, 4441.289393696993, 4449.599536041772, 4453.554644535585, 4484.2376795944765, 4527.660425468103, 5719.2279042328755, 5756.597038207286, 5770.105633626795, 5795.391483894215, 5795.478406943395, 5619.578531610146, 5837.591368604157, 6243.937560624336, 6325.620462772156, 6331.145295385064, 4300.8709738707885, 5688.23208866806, 5732.455416735404, 5740.770369185186, 5749.310082790092, 5394.78420863161, 5455.990641731292, 5456.154296084113, 5457.645253058538, 5461.290032295776, 6243.625382477066, 6298.685065746694, 6306.716197771111, 6308.179936608211, 6310.116583678288, 5248.317718696545, 6237.5009999200865, 6303.495720342454, 6318.399752023551, 6329.050642403677, 6266.0, 6362.650054246876, 6363.90454143179, 6378.840528986812, 6380.617162970237, 6098.481629061579, 6107.3405344170405, 6186.938130618816, 6220.813375598739, 6284.151639528605, 6329.7468101275435, 6330.240371155491, 6334.4932405406535, 6342.365763423621, 6347.809565713036, 5799.072148456226, 5950.107483877453, 6024.216851809237, 6189.164462797465, 6194.5973511721595, 6063.605865618721, 6082.756689732361, 6105.877882442237, 6145.66198859067, 6155.169052178077, 5970.940290597038, 5973.044312909914, 5993.310769261417, 5993.940060599338, 5994.55040871945, 5661.377248502579, 5979.940200597938, 6192.009278515416, 6211.2857021443115, 6216.937830621636, 4845.297431872288, 4899.779509921991, 5939.16851640762, 5958.404159584007, 6067.453929146398], "value": 5684.426583890097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.01478791023476, 492.2689805638626, 502.04110149614246, 515.8349328214971, 516.6022162934539, 30821.691783082162, 39469.80265098674, 41657.16685666285, 41827.79086104573, 42004.369934450966, 42283.0, 42773.57226427735, 42814.357784633256, 42836.0, 42843.0, 9208.309376796733, 9423.434593924352, 9430.29272804539, 9447.385919915183, 9448.338616296827, 8329.83340333193, 8556.144385561456, 11164.106871450265, 11411.0, 11426.37154956477, 11415.429228538582, 11420.885791142107, 11469.942650286737, 11475.426228688573, 11475.598354057609, 11319.151063670175, 11371.204015718902, 11445.370504622242, 11452.427378631119, 11480.598179063734, 8238.629261683238, 8442.197991190827, 10592.728872535345, 10986.450677466175, 11255.943720281428, 34307.656923430695, 40823.77528674115, 40856.570020049454, 40857.0, 40918.590814091775, 3743.756655817363, 3829.9617003830163, 3997.160596274786, 4055.8643579797704, 4073.4500842386196, 27120.1863944082, 27579.724202757916, 27765.444691106066, 28607.713922860923, 29205.561916571267, 3111.2532992081965, 3208.0, 3237.7247933925646, 3240.141362538929, 3300.5709257796575, 444394.0, 463922.0, 467081.0, 467735.0, 467796.66101669276, 55886.0, 56240.15639765407, 56384.71807640936, 56389.43610563924, 56425.43574564284, 58981.70509147512, 59057.40942590605, 59098.56760742961, 59114.70442647759, 59137.40862591319, 14607.92696036513, 15110.244487775568, 15137.243137843065, 15168.165750883807, 15228.619284517976, 10471.371717696962, 11442.771144577227, 11497.712557186138, 11516.021138203347, 11587.478563464665, 15443.30505127272, 15867.285972131282, 17937.820621793617, 18367.72448413275, 18391.54021149482, 6447.871042579122, 8022.438429309892, 8039.2764651180505, 8098.797530061795, 8182.918170818335, 858.4806192253722, 872.1583671756786, 890.0787684746257, 895.1809094678426, 922.2253307221965, 29911.55132672968, 29972.0, 30032.399352013275, 30420.0, 30444.0, 1064.2390690656218, 1102.9172812039128, 1103.3931337764197, 1106.9003789658968, 1122.8154297216515, 15193.392264309305, 15685.294161762748, 15697.058176509447, 15760.975536590315, 16008.03951762898, 604937.0, 604963.0, 605545.0, 606013.0, 608948.0, 58922.0, 59615.80768384608, 59652.70173649104, 59810.0, 59902.70048649816, 1236.7402845402387, 1457.6574504991318, 1471.0805746408494, 1475.7417451945867, 1489.6946126044136, 28604.0, 29012.274693131996, 29154.271143221587, 29842.70157298399, 30015.54976675308, 49058.75470622624, 49762.25356619581, 50389.49610503994, 50420.0, 50433.99132017266, 396555.017224912, 398423.0, 398559.0072049737, 398755.0, 398797.0, 26038.60942085908, 26066.087686930867, 26071.696415179544, 26273.605895911194, 26655.0, 38705.03237419087, 39377.818665440085, 40181.0, 46196.76901615471, 46714.83212919568, 35748.4637730429, 38082.0, 38201.4269785959, 39519.0, 40064.99837504086, 32286.0, 37481.188910832345, 37495.0, 37716.05709857275, 38847.805760971016, 37501.43747843839, 37513.624863752106, 38098.42852357272, 38445.4233186508, 38630.4205436913, 30734.0, 32454.83772581122, 33750.95934375876, 34523.13692157716, 34771.82614086913, 24910.626340604544, 25243.99024039018, 25304.873475632503, 25320.969332364104, 25766.742332577185], "value": 19630.24710740436, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.45844771649615, 388.48913678512736, 396.7262588813719, 408.83033541080454, 421.3195688962327, 14456.783148252785, 15308.387664493406, 19099.94950277734, 20988.26541071063, 21339.0, 16979.0, 20950.26674066408, 20956.847373394456, 21399.786002139976, 21679.0, 5790.536757059435, 5901.645901245939, 5960.374160713128, 6044.2746870375395, 6070.453659170674, 5888.352281249059, 6085.847853803646, 6086.026235802273, 6090.086487026937, 6091.51267898567, 4197.538270790211, 4412.933805992912, 6030.396960303979, 6679.899801502981, 6686.83282917926, 5753.741081651336, 6748.0, 6763.222229443579, 6765.458763298924, 6769.8646027079185, 5864.648121112747, 5997.22036135304, 6016.217891674098, 6016.518678505709, 6016.639001659914, 13236.205827650372, 17322.82677173225, 18955.526111847175, 25798.87100564485, 25799.968001279925, 2624.6719160104985, 2630.8684565771637, 2631.460550587125, 2657.1497120921313, 2745.5226822489262, 9898.05968433005, 10013.79972400548, 10100.191984641211, 10521.000504952017, 10560.313579617301, 1808.8733788634802, 1847.6858933981255, 1853.9814601853943, 1855.053922499535, 1856.340998945382, 138902.0, 141252.0, 146023.0, 148750.0, 149607.25196374056, 9838.803223935623, 11786.823197652042, 11882.0, 12001.939990299992, 12188.085893557842, 15795.605109872346, 15822.446214382442, 15851.048937063813, 15857.365705371887, 15876.92061539708, 7011.649417529103, 8264.958675206586, 8370.079291277954, 8552.786180345542, 8662.6101825418, 8004.719834805754, 8224.876626850602, 8246.340292776564, 8358.665653373919, 8390.664373425117, 4729.314249433882, 4731.810727570927, 4732.2428411454, 4733.857984260478, 4813.278008298713, 1746.6768647800197, 1996.4110587376758, 2045.2534824789143, 2049.272508259576, 2058.6191554562156, 997.4464172384396, 1013.2400699475394, 1015.4922538730634, 1028.711960651019, 1034.818906691341, 20740.377788666363, 21183.576328473344, 21211.575768484854, 21351.46621334448, 21603.35189944304, 858.579296144897, 885.406777459104, 905.6920646980059, 912.0924679943498, 927.9536023198813, 5787.276590426197, 6778.796636100925, 6835.555688880307, 6940.514164008572, 6972.965135174393, 613387.0, 694931.0, 756051.0, 765264.0, 800665.0, 156009.0, 156959.0, 158300.0, 159359.17033839892, 164128.0, 862.2584577263674, 1050.6795427394718, 1068.1454836131063, 1070.577122036791, 1081.091882818452, 15769.605759856095, 18849.24603015864, 19232.519187020436, 19815.108320125917, 19860.415567347925, 41728.0, 58681.70659146677, 60372.076806215526, 60503.69748151231, 60918.0, 68610.65694671495, 79577.8063329039, 80697.59651201706, 83725.58137209275, 90292.5485372569, 8223.259906608433, 8356.164383561596, 8390.538520381439, 8414.957925210334, 8552.80260763506, 13014.544490942772, 13292.534761283308, 13461.596152115451, 13556.322183890963, 13747.0, 11217.831732523855, 11320.433978300887, 11455.770884582094, 11737.589184378507, 11826.0, 11272.83090753623, 11413.60052398162, 11506.654800356002, 11921.165518413627, 11946.0, 11295.0, 11803.645890623295, 11821.822672659744, 11968.820467692818, 12053.819192712292, 7165.319294666998, 7398.96300518494, 7534.0582427196605, 8143.633536490991, 8475.110113438, 8108.0, 9142.908570914205, 9802.65690700822, 11431.256968297033, 11748.765024699629], "value": 9711.102575385581, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1307.653117289192, 1390.2562129260841, 1406.5499040307106, 1411.6118067531427, 1416.9149851008938, 8082.474639148451, 8490.702825401113, 8516.361272904534, 8546.40175187737, 8565.271951884082, 6673.899891501631, 7474.476786624925, 7728.845423091535, 7751.806204844882, 8172.2236387543235, 2337.8947947342367, 2366.408397900525, 2366.8698221597806, 2376.809855211579, 2380.000399832075, 2084.1871670048695, 2263.864168149908, 2311.3759284993043, 2338.0, 2343.320437073247, 2075.8339332853334, 2148.9355319340443, 2260.7174103237094, 2319.617263151578, 2336.2290444153473, 2323.5004474038165, 2327.627579587266, 2330.2193765088714, 2338.275134708246, 2340.180936672168, 2290.6564015397657, 2332.3935776698013, 2374.786269235777, 2378.9048438062628, 2378.9167379141645, 8413.537255450949, 8491.74524764258, 8499.575021248913, 8507.319414446829, 8522.82954340916, 5049.0, 5212.478752124795, 5214.270002199695, 5216.113260745645, 5224.03355379256, 3316.502524621302, 3444.5522082129414, 3461.44616861301, 3486.267883744417, 3497.510348551205, 985.7042887133831, 1124.7019539821954, 1206.009097438349, 1216.6714986953473, 1224.1492162946756, 10947.014768670779, 11094.944525277322, 11103.777924441465, 11121.777564448746, 11138.443077846156, 3968.3849003404516, 4646.581807637329, 4758.857234282977, 4765.73788441639, 4794.376731024944, 9605.279604029585, 9626.085521875411, 9630.759231019141, 9631.133198012212, 9634.325597208268, 5277.050130976384, 5281.630285880028, 5287.629865909349, 5291.444398338196, 5303.761330740126, 4082.9387559186634, 4292.720973136736, 4443.000324926866, 4716.481187069419, 4747.548982846624, 3905.37513997759, 3909.944315034925, 4007.5391329997424, 4032.1734044520804, 4067.593240675968, 1084.414416215235, 1300.5318085489216, 1301.219268438929, 1312.835895513061, 1313.159577870164, 869.4609342207746, 874.9343799215085, 877.8405123396516, 884.3190743127884, 887.2547060469108, 5490.945090549043, 5493.862653433696, 5578.693171875586, 5767.769289228384, 5822.475977161991, 898.8090779716902, 934.528118213816, 956.9521523923916, 984.3109823123842, 996.0686757881404, 3678.374676304981, 3793.317202903504, 3802.1825307559006, 3802.8288727007352, 3950.7827069511454, 8021.759347219593, 9905.455199964072, 10231.488425578691, 10266.076053155251, 10270.743231419274, 9922.255830812717, 10187.453136715822, 10207.0, 10207.7448063799, 10235.283530152818, 6699.129113215251, 7797.571133587707, 7864.882026769603, 7939.880901786478, 7951.880721789178, 4179.937300940549, 4839.782209800497, 5296.590051526469, 5388.973055134699, 5565.1374037024325, 8076.798080047811, 9163.0, 9324.860127097963, 9420.62317507292, 9472.763180920256, 9307.581158847732, 9312.674056407994, 9553.235741140554, 9688.079632434907, 9695.515224238901, 6377.266614339411, 6558.081868538313, 6562.573432726857, 6725.327467253432, 6904.516683832084, 7816.296533312029, 8036.116027237116, 8071.596420179085, 8141.7964550884335, 8152.388570857328, 7074.752383666547, 7221.891671624825, 7237.203907570269, 7289.416846652149, 7328.5969271690565, 7030.718771249093, 7059.258777828254, 7075.257098004636, 7093.3970612498515, 7192.172900116553, 6355.586886852339, 6488.0, 6495.675216239264, 6500.122483464672, 6509.837254068686, 4288.571142885687, 4930.013997200646, 5093.668911520739, 5099.184130539096, 5104.438511763628, 3753.680937120266, 4973.477784832685, 4979.701217926936, 4991.50084991498, 5158.742062896915], "value": 4398.684834033659, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.88288864674644, 356.95181150544676, 368.78057555754333, 373.52935301520074, 374.130147407278, 4791.592714619262, 4814.807407703687, 5201.375834899813, 5311.0, 5323.361196656397, 4853.7815798289075, 5040.949590504103, 5045.167547354691, 5119.926429795929, 5214.582833373331, 3466.341395134929, 3532.5231093802263, 3879.476270703461, 4131.8347266109395, 4168.937465938014, 3228.674465300732, 4172.186423647375, 4178.6448151907125, 4187.895302617429, 4208.326667733163, 3734.514513113305, 3926.3128952433353, 4124.628783409493, 4126.257273690734, 4153.605407486299, 3366.612839523462, 3704.944090934071, 3956.268090403256, 4082.83668653252, 4083.4079058536495, 3630.909227269313, 3644.487537671863, 3646.507721457596, 3652.6164752700847, 3653.2328211075705, 4394.318880573484, 4644.303354496818, 4905.386826646669, 5009.749512524396, 5087.847364579068, 4311.892202694927, 4497.527759585229, 4656.4877863434995, 4719.929201061953, 4741.933065060368, 4240.872773816791, 5518.641288316287, 5549.058998730679, 5550.944490555084, 5574.414686457904, 3704.407294832814, 3925.21495700861, 3931.253061918255, 3996.780177090259, 4047.797610119482, 4490.973440799442, 4763.54746299101, 5598.608097433182, 5699.401562835884, 5719.568259044581, 3858.903527411781, 3872.934942890671, 4093.119979204426, 4096.446979657768, 4126.42230087788, 4151.086760912594, 4161.521425036099, 4185.58144185579, 4186.016286172747, 4197.160567886435, 4249.6387807036745, 4531.977340113278, 4567.657425693086, 4581.717119206627, 4743.003969166445, 4959.908820059582, 5586.636868603528, 5598.272224610774, 5601.719914004283, 5614.382417934024, 1156.4160099150045, 1187.4003628167893, 1268.6805722048966, 1273.5224290890917, 1275.7257189704073, 749.9687929097491, 817.5666896544841, 819.8726750717763, 858.4806192253596, 864.7059999600166, 4882.389701287339, 4905.337779399735, 4912.557869791736, 4926.211806111077, 5009.7495125243595, 4489.685721999429, 4967.925481117786, 5351.518363347317, 5497.26836046644, 5509.862253443696, 4000.939750965996, 4632.675712700146, 4715.618612600683, 4764.285357196379, 5144.61415393847, 2669.2526092694075, 2775.6114144019853, 2900.303927057491, 2907.200519857014, 2916.3292442737866, 5619.831405057855, 5729.799457018984, 5734.222391058785, 5735.053716136874, 5746.454086861741, 5396.4873337033705, 5627.352854421712, 5864.827034593013, 5893.823185304448, 5918.0, 4957.107720610325, 5168.0, 5366.91949620756, 5918.307170237532, 5922.289325280994, 5531.806386776443, 5623.3814280428305, 5665.915011274917, 5747.885042299047, 5755.884882302415, 5589.552835773047, 5622.803201887914, 5649.3220813501, 5659.660420374791, 5704.629199102045, 5116.720819795051, 5147.0, 5821.534277257724, 5871.001929671881, 5898.705064746831, 3627.528421305213, 3818.6945044395825, 3885.1258466844733, 4124.237016152021, 4175.6868234881895, 4225.471816022997, 5499.395066542597, 5685.516731077904, 5687.724910035853, 5752.913706294493, 4275.593818587229, 4530.0, 4797.520247975174, 4854.975725121351, 5447.291852059207, 4487.125010622897, 5389.556547886741, 5461.34463864323, 5526.944730552643, 5565.944340556543, 5395.757190926339, 5417.377001644703, 5452.809151679672, 5453.563714902719, 5481.945180548143, 5264.604055613606, 5312.4156342803035, 5428.430014848542, 5529.668219906818, 5546.916796248141, 4942.220800511741, 5020.945601423742, 5402.730853041653, 5443.067710962551, 5451.618386712892], "value": 4047.9220857771484, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6997496164284, 663.2969052804032, 668.191488299158, 743.9696021010898, 747.6971826410303, 14716.411343546259, 15197.924010379946, 15777.684446311066, 15782.60543486412, 15786.605334866634, 14118.223497707622, 14282.857171428308, 14402.207878566674, 14465.63835904103, 14576.052556583814, 850.9404341696069, 860.0195776814405, 861.7070196133313, 861.7199410191681, 866.536403024382, 672.9798106056802, 695.1102588686464, 862.8446879561676, 863.3524856357732, 870.316801310971, 729.0813574895617, 874.7813046738315, 905.9365844390895, 911.9785839859367, 917.9908200918005, 900.8108297257584, 902.2285945516554, 904.1771987491417, 904.868794024866, 908.1780988205718, 524.6117872774158, 674.1303718203511, 674.8852695041854, 677.4275737002274, 679.9558028728117, 11381.829272560835, 12619.684507887285, 12631.242125472409, 12657.493700251978, 14511.0, 13593.524226652118, 14053.578392648236, 14109.012369134165, 14190.503332383318, 14222.288885555681, 10611.893881061167, 10669.466526673636, 10928.344299341985, 10993.780124397546, 11002.284851484628, 3554.73339499536, 3577.266660334651, 3746.737728359016, 3747.1006958329804, 3825.6939444844347, 99548.0, 102644.48677756639, 106865.0, 107824.0, 107856.0, 10189.54147063384, 10370.0, 10624.78750424987, 10718.892811071946, 10771.138308935266, 23218.187363442536, 23646.88176559106, 23648.290551283488, 23695.28914132579, 23710.288691339287, 7603.125640551297, 7624.636362727461, 7687.5387476751575, 7774.689012439552, 7910.248526389983, 4091.815868285875, 4203.159368126387, 4270.274053410928, 4328.026194106301, 4367.978160109179, 3450.9654903451146, 3509.7543171978227, 3543.5039094526787, 3552.289542091592, 3567.839447224881, 495.9652824302264, 579.0503574138417, 591.1369400674977, 599.9291265091878, 602.3645054467491, 629.8771739510843, 655.4723447624613, 662.3608218069586, 666.7533012785301, 669.2303850571881, 9313.254939604816, 9797.0, 9811.362261452983, 9985.650502232387, 10075.244356673278, 626.9122322874802, 628.1888548744423, 653.8463461086641, 667.0694381338103, 689.837888096297, 4517.570830771071, 4626.676132670681, 4645.790939407735, 4655.740981313094, 4722.811087556528, 95258.0, 100249.49875250577, 101425.0, 101555.0, 102164.48917755364, 84228.57885710533, 87244.0, 87324.0, 87792.5610371944, 89965.55017224872, 78235.60882195552, 80265.0, 80766.0, 81667.0, 83375.58312208521, 8909.866352004596, 8945.19493245611, 9013.684521041994, 9024.337820343146, 9110.635574577207, 53074.0, 53118.203226950856, 54514.397023199424, 54744.0, 55224.72387638036, 53481.465185347646, 71033.28966710267, 72073.27926720666, 72270.27729722846, 72354.27645723475, 10924.836127458253, 10963.287386319864, 11152.107831373309, 11238.887611123784, 11658.300501969909, 11914.880851191378, 12049.939750301193, 12159.148859579744, 12194.329311887932, 12635.431405586587, 11269.830952535882, 11299.0, 11810.645680629596, 11853.5851245206, 12213.0, 11349.602763903224, 11674.0, 11693.707657308636, 11822.9309870774, 11833.70415739579, 10734.624288149877, 11058.557657693602, 11169.72075698114, 11176.385298808644, 11655.650330490098, 9252.0, 9707.757306067404, 9853.310268281439, 10009.899901001188, 10157.949210254197, 8753.431026983226, 9021.819563608822, 9210.907890921273, 9333.479303721077, 9439.433633981984], "value": 7149.947075501783, "unit": "score"}], "name": "dromaeo_css", "value": 7188.380336757069, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 111.0, 112.0, 110.0, 114.0, 111.0, 112.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 108.0, 105.0, 139.0, 110.0, 109.0, 108.0, 111.0, 127.0, 104.0], "value": 115.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 182.0, 183.0, 186.0, 181.0, 183.0, 184.0, 185.0, 183.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 88.0, 62.0, 59.0, 59.0, 58.0, 73.0, 59.0], "value": 65.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 86.0, 70.0, 68.0, 68.0, 81.0, 68.0, 69.0, 83.0], "value": 74.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 84.0, 86.0, 83.0, 87.0, 84.0, 86.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 97.0, 93.0, 93.0, 92.0, 93.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 86.0, 86.0, 84.0, 87.0, 85.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 52.0, 56.0, 57.0, 57.0, 56.0, 58.0, 57.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 71.0, 75.0, 72.0, 69.0, 70.0, 68.0, 68.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 89.0, 102.0, 93.0, 83.0, 83.0, 83.0, 85.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 143.0, 127.0, 139.0, 141.0, 146.0, 160.0, 145.0, 194.0, 177.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 195.0, 189.0, 166.0, 167.0, 166.0, 165.0, 164.0, 164.0, 167.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 80.0, 83.0, 82.0, 84.0, 82.0, 82.0, 64.0, 63.0], "value": 75.6, "unit": "score"}], "name": "kraken", "value": 1427.3, "alertThreshold": 2.0}]} 17:14:42 INFO - Return code: 0 17:14:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:14:42 ERROR - # TBPL SUCCESS # 17:14:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:14:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:14:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:14:42 INFO - 2017-02-28 17:14:42.594 screenresolution[1656:9978] starting screenresolution argv=screenresolution get 17:14:42 INFO - 2017-02-28 17:14:42.597 screenresolution[1656:9978] Display 0: 1600x1200x32@60 17:14:42 INFO - 2017-02-28 17:14:42.603 screenresolution[1657:9981] starting screenresolution argv=screenresolution list 17:14:42 INFO - Available Modes on Display 0 17:14:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:14:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:14:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:14:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:14:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:14:42 INFO - Intel Iris: 17:14:42 INFO - Chipset Model: Intel Iris 17:14:42 INFO - Type: GPU 17:14:42 INFO - Bus: Built-In 17:14:42 INFO - VRAM (Dynamic, Max): 1536 MB 17:14:42 INFO - Vendor: Intel (0x8086) 17:14:42 INFO - Device ID: 0x0a2e 17:14:42 INFO - Revision ID: 0x0009 17:14:42 INFO - Displays: 17:14:42 INFO - Display: 17:14:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:14:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:14:42 INFO - Display Serial Number: 1600x1200 60 17:14:42 INFO - Main Display: Yes 17:14:42 INFO - Mirror: Off 17:14:42 INFO - Online: Yes 17:14:42 INFO - Rotation: Supported 17:14:42 INFO - Return code: 0 17:14:42 INFO - Running post-action listener: _resource_record_post_action 17:14:42 INFO - [mozharness: 2017-03-01 01:14:42.837303Z] Finished run-tests step (success) 17:14:42 INFO - Running post-run listener: _resource_record_post_run 17:14:42 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39023616; Write bytes: 509169664; Read time: 379; Write time: 1910 17:14:42 INFO - TinderboxPrint: CPU usage
53.6% 17:14:42 INFO - TinderboxPrint: I/O read bytes / time
39,023,616 / 379 17:14:42 INFO - TinderboxPrint: I/O write bytes / time
509,169,664 / 1,910 17:14:42 INFO - TinderboxPrint: CPU idle
2,226.1 (46.4%) 17:14:42 INFO - TinderboxPrint: CPU system
963.2 (20.1%) 17:14:42 INFO - TinderboxPrint: CPU user
1,608.4 (33.5%) 17:14:42 INFO - TinderboxPrint: Swap in / out
246,628,352 / 0 17:14:42 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 206778880; Write bytes: 199012352; Read time: 15548; Write time: 383 17:14:42 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31898624; Write bytes: 299466752; Read time: 296; Write time: 1497 17:14:43 INFO - Running post-run listener: _upload_blobber_files 17:14:43 INFO - Blob upload gear active. 17:14:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:43 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 17:14:43 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'] 17:14:43 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 17:14:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:14:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:14:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:44 INFO - (blobuploader) - INFO - Done attempting. 17:14:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:14:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:14:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:45 INFO - (blobuploader) - INFO - Done attempting. 17:14:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:14:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:46 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:14:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:46 INFO - (blobuploader) - INFO - Done attempting. 17:14:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:14:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:14:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:49 INFO - (blobuploader) - INFO - Done attempting. 17:14:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:14:49 INFO - Return code: 0 17:14:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:14:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:14:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0978bc62b9d4c65f91d1820f66a49d62cae2683130eab96cfe891e42f1124c2030cd7b7aa858dddee5318b3550443d122fe2b783a2cc5695497b91c27b4a578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bea21a8affe246a92d7db196af67f863beb8034ac0fddd7474b09bc5037eafc12b411994eae7beb2c5f9cdd088d08346bc6aed16ed620034c9198c86cb53d1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3245978c6b29ab0a2ba026aa0b72656b224e29779203ae9803981045bda696b19fccb6ad1e22f0f5e9ab1eb217e227681153d4df69a10448134dca4e475bc85b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c88691ea5bcf4184eba5bbbea4559f7cd328be55b1f5a5e12523b37988b45bd3d3ab35b3e2132b170544f92a9179898878e11fc0db8ce2af5e17f53892ae08b"} 17:14:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:14:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:14:49 INFO - Contents: 17:14:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0978bc62b9d4c65f91d1820f66a49d62cae2683130eab96cfe891e42f1124c2030cd7b7aa858dddee5318b3550443d122fe2b783a2cc5695497b91c27b4a578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bea21a8affe246a92d7db196af67f863beb8034ac0fddd7474b09bc5037eafc12b411994eae7beb2c5f9cdd088d08346bc6aed16ed620034c9198c86cb53d1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3245978c6b29ab0a2ba026aa0b72656b224e29779203ae9803981045bda696b19fccb6ad1e22f0f5e9ab1eb217e227681153d4df69a10448134dca4e475bc85b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c88691ea5bcf4184eba5bbbea4559f7cd328be55b1f5a5e12523b37988b45bd3d3ab35b3e2132b170544f92a9179898878e11fc0db8ce2af5e17f53892ae08b"} 17:14:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:14:49 INFO - Copying logs to upload dir... 17:14:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:14:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.806006 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-28 17:14:49.084919) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:49.088282) ========= 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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/d0978bc62b9d4c65f91d1820f66a49d62cae2683130eab96cfe891e42f1124c2030cd7b7aa858dddee5318b3550443d122fe2b783a2cc5695497b91c27b4a578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bea21a8affe246a92d7db196af67f863beb8034ac0fddd7474b09bc5037eafc12b411994eae7beb2c5f9cdd088d08346bc6aed16ed620034c9198c86cb53d1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3245978c6b29ab0a2ba026aa0b72656b224e29779203ae9803981045bda696b19fccb6ad1e22f0f5e9ab1eb217e227681153d4df69a10448134dca4e475bc85b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c88691ea5bcf4184eba5bbbea4559f7cd328be55b1f5a5e12523b37988b45bd3d3ab35b3e2132b170544f92a9179898878e11fc0db8ce2af5e17f53892ae08b"} build_url:https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011096 build_url: 'https://queue.taskcluster.net/v1/task/S32kwKSZR82185zE88Nt7A/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/d0978bc62b9d4c65f91d1820f66a49d62cae2683130eab96cfe891e42f1124c2030cd7b7aa858dddee5318b3550443d122fe2b783a2cc5695497b91c27b4a578", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0bea21a8affe246a92d7db196af67f863beb8034ac0fddd7474b09bc5037eafc12b411994eae7beb2c5f9cdd088d08346bc6aed16ed620034c9198c86cb53d1d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3245978c6b29ab0a2ba026aa0b72656b224e29779203ae9803981045bda696b19fccb6ad1e22f0f5e9ab1eb217e227681153d4df69a10448134dca4e475bc85b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c88691ea5bcf4184eba5bbbea4559f7cd328be55b1f5a5e12523b37988b45bd3d3ab35b3e2132b170544f92a9179898878e11fc0db8ce2af5e17f53892ae08b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:49.123653) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:49.124054) ========= 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.a7KcGW8ulP/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.SD2nFzmbbK/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.004979 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-28 17:14:49.172791) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 17:14:49.173151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-28 17:14:49.173578) ========= ========= Total master_lag: 0.18 =========