builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0168 starttime: 1491417631.05 results: success (0) buildid: 20170405080221 builduid: e66679fe27f74005b950f62ba1831f4d revision: 943472295ee61812ffea25699d548d53ca7bcb22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.054110) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.054600) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.054880) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.082051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.082463) ========= 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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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-04-05 11:40:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.6M=0.001s 2017-04-05 11:40:31 (13.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140371 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.248167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.248542) ========= 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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.039132 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:31.309465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 11:40:31.309819) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 943472295ee61812ffea25699d548d53ca7bcb22 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 943472295ee61812ffea25699d548d53ca7bcb22 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0CrDuCTm9a/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.cpCVBaJQL4/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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-04-05 11:40:31,413 truncating revision to first 12 chars 2017-04-05 11:40:31,414 Setting DEBUG logging. 2017-04-05 11:40:31,414 attempt 1/10 2017-04-05 11:40:31,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/943472295ee6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 11:40:32,452 unpacking tar archive at: pine-943472295ee6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.332149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 11:40:32.665299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:32.665645) ========= script_repo_revision: 943472295ee61812ffea25699d548d53ca7bcb22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:32.666025) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:32.666333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 11:40:32.690268) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-05 11:40:32.690584) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0CrDuCTm9a/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.cpCVBaJQL4/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:40:32 INFO - MultiFileLogger online at 20170405 11:40:32 in /builds/slave/test 11:40:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 11:40:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:40:32 INFO - {'append_to_log': False, 11:40:32 INFO - 'base_work_dir': '/builds/slave/test', 11:40:32 INFO - 'blob_upload_branch': 'Pine', 11:40:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:40:32 INFO - 'branch': 'Pine', 11:40:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:40:32 INFO - 'config_files': ('talos/mac_config.py',), 11:40:32 INFO - 'default_actions': ('clobber', 11:40:32 INFO - 'read-buildbot-config', 11:40:32 INFO - 'download-and-extract', 11:40:32 INFO - 'populate-webroot', 11:40:32 INFO - 'create-virtualenv', 11:40:32 INFO - 'install', 11:40:32 INFO - 'run-tests'), 11:40:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:40:32 INFO - 'download_minidump_stackwalk': True, 11:40:32 INFO - 'download_symbols': 'ondemand', 11:40:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:40:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:40:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:40:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:40:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:40:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:40:32 INFO - 'gecko_profile': False, 11:40:32 INFO - 'gecko_profile_interval': 0, 11:40:32 INFO - 'installer_path': 'installer.exe', 11:40:32 INFO - 'log_level': 'info', 11:40:32 INFO - 'log_name': 'talos', 11:40:32 INFO - 'log_to_console': True, 11:40:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:40:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:40:32 INFO - 'opt_config_files': (), 11:40:32 INFO - 'pip_index': False, 11:40:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:40:32 INFO - 'cmd': ('bash', 11:40:32 INFO - '-c', 11:40:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:40:32 INFO - 'enabled': True, 11:40:32 INFO - 'halt_on_failure': False, 11:40:32 INFO - 'name': 'check_screen_resolution'},), 11:40:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:40:32 INFO - 'cmd': ('bash', 11:40:32 INFO - '-c', 11:40:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:40:32 INFO - 'enabled': True, 11:40:32 INFO - 'halt_on_failure': False, 11:40:32 INFO - 'name': 'check_screen_resolution'},), 11:40:32 INFO - 'run_cmd_checks_enabled': True, 11:40:32 INFO - 'suite': 'dromaeojs', 11:40:32 INFO - 'system_bits': '32', 11:40:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:40:32 INFO - 'title': 't-yosemite-r7-0168', 11:40:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:40:32 INFO - 'use_talos_json': True, 11:40:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:40:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:40:32 INFO - 'work_dir': 'build'} 11:40:32 INFO - [mozharness: 2017-04-05 18:40:32.899830Z] Running clobber step. 11:40:32 INFO - Running pre-action listener: _resource_record_pre_action 11:40:32 INFO - Running main action method: clobber 11:40:32 INFO - rmtree: /builds/slave/test/build 11:40:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:40:35 INFO - Running post-action listener: _resource_record_post_action 11:40:35 INFO - [mozharness: 2017-04-05 18:40:35.472603Z] Finished clobber step (success) 11:40:35 INFO - [mozharness: 2017-04-05 18:40:35.472734Z] Running read-buildbot-config step. 11:40:35 INFO - Running pre-action listener: _resource_record_pre_action 11:40:35 INFO - Running main action method: read_buildbot_config 11:40:35 INFO - Using buildbot properties: 11:40:35 INFO - { 11:40:35 INFO - "project": "", 11:40:35 INFO - "product": "firefox", 11:40:35 INFO - "script_repo_revision": "default", 11:40:35 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 11:40:35 INFO - "repository": "", 11:40:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 11:40:35 INFO - "buildid": "20170405080221", 11:40:35 INFO - "pgo_build": "False", 11:40:35 INFO - "basedir": "/builds/slave/test", 11:40:35 INFO - "buildnumber": 5, 11:40:35 INFO - "slavename": "t-yosemite-r7-0168", 11:40:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:40:35 INFO - "platform": "yosemite_r7", 11:40:35 INFO - "scheduler": "tests-pine-macosx64-talos", 11:40:35 INFO - "branch": "pine", 11:40:35 INFO - "repo_path": "projects/pine", 11:40:35 INFO - "revision": "943472295ee61812ffea25699d548d53ca7bcb22", 11:40:35 INFO - "stage_platform": "macosx64", 11:40:35 INFO - "builduid": "e66679fe27f74005b950f62ba1831f4d", 11:40:35 INFO - "slavebuilddir": "test" 11:40:35 INFO - } 11:40:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 11:40:35 INFO - Running post-action listener: _resource_record_post_action 11:40:35 INFO - [mozharness: 2017-04-05 18:40:35.476203Z] Finished read-buildbot-config step (success) 11:40:35 INFO - [mozharness: 2017-04-05 18:40:35.476321Z] Running download-and-extract step. 11:40:35 INFO - Running pre-action listener: _resource_record_pre_action 11:40:35 INFO - Running main action method: download_and_extract 11:40:35 INFO - mkdir: /builds/slave/test/build/tests 11:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:40:35 INFO - trying https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 11:40:35 INFO - Downloading https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 11:40:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 11:40:36 INFO - Downloaded 1325 bytes. 11:40:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 11:40:36 INFO - Using the following test package requirements: 11:40:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 11:40:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:40:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 11:40:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 11:40:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'jsshell-mac.zip'], 11:40:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 11:40:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 11:40:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 11:40:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 11:40:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 11:40:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 11:40:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 11:40:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:40:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:40:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:40:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:40:37 INFO - Expected file size: 52520938 11:40:37 INFO - Obtained file size: 52520938 11:40:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:40:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 11:40:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:40:54 INFO - Fetch https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 11:40:55 INFO - Expected file size: 52520938 11:40:55 INFO - Obtained file size: 52520938 11:41:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 11:41:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:41:11 INFO - Fetch https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 11:41:13 INFO - Expected file size: 14404152 11:41:13 INFO - Obtained file size: 14404152 11:41:13 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')]} 11:41:13 INFO - trying https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:41:13 INFO - Downloading https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 11:41:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 11:41:15 INFO - Downloaded 70981168 bytes. 11:41:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:41:15 INFO - mkdir: /builds/slave/test/properties 11:41:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:41:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:41:15 INFO - Contents: 11:41:15 INFO - build_url:https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 11:41:16 INFO - Running post-action listener: _resource_record_post_action 11:41:16 INFO - Running post-action listener: set_extra_try_arguments 11:41:16 INFO - [mozharness: 2017-04-05 18:41:16.278312Z] Finished download-and-extract step (success) 11:41:16 INFO - [mozharness: 2017-04-05 18:41:16.278439Z] Running populate-webroot step. 11:41:16 INFO - Running pre-action listener: _resource_record_pre_action 11:41:16 INFO - Running main action method: populate_webroot 11:41:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:41:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:41:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:41:16 INFO - '--tppagecycles', 11:41:16 INFO - '7'], 11:41:16 INFO - 'tests': ['tsvgm']}}, 11:41:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:41:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:41:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:41:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:41:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:41:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['damp', 'tps']}, 11:41:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'tests': ['damp', 'tps']}, 11:41:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['dromaeo_dom']}, 11:41:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:41:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['basic_compositor_video']}, 11:41:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:41:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['a11yr', 11:41:16 INFO - 'ts_paint', 11:41:16 INFO - 'tpaint', 11:41:16 INFO - 'sessionrestore', 11:41:16 INFO - 'sessionrestore_no_auto_restore', 11:41:16 INFO - 'tabpaint']}, 11:41:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:41:16 INFO - 'ts_paint', 11:41:16 INFO - 'tpaint', 11:41:16 INFO - 'sessionrestore', 11:41:16 INFO - 'sessionrestore_no_auto_restore', 11:41:16 INFO - 'tabpaint']}, 11:41:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:41:16 INFO - 'ts_paint', 11:41:16 INFO - 'tpaint', 11:41:16 INFO - 'sessionrestore', 11:41:16 INFO - 'sessionrestore_no_auto_restore', 11:41:16 INFO - 'tabpaint']}, 11:41:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:41:16 INFO - 'ts_paint', 11:41:16 INFO - 'tpaint', 11:41:16 INFO - 'sessionrestore', 11:41:16 INFO - 'sessionrestore_no_auto_restore', 11:41:16 INFO - 'tabpaint']}, 11:41:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['a11yr', 11:41:16 INFO - 'ts_paint', 11:41:16 INFO - 'tpaint', 11:41:16 INFO - 'sessionrestore', 11:41:16 INFO - 'sessionrestore_no_auto_restore', 11:41:16 INFO - 'tabpaint']}, 11:41:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['a11yr', 11:41:16 INFO - 'ts_paint', 11:41:16 INFO - 'tpaint', 11:41:16 INFO - 'sessionrestore', 11:41:16 INFO - 'sessionrestore_no_auto_restore', 11:41:16 INFO - 'tabpaint']}, 11:41:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['tsvgx', 11:41:16 INFO - 'tsvgr_opacity', 11:41:16 INFO - 'tart', 11:41:16 INFO - 'tscrollx', 11:41:16 INFO - 'cart', 11:41:16 INFO - 'tsvg_static']}, 11:41:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:41:16 INFO - 'tsvgr_opacity', 11:41:16 INFO - 'tart', 11:41:16 INFO - 'tscrollx', 11:41:16 INFO - 'cart', 11:41:16 INFO - 'tsvg_static']}, 11:41:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'talos_options': ['--disable-e10s'], 11:41:16 INFO - 'tests': ['tp5o']}, 11:41:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:41:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'talos_options': ['--disable-e10s', 11:41:16 INFO - '--xperf_path', 11:41:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:16 INFO - 'tests': ['tp5n']}, 11:41:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:41:16 INFO - 'talos_options': ['--xperf_path', 11:41:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:41:16 INFO - 'tests': ['tp5n']}}, 11:41:16 INFO - 'talos.zip': {'path': '', 11:41:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:41:16 INFO - Running post-action listener: _resource_record_post_action 11:41:16 INFO - [mozharness: 2017-04-05 18:41:16.297298Z] Finished populate-webroot step (success) 11:41:16 INFO - [mozharness: 2017-04-05 18:41:16.297416Z] Running create-virtualenv step. 11:41:16 INFO - Running pre-action listener: _resource_record_pre_action 11:41:16 INFO - Running main action method: create_virtualenv 11:41:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:41:16 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 11:41:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:41:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:41:16 INFO - Using real prefix '/tools/python27' 11:41:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:41:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:41:19 INFO - Installing pip.................done. 11:41:19 INFO - Return code: 0 11:41:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:41:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:41:20 INFO - Reading from file tmpfile_stdout 11:41:20 INFO - Output received: 11:41:20 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) 11:41:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:41: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')]} 11:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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')]} 11:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41: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', 'pip>=1.5'] in /builds/slave/test/build 11:41: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 pip>=1.5 11:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:20 INFO - 'HOME': '/Users/cltbld', 11:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:20 INFO - 'LOGNAME': 'cltbld', 11:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:20 INFO - 'MOZ_NO_REMOTE': '1', 11:41:20 INFO - 'NO_EM_RESTART': '1', 11:41:20 INFO - 'PAGER': '/bin/cat', 11:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:20 INFO - 'PWD': '/builds/slave/test', 11:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:20 INFO - 'SHELL': '/bin/bash', 11:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:20 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:20 INFO - 'USER': 'cltbld', 11:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:20 INFO - 'XPC_FLAGS': '0x0', 11:41:20 INFO - 'XPC_SERVICE_NAME': '0', 11:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:20 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 11:41:20 INFO - Cleaning up... 11:41:20 INFO - Return code: 0 11:41:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:41: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')]} 11:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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')]} 11:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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', '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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:41: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 psutil>=3.1.1 11:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:20 INFO - 'HOME': '/Users/cltbld', 11:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:20 INFO - 'LOGNAME': 'cltbld', 11:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:20 INFO - 'MOZ_NO_REMOTE': '1', 11:41:20 INFO - 'NO_EM_RESTART': '1', 11:41:20 INFO - 'PAGER': '/bin/cat', 11:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:20 INFO - 'PWD': '/builds/slave/test', 11:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:20 INFO - 'SHELL': '/bin/bash', 11:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:20 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:20 INFO - 'USER': 'cltbld', 11:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:20 INFO - 'XPC_FLAGS': '0x0', 11:41:20 INFO - 'XPC_SERVICE_NAME': '0', 11:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:20 INFO - Downloading/unpacking psutil>=3.1.1 11:41: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 11:41: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 11:41: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 11:41: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 11:41: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 11:41: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 11:41:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:41:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:24 INFO - Installing collected packages: psutil 11:41:24 INFO - Running setup.py install for psutil 11:41:24 INFO - building 'psutil._psutil_osx' extension 11:41:24 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 11:41:25 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 11:41:25 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 11:41:25 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 11:41:25 INFO - building 'psutil._psutil_posix' extension 11:41:25 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 11:41:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:41:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:41:25 INFO - ^ 11:41:25 INFO - 1 warning generated. 11:41:25 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 11:41:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:41:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:41:25 INFO - Successfully installed psutil 11:41:25 INFO - Cleaning up... 11:41:25 INFO - Return code: 0 11:41:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:41:25 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')]} 11:41:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:25 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')]} 11:41:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:25 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:25 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 11:41:25 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 11:41:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:25 INFO - 'HOME': '/Users/cltbld', 11:41:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:25 INFO - 'LOGNAME': 'cltbld', 11:41:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:25 INFO - 'MOZ_NO_REMOTE': '1', 11:41:25 INFO - 'NO_EM_RESTART': '1', 11:41:25 INFO - 'PAGER': '/bin/cat', 11:41:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:25 INFO - 'PWD': '/builds/slave/test', 11:41:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:25 INFO - 'SHELL': '/bin/bash', 11:41:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:25 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:25 INFO - 'USER': 'cltbld', 11:41:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:25 INFO - 'XPC_FLAGS': '0x0', 11:41:25 INFO - 'XPC_SERVICE_NAME': '0', 11:41:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:41:25 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 11:41:25 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 11:41:25 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 11:41:25 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 11:41:25 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 11:41:25 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 11:41:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:41:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:41:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:41:28 INFO - Installing collected packages: mozsystemmonitor 11:41:28 INFO - Running setup.py install for mozsystemmonitor 11:41:28 INFO - Successfully installed mozsystemmonitor 11:41:28 INFO - Cleaning up... 11:41:28 INFO - Return code: 0 11:41:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:41:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:29 INFO - 'HOME': '/Users/cltbld', 11:41:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:29 INFO - 'LOGNAME': 'cltbld', 11:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:29 INFO - 'MOZ_NO_REMOTE': '1', 11:41:29 INFO - 'NO_EM_RESTART': '1', 11:41:29 INFO - 'PAGER': '/bin/cat', 11:41:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:29 INFO - 'PWD': '/builds/slave/test', 11:41:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:29 INFO - 'SHELL': '/bin/bash', 11:41:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:29 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:29 INFO - 'USER': 'cltbld', 11:41:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:29 INFO - 'XPC_FLAGS': '0x0', 11:41:29 INFO - 'XPC_SERVICE_NAME': '0', 11:41:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:29 INFO - Downloading/unpacking jsonschema==2.5.1 11:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:41:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:41:33 INFO - warning: no files found matching '*.txt' 11:41:33 INFO - no previously-included directories found matching 'build' 11:41:33 INFO - no previously-included directories found matching 'dist' 11:41:33 INFO - no previously-included directories found matching '.git*' 11:41:33 INFO - Installing collected packages: jsonschema, functools32 11:41:33 INFO - Running setup.py install for functools32 11:41:33 INFO - warning: no files found matching '*.txt' 11:41:33 INFO - no previously-included directories found matching 'build' 11:41:33 INFO - no previously-included directories found matching 'dist' 11:41:33 INFO - no previously-included directories found matching '.git*' 11:41:33 INFO - Successfully installed jsonschema functools32 11:41:33 INFO - Cleaning up... 11:41:33 INFO - Return code: 0 11:41:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:41:33 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')]} 11:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:33 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')]} 11:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:33 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:33 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 11:41:33 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 11:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:33 INFO - 'HOME': '/Users/cltbld', 11:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:33 INFO - 'LOGNAME': 'cltbld', 11:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:33 INFO - 'MOZ_NO_REMOTE': '1', 11:41:33 INFO - 'NO_EM_RESTART': '1', 11:41:33 INFO - 'PAGER': '/bin/cat', 11:41:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:33 INFO - 'PWD': '/builds/slave/test', 11:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:33 INFO - 'SHELL': '/bin/bash', 11:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:33 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:33 INFO - 'USER': 'cltbld', 11:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:33 INFO - 'XPC_FLAGS': '0x0', 11:41:33 INFO - 'XPC_SERVICE_NAME': '0', 11:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:41:33 INFO - Cleaning up... 11:41:33 INFO - Return code: 0 11:41:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:41:33 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')]} 11:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:33 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')]} 11:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:33 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:33 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 11:41:33 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 11:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:33 INFO - 'HOME': '/Users/cltbld', 11:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:33 INFO - 'LOGNAME': 'cltbld', 11:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:33 INFO - 'MOZ_NO_REMOTE': '1', 11:41:33 INFO - 'NO_EM_RESTART': '1', 11:41:33 INFO - 'PAGER': '/bin/cat', 11:41:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:33 INFO - 'PWD': '/builds/slave/test', 11:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:33 INFO - 'SHELL': '/bin/bash', 11:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:33 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:33 INFO - 'USER': 'cltbld', 11:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:33 INFO - 'XPC_FLAGS': '0x0', 11:41:33 INFO - 'XPC_SERVICE_NAME': '0', 11:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:34 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 11:41:34 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 11:41:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:36 INFO - Downloading blobuploader-1.2.4.tar.gz 11:41:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:41:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:36 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 11:41:36 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 11:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:41:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:41:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:41:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:41:37 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 11:41:37 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 11:41:37 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 11:41:37 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 11:41:37 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 11:41:37 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 11:41:38 INFO - Downloading docopt-0.6.1.tar.gz 11:41:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:41:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:41:38 INFO - Running setup.py install for blobuploader 11:41:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:41:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:41:38 INFO - Running setup.py install for requests 11:41:38 INFO - Running setup.py install for docopt 11:41:38 INFO - Successfully installed blobuploader requests docopt 11:41:38 INFO - Cleaning up... 11:41:39 INFO - Return code: 0 11:41:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:41:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:39 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:39 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 11:41:39 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 11:41:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:39 INFO - 'HOME': '/Users/cltbld', 11:41:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:39 INFO - 'LOGNAME': 'cltbld', 11:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:39 INFO - 'MOZ_NO_REMOTE': '1', 11:41:39 INFO - 'NO_EM_RESTART': '1', 11:41:39 INFO - 'PAGER': '/bin/cat', 11:41:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:39 INFO - 'PWD': '/builds/slave/test', 11:41:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:39 INFO - 'SHELL': '/bin/bash', 11:41:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:39 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:39 INFO - 'USER': 'cltbld', 11:41:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:39 INFO - 'XPC_FLAGS': '0x0', 11:41:39 INFO - 'XPC_SERVICE_NAME': '0', 11:41:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-w3gMH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-rMMsDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-2rGbMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-5FvzTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-GPU9XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-dIgbur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:39 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-iEH0kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-wmaOUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-MXArDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-KS3SEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-cgUpEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Px2eiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-EQwjAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-3WKCM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-lxfxpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-0t8rmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:40 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-Bm_8Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:41:41 INFO - Running setup.py install for manifestparser 11:41:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:41:41 INFO - Running setup.py install for mozcrash 11:41:41 INFO - Running setup.py install for mozdebug 11:41:41 INFO - Running setup.py install for mozdevice 11:41:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:41:41 INFO - Running setup.py install for mozfile 11:41:41 INFO - Running setup.py install for mozhttpd 11:41:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:41:41 INFO - Running setup.py install for mozinfo 11:41:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Running setup.py install for mozInstall 11:41:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Running setup.py install for mozleak 11:41:42 INFO - Running setup.py install for mozlog 11:41:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Running setup.py install for moznetwork 11:41:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:41:42 INFO - Running setup.py install for mozprocess 11:41:42 INFO - Running setup.py install for mozprofile 11:41:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:41:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:41:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:41:43 INFO - Running setup.py install for mozrunner 11:41:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:41:43 INFO - Running setup.py install for mozscreenshot 11:41:43 INFO - Running setup.py install for moztest 11:41:43 INFO - Running setup.py install for mozversion 11:41:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:41:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:41:43 INFO - Cleaning up... 11:41:43 INFO - Return code: 0 11:41:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41: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')]} 11:41:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41: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')]} 11:41:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:43 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:43 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 11:41:43 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 11:41:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:43 INFO - 'HOME': '/Users/cltbld', 11:41:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:43 INFO - 'LOGNAME': 'cltbld', 11:41:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:43 INFO - 'MOZ_NO_REMOTE': '1', 11:41:43 INFO - 'NO_EM_RESTART': '1', 11:41:43 INFO - 'PAGER': '/bin/cat', 11:41:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:43 INFO - 'PWD': '/builds/slave/test', 11:41:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:43 INFO - 'SHELL': '/bin/bash', 11:41:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:43 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:43 INFO - 'USER': 'cltbld', 11:41:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:43 INFO - 'XPC_FLAGS': '0x0', 11:41:43 INFO - 'XPC_SERVICE_NAME': '0', 11:41:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:41:43 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-RuxtSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-mmatRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-cz1Fen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-T0SvuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-jv3rxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-tavSvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-SDtg8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-0zSYGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-UOghGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-lTtuF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:41:44 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)) 11:41:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:41:44 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-4l3xgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:41:45 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)) 11:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:41:45 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-T_W821-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:41:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:41:45 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-C6WOhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:41:45 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)) 11:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:41:45 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-64mQup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:41:45 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)) 11:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:45 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-56XyfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:41:45 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)) 11:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:41:45 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-0NvlLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:41:45 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)) 11:41:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:41:45 INFO - Running setup.py (path:/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/pip-fL23U7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:41:45 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)) 11:41:45 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)) 11:41:45 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)) 11:41:45 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)) 11:41:45 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)) 11:41:45 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)) 11:41:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:41:45 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 11:41:45 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 11:41:45 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 11:41:45 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 11:41:45 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 11:41:45 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 11:41:48 INFO - Downloading blessings-1.6.tar.gz 11:41:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:41:48 INFO - Installing collected packages: blessings 11:41:48 INFO - Running setup.py install for blessings 11:41:48 INFO - Successfully installed blessings 11:41:48 INFO - Cleaning up... 11:41:48 INFO - Return code: 0 11:41:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:41:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:49 INFO - Reading from file tmpfile_stdout 11:41:49 INFO - Current package versions: 11:41:49 INFO - blessings == 1.6 11:41:49 INFO - blobuploader == 1.2.4 11:41:49 INFO - docopt == 0.6.1 11:41:49 INFO - functools32 == 3.2.3-2 11:41:49 INFO - jsonschema == 2.5.1 11:41:49 INFO - manifestparser == 1.1 11:41:49 INFO - mozInstall == 1.12 11:41:49 INFO - mozcrash == 1.0 11:41:49 INFO - mozdebug == 0.1 11:41:49 INFO - mozdevice == 0.49 11:41:49 INFO - mozfile == 1.2 11:41:49 INFO - mozhttpd == 0.7 11:41:49 INFO - mozinfo == 0.9 11:41:49 INFO - mozleak == 0.1 11:41:49 INFO - mozlog == 3.4 11:41:49 INFO - moznetwork == 0.27 11:41:49 INFO - mozprocess == 0.25 11:41:49 INFO - mozprofile == 0.28 11:41:49 INFO - mozrunner == 6.13 11:41:49 INFO - mozscreenshot == 0.1 11:41:49 INFO - mozsystemmonitor == 0.3 11:41:49 INFO - moztest == 0.8 11:41:49 INFO - mozversion == 1.4 11:41:49 INFO - psutil == 3.1.1 11:41:49 INFO - requests == 1.2.3 11:41:49 INFO - wsgiref == 0.1.2 11:41:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:41:49 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')]} 11:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:49 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')]} 11:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:49 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:49 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 11:41:49 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 11:41:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:49 INFO - 'HOME': '/Users/cltbld', 11:41:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:49 INFO - 'LOGNAME': 'cltbld', 11:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:49 INFO - 'MOZ_NO_REMOTE': '1', 11:41:49 INFO - 'NO_EM_RESTART': '1', 11:41:49 INFO - 'PAGER': '/bin/cat', 11:41:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:49 INFO - 'PWD': '/builds/slave/test', 11:41:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:49 INFO - 'SHELL': '/bin/bash', 11:41:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:49 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:49 INFO - 'USER': 'cltbld', 11:41:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:49 INFO - 'XPC_FLAGS': '0x0', 11:41:49 INFO - 'XPC_SERVICE_NAME': '0', 11:41:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 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)) 11:41:49 INFO - Cleaning up... 11:41:49 INFO - Return code: 0 11:41:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:41:49 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')]} 11:41:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:41:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:49 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')]} 11:41:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:41:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:41:49 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 0x10c595b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4aa594f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, '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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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 11:41:49 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 11:41:49 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 11:41:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:41:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:41:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:41:49 INFO - 'HOME': '/Users/cltbld', 11:41:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:41:49 INFO - 'LOGNAME': 'cltbld', 11:41:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:41:49 INFO - 'MOZ_NO_REMOTE': '1', 11:41:49 INFO - 'NO_EM_RESTART': '1', 11:41:49 INFO - 'PAGER': '/bin/cat', 11:41:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:41:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:41:49 INFO - 'PWD': '/builds/slave/test', 11:41:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:41:49 INFO - 'SHELL': '/bin/bash', 11:41:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:41:49 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:41:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:41:49 INFO - 'USER': 'cltbld', 11:41:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:41:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:41:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:41:49 INFO - 'XPC_FLAGS': '0x0', 11:41:49 INFO - 'XPC_SERVICE_NAME': '0', 11:41:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:41:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:41:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:41:49 INFO - Cleaning up... 11:41:49 INFO - Return code: 0 11:41:49 INFO - Running post-action listener: _resource_record_post_action 11:41:49 INFO - Running post-action listener: _start_resource_monitoring 11:41:49 INFO - Starting resource monitoring. 11:41:49 INFO - [mozharness: 2017-04-05 18:41:49.582944Z] Finished create-virtualenv step (success) 11:41:49 INFO - [mozharness: 2017-04-05 18:41:49.583882Z] Running install step. 11:41:49 INFO - Running pre-action listener: _resource_record_pre_action 11:41:49 INFO - Running main action method: install 11:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:41:49 INFO - Reading from file tmpfile_stdout 11:41:49 INFO - Detecting whether we're running mozinstall >=1.0... 11:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:41:49 INFO - Reading from file tmpfile_stdout 11:41:49 INFO - Output received: 11:41:49 INFO - Usage: mozinstall [options] installer 11:41:49 INFO - Options: 11:41:49 INFO - -h, --help show this help message and exit 11:41:49 INFO - -d DEST, --destination=DEST 11:41:49 INFO - Directory to install application into. [default: 11:41:49 INFO - "/builds/slave/test"] 11:41:49 INFO - --app=APP Application being installed. [default: firefox] 11:41:49 INFO - mkdir: /builds/slave/test/build/application 11:41:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:41:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:42:09 INFO - Reading from file tmpfile_stdout 11:42:09 INFO - Output received: 11:42:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:42:09 INFO - Running post-action listener: _resource_record_post_action 11:42:09 INFO - [mozharness: 2017-04-05 18:42:09.619850Z] Finished install step (success) 11:42:09 INFO - [mozharness: 2017-04-05 18:42:09.619967Z] Running run-tests step. 11:42:09 INFO - Running pre-action listener: _resource_record_pre_action 11:42:09 INFO - Running main action method: run_tests 11:42:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:42:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:42:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:42:09 INFO - 2017-04-05 11:42:09.634 screenresolution[1626:7499] starting screenresolution argv=screenresolution get 11:42:09 INFO - 2017-04-05 11:42:09.637 screenresolution[1626:7499] Display 0: 1600x1200x32@60 11:42:09 INFO - 2017-04-05 11:42:09.642 screenresolution[1627:7502] starting screenresolution argv=screenresolution list 11:42:09 INFO - Available Modes on Display 0 11:42:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:42:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:42:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:42:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:42:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:42:09 INFO - Intel Iris: 11:42:09 INFO - Chipset Model: Intel Iris 11:42:09 INFO - Type: GPU 11:42:09 INFO - Bus: Built-In 11:42:09 INFO - VRAM (Dynamic, Max): 1536 MB 11:42:09 INFO - Vendor: Intel (0x8086) 11:42:09 INFO - Device ID: 0x0a2e 11:42:09 INFO - Revision ID: 0x0009 11:42:09 INFO - Displays: 11:42:09 INFO - Display: 11:42:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:42:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:42:09 INFO - Display Serial Number: 1600x1200 60 11:42:09 INFO - Main Display: Yes 11:42:09 INFO - Mirror: Off 11:42:09 INFO - Online: Yes 11:42:09 INFO - Rotation: Supported 11:42:09 INFO - Return code: 0 11:42:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:42:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:42:09 INFO - Python 2.7.3 11:42:09 INFO - Return code: 0 11:42:09 INFO - grabbing minidump binary from tooltool 11:42:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:42:09 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 0x10c373d30>, '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 0x10c29adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c368be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:42:09 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 11:42:09 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 11:42:09 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 11:42:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:42:10 INFO - Return code: 0 11:42:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:42:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:42:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:42:10 INFO - ENV: RUST_BACKTRACE is now 1 11:42:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:42:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:42:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 11:42:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0168 --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 11:42:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0CrDuCTm9a/Render', 11:42:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:42:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:42:10 INFO - 'HOME': '/Users/cltbld', 11:42:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:42:10 INFO - 'LOGNAME': 'cltbld', 11:42:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:42:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:42:10 INFO - 'MOZ_NO_REMOTE': '1', 11:42:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:42:10 INFO - 'NO_EM_RESTART': '1', 11:42:10 INFO - 'PAGER': '/bin/cat', 11:42:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:42:10 INFO - 'PWD': '/builds/slave/test', 11:42:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:42:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:42:10 INFO - 'RUST_BACKTRACE': '1', 11:42:10 INFO - 'SHELL': '/bin/bash', 11:42:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cpCVBaJQL4/Listeners', 11:42:10 INFO - 'TMPDIR': '/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/', 11:42:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:42:10 INFO - 'USER': 'cltbld', 11:42:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:42:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:42:10 INFO - 'XPC_FLAGS': '0x0', 11:42:10 INFO - 'XPC_SERVICE_NAME': '0', 11:42:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:42:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0168', '--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 11:42:10 INFO - mozversion application_buildid: 20170405080221 11:42:10 INFO - mozversion application_changeset: 943472295ee61812ffea25699d548d53ca7bcb22 11:42:10 INFO - mozversion application_display_name: Nightly 11:42:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:42:10 INFO - mozversion application_name: Firefox 11:42:10 INFO - mozversion application_remotingname: firefox 11:42:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 11:42:10 INFO - mozversion application_vendor: Mozilla 11:42:10 INFO - mozversion application_version: 55.0a1 11:42:10 INFO - mozversion platform_buildid: 20170405080221 11:42:10 INFO - mozversion platform_changeset: 943472295ee61812ffea25699d548d53ca7bcb22 11:42:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 11:42:10 INFO - mozversion platform_version: 55.0a1 11:42:10 INFO - using testdate: 1491417730 11:42:10 INFO - actual date: 1491417730 11:42:10 INFO - starting webserver on 'localhost:49241' 11:42:10 INFO - SUITE-START | Running 2 tests 11:42:10 INFO - TEST-START | dromaeo_css 11:42:10 INFO - operating with platform_type : mac_ 11:42:10 INFO - Initialising browser for dromaeo_css test... 11:42:10 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpe46NdH/profile http://localhost:49241/getInfo.html) 11:42:13 INFO - PID 1637 | __metrics Screen width/height:1600/1200 11:42:13 INFO - PID 1637 | colorDepth:24 11:42:13 INFO - PID 1637 | Browser inner width/height: 1024/689 11:42:13 INFO - PID 1637 | __metrics 11:42:13 INFO - PID 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:42:13 INFO - PID 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:42:14 INFO - TEST-INFO | 1637: exit 0 11:42:14 INFO - Browser initialized. 11:42:14 INFO - Running cycle 1/1 for dromaeo_css test... 11:42:14 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpe46NdH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:26 INFO - PID 1640 | RSS: Main: 239726592 11:42:26 INFO - PID 1640 | 11:45:32 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 11:45:33 INFO - PID 1640 | RSS: Main: 379535360 11:45:33 INFO - PID 1640 | 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 11:47:16 INFO - PID 1640 | 11:47:16 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:16 INFO - PID 1640 | Full stack: 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 11:47:16 INFO - PID 1640 | 11:47:16 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:16 INFO - PID 1640 | Full stack: 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 11:47:16 INFO - PID 1640 | 11:47:16 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:16 INFO - PID 1640 | Full stack: 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | ************************* 11:47:16 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 11:47:16 INFO - PID 1640 | 11:47:16 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:47:16 INFO - PID 1640 | Full stack: 11:47:16 INFO - PID 1640 | ************************* 11:48:36 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 11:48:37 INFO - PID 1640 | RSS: Main: 365297664 11:48:37 INFO - PID 1640 | 11:51:39 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 11:51:40 INFO - PID 1640 | RSS: Main: 358227968 11:51:40 INFO - PID 1640 | 11:54:42 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 11:54:42 INFO - PID 1640 | RSS: Main: 354496512 11:54:42 INFO - PID 1640 | 11:57:46 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 11:57:47 INFO - PID 1640 | RSS: Main: 336334848 11:57:47 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 12:00:50 INFO - PID 1640 | RSS: Main: 431476736 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | __start_tp_report 12:00:50 INFO - PID 1640 | _x_x_mozilla_page_load 12:00:50 INFO - PID 1640 | _x_x_mozilla_page_load_details 12:00:50 INFO - PID 1640 | |i|pagename|runs| 12:00:50 INFO - PID 1640 | |0;dojo.html;3245.464498357771;3321.3689399014183;3346.0129261867746;3479.2519608284215;3492.3189977954294;6093.383632334788;6179.752809887599;6219.844503887405;6222.84442888928;6227.750889964396;6153.999999999989;6166.938330616704;6227.28386235583;6228.875422491547;6246.09431632413;4017.5178978522617;4599.379083823691;5287.259783630295;5408.945910540903;5460.781568737266;5504;5546.750396232179;5554.1113421852515;5563.8887222255535;5571.164325351189;5330.0405926932945;5420.159875219308;5426.321709786277;5436.157395603688;5437.401885792559;5403.567714582824;5446.537044351235;5462.289902312674;5510.393856675762;5539.390667026624;5380.300560927054;5400.405955344909;5423.810166644188;5441.945580544183;5486.094794358926;6112.685862051835;6163.2604087509335;6184.87630247397;6204.286507051702;6217.409346112157;6597.703103360361;6651.86696266072;6684.364985326386;6704.731810727565;6710.3289671033;6766.120404347453;6773.8983915241315;6775.322467753234;6780.762673306411;6792.558483698544;6169.074638804171;6269.028300613412;6279.026750853625;6290.874182516324;6293.842653933688;6686;6761.188657361148;6780.1524809398825;6819.727210911508;6949.756758513528;6562.901556476561;6598.967005165039;6602.702878370389;6603.8349041273395;6607.041978913031;6688.063671086052;6749.797506074728;6757.054012438262;6765.1205343305055;6766.69549870257;6392.296847346788;6468.3855033771715;6476.579022363531;6662.833429164213;6689.331066893272;6447.709853056624;6478.643674597943;6480.319566445455;6486.254080780676;6496.707648155844;5267.683938963674;5329.387120481117;5372.946270537323;5404.108322126805;5411.78352865881;4667.463241727245;4740.028294199681;4743.620510359163;4743.715377077387;4776.928346074812;6292.590981586182;6307.747690092437;6315.463185629273;6329.367063293726;6330.778422755181;6483.448906842971;6592.571482853599;6603.70283337251;6678.766243181465;6772.153480814898;6283.7800676976085;6288.9056664150075;6323.557350985387;6326.4622507087415;6334.3665633436285;5955.434233747787;5979.402059793986;5980.312264089685;5985.952458319776;6006.069059295816;6753.257141714505;6861.759838405632;6985.057017302701;7027.22700502934;7034.47241456903;6118.265808103056;6613.966930165318;6615.338466153346;6768.492363072691;6784.728610855511;5680.71596420169;6997.405220556309;7035.155781306276;7038.894416583653;7041.119860017498;5758.539316854558;6647.767328143492;6666.633335166613;6671.099401580725;6673.432758215606;5626.35296940857;6480.967595161994;6587.4071333580205;6621.205455345389;6718;6508.186476690414;6511;6521.771737989147;6529.542931994904;6535.44448721864;6485.481161506974;6524.412802847577;6533.803985880431;6548.377904099103;6549.672516374258;6269.62382257066;6319.431251187231;6330.683465826598;6334.3665633436285;6590.044443555754;6520;6539.084528165966;6540.672966351568;6544.901826472702;6551.279359270572;6349.6507692077375;6351.555391122577;6366.777162799465;6377.489800816016;6378.1070650108095 12:00:50 INFO - PID 1640 | |1;ext.html;770.2643975003872;803.879418087287;822.5640410582394;1131.1911982932206;1155.4396117882832;28679.569806452895;30482.54276185859;38503.614963850356;38914;39038.414423783666;41077.892210778904;41493.792531037376;41516.792416037955;41553;41561.16877662445;6110.572259941806;8521.70174043907;8708.608112634947;8733.563321833915;8734.781630459225;6197.349278325756;6280.309165991737;6291.307956124822;6291.559590828644;6295.937040629604;8452.8732069019;8643.827123457559;8666.610002549869;8666.956665216665;8670.046294907555;8631.525266110362;8690.652373905035;8692.565371731389;8713.651453941835;8717.346199035066;8415.789605259917;8506.404551681384;8516.957415212946;8524.957375213145;8533.01870284919;38490.80754596209;38744.806275968724;38766.41850372247;38832.805835970925;39013;3408.437607794711;3439.724822014233;3442.845071971742;3445.414279572479;3455.153487395579;30499.93250236253;30565.847170764227;30579.23551911198;30593.694063059305;30643.846780765954;3075.600171977651;3097.767667424952;3110.3779244151033;3119;3136.419762343951;315276.4236178827;325567;328616;329185.35407323047;329275;50525.24212136821;50630.911672365895;50655.49344506581;50699.746501268;50767.73080673013;52958.73520632372;53010.73494632579;53028.46971530312;53041.469585303654;53041.469585304425;13876.58370248894;14279.428822847178;14288.14271143714;14288.285585720672;14290.57128286153;11618.128640352008;11620.07039436843;11624.825627615592;11647.6505704829;11655.708607284885;10798;10937.179711521667;10962.506687199095;12450.758863404493;12518.436670349856;4648.442186937522;4881.925976285212;5149.485051494896;5412.5940554458575;5425.321834770653;801.8235988082613;871.5816408124009;926.2589928057527;963.4989805301204;1021.5045702834119;19453.51366215856;24316.392090197533;24376;24428.26715198547;24585.754142458347;1070.2240875365299;1073.436445865911;1108.7449886526144;1110.4114819145866;1116.9385683787307;11883.58407455735;12511.874881251253;12517.186382885084;12519.749605007848;12557.56048538315;417896;419752;420413;420496;420979;54729.726351367986;54883;54905.45094549003;54940;55013;1449;1475.129673492623;1508.0725353907487;1521.5663535892438;1528.671335662838;17583;22112.889435553363;23735.52528949377;23885.044598216573;23941.16205932784;38853;38885.80557097196;38948;38977.025574360865;38999.02502437462;419545;421506;422479;422601;422746;33035.669643303256;33786.60774099352;33816.83091584625;33837;33875.49186762151;42721.78639106909;43661;43745;43958.12083758371;44065.898352541444;29197.562036569892;30502;30826.229344266572;30953.845230773702;31443.585038673773;29831.701682982894;30116.849415752782;30696.693033070278;30908.69091309058;30955.845220773754;36494.8175259122;37116.6288337124;37143;37340.813295933345;37346.81326593459;29781.70218297876;30319.696803031686;30861.38277234398;31443.056708298787;31663;24217.152399665927;24379;24488.89799959042;24609.753902460747;24614.753852461246 12:00:50 INFO - PID 1640 | |2;jquery.html;387.66467006039784;426.75420599097254;431.45636498012493;435.67977536510665;455.2442944711779;13867.791983120262;18950.526236844053;21889.014994325255;22183.889080554596;22410.663840042373;21556.568868622617;22172.55654886901;22745.431364215903;22869.656955145685;22986.310410687664;5937.940620593782;6050.1227322038385;6161.969190154043;6288;6292.71682774274;6104.725287362079;6221.191245138126;6236.189295391593;6242.344553821851;6258.749650013994;6062.302835173968;6133.631982081067;6143.969280153593;6209.534284928626;6236.095766113911;5964.254468191476;6082.969585152068;6135.171751813493;6135.631862088289;6145.8156255312415;5060;5369.167778994262;5463.125899856043;5480.068388373986;5483.232347471358;26169.214923552325;26226.475470490674;26427.603585946224;27059;27433.588496172575;2092.204962114402;2178.6949827024227;2183.290430610058;2183.4541364658835;2184.6613774864923;17145.742813857803;17489.562760930952;17499;18099.819001809945;18306.450806475696;2043.7343145391153;2106.0733277357913;2134.1676746069047;2144.8069673729437;2147.967780483294;146595.26702366528;146855;149275;149423;152364.9999999989;11246.66260012201;11601;12083.516659333704;12165.574204902787;12173.513059477698;15088.170150641601;15114.395424182909;15116.470923517623;15149.924250378677;15162.924185379003;7890.842183156305;8140.104588495261;8866.556672166365;8961.372703910794;8982.281417486585;8183.304419124441;8296.25333719956;8303.1281715419;8471.661133554711;8482.575871206414;6043.184170137063;7500.437467189982;7676.462647614613;7683.231676832272;7697.114831794303;2113.545587698652;2133.445304220914;2138.3050508584774;2142.5714857028347;2302.873341966208;913.862920561921;918.5223683684446;923.584387025841;960.0639376607891;961.9134277915022;19605.90197049034;20419;20541.38375848727;20558.897205513877;20662.793372066386;936.8149291146705;957.698325027614;960.8174446855076;1001.249063202598;1004.7990401919645;9738.659146929966;10053.497325133714;10295.815981162112;10508.632197873038;10596.788064238672;669928;671159;671270.436478184;697763.511182451;713462;143199.28400357932;151686.24156879366;154891;156821;162334;1167.9532818687328;1169.9649010529697;1202.4228370382266;1203.5847632566574;1205.4153735438306;17469.82530174682;17990.830596011216;17999.10004499796;18092;18155.001474919005;62113.273203607925;62486.68756656188;62542;63155.36844631495;63313.417164571256;88542.67185992087;89599.17605355631;90165.54917225371;91162;91763;6869.210040845167;8112.878306825284;8438.451500652684;8513.574321283788;8725.432846864933;13378.665533361744;13563;13710.45158193701;13980.720385592027;13991.58025259244;11705.707357316136;11807.940960295144;11954;11973.341466219441;11995;10561.10230630405;10576.20678449104;10734.73163170927;10933.453327333442;11106.389148596905;10512.159027277647;11544.422778861192;11841.703957401134;11863.466144023367;11996.40017999114;8299.751007469786;8309.044459886949;8671.696490622799;8698.173673501007;8819.073997230455;11676.299422034705;11683;11969.401529923294;12037.097217708531;12129.818052729039 12:00:50 INFO - PID 1640 | |3;mootools.html;1201.2612243470267;1290.7999260114673;1291.6577107066623;1448.2758620689656;1472.970540589188;11142.49858756356;11646.883531164685;11650.708732281686;11663.650090497287;11677.883221167785;11272.210945233837;11708.824367634492;11759.35323557204;11774.882251177485;11780.116491263147;2492.962605560918;2534.4170840706647;2540.4792017636432;2540.530001949636;2549.3244290263096;2101.8318534517202;2389.0563227525117;2457.741937096597;2492.289697436231;2495.9126430574843;2162.9891850540803;2195;2420.854748715074;2505.285993491855;2505.8621775802326;2433.8783060846886;2456.0421435640114;2469.4567195217205;2470.8641024743633;2473.826832121752;2445.144199530168;2459.274514018369;2461.1386014894824;2462.9261122166185;2465.0509553821908;11389.316641001484;11685.2404593702;11704.47329870158;11708.590199342982;11765.823512647317;6425.807225783234;6685.19777626683;6690.498212634072;6690.63201523916;6703.798886033378;3914.197589494147;4125.773082480462;4276.166147601219;4293.957060429387;4299.677524185668;1112.9371450265057;1166.632510759108;1189.9464524096436;1234.4568389908502;1240.1690867119053;14531;16158.919205404016;16171.595710107224;16180.271887765079;16188.514344569681;5286.154215325606;5442.0749970049155;5451.2640793493165;5568.638038527482;5581.3302403711;11907.761844763056;11913.702157446132;11965.581204657969;11982.58060967862;11988.580399686143;6318.462930650854;6450.838729031718;6451.516136289797;6453.870922581522;6467.51493637979;5737.340205876378;5972.25346831646;6061.818145455643;6113.755449781959;6117.235345581802;4161.292580261363;4240.5123410808155;4250.4474418326035;4304.48346198452;4314.590113939171;1160.0214341000594;1163.139276935062;1254.0657210378145;1274.6749578857332;1275.4706796679275;582.9741647774036;724.4530379563396;726.920038795732;731.4587205468022;762.8359902620853;6248.687775567182;6554.7378104876225;6692.431143352869;6775.22084960226;6857.897131543031;563.9774409023676;585.689584520205;592.3750443282379;593.1103344982527;700.0059914920723;3570.285942811448;3780.7920564369224;3916.8629097981434;4098;4144.171165766858;11992.280463172237;14351.210683412304;15069.849301507064;15151.090934543963;15190.696186076437;14765.261736913111;14983.850161498463;15051.322690478955;15327.770083448757;15334.386624534895;10620.150387969099;10627.84058239127;10864.185186111074;11020.724481888017;11045.226834121535;6297.811065668037;6496.512761542997;6656;6700.66496675174;6730.0446640216405;13351.666208344868;13366.06437549401;13481.528146514825;13599.728005439638;13755.31223438844;13756.65608359799;13845.515406960709;13874.306284685927;13927.094738841943;13953.232572208626;8383.245507904317;8587.95706021466;8588.871166932377;8595.18345757152;8608.225259726654;10461.476926153815;10553.63062292816;10683;10688.946555267485;10693.05940866268;7205.819854503679;8934.374593778373;8961.686340978034;9027.4132181408;9208.861867072133;8634.654613815628;8771.868421973802;8829.867551986854;8877.201051905102;8919.910800891908;7980.840383192188;8068.99137607799;8136.633851476579;8154.38842086834;8166.265036146775;5847.853803654943;5861.413858614275;6058.909116363347;6142.969285153546;6174.320824709368;5955.464008239279;5965.73154208053;6168.506519478521;6185.84535386619;6188.3910183353555 12:00:50 INFO - PID 1640 | |4;prototype.html;383.6700437623644;384.97112716546246;393.85033687198865;407.694229328004;409.74186262654507;5620.803271885485;5843.298804143508;5920.28956525217;6035.879282414355;6047.516198704104;4839.806407743695;5082.3990443010425;5717.742701578429;5732.31212254529;5839.299284085916;4119.917601647972;4542.6593005524555;4546.727196368212;4554.362389265505;4570.360149579062;3422.7775194612395;4349.456317960255;4401.493828209765;4562.657800664947;4600.700954437968;3965.662918651918;4064.2074795414906;4273.884427208521;4303.935440968388;4318.67609929255;4195.15413218183;4199.580041995791;4214.836824889501;4262.445882035316;4324.632406245473;3720.2001569662384;3751.718621103428;3754;3763.6236376362417;3766.886993390203;4518.774061296922;5669.036263835117;5695.601307908448;5727.513161381287;5736.971315143439;5141.177411614124;5144.048351055029;5157.6647517911215;5157.7936882524655;5167.199084141964;6294.622322660655;6309.3690630936535;6315.494760419156;6332.936670633281;6350.174477317965;4096.467459230281;4213.4522512073545;4225.15496900618;4265.466816647919;4296.205202037633;5699.458551437649;6568.507361947825;6576.967115164442;6605.735770569219;6636.834079148011;4291.914161716811;4292.441982542312;4296.82812687489;4308.4399028126145;4321.416608757778;4003.179348233605;4202.579742025773;4332.67504937131;4362.672799540047;4364.148990946798;4267.338562522814;4953.628477864175;5065.341505604248;5101.8724531887;5121.129408000649;5498.5876059295715;5970.552208584373;6145.784897528654;6243.96878015607;6301.684915754194;1413.639521921924;1461;1474.506040476431;1492.671612245326;1496.7231062253518;947.6825263536792;973.2408721197477;988.3526290279734;997.1922742578535;1001.1990407673977;5830.533557315404;5837.09525023622;5867.765289388377;5889.851478961647;5890.2342695449315;5756.539476841843;6443.162388889415;6443.871122577522;6444.452221561126;6493.318201588765;5548.77804887808;5800.274965629296;5849.590528662953;5850.0932355484965;5864.648121112661;3326.4511355626532;3371.359441706068;3385.6614338565946;3389.8305084745666;3396.3546926083964;5790.247267855152;5862.391235899983;6473.480594034693;6697.464202863759;6772.525923185428;5746.4253574643035;5791.913121303184;6556.508261880378;6573.244076931119;6578.868422631521;5850.444207800252;6370.8213980413775;6608.933910660832;6663.833404164838;6665.300143484961;5712.08606622955;5821.970890145522;6042.5285288885025;6385.499407639294;6421.325760795236;5592.608517403743;5597.860053498533;6305.337939516285;6327.936720632735;6353.237611486651;5450.509454149145;6417.005364168562;6635.369639884203;6635.933640663531;6669.199696036507;4212.945614429636;4221.746695198298;4235.936460953027;4238.851640192578;4251.511076226274;6273.247210334789;6290.150829637941;6293.276273228455;6306.621602703853;6499.5775274607;5451.100568406168;5476.2333273342565;5701.8859622806485;5749.310082790092;6209.181353467675;6018.849528761641;6202.224721909762;6204.410580994799;6213.471854892204;6278.215223097113;4702.858914232578;5745.712714364348;5874.882502350015;6069.848253793691;6190.380961903774;6308.463780578702;6317.368263173646;6324.810255692337;6353.904691429725;6361.236651601837;5867.442592953663;6089.786857459968;6157.138000679998;6176.258848938156;6192.81421557354 12:00:50 INFO - PID 1640 | |5;yui.html;767.7926959720876;792.5680504125247;827;827.8261565071334;837.2799392522431;15954.28205730742;16036.518904432856;16577;16637.83362166378;16777.412790552335;12140.81788773167;15282.083075015507;15348.61628459289;15378.615534611612;15480.535583932471;948.2840455456121;985.0494273026528;985.3939827006375;986.0977205856633;986.5659109991617;977.9413235205875;987.8863930647996;1023.0894503891542;1027.7533391985908;1032.1742605915238;1036.9992956796689;1046.7697106636529;1048.8269435543164;1049.595905576351;1051.1328154272717;1036.8289232276666;1042.1766804224728;1046.2989796836139;1046.931949423285;1050.3802756373739;770.2567022823002;776.4370831147429;776.8718161503401;778.7352300217954;779.9142094369671;16476.340946362132;16823.41118060862;16887.66224675512;17077.316907323817;17308;14806.629834254121;14904.153592195518;14910.850891491054;15088.321025553767;15802.288896999662;13469.057165998383;13607.523736669169;13616.114952528054;13617.182969021891;13620.863791362059;3376.5104059911178;3377.3583019226267;3379.7972121672533;3380.5267262583257;3448;92402;115713.4214328923;116970;120433;121159.3942030293;11218.66344009681;11296.739054950884;11408.258463199865;11621.88378116208;12103.273803571637;24732.876335618566;24734.628980565307;24746.628800568007;24848;24989.00043998256;6787.321267873173;7699.153093159748;7764.883526747103;7965.243301886311;8077.07483231033;3479.8956031319103;4220.344966462931;4245.936310955338;4254.553271906467;4263.445752052214;4206.47419072616;4291.034517233597;4319.568043195655;4321.719088259316;4335.284678028153;813.7396033269297;868.1015149320423;877.0045997792552;877.8814859993819;878.9648414063494;548.8380927626359;621.9378062193745;625.6371304643296;642;668.9665516724144;9354.532273386303;9897.109260166619;9936.403815771077;10121.1903047756;10167.339122956984;503.8790690234317;558.9804356847491;590.754836742747;607.7751232044172;625.7590827531433;4623.838165664186;4625.861224163281;4629.074185162981;4629.513901040342;4818.6626936114135;97162;97231;97811.51094244483;98018.50990745;99719;71090.2890971094;83534;83771;86196;86899;60116.69941650264;68311.65844170748;73783;74920.25079749242;77036.61481692668;9168.659961273048;10815.891841081488;10844.735780355822;11042.503087360927;11104.389258590854;36998.44502332414;37882.62117378901;38172.809135955256;38249.61750382461;38870.91855355147;38851.417228741026;41331;49410.77651505619;49844.50155498399;50900;13203.405846736729;13253.734925301633;13837.446502139801;13936.790948135584;14132.434702611781;12039.053661405522;13833.377498012413;14590.85409145895;14866.702665946405;15017.549473515812;13587.59237222885;13647.454101835816;13736.587902362946;14173.433062677377;14312.928435357757;13700;13709.725805484033;13733.313334333043;13903.721925561229;14025.0182487229;13432.529861454803;13535.052546321664;13600.319984000562;13621.318934053455;13635;9439.480828554495;9528.428294302365;10242.334248273839;10312.48437578133;10353.896461035294;9667.323287369816;10034.49827508607;10544.630937917136;11229.606963756229;11241.437928103725 12:00:50 INFO - PID 1640 | __end_tp_report 12:00:50 INFO - PID 1640 | __start_cc_report 12:00:50 INFO - PID 1640 | _x_x_mozilla_cycle_collect,1399 12:00:50 INFO - PID 1640 | __end_cc_report 12:00:50 INFO - PID 1640 | __startTimestamp1491418850744__endTimestamp 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | ------- Summary: start ------- 12:00:50 INFO - PID 1640 | Number of tests: 6 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6134.28 Median:6334.37 stddev:756.47 (11.9%) stddev-sans-first:724.05 12:00:50 INFO - PID 1640 | Values: 3245.5 3321.4 3346.0 3479.3 3492.3 6093.4 6179.8 6219.8 6222.8 6227.8 6154.0 6166.9 6227.3 6228.9 6246.1 4017.5 4599.4 5287.3 5408.9 5460.8 5504.0 5546.8 5554.1 5563.9 5571.2 5330.0 5420.2 5426.3 5436.2 5437.4 5403.6 5446.5 5462.3 5510.4 5539.4 5380.3 5400.4 5423.8 5441.9 5486.1 6112.7 6163.3 6184.9 6204.3 6217.4 6597.7 6651.9 6684.4 6704.7 6710.3 6766.1 6773.9 6775.3 6780.8 6792.6 6169.1 6269.0 6279.0 6290.9 6293.8 6686.0 6761.2 6780.2 6819.7 6949.8 6562.9 6599.0 6602.7 6603.8 6607.0 6688.1 6749.8 6757.1 6765.1 6766.7 6392.3 6468.4 6476.6 6662.8 6689.3 6447.7 6478.6 6480.3 6486.3 6496.7 5267.7 5329.4 5372.9 5404.1 5411.8 4667.5 4740.0 4743.6 4743.7 4776.9 6292.6 6307.7 6315.5 6329.4 6330.8 6483.4 6592.6 6603.7 6678.8 6772.2 6283.8 6288.9 6323.6 6326.5 6334.4 5955.4 5979.4 5980.3 5986.0 6006.1 6753.3 6861.8 6985.1 7027.2 7034.5 6118.3 6614.0 6615.3 6768.5 6784.7 5680.7 6997.4 7035.2 7038.9 7041.1 5758.5 6647.8 6666.6 6671.1 6673.4 5626.4 6481.0 6587.4 6621.2 6718.0 6508.2 6511.0 6521.8 6529.5 6535.4 6485.5 6524.4 6533.8 6548.4 6549.7 6269.6 6319.4 6330.7 6334.4 6590.0 6520.0 6539.1 6540.7 6544.9 6551.3 6349.7 6351.6 6366.8 6377.5 6378.1 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:52589.37 Median:36805.72 stddev:103822.72 (282.1%) stddev-sans-first:104041.07 12:00:50 INFO - PID 1640 | Values: 770.3 803.9 822.6 1131.2 1155.4 28679.6 30482.5 38503.6 38914.0 39038.4 41077.9 41493.8 41516.8 41553.0 41561.2 6110.6 8521.7 8708.6 8733.6 8734.8 6197.3 6280.3 6291.3 6291.6 6295.9 8452.9 8643.8 8666.6 8667.0 8670.0 8631.5 8690.7 8692.6 8713.7 8717.3 8415.8 8506.4 8517.0 8525.0 8533.0 38490.8 38744.8 38766.4 38832.8 39013.0 3408.4 3439.7 3442.8 3445.4 3455.2 30499.9 30565.8 30579.2 30593.7 30643.8 3075.6 3097.8 3110.4 3119.0 3136.4 315276.4 325567.0 328616.0 329185.4 329275.0 50525.2 50630.9 50655.5 50699.7 50767.7 52958.7 53010.7 53028.5 53041.5 53041.5 13876.6 14279.4 14288.1 14288.3 14290.6 11618.1 11620.1 11624.8 11647.7 11655.7 10798.0 10937.2 10962.5 12450.8 12518.4 4648.4 4881.9 5149.5 5412.6 5425.3 801.8 871.6 926.3 963.5 1021.5 19453.5 24316.4 24376.0 24428.3 24585.8 1070.2 1073.4 1108.7 1110.4 1116.9 11883.6 12511.9 12517.2 12519.7 12557.6 417896.0 419752.0 420413.0 420496.0 420979.0 54729.7 54883.0 54905.5 54940.0 55013.0 1449.0 1475.1 1508.1 1521.6 1528.7 17583.0 22112.9 23735.5 23885.0 23941.2 38853.0 38885.8 38948.0 38977.0 38999.0 419545.0 421506.0 422479.0 422601.0 422746.0 33035.7 33786.6 33816.8 33837.0 33875.5 42721.8 43661.0 43745.0 43958.1 44065.9 29197.6 30502.0 30826.2 30953.8 31443.6 29831.7 30116.8 30696.7 30908.7 30955.8 36494.8 37116.6 37143.0 37340.8 37346.8 29781.7 30319.7 30861.4 31443.1 31663.0 24217.2 24379.0 24488.9 24609.8 24614.8 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:40092.03 Median:22297.28 stddev:115021.99 (515.9%) stddev-sans-first:115306.02 12:00:50 INFO - PID 1640 | Values: 387.7 426.8 431.5 435.7 455.2 13867.8 18950.5 21889.0 22183.9 22410.7 21556.6 22172.6 22745.4 22869.7 22986.3 5937.9 6050.1 6162.0 6288.0 6292.7 6104.7 6221.2 6236.2 6242.3 6258.7 6062.3 6133.6 6144.0 6209.5 6236.1 5964.3 6083.0 6135.2 6135.6 6145.8 5060.0 5369.2 5463.1 5480.1 5483.2 26169.2 26226.5 26427.6 27059.0 27433.6 2092.2 2178.7 2183.3 2183.5 2184.7 17145.7 17489.6 17499.0 18099.8 18306.5 2043.7 2106.1 2134.2 2144.8 2148.0 146595.3 146855.0 149275.0 149423.0 152365.0 11246.7 11601.0 12083.5 12165.6 12173.5 15088.2 15114.4 15116.5 15149.9 15162.9 7890.8 8140.1 8866.6 8961.4 8982.3 8183.3 8296.3 8303.1 8471.7 8482.6 6043.2 7500.4 7676.5 7683.2 7697.1 2113.5 2133.4 2138.3 2142.6 2302.9 913.9 918.5 923.6 960.1 961.9 19605.9 20419.0 20541.4 20558.9 20662.8 936.8 957.7 960.8 1001.2 1004.8 9738.7 10053.5 10295.8 10508.6 10596.8 669928.0 671159.0 671270.4 697763.5 713462.0 143199.3 151686.2 154891.0 156821.0 162334.0 1168.0 1170.0 1202.4 1203.6 1205.4 17469.8 17990.8 17999.1 18092.0 18155.0 62113.3 62486.7 62542.0 63155.4 63313.4 88542.7 89599.2 90165.5 91162.0 91763.0 6869.2 8112.9 8438.5 8513.6 8725.4 13378.7 13563.0 13710.5 13980.7 13991.6 11705.7 11807.9 11954.0 11973.3 11995.0 10561.1 10576.2 10734.7 10933.5 11106.4 10512.2 11544.4 11841.7 11863.5 11996.4 8299.8 8309.0 8671.7 8698.2 8819.1 11676.3 11683.0 11969.4 12037.1 12129.8 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:7069.95 Median:2520.14 stddev:4518.45 (179.3%) stddev-sans-first:4509.61 12:00:50 INFO - PID 1640 | Values: 1201.3 1290.8 1291.7 1448.3 1473.0 11142.5 11646.9 11650.7 11663.7 11677.9 11272.2 11708.8 11759.4 11774.9 11780.1 2493.0 2534.4 2540.5 2540.5 2549.3 2101.8 2389.1 2457.7 2492.3 2495.9 2163.0 2195.0 2420.9 2505.3 2505.9 2433.9 2456.0 2469.5 2470.9 2473.8 2445.1 2459.3 2461.1 2462.9 2465.1 11389.3 11685.2 11704.5 11708.6 11765.8 6425.8 6685.2 6690.5 6690.6 6703.8 3914.2 4125.8 4276.2 4294.0 4299.7 1112.9 1166.6 1189.9 1234.5 1240.2 14531.0 16158.9 16171.6 16180.3 16188.5 5286.2 5442.1 5451.3 5568.6 5581.3 11907.8 11913.7 11965.6 11982.6 11988.6 6318.5 6450.8 6451.5 6453.9 6467.5 5737.3 5972.3 6061.8 6113.8 6117.2 4161.3 4240.5 4250.4 4304.5 4314.6 1160.0 1163.1 1254.1 1274.7 1275.5 583.0 724.5 726.9 731.5 762.8 6248.7 6554.7 6692.4 6775.2 6857.9 564.0 585.7 592.4 593.1 700.0 3570.3 3780.8 3916.9 4098.0 4144.2 11992.3 14351.2 15069.8 15151.1 15190.7 14765.3 14983.9 15051.3 15327.8 15334.4 10620.2 10627.8 10864.2 11020.7 11045.2 6297.8 6496.5 6656.0 6700.7 6730.0 13351.7 13366.1 13481.5 13599.7 13755.3 13756.7 13845.5 13874.3 13927.1 13953.2 8383.2 8588.0 8588.9 8595.2 8608.2 10461.5 10553.6 10683.0 10688.9 10693.1 7205.8 8934.4 8961.7 9027.4 9208.9 8634.7 8771.9 8829.9 8877.2 8919.9 7980.8 8069.0 8136.6 8154.4 8166.3 5847.9 5861.4 6058.9 6143.0 6174.3 5955.5 5965.7 6168.5 6185.8 6188.4 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5043.98 Median:5734.64 stddev:1553.21 (27.1%) stddev-sans-first:1517.67 12:00:50 INFO - PID 1640 | Values: 383.7 385.0 393.9 407.7 409.7 5620.8 5843.3 5920.3 6035.9 6047.5 4839.8 5082.4 5717.7 5732.3 5839.3 4119.9 4542.7 4546.7 4554.4 4570.4 3422.8 4349.5 4401.5 4562.7 4600.7 3965.7 4064.2 4273.9 4303.9 4318.7 4195.2 4199.6 4214.8 4262.4 4324.6 3720.2 3751.7 3754.0 3763.6 3766.9 4518.8 5669.0 5695.6 5727.5 5737.0 5141.2 5144.0 5157.7 5157.8 5167.2 6294.6 6309.4 6315.5 6332.9 6350.2 4096.5 4213.5 4225.2 4265.5 4296.2 5699.5 6568.5 6577.0 6605.7 6636.8 4291.9 4292.4 4296.8 4308.4 4321.4 4003.2 4202.6 4332.7 4362.7 4364.1 4267.3 4953.6 5065.3 5101.9 5121.1 5498.6 5970.6 6145.8 6244.0 6301.7 1413.6 1461.0 1474.5 1492.7 1496.7 947.7 973.2 988.4 997.2 1001.2 5830.5 5837.1 5867.8 5889.9 5890.2 5756.5 6443.2 6443.9 6444.5 6493.3 5548.8 5800.3 5849.6 5850.1 5864.6 3326.5 3371.4 3385.7 3389.8 3396.4 5790.2 5862.4 6473.5 6697.5 6772.5 5746.4 5791.9 6556.5 6573.2 6578.9 5850.4 6370.8 6608.9 6663.8 6665.3 5712.1 5822.0 6042.5 6385.5 6421.3 5592.6 5597.9 6305.3 6327.9 6353.2 5450.5 6417.0 6635.4 6635.9 6669.2 4212.9 4221.7 4235.9 4238.9 4251.5 6273.2 6290.2 6293.3 6306.6 6499.6 5451.1 5476.2 5701.9 5749.3 6209.2 6018.8 6202.2 6204.4 6213.5 6278.2 4702.9 5745.7 5874.9 6069.8 6190.4 6308.5 6317.4 6324.8 6353.9 6361.2 5867.4 6089.8 6157.1 6176.3 6192.8 12:00:50 INFO - PID 1640 | 12:00:50 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:19541.08 Median:3376.93 stddev:27823.53 (823.9%) stddev-sans-first:27865.88 12:00:50 INFO - PID 1640 | Values: 767.8 792.6 827.0 827.8 837.3 15954.3 16036.5 16577.0 16637.8 16777.4 12140.8 15282.1 15348.6 15378.6 15480.5 948.3 985.0 985.4 986.1 986.6 977.9 987.9 1023.1 1027.8 1032.2 1037.0 1046.8 1048.8 1049.6 1051.1 1036.8 1042.2 1046.3 1046.9 1050.4 770.3 776.4 776.9 778.7 779.9 16476.3 16823.4 16887.7 17077.3 17308.0 14806.6 14904.2 14910.9 15088.3 15802.3 13469.1 13607.5 13616.1 13617.2 13620.9 3376.5 3377.4 3379.8 3380.5 3448.0 92402.0 115713.4 116970.0 120433.0 121159.4 11218.7 11296.7 11408.3 11621.9 12103.3 24732.9 24734.6 24746.6 24848.0 24989.0 6787.3 7699.2 7764.9 7965.2 8077.1 3479.9 4220.3 4245.9 4254.6 4263.4 4206.5 4291.0 4319.6 4321.7 4335.3 813.7 868.1 877.0 877.9 879.0 548.8 621.9 625.6 642.0 669.0 9354.5 9897.1 9936.4 10121.2 10167.3 503.9 559.0 590.8 607.8 625.8 4623.8 4625.9 4629.1 4629.5 4818.7 97162.0 97231.0 97811.5 98018.5 99719.0 71090.3 83534.0 83771.0 86196.0 86899.0 60116.7 68311.7 73783.0 74920.3 77036.6 9168.7 10815.9 10844.7 11042.5 11104.4 36998.4 37882.6 38172.8 38249.6 38870.9 38851.4 41331.0 49410.8 49844.5 50900.0 13203.4 13253.7 13837.4 13936.8 14132.4 12039.1 13833.4 14590.9 14866.7 15017.5 13587.6 13647.5 13736.6 14173.4 14312.9 13700.0 13709.7 13733.3 13903.7 14025.0 13432.5 13535.1 13600.3 13621.3 13635.0 9439.5 9528.4 10242.3 10312.5 10353.9 9667.3 10034.5 10544.6 11229.6 11241.4 12:00:50 INFO - PID 1640 | -------- Summary: end -------- 12:00:50 INFO - PID 1640 | 12:00:51 INFO - TEST-INFO | 1640: exit 0 12:00:51 INFO - TEST-OK | dromaeo_css | took 1121224ms 12:00:51 INFO - TEST-START | kraken 12:00:51 INFO - operating with platform_type : mac_ 12:00:51 INFO - Initialising browser for kraken test... 12:00:51 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpB6Xd2f/profile http://localhost:49241/getInfo.html) 12:00:53 INFO - PID 1651 | __metrics Screen width/height:1600/1200 12:00:53 INFO - PID 1651 | colorDepth:24 12:00:53 INFO - PID 1651 | Browser inner width/height: 1024/689 12:00:53 INFO - PID 1651 | __metrics 12:00:54 INFO - PID 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:00:54 INFO - PID 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:00:55 INFO - TEST-INFO | 1651: exit 0 12:00:55 INFO - Browser initialized. 12:00:55 INFO - Running cycle 1/1 for kraken test... 12:00:55 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/T/tmpB6Xd2f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:01:07 INFO - PID 1652 | RSS: Main: 239763456 12:01:07 INFO - PID 1652 | 12:01:10 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 12:01:11 INFO - PID 1652 | RSS: Main: 291893248 12:01:11 INFO - PID 1652 | 12:01:14 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 12:01:14 INFO - PID 1652 | RSS: Main: 294518784 12:01:14 INFO - PID 1652 | 12:01:18 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 12:01:18 INFO - PID 1652 | RSS: Main: 385871872 12:01:18 INFO - PID 1652 | 12:01:21 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 12:01:21 INFO - PID 1652 | RSS: Main: 289456128 12:01:21 INFO - PID 1652 | 12:01:23 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:01:24 INFO - PID 1652 | RSS: Main: 291942400 12:01:24 INFO - PID 1652 | 12:01:27 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 12:01:28 INFO - PID 1652 | RSS: Main: 332881920 12:01:28 INFO - PID 1652 | 12:01:31 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 12:01:32 INFO - PID 1652 | RSS: Main: 345042944 12:01:32 INFO - PID 1652 | 12:01:35 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 12:01:35 INFO - PID 1652 | RSS: Main: 349372416 12:01:35 INFO - PID 1652 | 12:01:37 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:01:38 INFO - PID 1652 | RSS: Main: 309739520 12:01:38 INFO - PID 1652 | 12:01:40 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:01:40 INFO - PID 1652 | RSS: Main: 311091200 12:01:40 INFO - PID 1652 | 12:01:42 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:01:43 INFO - PID 1652 | RSS: Main: 312840192 12:01:43 INFO - PID 1652 | 12:01:46 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:01:47 INFO - PID 1652 | RSS: Main: 331993088 12:01:47 INFO - PID 1652 | 12:01:50 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:01:51 INFO - PID 1652 | RSS: Main: 325988352 12:01:51 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 12:01:53 INFO - PID 1652 | RSS: Main: 388444160 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | __start_tp_report 12:01:53 INFO - PID 1652 | _x_x_mozilla_page_load 12:01:53 INFO - PID 1652 | _x_x_mozilla_page_load_details 12:01:53 INFO - PID 1652 | |i|pagename|runs| 12:01:53 INFO - PID 1652 | |0;ai-astar;111;123;123;119;122;123;122;121;124;122 12:01:53 INFO - PID 1652 | |1;audio-beat-detection;154;116;117;174;119;113;154;155;180;132 12:01:53 INFO - PID 1652 | |2;audio-dft;207;215;214;209;208;218;216;209;209;210 12:01:53 INFO - PID 1652 | |3;audio-fft;83;61;64;99;66;65;68;65;86;66 12:01:53 INFO - PID 1652 | |4;audio-oscillator;96;76;95;77;80;110;133;113;73;95 12:01:53 INFO - PID 1652 | |5;imaging-gaussian-blur;94;91;91;91;90;91;91;92;90;90 12:01:53 INFO - PID 1652 | |6;imaging-darkroom;99;100;99;99;98;99;101;100;100;99 12:01:53 INFO - PID 1652 | |7;imaging-desaturate;102;101;101;127;116;100;101;101;102;101 12:01:53 INFO - PID 1652 | |8;json-parse-financial;49;51;51;51;52;52;52;52;52;54 12:01:53 INFO - PID 1652 | |9;json-stringify-tinderbox;57;63;66;75;64;65;62;78;91;90 12:01:53 INFO - PID 1652 | |10;stanford-crypto-aes;90;92;94;92;90;91;91;89;92;89 12:01:53 INFO - PID 1652 | |11;stanford-crypto-ccm;158;163;151;151;151;146;150;149;203;161 12:01:53 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;202;200;199;201;199;203;200;197;201;215 12:01:53 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;71;72;75;71;73;74;73;72;73;72 12:01:53 INFO - PID 1652 | __end_tp_report 12:01:53 INFO - PID 1652 | __start_cc_report 12:01:53 INFO - PID 1652 | _x_x_mozilla_cycle_collect,2218 12:01:53 INFO - PID 1652 | __end_cc_report 12:01:53 INFO - PID 1652 | __startTimestamp1491418913431__endTimestamp 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | ------- Summary: start ------- 12:01:53 INFO - PID 1652 | Number of tests: 14 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:121.00 Median:122.50 stddev:3.77 (3.1%) stddev-sans-first:1.45 12:01:53 INFO - PID 1652 | Values: 111.0 123.0 123.0 119.0 122.0 123.0 122.0 121.0 124.0 122.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:154.00 stddev:25.15 (16.3%) stddev-sans-first:26.26 12:01:53 INFO - PID 1652 | Values: 154.0 116.0 117.0 174.0 119.0 113.0 154.0 155.0 180.0 132.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:211.50 Median:212.00 stddev:3.87 (1.8%) stddev-sans-first:3.74 12:01:53 INFO - PID 1652 | Values: 207.0 215.0 214.0 209.0 208.0 218.0 216.0 209.0 209.0 210.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:72.30 Median:67.00 stddev:12.54 (18.7%) stddev-sans-first:12.69 12:01:53 INFO - PID 1652 | Values: 83.0 61.0 64.0 99.0 66.0 65.0 68.0 65.0 86.0 66.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:78.50 stddev:19.40 (24.7%) stddev-sans-first:20.57 12:01:53 INFO - PID 1652 | Values: 96.0 76.0 95.0 77.0 80.0 110.0 133.0 113.0 73.0 95.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:91.10 Median:91.00 stddev:1.20 (1.3%) stddev-sans-first:0.67 12:01:53 INFO - PID 1652 | Values: 94.0 91.0 91.0 91.0 90.0 91.0 91.0 92.0 90.0 90.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:99.00 stddev:0.84 (0.9%) stddev-sans-first:0.88 12:01:53 INFO - PID 1652 | Values: 99.0 100.0 99.0 99.0 98.0 99.0 101.0 100.0 100.0 99.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:105.20 Median:101.50 stddev:8.99 (8.9%) stddev-sans-first:9.46 12:01:53 INFO - PID 1652 | Values: 102.0 101.0 101.0 127.0 116.0 100.0 101.0 101.0 102.0 101.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.26 (2.4%) stddev-sans-first:0.93 12:01:53 INFO - PID 1652 | Values: 49.0 51.0 51.0 51.0 52.0 52.0 52.0 52.0 52.0 54.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:70.50 stddev:11.91 (16.9%) stddev-sans-first:11.49 12:01:53 INFO - PID 1652 | Values: 57.0 63.0 66.0 75.0 64.0 65.0 62.0 78.0 91.0 90.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:91.50 stddev:1.56 (1.7%) stddev-sans-first:1.62 12:01:53 INFO - PID 1652 | Values: 90.0 92.0 94.0 92.0 90.0 91.0 91.0 89.0 92.0 89.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:158.30 Median:154.50 stddev:16.65 (10.8%) stddev-sans-first:17.66 12:01:53 INFO - PID 1652 | Values: 158.0 163.0 151.0 151.0 151.0 146.0 150.0 149.0 203.0 161.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.70 Median:201.00 stddev:4.97 (2.5%) stddev-sans-first:5.27 12:01:53 INFO - PID 1652 | Values: 202.0 200.0 199.0 201.0 199.0 203.0 200.0 197.0 201.0 215.0 12:01:53 INFO - PID 1652 | 12:01:53 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.00 stddev:1.26 (1.7%) stddev-sans-first:1.20 12:01:53 INFO - PID 1652 | Values: 71.0 72.0 75.0 71.0 73.0 74.0 73.0 72.0 73.0 72.0 12:01:53 INFO - PID 1652 | -------- Summary: end -------- 12:01:53 INFO - PID 1652 | 12:01:54 INFO - TEST-INFO | 1652: exit 0 12:01:54 INFO - TEST-OK | kraken | took 63246ms 12:01:54 INFO - SUITE-END | took 1184s 12:01:55 INFO - Completed test suite (00:19:44) 12:01:55 INFO - javascript benchmark 12:01:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7671.378859936584, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.464498357771, 3321.3689399014183, 3346.0129261867746, 3479.2519608284215, 3492.3189977954294, 6093.383632334788, 6179.752809887599, 6219.844503887405, 6222.84442888928, 6227.750889964396, 6153.999999999989, 6166.938330616704, 6227.28386235583, 6228.875422491547, 6246.09431632413, 4017.5178978522617, 4599.379083823691, 5287.259783630295, 5408.945910540903, 5460.781568737266, 5504.0, 5546.750396232179, 5554.1113421852515, 5563.8887222255535, 5571.164325351189, 5330.0405926932945, 5420.159875219308, 5426.321709786277, 5436.157395603688, 5437.401885792559, 5403.567714582824, 5446.537044351235, 5462.289902312674, 5510.393856675762, 5539.390667026624, 5380.300560927054, 5400.405955344909, 5423.810166644188, 5441.945580544183, 5486.094794358926, 6112.685862051835, 6163.2604087509335, 6184.87630247397, 6204.286507051702, 6217.409346112157, 6597.703103360361, 6651.86696266072, 6684.364985326386, 6704.731810727565, 6710.3289671033, 6766.120404347453, 6773.8983915241315, 6775.322467753234, 6780.762673306411, 6792.558483698544, 6169.074638804171, 6269.028300613412, 6279.026750853625, 6290.874182516324, 6293.842653933688, 6686.0, 6761.188657361148, 6780.1524809398825, 6819.727210911508, 6949.756758513528, 6562.901556476561, 6598.967005165039, 6602.702878370389, 6603.8349041273395, 6607.041978913031, 6688.063671086052, 6749.797506074728, 6757.054012438262, 6765.1205343305055, 6766.69549870257, 6392.296847346788, 6468.3855033771715, 6476.579022363531, 6662.833429164213, 6689.331066893272, 6447.709853056624, 6478.643674597943, 6480.319566445455, 6486.254080780676, 6496.707648155844, 5267.683938963674, 5329.387120481117, 5372.946270537323, 5404.108322126805, 5411.78352865881, 4667.463241727245, 4740.028294199681, 4743.620510359163, 4743.715377077387, 4776.928346074812, 6292.590981586182, 6307.747690092437, 6315.463185629273, 6329.367063293726, 6330.778422755181, 6483.448906842971, 6592.571482853599, 6603.70283337251, 6678.766243181465, 6772.153480814898, 6283.7800676976085, 6288.9056664150075, 6323.557350985387, 6326.4622507087415, 6334.3665633436285, 5955.434233747787, 5979.402059793986, 5980.312264089685, 5985.952458319776, 6006.069059295816, 6753.257141714505, 6861.759838405632, 6985.057017302701, 7027.22700502934, 7034.47241456903, 6118.265808103056, 6613.966930165318, 6615.338466153346, 6768.492363072691, 6784.728610855511, 5680.71596420169, 6997.405220556309, 7035.155781306276, 7038.894416583653, 7041.119860017498, 5758.539316854558, 6647.767328143492, 6666.633335166613, 6671.099401580725, 6673.432758215606, 5626.35296940857, 6480.967595161994, 6587.4071333580205, 6621.205455345389, 6718.0, 6508.186476690414, 6511.0, 6521.771737989147, 6529.542931994904, 6535.44448721864, 6485.481161506974, 6524.412802847577, 6533.803985880431, 6548.377904099103, 6549.672516374258, 6269.62382257066, 6319.431251187231, 6330.683465826598, 6334.3665633436285, 6590.044443555754, 6520.0, 6539.084528165966, 6540.672966351568, 6544.901826472702, 6551.279359270572, 6349.6507692077375, 6351.555391122577, 6366.777162799465, 6377.489800816016, 6378.1070650108095], "value": 6080.806750416023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.2643975003872, 803.879418087287, 822.5640410582394, 1131.1911982932206, 1155.4396117882832, 28679.569806452895, 30482.54276185859, 38503.614963850356, 38914.0, 39038.414423783666, 41077.892210778904, 41493.792531037376, 41516.792416037955, 41553.0, 41561.16877662445, 6110.572259941806, 8521.70174043907, 8708.608112634947, 8733.563321833915, 8734.781630459225, 6197.349278325756, 6280.309165991737, 6291.307956124822, 6291.559590828644, 6295.937040629604, 8452.8732069019, 8643.827123457559, 8666.610002549869, 8666.956665216665, 8670.046294907555, 8631.525266110362, 8690.652373905035, 8692.565371731389, 8713.651453941835, 8717.346199035066, 8415.789605259917, 8506.404551681384, 8516.957415212946, 8524.957375213145, 8533.01870284919, 38490.80754596209, 38744.806275968724, 38766.41850372247, 38832.805835970925, 39013.0, 3408.437607794711, 3439.724822014233, 3442.845071971742, 3445.414279572479, 3455.153487395579, 30499.93250236253, 30565.847170764227, 30579.23551911198, 30593.694063059305, 30643.846780765954, 3075.600171977651, 3097.767667424952, 3110.3779244151033, 3119.0, 3136.419762343951, 315276.4236178827, 325567.0, 328616.0, 329185.35407323047, 329275.0, 50525.24212136821, 50630.911672365895, 50655.49344506581, 50699.746501268, 50767.73080673013, 52958.73520632372, 53010.73494632579, 53028.46971530312, 53041.469585303654, 53041.469585304425, 13876.58370248894, 14279.428822847178, 14288.14271143714, 14288.285585720672, 14290.57128286153, 11618.128640352008, 11620.07039436843, 11624.825627615592, 11647.6505704829, 11655.708607284885, 10798.0, 10937.179711521667, 10962.506687199095, 12450.758863404493, 12518.436670349856, 4648.442186937522, 4881.925976285212, 5149.485051494896, 5412.5940554458575, 5425.321834770653, 801.8235988082613, 871.5816408124009, 926.2589928057527, 963.4989805301204, 1021.5045702834119, 19453.51366215856, 24316.392090197533, 24376.0, 24428.26715198547, 24585.754142458347, 1070.2240875365299, 1073.436445865911, 1108.7449886526144, 1110.4114819145866, 1116.9385683787307, 11883.58407455735, 12511.874881251253, 12517.186382885084, 12519.749605007848, 12557.56048538315, 417896.0, 419752.0, 420413.0, 420496.0, 420979.0, 54729.726351367986, 54883.0, 54905.45094549003, 54940.0, 55013.0, 1449.0, 1475.129673492623, 1508.0725353907487, 1521.5663535892438, 1528.671335662838, 17583.0, 22112.889435553363, 23735.52528949377, 23885.044598216573, 23941.16205932784, 38853.0, 38885.80557097196, 38948.0, 38977.025574360865, 38999.02502437462, 419545.0, 421506.0, 422479.0, 422601.0, 422746.0, 33035.669643303256, 33786.60774099352, 33816.83091584625, 33837.0, 33875.49186762151, 42721.78639106909, 43661.0, 43745.0, 43958.12083758371, 44065.898352541444, 29197.562036569892, 30502.0, 30826.229344266572, 30953.845230773702, 31443.585038673773, 29831.701682982894, 30116.849415752782, 30696.693033070278, 30908.69091309058, 30955.845220773754, 36494.8175259122, 37116.6288337124, 37143.0, 37340.813295933345, 37346.81326593459, 29781.70218297876, 30319.696803031686, 30861.38277234398, 31443.056708298787, 31663.0, 24217.152399665927, 24379.0, 24488.89799959042, 24609.753902460747, 24614.753852461246], "value": 17591.42179247707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.66467006039784, 426.75420599097254, 431.45636498012493, 435.67977536510665, 455.2442944711779, 13867.791983120262, 18950.526236844053, 21889.014994325255, 22183.889080554596, 22410.663840042373, 21556.568868622617, 22172.55654886901, 22745.431364215903, 22869.656955145685, 22986.310410687664, 5937.940620593782, 6050.1227322038385, 6161.969190154043, 6288.0, 6292.71682774274, 6104.725287362079, 6221.191245138126, 6236.189295391593, 6242.344553821851, 6258.749650013994, 6062.302835173968, 6133.631982081067, 6143.969280153593, 6209.534284928626, 6236.095766113911, 5964.254468191476, 6082.969585152068, 6135.171751813493, 6135.631862088289, 6145.8156255312415, 5060.0, 5369.167778994262, 5463.125899856043, 5480.068388373986, 5483.232347471358, 26169.214923552325, 26226.475470490674, 26427.603585946224, 27059.0, 27433.588496172575, 2092.204962114402, 2178.6949827024227, 2183.290430610058, 2183.4541364658835, 2184.6613774864923, 17145.742813857803, 17489.562760930952, 17499.0, 18099.819001809945, 18306.450806475696, 2043.7343145391153, 2106.0733277357913, 2134.1676746069047, 2144.8069673729437, 2147.967780483294, 146595.26702366528, 146855.0, 149275.0, 149423.0, 152364.9999999989, 11246.66260012201, 11601.0, 12083.516659333704, 12165.574204902787, 12173.513059477698, 15088.170150641601, 15114.395424182909, 15116.470923517623, 15149.924250378677, 15162.924185379003, 7890.842183156305, 8140.104588495261, 8866.556672166365, 8961.372703910794, 8982.281417486585, 8183.304419124441, 8296.25333719956, 8303.1281715419, 8471.661133554711, 8482.575871206414, 6043.184170137063, 7500.437467189982, 7676.462647614613, 7683.231676832272, 7697.114831794303, 2113.545587698652, 2133.445304220914, 2138.3050508584774, 2142.5714857028347, 2302.873341966208, 913.862920561921, 918.5223683684446, 923.584387025841, 960.0639376607891, 961.9134277915022, 19605.90197049034, 20419.0, 20541.38375848727, 20558.897205513877, 20662.793372066386, 936.8149291146705, 957.698325027614, 960.8174446855076, 1001.249063202598, 1004.7990401919645, 9738.659146929966, 10053.497325133714, 10295.815981162112, 10508.632197873038, 10596.788064238672, 669928.0, 671159.0, 671270.436478184, 697763.511182451, 713462.0, 143199.28400357932, 151686.24156879366, 154891.0, 156821.0, 162334.0, 1167.9532818687328, 1169.9649010529697, 1202.4228370382266, 1203.5847632566574, 1205.4153735438306, 17469.82530174682, 17990.830596011216, 17999.10004499796, 18092.0, 18155.001474919005, 62113.273203607925, 62486.68756656188, 62542.0, 63155.36844631495, 63313.417164571256, 88542.67185992087, 89599.17605355631, 90165.54917225371, 91162.0, 91763.0, 6869.210040845167, 8112.878306825284, 8438.451500652684, 8513.574321283788, 8725.432846864933, 13378.665533361744, 13563.0, 13710.45158193701, 13980.720385592027, 13991.58025259244, 11705.707357316136, 11807.940960295144, 11954.0, 11973.341466219441, 11995.0, 10561.10230630405, 10576.20678449104, 10734.73163170927, 10933.453327333442, 11106.389148596905, 10512.159027277647, 11544.422778861192, 11841.703957401134, 11863.466144023367, 11996.40017999114, 8299.751007469786, 8309.044459886949, 8671.696490622799, 8698.173673501007, 8819.073997230455, 11676.299422034705, 11683.0, 11969.401529923294, 12037.097217708531, 12129.818052729039], "value": 10386.871191125134, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1201.2612243470267, 1290.7999260114673, 1291.6577107066623, 1448.2758620689656, 1472.970540589188, 11142.49858756356, 11646.883531164685, 11650.708732281686, 11663.650090497287, 11677.883221167785, 11272.210945233837, 11708.824367634492, 11759.35323557204, 11774.882251177485, 11780.116491263147, 2492.962605560918, 2534.4170840706647, 2540.4792017636432, 2540.530001949636, 2549.3244290263096, 2101.8318534517202, 2389.0563227525117, 2457.741937096597, 2492.289697436231, 2495.9126430574843, 2162.9891850540803, 2195.0, 2420.854748715074, 2505.285993491855, 2505.8621775802326, 2433.8783060846886, 2456.0421435640114, 2469.4567195217205, 2470.8641024743633, 2473.826832121752, 2445.144199530168, 2459.274514018369, 2461.1386014894824, 2462.9261122166185, 2465.0509553821908, 11389.316641001484, 11685.2404593702, 11704.47329870158, 11708.590199342982, 11765.823512647317, 6425.807225783234, 6685.19777626683, 6690.498212634072, 6690.63201523916, 6703.798886033378, 3914.197589494147, 4125.773082480462, 4276.166147601219, 4293.957060429387, 4299.677524185668, 1112.9371450265057, 1166.632510759108, 1189.9464524096436, 1234.4568389908502, 1240.1690867119053, 14531.0, 16158.919205404016, 16171.595710107224, 16180.271887765079, 16188.514344569681, 5286.154215325606, 5442.0749970049155, 5451.2640793493165, 5568.638038527482, 5581.3302403711, 11907.761844763056, 11913.702157446132, 11965.581204657969, 11982.58060967862, 11988.580399686143, 6318.462930650854, 6450.838729031718, 6451.516136289797, 6453.870922581522, 6467.51493637979, 5737.340205876378, 5972.25346831646, 6061.818145455643, 6113.755449781959, 6117.235345581802, 4161.292580261363, 4240.5123410808155, 4250.4474418326035, 4304.48346198452, 4314.590113939171, 1160.0214341000594, 1163.139276935062, 1254.0657210378145, 1274.6749578857332, 1275.4706796679275, 582.9741647774036, 724.4530379563396, 726.920038795732, 731.4587205468022, 762.8359902620853, 6248.687775567182, 6554.7378104876225, 6692.431143352869, 6775.22084960226, 6857.897131543031, 563.9774409023676, 585.689584520205, 592.3750443282379, 593.1103344982527, 700.0059914920723, 3570.285942811448, 3780.7920564369224, 3916.8629097981434, 4098.0, 4144.171165766858, 11992.280463172237, 14351.210683412304, 15069.849301507064, 15151.090934543963, 15190.696186076437, 14765.261736913111, 14983.850161498463, 15051.322690478955, 15327.770083448757, 15334.386624534895, 10620.150387969099, 10627.84058239127, 10864.185186111074, 11020.724481888017, 11045.226834121535, 6297.811065668037, 6496.512761542997, 6656.0, 6700.66496675174, 6730.0446640216405, 13351.666208344868, 13366.06437549401, 13481.528146514825, 13599.728005439638, 13755.31223438844, 13756.65608359799, 13845.515406960709, 13874.306284685927, 13927.094738841943, 13953.232572208626, 8383.245507904317, 8587.95706021466, 8588.871166932377, 8595.18345757152, 8608.225259726654, 10461.476926153815, 10553.63062292816, 10683.0, 10688.946555267485, 10693.05940866268, 7205.819854503679, 8934.374593778373, 8961.686340978034, 9027.4132181408, 9208.861867072133, 8634.654613815628, 8771.868421973802, 8829.867551986854, 8877.201051905102, 8919.910800891908, 7980.840383192188, 8068.99137607799, 8136.633851476579, 8154.38842086834, 8166.265036146775, 5847.853803654943, 5861.413858614275, 6058.909116363347, 6142.969285153546, 6174.320824709368, 5955.464008239279, 5965.73154208053, 6168.506519478521, 6185.84535386619, 6188.3910183353555], "value": 5247.0270428020485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.6700437623644, 384.97112716546246, 393.85033687198865, 407.694229328004, 409.74186262654507, 5620.803271885485, 5843.298804143508, 5920.28956525217, 6035.879282414355, 6047.516198704104, 4839.806407743695, 5082.3990443010425, 5717.742701578429, 5732.31212254529, 5839.299284085916, 4119.917601647972, 4542.6593005524555, 4546.727196368212, 4554.362389265505, 4570.360149579062, 3422.7775194612395, 4349.456317960255, 4401.493828209765, 4562.657800664947, 4600.700954437968, 3965.662918651918, 4064.2074795414906, 4273.884427208521, 4303.935440968388, 4318.67609929255, 4195.15413218183, 4199.580041995791, 4214.836824889501, 4262.445882035316, 4324.632406245473, 3720.2001569662384, 3751.718621103428, 3754.0, 3763.6236376362417, 3766.886993390203, 4518.774061296922, 5669.036263835117, 5695.601307908448, 5727.513161381287, 5736.971315143439, 5141.177411614124, 5144.048351055029, 5157.6647517911215, 5157.7936882524655, 5167.199084141964, 6294.622322660655, 6309.3690630936535, 6315.494760419156, 6332.936670633281, 6350.174477317965, 4096.467459230281, 4213.4522512073545, 4225.15496900618, 4265.466816647919, 4296.205202037633, 5699.458551437649, 6568.507361947825, 6576.967115164442, 6605.735770569219, 6636.834079148011, 4291.914161716811, 4292.441982542312, 4296.82812687489, 4308.4399028126145, 4321.416608757778, 4003.179348233605, 4202.579742025773, 4332.67504937131, 4362.672799540047, 4364.148990946798, 4267.338562522814, 4953.628477864175, 5065.341505604248, 5101.8724531887, 5121.129408000649, 5498.5876059295715, 5970.552208584373, 6145.784897528654, 6243.96878015607, 6301.684915754194, 1413.639521921924, 1461.0, 1474.506040476431, 1492.671612245326, 1496.7231062253518, 947.6825263536792, 973.2408721197477, 988.3526290279734, 997.1922742578535, 1001.1990407673977, 5830.533557315404, 5837.09525023622, 5867.765289388377, 5889.851478961647, 5890.2342695449315, 5756.539476841843, 6443.162388889415, 6443.871122577522, 6444.452221561126, 6493.318201588765, 5548.77804887808, 5800.274965629296, 5849.590528662953, 5850.0932355484965, 5864.648121112661, 3326.4511355626532, 3371.359441706068, 3385.6614338565946, 3389.8305084745666, 3396.3546926083964, 5790.247267855152, 5862.391235899983, 6473.480594034693, 6697.464202863759, 6772.525923185428, 5746.4253574643035, 5791.913121303184, 6556.508261880378, 6573.244076931119, 6578.868422631521, 5850.444207800252, 6370.8213980413775, 6608.933910660832, 6663.833404164838, 6665.300143484961, 5712.08606622955, 5821.970890145522, 6042.5285288885025, 6385.499407639294, 6421.325760795236, 5592.608517403743, 5597.860053498533, 6305.337939516285, 6327.936720632735, 6353.237611486651, 5450.509454149145, 6417.005364168562, 6635.369639884203, 6635.933640663531, 6669.199696036507, 4212.945614429636, 4221.746695198298, 4235.936460953027, 4238.851640192578, 4251.511076226274, 6273.247210334789, 6290.150829637941, 6293.276273228455, 6306.621602703853, 6499.5775274607, 5451.100568406168, 5476.2333273342565, 5701.8859622806485, 5749.310082790092, 6209.181353467675, 6018.849528761641, 6202.224721909762, 6204.410580994799, 6213.471854892204, 6278.215223097113, 4702.858914232578, 5745.712714364348, 5874.882502350015, 6069.848253793691, 6190.380961903774, 6308.463780578702, 6317.368263173646, 6324.810255692337, 6353.904691429725, 6361.236651601837, 5867.442592953663, 6089.786857459968, 6157.138000679998, 6176.258848938156, 6192.81421557354], "value": 4563.76037283184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7926959720876, 792.5680504125247, 827.0, 827.8261565071334, 837.2799392522431, 15954.28205730742, 16036.518904432856, 16577.0, 16637.83362166378, 16777.412790552335, 12140.81788773167, 15282.083075015507, 15348.61628459289, 15378.615534611612, 15480.535583932471, 948.2840455456121, 985.0494273026528, 985.3939827006375, 986.0977205856633, 986.5659109991617, 977.9413235205875, 987.8863930647996, 1023.0894503891542, 1027.7533391985908, 1032.1742605915238, 1036.9992956796689, 1046.7697106636529, 1048.8269435543164, 1049.595905576351, 1051.1328154272717, 1036.8289232276666, 1042.1766804224728, 1046.2989796836139, 1046.931949423285, 1050.3802756373739, 770.2567022823002, 776.4370831147429, 776.8718161503401, 778.7352300217954, 779.9142094369671, 16476.340946362132, 16823.41118060862, 16887.66224675512, 17077.316907323817, 17308.0, 14806.629834254121, 14904.153592195518, 14910.850891491054, 15088.321025553767, 15802.288896999662, 13469.057165998383, 13607.523736669169, 13616.114952528054, 13617.182969021891, 13620.863791362059, 3376.5104059911178, 3377.3583019226267, 3379.7972121672533, 3380.5267262583257, 3448.0, 92402.0, 115713.4214328923, 116970.0, 120433.0, 121159.3942030293, 11218.66344009681, 11296.739054950884, 11408.258463199865, 11621.88378116208, 12103.273803571637, 24732.876335618566, 24734.628980565307, 24746.628800568007, 24848.0, 24989.00043998256, 6787.321267873173, 7699.153093159748, 7764.883526747103, 7965.243301886311, 8077.07483231033, 3479.8956031319103, 4220.344966462931, 4245.936310955338, 4254.553271906467, 4263.445752052214, 4206.47419072616, 4291.034517233597, 4319.568043195655, 4321.719088259316, 4335.284678028153, 813.7396033269297, 868.1015149320423, 877.0045997792552, 877.8814859993819, 878.9648414063494, 548.8380927626359, 621.9378062193745, 625.6371304643296, 642.0, 668.9665516724144, 9354.532273386303, 9897.109260166619, 9936.403815771077, 10121.1903047756, 10167.339122956984, 503.8790690234317, 558.9804356847491, 590.754836742747, 607.7751232044172, 625.7590827531433, 4623.838165664186, 4625.861224163281, 4629.074185162981, 4629.513901040342, 4818.6626936114135, 97162.0, 97231.0, 97811.51094244483, 98018.50990745, 99719.0, 71090.2890971094, 83534.0, 83771.0, 86196.0, 86899.0, 60116.69941650264, 68311.65844170748, 73783.0, 74920.25079749242, 77036.61481692668, 9168.659961273048, 10815.891841081488, 10844.735780355822, 11042.503087360927, 11104.389258590854, 36998.44502332414, 37882.62117378901, 38172.809135955256, 38249.61750382461, 38870.91855355147, 38851.417228741026, 41331.0, 49410.77651505619, 49844.50155498399, 50900.0, 13203.405846736729, 13253.734925301633, 13837.446502139801, 13936.790948135584, 14132.434702611781, 12039.053661405522, 13833.377498012413, 14590.85409145895, 14866.702665946405, 15017.549473515812, 13587.59237222885, 13647.454101835816, 13736.587902362946, 14173.433062677377, 14312.928435357757, 13700.0, 13709.725805484033, 13733.313334333043, 13903.721925561229, 14025.0182487229, 13432.529861454803, 13535.052546321664, 13600.319984000562, 13621.318934053455, 13635.0, 9439.480828554495, 9528.428294302365, 10242.334248273839, 10312.48437578133, 10353.896461035294, 9667.323287369816, 10034.49827508607, 10544.630937917136, 11229.606963756229, 11241.437928103725], "value": 7659.928175139918, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 123.0, 123.0, 119.0, 122.0, 123.0, 122.0, 121.0, 124.0, 122.0], "value": 121.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 116.0, 117.0, 174.0, 119.0, 113.0, 154.0, 155.0, 180.0, 132.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [207.0, 215.0, 214.0, 209.0, 208.0, 218.0, 216.0, 209.0, 209.0, 210.0], "value": 211.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 64.0, 99.0, 66.0, 65.0, 68.0, 65.0, 86.0, 66.0], "value": 72.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 76.0, 95.0, 77.0, 80.0, 110.0, 133.0, 113.0, 73.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 91.0, 91.0, 90.0, 91.0, 91.0, 92.0, 90.0, 90.0], "value": 91.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 100.0, 99.0, 99.0, 98.0, 99.0, 101.0, 100.0, 100.0, 99.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 101.0, 127.0, 116.0, 100.0, 101.0, 101.0, 102.0, 101.0], "value": 105.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 51.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 54.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 63.0, 66.0, 75.0, 64.0, 65.0, 62.0, 78.0, 91.0, 90.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 94.0, 92.0, 90.0, 91.0, 91.0, 89.0, 92.0, 89.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 163.0, 151.0, 151.0, 151.0, 146.0, 150.0, 149.0, 203.0, 161.0], "value": 158.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 200.0, 199.0, 201.0, 199.0, 203.0, 200.0, 197.0, 201.0, 215.0], "value": 201.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 75.0, 71.0, 73.0, 74.0, 73.0, 72.0, 73.0, 72.0], "value": 72.6, "unit": "score"}]}]} 12:01:55 INFO - Return code: 0 12:01:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:01:55 ERROR - # TBPL SUCCESS # 12:01:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:01:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:01:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:01:55 INFO - 2017-04-05 12:01:55.246 screenresolution[1656:10020] starting screenresolution argv=screenresolution get 12:01:55 INFO - 2017-04-05 12:01:55.248 screenresolution[1656:10020] Display 0: 1600x1200x32@60 12:01:55 INFO - 2017-04-05 12:01:55.254 screenresolution[1657:10023] starting screenresolution argv=screenresolution list 12:01:55 INFO - Available Modes on Display 0 12:01:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:01:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:01:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:01:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:01:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:01:55 INFO - Intel Iris: 12:01:55 INFO - Chipset Model: Intel Iris 12:01:55 INFO - Type: GPU 12:01:55 INFO - Bus: Built-In 12:01:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:01:55 INFO - Vendor: Intel (0x8086) 12:01:55 INFO - Device ID: 0x0a2e 12:01:55 INFO - Revision ID: 0x0009 12:01:55 INFO - Displays: 12:01:55 INFO - Display: 12:01:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:01:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:01:55 INFO - Display Serial Number: 1600x1200 60 12:01:55 INFO - Main Display: Yes 12:01:55 INFO - Mirror: Off 12:01:55 INFO - Online: Yes 12:01:55 INFO - Rotation: Supported 12:01:55 INFO - Return code: 0 12:01:55 INFO - Running post-action listener: _resource_record_post_action 12:01:55 INFO - [mozharness: 2017-04-05 19:01:55.499464Z] Finished run-tests step (success) 12:01:55 INFO - Running post-run listener: _resource_record_post_run 12:01:55 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 45508096; Write bytes: 518977536; Read time: 435; Write time: 1877 12:01:55 INFO - TinderboxPrint: CPU usage
53.3% 12:01:55 INFO - TinderboxPrint: I/O read bytes / time
45,508,096 / 435 12:01:55 INFO - TinderboxPrint: I/O write bytes / time
518,977,536 / 1,877 12:01:55 INFO - TinderboxPrint: CPU idle
2,250.4 (46.7%) 12:01:55 INFO - TinderboxPrint: CPU system
958.2 (19.9%) 12:01:55 INFO - TinderboxPrint: CPU user
1,613.0 (33.5%) 12:01:55 INFO - TinderboxPrint: Swap in / out
260,308,992 / 0 12:01:55 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208433664; Write bytes: 209770496; Read time: 15897; Write time: 454 12:01:55 INFO - run-tests - Wall time: 1186s; CPU: 53.0%; Read bytes: 40920576; Write bytes: 307867648; Read time: 400; Write time: 1418 12:01:55 INFO - Running post-run listener: _upload_blobber_files 12:01:55 INFO - Blob upload gear active. 12:01:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:01:55 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 12:01:55 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:01:55 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:01:56 INFO - (blobuploader) - INFO - Open directory for files ... 12:01:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:01:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:01:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:57 INFO - (blobuploader) - INFO - Done attempting. 12:01:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:01:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:01:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:58 INFO - (blobuploader) - INFO - Done attempting. 12:01:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:01:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:01:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:01:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:01:59 INFO - (blobuploader) - INFO - Done attempting. 12:01:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:01:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:01:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:02:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:02:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:02:01 INFO - (blobuploader) - INFO - Done attempting. 12:02:01 INFO - (blobuploader) - INFO - Iteration through files over. 12:02:01 INFO - Return code: 0 12:02:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:02:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:02:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4e5ffffe0c8a9adf4331f7c83eaa44373995947627e47285f20f698ecb698e968d5fc68345e66938cf83f7117f06599d777b8938d49b3df5d326f2dee3649c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca6b3dbeefce19e6370ca0f3c6fe6181427a366384ebb556f4189df287fb1b144390864bcf781ea664d9921f45e08a6780221b0a01e8ed24897aa30ad98d55d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/430f241f24ee79b9f3fa1daa57b0ea660be8f32652cb1f1022b4b2f22e57807db80fcffc0f44b53fcceb107aa825f320f2c945a6ab819d93792802062fe0034c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18e7538823f3895116f3969cf8efce06639dc48aaebee89b69dc52c6ef4c7d0f2534e6481f30f14f50fbb58c75c0e6208e4be422d345e5dd237fdf2e2421fa69"} 12:02:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:02:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:02:01 INFO - Contents: 12:02:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4e5ffffe0c8a9adf4331f7c83eaa44373995947627e47285f20f698ecb698e968d5fc68345e66938cf83f7117f06599d777b8938d49b3df5d326f2dee3649c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca6b3dbeefce19e6370ca0f3c6fe6181427a366384ebb556f4189df287fb1b144390864bcf781ea664d9921f45e08a6780221b0a01e8ed24897aa30ad98d55d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/430f241f24ee79b9f3fa1daa57b0ea660be8f32652cb1f1022b4b2f22e57807db80fcffc0f44b53fcceb107aa825f320f2c945a6ab819d93792802062fe0034c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18e7538823f3895116f3969cf8efce06639dc48aaebee89b69dc52c6ef4c7d0f2534e6481f30f14f50fbb58c75c0e6208e4be422d345e5dd237fdf2e2421fa69"} 12:02:01 INFO - Running post-run listener: copy_logs_to_upload_dir 12:02:01 INFO - Copying logs to upload dir... 12:02:01 INFO - mkdir: /builds/slave/test/build/upload/logs 12:02:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.817243 ========= master_lag: 1.85 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-04-05 12:02:03.353700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:03.357571) ========= 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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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/Pine/sha512/4e5ffffe0c8a9adf4331f7c83eaa44373995947627e47285f20f698ecb698e968d5fc68345e66938cf83f7117f06599d777b8938d49b3df5d326f2dee3649c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca6b3dbeefce19e6370ca0f3c6fe6181427a366384ebb556f4189df287fb1b144390864bcf781ea664d9921f45e08a6780221b0a01e8ed24897aa30ad98d55d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/430f241f24ee79b9f3fa1daa57b0ea660be8f32652cb1f1022b4b2f22e57807db80fcffc0f44b53fcceb107aa825f320f2c945a6ab819d93792802062fe0034c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18e7538823f3895116f3969cf8efce06639dc48aaebee89b69dc52c6ef4c7d0f2534e6481f30f14f50fbb58c75c0e6208e4be422d345e5dd237fdf2e2421fa69"} build_url:https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/dc_75W1WT6us6uP_1XZ0qQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/4e5ffffe0c8a9adf4331f7c83eaa44373995947627e47285f20f698ecb698e968d5fc68345e66938cf83f7117f06599d777b8938d49b3df5d326f2dee3649c0d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/ca6b3dbeefce19e6370ca0f3c6fe6181427a366384ebb556f4189df287fb1b144390864bcf781ea664d9921f45e08a6780221b0a01e8ed24897aa30ad98d55d3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/430f241f24ee79b9f3fa1daa57b0ea660be8f32652cb1f1022b4b2f22e57807db80fcffc0f44b53fcceb107aa825f320f2c945a6ab819d93792802062fe0034c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18e7538823f3895116f3969cf8efce06639dc48aaebee89b69dc52c6ef4c7d0f2534e6481f30f14f50fbb58c75c0e6208e4be422d345e5dd237fdf2e2421fa69"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:03.396876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:03.397222) ========= 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.0CrDuCTm9a/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.cpCVBaJQL4/Listeners TMPDIR=/var/folders/wq/k1fxgwns1ls22g4fg828fjf400000w/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.005177 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 12:02:03.446016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 12:02:03.446334) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 12:02:03.446665) ========= ========= Total master_lag: 1.99 =========