builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0221 starttime: 1486678621.28 results: success (0) buildid: 20170209120619 builduid: 89489f7bec2d4828b1828b2ca9f72e2e revision: 49b3ad9f467d48194dab8121f82e4c938b70b484 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.283717) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.284138) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.284453) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.311372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.311832) ========= 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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-09 14:17:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 65.3M=0s 2017-02-09 14:17:01 (65.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093064 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.431222) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.431653) ========= 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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.027707 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:01.486639) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 14:17:01.487370) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49b3ad9f467d48194dab8121f82e4c938b70b484 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49b3ad9f467d48194dab8121f82e4c938b70b484 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ek5Y0YXeby/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.VUZDtZzjzU/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-09 14:17:01,588 truncating revision to first 12 chars 2017-02-09 14:17:01,588 Setting DEBUG logging. 2017-02-09 14:17:01,588 attempt 1/10 2017-02-09 14:17:01,588 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/49b3ad9f467d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 14:17:02,703 unpacking tar archive at: mozilla-beta-49b3ad9f467d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.403669 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 14:17:02.917527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:02.918034) ========= script_repo_revision: 49b3ad9f467d48194dab8121f82e4c938b70b484 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:02.918519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:02.918856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 14:17:02.939092) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-09 14:17:02.939473) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ek5Y0YXeby/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.VUZDtZzjzU/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:03 INFO - MultiFileLogger online at 20170209 14:17:03 in /builds/slave/test 14:17:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:17:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:17:03 INFO - {'append_to_log': False, 14:17:03 INFO - 'base_work_dir': '/builds/slave/test', 14:17:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:17:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:17:03 INFO - 'branch': 'Mozilla-Beta', 14:17:03 INFO - 'buildbot_json_path': 'buildprops.json', 14:17:03 INFO - 'config_files': ('talos/mac_config.py',), 14:17:03 INFO - 'default_actions': ('clobber', 14:17:03 INFO - 'read-buildbot-config', 14:17:03 INFO - 'download-and-extract', 14:17:03 INFO - 'populate-webroot', 14:17:03 INFO - 'create-virtualenv', 14:17:03 INFO - 'install', 14:17:03 INFO - 'run-tests'), 14:17:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:17:03 INFO - 'download_minidump_stackwalk': True, 14:17:03 INFO - 'download_symbols': 'ondemand', 14:17:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:17:03 INFO - 'tooltool.py': '/tools/tooltool.py', 14:17:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:17:03 INFO - '/tools/misc-python/virtualenv.py')}, 14:17:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:17:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:17:03 INFO - 'installer_path': 'installer.exe', 14:17:03 INFO - 'log_level': 'info', 14:17:03 INFO - 'log_name': 'talos', 14:17:03 INFO - 'log_to_console': True, 14:17:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:17:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:17:03 INFO - 'opt_config_files': (), 14:17:03 INFO - 'pip_index': False, 14:17:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:17:03 INFO - 'cmd': ('bash', 14:17:03 INFO - '-c', 14:17:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:17:03 INFO - 'enabled': True, 14:17:03 INFO - 'halt_on_failure': False, 14:17:03 INFO - 'name': 'check_screen_resolution'},), 14:17:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:17:03 INFO - 'cmd': ('bash', 14:17:03 INFO - '-c', 14:17:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:17:03 INFO - 'enabled': True, 14:17:03 INFO - 'halt_on_failure': False, 14:17:03 INFO - 'name': 'check_screen_resolution'},), 14:17:03 INFO - 'run_cmd_checks_enabled': True, 14:17:03 INFO - 'sps_profile': False, 14:17:03 INFO - 'sps_profile_interval': 0, 14:17:03 INFO - 'suite': 'dromaeojs', 14:17:03 INFO - 'system_bits': '32', 14:17:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:17:03 INFO - 'title': 't-yosemite-r7-0221', 14:17:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:17:03 INFO - 'use_talos_json': True, 14:17:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:17:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:17:03 INFO - 'work_dir': 'build'} 14:17:03 INFO - [mozharness: 2017-02-09 22:17:03.144177Z] Running clobber step. 14:17:03 INFO - Running pre-action listener: _resource_record_pre_action 14:17:03 INFO - Running main action method: clobber 14:17:03 INFO - rmtree: /builds/slave/test/build 14:17:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:17:05 INFO - Running post-action listener: _resource_record_post_action 14:17:05 INFO - [mozharness: 2017-02-09 22:17:05.515312Z] Finished clobber step (success) 14:17:05 INFO - [mozharness: 2017-02-09 22:17:05.515385Z] Running read-buildbot-config step. 14:17:05 INFO - Running pre-action listener: _resource_record_pre_action 14:17:05 INFO - Running main action method: read_buildbot_config 14:17:05 INFO - Using buildbot properties: 14:17:05 INFO - { 14:17:05 INFO - "project": "", 14:17:05 INFO - "product": "firefox", 14:17:05 INFO - "script_repo_revision": "production", 14:17:05 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 14:17:05 INFO - "repository": "", 14:17:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 14:17:05 INFO - "buildid": "20170209120619", 14:17:05 INFO - "pgo_build": "False", 14:17:05 INFO - "basedir": "/builds/slave/test", 14:17:05 INFO - "buildnumber": 17, 14:17:05 INFO - "slavename": "t-yosemite-r7-0221", 14:17:05 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:17:05 INFO - "platform": "yosemite_r7", 14:17:05 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:17:05 INFO - "branch": "mozilla-beta", 14:17:05 INFO - "repo_path": "releases/mozilla-beta", 14:17:05 INFO - "revision": "49b3ad9f467d48194dab8121f82e4c938b70b484", 14:17:05 INFO - "stage_platform": "macosx64", 14:17:05 INFO - "builduid": "89489f7bec2d4828b1828b2ca9f72e2e", 14:17:05 INFO - "slavebuilddir": "test" 14:17:05 INFO - } 14:17:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:17:05 INFO - Running post-action listener: _resource_record_post_action 14:17:05 INFO - [mozharness: 2017-02-09 22:17:05.518673Z] Finished read-buildbot-config step (success) 14:17:05 INFO - [mozharness: 2017-02-09 22:17:05.518827Z] Running download-and-extract step. 14:17:05 INFO - Running pre-action listener: _resource_record_pre_action 14:17:05 INFO - Running main action method: download_and_extract 14:17:05 INFO - mkdir: /builds/slave/test/build/tests 14:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:05 INFO - trying https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:17:05 INFO - Downloading https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:17:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 14:17:06 INFO - Downloaded 1165 bytes. 14:17:06 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:17:06 INFO - Using the following test package requirements: 14:17:06 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:17:06 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:17:06 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:17:06 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:17:06 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:17:06 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:17:06 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:17:06 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:17:06 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:17:06 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:17:06 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:17:06 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:17:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:17:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:17:06 INFO - Fetch https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:17:07 INFO - Http code: 200 14:17:07 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 14:17:07 INFO - x-amz-cf-id: -h-Ux4Z9Tnu1rC9LOo2MdGxtCu_fT4w9V-joXZzsesvyqZx4o1ZQbA== 14:17:07 INFO - x-amz-version-id: 89JFBa4YoSfATEs5difc7MEWLAx_wZ67 14:17:07 INFO - Expected file size: 16093658 14:17:07 INFO - Obtained file size: 16093658 14:17:14 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:17:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:17:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:17:14 INFO - Fetch https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:17:14 INFO - Http code: 200 14:17:14 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 14:17:14 INFO - x-amz-cf-id: 0-e63jI82uID6yoheyJF2Pu6Wn5Vds7tupSSdMORs0NpHuONVHWm0Q== 14:17:14 INFO - x-amz-version-id: 89JFBa4YoSfATEs5difc7MEWLAx_wZ67 14:17:15 INFO - Expected file size: 16093658 14:17:15 INFO - Obtained file size: 16093658 14:17:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:17:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:17:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:17:22 INFO - Http code: 200 14:17:22 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 14:17:22 INFO - x-amz-cf-id: LPElQmAj0x0Fq7Iq_6lN82jK6eUDsSMJtr7JfI_cD6BiT-j7-LnG0w== 14:17:22 INFO - x-amz-version-id: fWAZnbob1Mgip46K4MoCmBGarY66s1oG 14:17:22 INFO - Expected file size: 14403005 14:17:22 INFO - Obtained file size: 14403005 14:17:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:22 INFO - trying https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:17:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:17:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 14:17:24 INFO - Downloaded 82150937 bytes. 14:17:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:17:24 INFO - mkdir: /builds/slave/test/properties 14:17:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:17:24 INFO - Writing to file /builds/slave/test/properties/build_url 14:17:24 INFO - Contents: 14:17:24 INFO - build_url:https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:17:25 INFO - Running post-action listener: _resource_record_post_action 14:17:25 INFO - Running post-action listener: set_extra_try_arguments 14:17:25 INFO - [mozharness: 2017-02-09 22:17:25.618644Z] Finished download-and-extract step (success) 14:17:25 INFO - [mozharness: 2017-02-09 22:17:25.618793Z] Running populate-webroot step. 14:17:25 INFO - Running pre-action listener: _resource_record_pre_action 14:17:25 INFO - Running main action method: populate_webroot 14:17:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:17:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:17:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:17:25 INFO - '--tppagecycles', 14:17:25 INFO - '7'], 14:17:25 INFO - 'tests': ['tsvgm']}}, 14:17:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:17:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:17:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:17:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:17:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:17:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['damp', 'tps']}, 14:17:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'tests': ['damp', 'tps']}, 14:17:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['dromaeo_dom']}, 14:17:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:17:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['basic_compositor_video']}, 14:17:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:17:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['a11yr', 14:17:25 INFO - 'ts_paint', 14:17:25 INFO - 'tpaint', 14:17:25 INFO - 'sessionrestore', 14:17:25 INFO - 'sessionrestore_no_auto_restore', 14:17:25 INFO - 'tabpaint']}, 14:17:25 INFO - 'other-e10s': {'tests': ['a11yr', 14:17:25 INFO - 'ts_paint', 14:17:25 INFO - 'tpaint', 14:17:25 INFO - 'sessionrestore', 14:17:25 INFO - 'sessionrestore_no_auto_restore', 14:17:25 INFO - 'tabpaint']}, 14:17:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:17:25 INFO - 'ts_paint', 14:17:25 INFO - 'tpaint', 14:17:25 INFO - 'sessionrestore', 14:17:25 INFO - 'sessionrestore_no_auto_restore', 14:17:25 INFO - 'tabpaint']}, 14:17:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:17:25 INFO - 'ts_paint', 14:17:25 INFO - 'tpaint', 14:17:25 INFO - 'sessionrestore', 14:17:25 INFO - 'sessionrestore_no_auto_restore', 14:17:25 INFO - 'tabpaint']}, 14:17:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['a11yr', 14:17:25 INFO - 'ts_paint', 14:17:25 INFO - 'tpaint', 14:17:25 INFO - 'sessionrestore', 14:17:25 INFO - 'sessionrestore_no_auto_restore', 14:17:25 INFO - 'tabpaint']}, 14:17:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['a11yr', 14:17:25 INFO - 'ts_paint', 14:17:25 INFO - 'tpaint', 14:17:25 INFO - 'sessionrestore', 14:17:25 INFO - 'sessionrestore_no_auto_restore', 14:17:25 INFO - 'tabpaint']}, 14:17:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['tsvgx', 14:17:25 INFO - 'tsvgr_opacity', 14:17:25 INFO - 'tart', 14:17:25 INFO - 'tscrollx', 14:17:25 INFO - 'cart']}, 14:17:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:17:25 INFO - 'tsvgr_opacity', 14:17:25 INFO - 'tart', 14:17:25 INFO - 'tscrollx', 14:17:25 INFO - 'cart']}, 14:17:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'talos_options': ['--disable-e10s'], 14:17:25 INFO - 'tests': ['tp5o']}, 14:17:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'tests': ['tp5o']}, 14:17:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'talos_options': ['--disable-e10s', 14:17:25 INFO - '--xperf_path', 14:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:25 INFO - 'tests': ['tp5n']}, 14:17:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:17:25 INFO - 'talos_options': ['--xperf_path', 14:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:17:25 INFO - 'tests': ['tp5n']}}, 14:17:25 INFO - 'talos.zip': {'path': '', 14:17:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:17:25 INFO - Running post-action listener: _resource_record_post_action 14:17:25 INFO - [mozharness: 2017-02-09 22:17:25.637463Z] Finished populate-webroot step (success) 14:17:25 INFO - [mozharness: 2017-02-09 22:17:25.637595Z] Running create-virtualenv step. 14:17:25 INFO - Running pre-action listener: _resource_record_pre_action 14:17:25 INFO - Running main action method: create_virtualenv 14:17:25 INFO - Creating virtualenv /builds/slave/test/build/venv 14:17:25 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 14:17:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:17:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:17:25 INFO - Using real prefix '/tools/python27' 14:17:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:17:26 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:29 INFO - Installing pip.................done. 14:17:29 INFO - Return code: 0 14:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:17:29 INFO - Reading from file tmpfile_stdout 14:17:29 INFO - Output received: 14:17:29 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) 14:17:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17: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', 'pip>=1.5'] in /builds/slave/test/build 14:17: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 pip>=1.5 14:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:29 INFO - 'HOME': '/Users/cltbld', 14:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:29 INFO - 'LOGNAME': 'cltbld', 14:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:29 INFO - 'MOZ_NO_REMOTE': '1', 14:17:29 INFO - 'NO_EM_RESTART': '1', 14:17:29 INFO - 'PAGER': '/bin/cat', 14:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:29 INFO - 'PWD': '/builds/slave/test', 14:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:29 INFO - 'SHELL': '/bin/bash', 14:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:29 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:29 INFO - 'USER': 'cltbld', 14:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:29 INFO - 'XPC_FLAGS': '0x0', 14:17:29 INFO - 'XPC_SERVICE_NAME': '0', 14:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:30 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 14:17:30 INFO - Cleaning up... 14:17:30 INFO - Return code: 0 14:17:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:17:30 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')]} 14:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:30 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')]} 14:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:30 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:30 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 14:17:30 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 14:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:30 INFO - 'HOME': '/Users/cltbld', 14:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:30 INFO - 'LOGNAME': 'cltbld', 14:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:30 INFO - 'MOZ_NO_REMOTE': '1', 14:17:30 INFO - 'NO_EM_RESTART': '1', 14:17:30 INFO - 'PAGER': '/bin/cat', 14:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:30 INFO - 'PWD': '/builds/slave/test', 14:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:30 INFO - 'SHELL': '/bin/bash', 14:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:30 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:30 INFO - 'USER': 'cltbld', 14:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:30 INFO - 'XPC_FLAGS': '0x0', 14:17:30 INFO - 'XPC_SERVICE_NAME': '0', 14:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:30 INFO - Downloading/unpacking psutil>=3.1.1 14:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:33 INFO - Installing collected packages: psutil 14:17:33 INFO - Running setup.py install for psutil 14:17:33 INFO - building 'psutil._psutil_osx' extension 14:17:33 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 14:17:34 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 14:17:34 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 14:17:34 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 14:17:34 INFO - building 'psutil._psutil_posix' extension 14:17:34 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 14:17:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:17:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:17:34 INFO - ^ 14:17:34 INFO - 1 warning generated. 14:17:34 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 14:17:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:34 INFO - Successfully installed psutil 14:17:34 INFO - Cleaning up... 14:17:35 INFO - Return code: 0 14:17:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:17: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')]} 14:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:35 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:35 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 14:17:35 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 14:17:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:35 INFO - 'HOME': '/Users/cltbld', 14:17:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:35 INFO - 'LOGNAME': 'cltbld', 14:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:35 INFO - 'MOZ_NO_REMOTE': '1', 14:17:35 INFO - 'NO_EM_RESTART': '1', 14:17:35 INFO - 'PAGER': '/bin/cat', 14:17:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:35 INFO - 'PWD': '/builds/slave/test', 14:17:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:35 INFO - 'SHELL': '/bin/bash', 14:17:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:35 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:35 INFO - 'USER': 'cltbld', 14:17:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:35 INFO - 'XPC_FLAGS': '0x0', 14:17:35 INFO - 'XPC_SERVICE_NAME': '0', 14:17:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:17:35 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 14:17:35 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 14:17:35 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 14:17:35 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 14:17:35 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 14:17:35 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 14:17:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:17:38 INFO - Installing collected packages: mozsystemmonitor 14:17:38 INFO - Running setup.py install for mozsystemmonitor 14:17:38 INFO - Successfully installed mozsystemmonitor 14:17:38 INFO - Cleaning up... 14:17:38 INFO - Return code: 0 14:17:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:17:38 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')]} 14:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:38 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')]} 14:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:38 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:38 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 14:17:38 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 14:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:38 INFO - 'HOME': '/Users/cltbld', 14:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:38 INFO - 'LOGNAME': 'cltbld', 14:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:38 INFO - 'MOZ_NO_REMOTE': '1', 14:17:38 INFO - 'NO_EM_RESTART': '1', 14:17:38 INFO - 'PAGER': '/bin/cat', 14:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:38 INFO - 'PWD': '/builds/slave/test', 14:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:38 INFO - 'SHELL': '/bin/bash', 14:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:38 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:38 INFO - 'USER': 'cltbld', 14:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:38 INFO - 'XPC_FLAGS': '0x0', 14:17:38 INFO - 'XPC_SERVICE_NAME': '0', 14:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:17:38 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 14:17:38 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 14:17:38 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 14:17:38 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 14:17:38 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 14:17:38 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 14:17:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:41 INFO - warning: no files found matching '*.txt' 14:17:41 INFO - no previously-included directories found matching 'build' 14:17:41 INFO - no previously-included directories found matching 'dist' 14:17:41 INFO - no previously-included directories found matching '.git*' 14:17:41 INFO - Installing collected packages: jsonschema, functools32 14:17:41 INFO - Running setup.py install for functools32 14:17:41 INFO - warning: no files found matching '*.txt' 14:17:41 INFO - no previously-included directories found matching 'build' 14:17:41 INFO - no previously-included directories found matching 'dist' 14:17:41 INFO - no previously-included directories found matching '.git*' 14:17:41 INFO - Successfully installed jsonschema functools32 14:17:41 INFO - Cleaning up... 14:17:42 INFO - Return code: 0 14:17:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:42 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:42 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 14:17:42 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 14:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:42 INFO - 'HOME': '/Users/cltbld', 14:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:42 INFO - 'LOGNAME': 'cltbld', 14:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:42 INFO - 'MOZ_NO_REMOTE': '1', 14:17:42 INFO - 'NO_EM_RESTART': '1', 14:17:42 INFO - 'PAGER': '/bin/cat', 14:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:42 INFO - 'PWD': '/builds/slave/test', 14:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:42 INFO - 'SHELL': '/bin/bash', 14:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:42 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:42 INFO - 'USER': 'cltbld', 14:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:42 INFO - 'XPC_FLAGS': '0x0', 14:17:42 INFO - 'XPC_SERVICE_NAME': '0', 14:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:17:42 INFO - Cleaning up... 14:17:42 INFO - Return code: 0 14:17:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:42 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:42 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 14:17:42 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 14:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:42 INFO - 'HOME': '/Users/cltbld', 14:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:42 INFO - 'LOGNAME': 'cltbld', 14:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:42 INFO - 'MOZ_NO_REMOTE': '1', 14:17:42 INFO - 'NO_EM_RESTART': '1', 14:17:42 INFO - 'PAGER': '/bin/cat', 14:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:42 INFO - 'PWD': '/builds/slave/test', 14:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:42 INFO - 'SHELL': '/bin/bash', 14:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:42 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:42 INFO - 'USER': 'cltbld', 14:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:42 INFO - 'XPC_FLAGS': '0x0', 14:17:42 INFO - 'XPC_SERVICE_NAME': '0', 14:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:42 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 14:17:42 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 14:17:42 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 14:17:42 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 14:17:42 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 14:17:42 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 14:17:45 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:17:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17: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 14:17:46 INFO - Downloading docopt-0.6.1.tar.gz 14:17:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:46 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:46 INFO - Running setup.py install for blobuploader 14:17:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:17:46 INFO - Running setup.py install for requests 14:17:47 INFO - Running setup.py install for docopt 14:17:47 INFO - Successfully installed blobuploader requests docopt 14:17:47 INFO - Cleaning up... 14:17:47 INFO - Return code: 0 14:17:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:47 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')]} 14:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:47 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')]} 14:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:47 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:47 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 14:17:47 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 14:17:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:47 INFO - 'HOME': '/Users/cltbld', 14:17:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:47 INFO - 'LOGNAME': 'cltbld', 14:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:47 INFO - 'MOZ_NO_REMOTE': '1', 14:17:47 INFO - 'NO_EM_RESTART': '1', 14:17:47 INFO - 'PAGER': '/bin/cat', 14:17:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:47 INFO - 'PWD': '/builds/slave/test', 14:17:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:47 INFO - 'SHELL': '/bin/bash', 14:17:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:47 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:47 INFO - 'USER': 'cltbld', 14:17:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:47 INFO - 'XPC_FLAGS': '0x0', 14:17:47 INFO - 'XPC_SERVICE_NAME': '0', 14:17:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:47 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-FOeOM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:47 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-_NcMV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:47 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-VwbNez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-RPHlDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-ZkvacQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-cEcnUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-Ny7JIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-y3cNKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-jZ8Mkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-63b12f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-XTBGoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-o1h0xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:48 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-w0Pkkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:49 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-K0inne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:49 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-rD48No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:49 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-aDvxRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:49 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-xGSUlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:49 INFO - Running setup.py install for manifestparser 14:17:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:17:49 INFO - Running setup.py install for mozcrash 14:17:49 INFO - Running setup.py install for mozdebug 14:17:49 INFO - Running setup.py install for mozdevice 14:17:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozfile 14:17:50 INFO - Running setup.py install for mozhttpd 14:17:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozinfo 14:17:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozInstall 14:17:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for mozleak 14:17:50 INFO - Running setup.py install for mozlog 14:17:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:17:50 INFO - Running setup.py install for moznetwork 14:17:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozprocess 14:17:51 INFO - Running setup.py install for mozprofile 14:17:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozrunner 14:17:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:17:51 INFO - Running setup.py install for mozscreenshot 14:17:51 INFO - Running setup.py install for moztest 14:17:51 INFO - Running setup.py install for mozversion 14:17:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:17:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:52 INFO - Cleaning up... 14:17:52 INFO - Return code: 0 14:17:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:17:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:52 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:52 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 14:17:52 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 14:17:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:52 INFO - 'HOME': '/Users/cltbld', 14:17:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:52 INFO - 'LOGNAME': 'cltbld', 14:17:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:52 INFO - 'MOZ_NO_REMOTE': '1', 14:17:52 INFO - 'NO_EM_RESTART': '1', 14:17:52 INFO - 'PAGER': '/bin/cat', 14:17:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:52 INFO - 'PWD': '/builds/slave/test', 14:17:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:52 INFO - 'SHELL': '/bin/bash', 14:17:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:52 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:52 INFO - 'USER': 'cltbld', 14:17:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:52 INFO - 'XPC_FLAGS': '0x0', 14:17:52 INFO - 'XPC_SERVICE_NAME': '0', 14:17:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-QnfFRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-tv9Fwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-mmMCfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-g4v_3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-dl_H5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-yTGNWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:17:52 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)) 14:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:17:52 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-9QtSAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-CS1eF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-_9pTYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-hapaHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-yVSako-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-iBvvYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:17:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-dvncaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-aWJ2W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-_XiNyE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:17:53 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)) 14:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:17:53 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-HdbbMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:17:54 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)) 14:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:17:54 INFO - Running setup.py (path:/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/pip-qqu70S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:17:54 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)) 14:17:54 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)) 14:17:54 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)) 14:17:54 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)) 14:17:54 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:54 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:54 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 14:17:54 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 14:17:54 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 14:17:54 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 14:17:54 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 14:17:54 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 14:17:56 INFO - Downloading blessings-1.6.tar.gz 14:17:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:56 INFO - Installing collected packages: blessings 14:17:56 INFO - Running setup.py install for blessings 14:17:57 INFO - Successfully installed blessings 14:17:57 INFO - Cleaning up... 14:17:57 INFO - Return code: 0 14:17:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:57 INFO - Reading from file tmpfile_stdout 14:17:57 INFO - Current package versions: 14:17:57 INFO - blessings == 1.6 14:17:57 INFO - blobuploader == 1.2.4 14:17:57 INFO - docopt == 0.6.1 14:17:57 INFO - functools32 == 3.2.3-2 14:17:57 INFO - jsonschema == 2.5.1 14:17:57 INFO - manifestparser == 1.1 14:17:57 INFO - mozInstall == 1.12 14:17:57 INFO - mozcrash == 1.0 14:17:57 INFO - mozdebug == 0.1 14:17:57 INFO - mozdevice == 0.48 14:17:57 INFO - mozfile == 1.2 14:17:57 INFO - mozhttpd == 0.7 14:17:57 INFO - mozinfo == 0.9 14:17:57 INFO - mozleak == 0.1 14:17:57 INFO - mozlog == 3.4 14:17:57 INFO - moznetwork == 0.27 14:17:57 INFO - mozprocess == 0.23 14:17:57 INFO - mozprofile == 0.28 14:17:57 INFO - mozrunner == 6.13 14:17:57 INFO - mozscreenshot == 0.1 14:17:57 INFO - mozsystemmonitor == 0.3 14:17:57 INFO - moztest == 0.8 14:17:57 INFO - mozversion == 1.4 14:17:57 INFO - psutil == 3.1.1 14:17:57 INFO - requests == 1.2.3 14:17:57 INFO - wsgiref == 0.1.2 14:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:17:57 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')]} 14:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:58 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')]} 14:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:58 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 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:58 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 14:17:58 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 14:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:58 INFO - 'HOME': '/Users/cltbld', 14:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:58 INFO - 'LOGNAME': 'cltbld', 14:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:58 INFO - 'MOZ_NO_REMOTE': '1', 14:17:58 INFO - 'NO_EM_RESTART': '1', 14:17:58 INFO - 'PAGER': '/bin/cat', 14:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:58 INFO - 'PWD': '/builds/slave/test', 14:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:58 INFO - 'SHELL': '/bin/bash', 14:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:58 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:58 INFO - 'USER': 'cltbld', 14:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:58 INFO - 'XPC_FLAGS': '0x0', 14:17:58 INFO - 'XPC_SERVICE_NAME': '0', 14:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 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)) 14:17:58 INFO - Cleaning up... 14:17:58 INFO - Return code: 0 14:17:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:17:58 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')]} 14:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:58 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')]} 14:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107841490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077b7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff92949ab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, '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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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 14:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:17:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:17:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:17:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:17:59 INFO - 'HOME': '/Users/cltbld', 14:17:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:17:59 INFO - 'LOGNAME': 'cltbld', 14:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:59 INFO - 'MOZ_NO_REMOTE': '1', 14:17:59 INFO - 'NO_EM_RESTART': '1', 14:17:59 INFO - 'PAGER': '/bin/cat', 14:17:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:17:59 INFO - 'PWD': '/builds/slave/test', 14:17:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:17:59 INFO - 'SHELL': '/bin/bash', 14:17:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:17:59 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:17:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:17:59 INFO - 'USER': 'cltbld', 14:17:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:17:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:59 INFO - 'XPC_FLAGS': '0x0', 14:17:59 INFO - 'XPC_SERVICE_NAME': '0', 14:17:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:17:59 INFO - Cleaning up... 14:17:59 INFO - Return code: 0 14:17:59 INFO - Running post-action listener: _resource_record_post_action 14:17:59 INFO - Running post-action listener: _start_resource_monitoring 14:17:59 INFO - Starting resource monitoring. 14:17:59 INFO - [mozharness: 2017-02-09 22:17:59.432932Z] Finished create-virtualenv step (success) 14:17:59 INFO - [mozharness: 2017-02-09 22:17:59.433919Z] Running install step. 14:17:59 INFO - Running pre-action listener: _resource_record_pre_action 14:17:59 INFO - Running main action method: install 14:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:17:59 INFO - Reading from file tmpfile_stdout 14:17:59 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:17:59 INFO - Reading from file tmpfile_stdout 14:17:59 INFO - Output received: 14:17:59 INFO - Usage: mozinstall [options] installer 14:17:59 INFO - Options: 14:17:59 INFO - -h, --help show this help message and exit 14:17:59 INFO - -d DEST, --destination=DEST 14:17:59 INFO - Directory to install application into. [default: 14:17:59 INFO - "/builds/slave/test"] 14:17:59 INFO - --app=APP Application being installed. [default: firefox] 14:17:59 INFO - mkdir: /builds/slave/test/build/application 14:17:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:18:21 INFO - Reading from file tmpfile_stdout 14:18:21 INFO - Output received: 14:18:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:18:21 INFO - Running post-action listener: _resource_record_post_action 14:18:21 INFO - [mozharness: 2017-02-09 22:18:21.209564Z] Finished install step (success) 14:18:21 INFO - [mozharness: 2017-02-09 22:18:21.209717Z] Running run-tests step. 14:18:21 INFO - Running pre-action listener: _resource_record_pre_action 14:18:21 INFO - Running main action method: run_tests 14:18:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:18:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:18:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:18:21 INFO - 2017-02-09 14:18:21.224 screenresolution[1620:7371] starting screenresolution argv=screenresolution get 14:18:21 INFO - 2017-02-09 14:18:21.227 screenresolution[1620:7371] Display 0: 1600x1200x32@60 14:18:21 INFO - 2017-02-09 14:18:21.232 screenresolution[1621:7374] starting screenresolution argv=screenresolution list 14:18:21 INFO - Available Modes on Display 0 14:18:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:18:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:18:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:18:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:18:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:18:21 INFO - Intel Iris: 14:18:21 INFO - Chipset Model: Intel Iris 14:18:21 INFO - Type: GPU 14:18:21 INFO - Bus: Built-In 14:18:21 INFO - VRAM (Dynamic, Max): 1536 MB 14:18:21 INFO - Vendor: Intel (0x8086) 14:18:21 INFO - Device ID: 0x0a2e 14:18:21 INFO - Revision ID: 0x0009 14:18:21 INFO - Displays: 14:18:21 INFO - Display: 14:18:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:18:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:18:21 INFO - Display Serial Number: 1600x1200 60 14:18:21 INFO - Main Display: Yes 14:18:21 INFO - Mirror: Off 14:18:21 INFO - Online: Yes 14:18:21 INFO - Rotation: Supported 14:18:21 INFO - Return code: 0 14:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:18:21 INFO - Python 2.7.3 14:18:21 INFO - Return code: 0 14:18:21 INFO - grabbing minidump binary from tooltool 14:18:21 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')]} 14:18:21 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 0x107655d30>, '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 0x1074bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10764db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:18:21 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 14:18:21 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 14:18:21 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 14:18:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:18:21 INFO - Return code: 0 14:18:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:18:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:18:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:18:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:18:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--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 14:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0221 --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 14:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ek5Y0YXeby/Render', 14:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:18:21 INFO - 'HOME': '/Users/cltbld', 14:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:18:21 INFO - 'LOGNAME': 'cltbld', 14:18:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:18:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:18:21 INFO - 'MOZ_NO_REMOTE': '1', 14:18:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:18:21 INFO - 'NO_EM_RESTART': '1', 14:18:21 INFO - 'PAGER': '/bin/cat', 14:18:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:18:21 INFO - 'PWD': '/builds/slave/test', 14:18:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:18:21 INFO - 'SHELL': '/bin/bash', 14:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.VUZDtZzjzU/Listeners', 14:18:21 INFO - 'TMPDIR': '/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/', 14:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:18:21 INFO - 'USER': 'cltbld', 14:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:18:21 INFO - 'XPC_FLAGS': '0x0', 14:18:21 INFO - 'XPC_SERVICE_NAME': '0', 14:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:18:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0221', '--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 14:18:21 INFO - mozversion application_buildid: 20170209120619 14:18:21 INFO - mozversion application_changeset: 49b3ad9f467d48194dab8121f82e4c938b70b484 14:18:21 INFO - mozversion application_display_name: Firefox 14:18:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:18:21 INFO - mozversion application_name: Firefox 14:18:21 INFO - mozversion application_remotingname: firefox 14:18:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:18:21 INFO - mozversion application_vendor: Mozilla 14:18:21 INFO - mozversion application_version: 52.0 14:18:21 INFO - mozversion platform_buildid: 20170209120619 14:18:21 INFO - mozversion platform_changeset: 49b3ad9f467d48194dab8121f82e4c938b70b484 14:18:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:18:21 INFO - mozversion platform_version: 52.0 14:18:21 INFO - using testdate: 1486678701 14:18:21 INFO - actual date: 1486678701 14:18:21 INFO - starting webserver on 'localhost:49239' 14:18:21 INFO - SUITE-START | Running 2 tests 14:18:21 INFO - TEST-START | dromaeo_css 14:18:21 INFO - operating with platform_type : mac_ 14:18:21 INFO - Initialising browser for dromaeo_css test... 14:18:21 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpJK0BSJ/profile http://localhost:49239/getInfo.html) 14:18:24 INFO - PROCESS | 1631 | __metrics Screen width/height:1600/1200 14:18:24 INFO - PROCESS | 1631 | colorDepth:24 14:18:24 INFO - PROCESS | 1631 | Browser inner width/height: 1024/689 14:18:24 INFO - PROCESS | 1631 | __metrics 14:18:24 INFO - PROCESS | 1631 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:18:24 INFO - PROCESS | 1631 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:18:25 INFO - TEST-INFO | 1631: exit 0 14:18:25 INFO - Browser initialized. 14:18:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:18:25 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpJK0BSJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:18:37 INFO - PROCESS | 1634 | RSS: Main: 167927808 14:18:37 INFO - PROCESS | 1634 | 14:21:40 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 14:21:41 INFO - PROCESS | 1634 | RSS: Main: 266317824 14:21:41 INFO - PROCESS | 1634 | 14:24:44 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 14:24:44 INFO - PROCESS | 1634 | RSS: Main: 295694336 14:24:44 INFO - PROCESS | 1634 | 14:27:47 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 14:27:47 INFO - PROCESS | 1634 | RSS: Main: 254164992 14:27:47 INFO - PROCESS | 1634 | 14:30:49 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 14:30:50 INFO - PROCESS | 1634 | RSS: Main: 284020736 14:30:50 INFO - PROCESS | 1634 | 14:33:53 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 14:33:54 INFO - PROCESS | 1634 | RSS: Main: 259747840 14:33:54 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 14:36:57 INFO - PROCESS | 1634 | RSS: Main: 328605696 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | __start_tp_report 14:36:57 INFO - PROCESS | 1634 | _x_x_mozilla_page_load 14:36:57 INFO - PROCESS | 1634 | _x_x_mozilla_page_load_details 14:36:57 INFO - PROCESS | 1634 | |i|pagename|runs| 14:36:57 INFO - PROCESS | 1634 | |0;dojo.html;2468.8518688878667;3383.8477268522915;3403.0301364111224;3410.437277849155;3461.4288642373995;5647.09646456567;5697.943020569793;5717.999350113734;5761.62549434287;5768.682722450264;5643.181738647893;5717.685527295997;5720.1991721159075;5721;5764.510016648579;5102.285680004802;5127.717975511346;5156.664816786897;5157.406898206698;5197.584193264549;4144.772037537934;5070.264811602316;5076.46697096805;5088.363954505687;5094.898102037957;5072.74636268187;5134.460881607433;5138.8715282118055;5151.201563757605;5155;5121.334226550562;5164.070467315882;5195.922061169085;5202.271681964528;5236.031334203185;5072.873178170538;5136.075506408845;5150.613703972217;5154.948450515484;5157.355330583677;5526.06056970312;5568.832935011957;5572.944270557324;5614.747336369873;5623.634463759883;6137.355577664371;6162.691865406757;6167.938320616781;6203.2245969253845;6227.813165605039;6256.03031530109;6266.060090986343;6273.05904114382;6292.370762923717;6306.400891915261;5633.183188437694;5682.147677848356;5684.91472627915;5729;5741.540676745851;6243.159884588562;6251.718672659741;6291.9685401573615;6304.842378940563;6325.58883672569;6097.939020609826;6118;6125.877482450326;6137.84655383619;6140.478059364915;6091.786787462506;6108.008189064015;6118.680093383066;6121.392004143319;6204.038374052029;6116.602420842631;6163.106349579286;6167.876642467126;6181.381861813783;6188.504919606421;6123.265208174958;6193.752249910043;6198.256209254828;6209.316975132731;6212.72042758077;4855.660103792771;4888.877778055577;4895.388076490439;4940.333055037596;4959.975200123977;4380.8685739427865;4406.383106365111;4412.911741765147;4416.955830441719;4437.889052773707;5720.856978575485;5723.399043100498;5738.368779434259;5744.425557444222;5759.164921086419;6028.216331876915;6245.219347581552;6255.874882502325;6267.091271765568;6281.8743625127245;5275.918436720463;5622.662640241599;5664.971675141598;5688.146777983336;5723.112917497794;5343.839684809462;5348.331458567679;5358.839234822962;5370.194470829407;5383.977044361559;6249.062640603855;6257.155284036597;6258.874822503524;6259.3427690091885;6277.937220627827;4722.48052714208;6113.57204995646;6141.271221159771;6143.204841797061;6166.445019948226;6269.404406581368;6282.654454005074;6291.1192433058495;6297.275813281532;6302.621842689453;6153.384661533811;6153.815385538441;6165.876682466236;6174.598651087665;6180.196574445294;6062.484688801324;6108.706347747117;6133.579501509479;6227.813165605039;6253.1245625613365;5938.198343223782;6060.818175454743;6067.848303792264;6078.696065196811;6090.878182436238;6031.547633927561;6041.75832966694;6049.78825741097;6051.183090282755;6072.757089716539;5716.685582293014;5775.422457754191;5800.56495762811;5842.3281322646735;5845.561582881216;5976.223090998143;6054.152418661479;6076.149339092619;6117.9492029047315;6119.106526814713;5927.40725927421;5932.347441781487;5950.19672344228;5956.37458066914;5961.672108034099 14:36:57 INFO - PROCESS | 1634 | |1;ext.html;474.66536092055105;485.7716873069658;491.43730428659165;539.0727947929562;548.4515484515484;27985.440291194165;40423.78728638138;40451.190976180456;40458.59541404585;42424.787876060655;41983.79008104963;42300.36549451761;42341.57658423415;42346.15307693844;42414;8798.648054077828;9390.24878009761;9579.994100619439;9592.08875156859;9596;8799.120087991181;9014.323925705598;9035.819283614324;9061;11536.365499897502;11518.424078796026;11776.646700598996;11823.822642660367;11839.7632047359;11863.703407414841;11632.360220187886;11730.824037639442;11745.236559623598;11749.530018799238;11755.471003804849;11669.883301166965;11707.765844683145;11718.945294923413;11721.941390292994;11729.53081876724;39465.60534394648;39693.40459893075;39750.0062498437;39769.801150994346;39898.80050599758;3306.35526072416;3358.0933148050135;3448.0173150651945;3522.6477352264824;4025.63769260765;24382.878085609635;29338.853305733548;30408.391832163456;31200.843995779876;31513.52729709056;3236.1262459136137;3247.8376081196084;3337.7830441021256;3339.5658564386476;3352.63121056686;508571;513392;513851;514479;514529;33126.3374732504;33305;33422.99731008073;35319.82340088283;58130;35822.462663060076;35981.64018359783;35988.460173097425;36005.91982240537;36037.8198109013;15074.944753867343;15241.3903443861;15248.695026099416;15260.542183734506;15261.694766104616;12908.225506469642;12982.545610903762;13022.80465792995;13029.869701302865;13057.738845223043;7373.81565460857;7401.81495462607;7740.922590774133;7743.264389882952;7901.446898717149;3223.854926528312;3292.111129994888;3305.25631732863;3311.8012919224443;3346.2303670156;985.5466485416789;1001.3741411617739;1013.0730381700662;1026.235454586338;1054.7468607534136;29500.557491637643;29523.409531809673;29841.52377143446;30146.547801782992;30189.547156792665;1013.3312014070679;1035.3787727363522;1059.523214553454;1079.2930630437077;1100.7138144082437;14594.270286485633;15305.158216297988;15673.059616423052;15818.60453488672;15952.92023539875;659545;662537;662639;663156;664776;55942.720286398304;56321.43678563162;56485;56509;56549.43450565442;1212.9454174562165;1244.5333000124954;1276.8659290774522;1352.0670737191306;1363.7817949128091;26823.463530729667;28641.570376443953;29966.85016574903;30626.234344141576;31177.8441107793;47866.5213347876;48407.5159248403;48552.5144748548;48574.271385928536;48588;527567;531834;532847;532916;533261;24148.63777043381;24731.752682472947;25499.36251593725;25719.357016074748;25915.740842591335;45114;45318.5617725875;45429.09141817079;45531.317030245234;46952.53047469482;36721.81639091788;36965;37694.8115259422;38527;38898.80550597229;37552.061198470255;37962.0509487265;37997;38035.23929521339;38085;35991.28017439689;36729.08177295589;37561.81219093887;37615;39382.803085985535;31539.52690709687;33289.83355083209;33790;34434.7947821825;34680.65319346774;25336.74663253344;25597.488050239263;25648.61527077058;25720.485590287713;26096 14:36:57 INFO - PROCESS | 1634 | |2;jquery.html;375.79894756305373;383.593391005534;389.2968263845675;394.51080659981596;409.30213985155314;19475.220991160353;20068.397948061545;20282.594348113027;20713.689294660573;20784.688229676565;19796.50508737282;19896.70154947677;20403;20664.276750313744;20907.268245611405;5074.898502029957;5955.761769529225;6218.253809542861;6868.656567171622;6943.548669336477;6641.900371494431;6888.724451021953;6976.093107895967;6977.162740471151;6983.615901125436;6621.9006714899315;6709.429698475636;6715.9664201678925;6719.697613607375;6726.293739157391;6500.9674951625175;6697.19633643961;6699.765508207213;6747.865042699168;6817.863642727168;5933.673647949361;5942.70286485674;5945.4946329562035;5957.314908785502;5961.463468287831;24036.158734444387;25025.124120655688;25281.873590632113;25507.362315942064;25771.613425798627;2078.9480262993393;2138.540213854029;2198.967015494769;2241.4060274027397;2694.4880472710124;7846.489978151402;10322.174226061898;10323.432211228379;10416.791664166674;10505.94940505951;1889.3481748796644;1932.439592518168;1949.9902500487406;1953.7167110769;1977.7033444983224;121249.39375303067;123689;126467;128010;128309;9349.158575728217;9792.804143917225;10064.39613623185;10207.846882296772;10352.223583231287;12573.182743121668;12623.305718185587;12624.990000799913;12637.93681031589;12650.493980240872;7978.202179781975;8148.633311500878;8164.918350816416;8237.50574965492;8247.752567422987;8528;8559.443636163629;8576.185262400188;8690.695825646071;8718.084601116918;3524.559430071241;3807.971847601132;3933.940990885139;3939.546952100488;3947.6644485219076;1902.73361729358;1948.7174359717762;1951.7170010348705;1953.2284747524932;1955.823975842181;720.2833180984953;766.9424793140537;810.2586133687728;881.9162179592928;897.7531178925717;19524.21903123859;20428.387148385274;20976.895115524323;21006.579868402852;21399.358019259445;915.3226612306845;919.4758987377264;923.0492592629603;944.3719926249105;952.2762700347647;10948.616798412017;11300.773984520429;11482.770344593062;11487.885121148849;11492.885071149349;608443;609818;619307;630348;631628;92663;130402;131034;135109;135258;889.7019498467956;954.4845783277092;993.299723694779;1022.7852151048214;1023.0127926550765;15251;19546.120424580644;19881.900590496956;19918.50203744918;20065.498362541053;56414.43585564092;56609;56831;57951;59235.11147332707;76087.23912760802;77924.61037694775;80894;81017;81726.59136704278;5618.381977982337;7080.256573059754;7434.405247580073;8187.5087494750505;8327.125651806715;12147.514099435924;12973.610791676265;13193;13384.263865487103;13463.326833658082;11086.113110950942;11164.939330763564;11283.492242848928;11363.943180284046;11704.765904682028;8856.955715221382;11099.445027748741;11143.777124457303;11643.5924742637;11650.592229271935;9939.453330066915;11032.724181895517;11500.94249528747;11551.537938482703;11984.58053968107;7280.3083707047745;7417.517861338995;7546.849063018819;7571.886421703569;7633.923660763543;7988.400869934662;8087.231712987257;8265.380096492667;10979.231453798158;11184.273022253528 14:36:57 INFO - PROCESS | 1634 | |3;mootools.html;1494.86546210841;1521.9086854788713;1677.2200926569144;1834.4496651004695;1845.2065611786927;7429.7399591014255;8096.230858068481;8356.91643083569;8548.743537693863;8548.871766923501;7456.515326503773;7695.538267703928;8147.1852814718495;8352.164783521644;8353.457025293352;1972.9704054439194;1975.87156834806;2335.1243283768586;2361.3978435498925;2365.396823809926;2097.2030628361204;2304.0553373117027;2351.905923763047;2385.022140922222;2404.8797560121925;2330.7319658239267;2331.9183828566;2353.62342025276;2355.5759963206615;2358.6108292131776;2288.119074156445;2310.9653355199684;2336.5210131922913;2337.415646088478;2338.240071976606;2357.799587035104;2378.1676413255395;2378.655095011231;2380.8809559521956;2382.1424287256573;8429.662813487454;8446.197611226924;8502.617382217815;8508.234258916666;8532.018817835966;5066.062778385974;5234.502722241381;5234.738263086831;5235.450277720823;5240.633155679104;3187.888423905152;3423.803680981595;3434.587849458056;3551.147724546116;3551.200979779555;1037.6108959140322;1045.8535804987307;1062.829947208443;1078.687180717591;1083.3608171179042;10782.5686972521;10838.67483975482;10877.238593298473;10878.61924832635;10886;4481.282994720829;4579.267317229227;4673.322368256584;4679.274712419512;4744.857654270378;9448.385854919408;9456.05439456049;9461.148496635198;9462.858057129148;9466.05339466048;5226.817061402832;5242.108841496878;5246.606504512177;5254.92117618236;5257.6845389276;4102.384642303678;4234.089670720809;4810.989692164615;4830.758462076882;4842.782074806642;3792.6965842733066;3812.1041555234497;3864.6908247340143;3894.7273690841935;3898.3957486589625;1263.216805580546;1272.1730874931368;1276.6297773645538;1287.7231395250067;1288.0597164070282;755.9395248380226;848.4018766769412;888.4269646078243;914.7621618379269;921.2860033474111;5467.17992301158;5620.707237335354;5641.5204707600315;5821.825345239649;5880.294364676266;987.3286165407592;1009.4649835587151;1021.4994652620163;1028.475477506462;1029.583018877356;3755.211405604799;3779.9726363935897;3806.1816709407613;3867.0912335601674;3959.2675355059405;9766.9023309766;10242.590296388062;10245.282830201962;10252.23108266883;10264.384136951807;10198.082172604501;10202.489875506195;10209.846852297222;10221.795564088676;10243.795124097476;7587.544747315179;7651.5409075455655;7827;7870.9606451967375;7877.4091943104495;5508.641938274;5541.556675466034;5636.098224284095;5733.455321744427;5743.368229494668;9264.490453024879;9285.396449230779;9285.67500137519;9387.81224375495;9407.52962351866;7329.596872172082;9373.578188981648;9565.713028608874;9650.469224192737;9652.131308182297;6303.842403939938;6493.577917435352;6617.073609694743;6703.095082164041;6838.487113466609;6786.93213067863;7901.249381308767;8075.757727268191;8079.757607271791;8083.555404452812;6107.389261073857;7103.538270012433;7215.639218038972;7235.2041275458605;7346.77959661211;7043.013978043181;7080.468964827555;7088.574685518885;7113.857722845618;7159.7136114556915;6676.265610782907;6684.231313399021;6784.118064651564;6788.490863185182;6789.1852977643;4161.396597493407;4867.075255701406;4920.31115643803;4931.482194369683;4942.184539550934;4834;4850.684705494132;4911.3369695090705;5047.1419858623385;5065.366829146356 14:36:57 INFO - PROCESS | 1634 | |4;prototype.html;305.66529650033215;307.98306093164865;313.7834893923194;320.2234581140735;323.5098825279703;5322.498425739896;5339.385970613375;5347.7326133693305;5350.41145473998;5402.135658294674;4464.866054018376;5109.208072748721;5174.4386528668365;5182.144946083901;5209.661372010816;3169.793963392384;4012.538558065831;4024.8390064397463;4059.9594004059877;4089.6708569714815;4017.8593749218785;4023.011465782438;4044.169081642862;4062.512498500184;4066;3139.2936589267347;3192.4413227685177;3912.8826135215845;4022.7385219960756;4023.1752490739473;4012.277789997799;4017.97991010046;4032.3145065338963;4033.2740106780766;4040.6161414665708;3189.81018981019;3493.371193185226;3540.044188069233;3548.006558163718;3576.5529308836394;5119.593790918262;5129.538341549279;5142.51146141116;5146.459621739701;5160.767765450564;3973.3443981742976;4266.485397683839;4518.847693838083;4600.148972440109;4608.815647374101;4761.262004389325;4963.255511673278;5408.972295263888;5563.693996830173;5572.461486955813;3767.0770661188185;3812.951438354447;3830.7893065881367;3832.96509942314;3834.3673293906472;4878.487668822676;5600.943990560124;5691.231683722727;5712.314867114212;5911.9113213301835;3878.9224215516097;3882.9805850970565;3895;3907.9218415631526;3922.764634121962;3810.7141964352786;3982.7212095153063;3989.3816458448987;3990.10222699896;3996.320625493673;4051.311277082844;4309.306683322923;4532.391001194528;4588.49526552079;4640.257558790645;5072.391313042459;5092;5357.973210133924;5601.467860553241;5621.606487545832;1149.8444063715913;1294.6633875192517;1297.5985935189972;1298.9090763646454;1302.798066299725;676.7191615479619;691.7924622613195;763.6410886883156;825.9793505162298;877.6928075173765;4834.975825120852;5008.821162794124;5260.447652996457;5264.605154613343;5310.867228319323;4365.476142862877;5307.6019298552765;5736.225609542658;5803.216565763568;5826.504747096459;5103.086342621517;5118.769655365518;5229.4770522948165;5290.259363689087;5299.682019078868;2455.980767981268;2551.8389132944835;2722.5235583773156;2897.058456001808;2911.5778212159116;5393.4336894626285;5777.64225407029;5797.768089276466;5810.477057064884;5820.1560773688425;4387.8244870204835;6034.250067480381;6041.2750469943885;6046;6061.848453788691;5583.609147359727;6118.1434599156155;6126.356732543108;6164.167837341902;6204.5967012144965;5054.873628159178;5553.444655534414;5760.1935728998815;5851.414858514285;5895.64626122434;5242.842714718565;5737.5983681141915;5753.367129615655;5766.942330576809;5795.304563452244;5233.581313494835;5345.919811202757;5778.572999340203;6075.908861367171;6090.573659843769;3204.4872820348633;3650.4341827016856;3779.263043706451;3823.4073718573663;3837.270918525471;4724.834630787906;5043.982407037214;5312.5484333832055;5786.797462088806;5912.940870591239;4596.931046034245;5157.149070403341;5748.080307150836;5750.281214848144;5785.161151632906;4552.930061435493;5417.458254174551;5634.464725851038;5662.348829884451;5711.371749107512;4905.607551395951;5138.434772175133;5282.837775689342;5334.733263336895;5551.584345991746;5195.636305458582;5250.737463126905;5477.315335583052;5556.499915007668;5574.832755017356;4560.315952607136;5183.403908550414;5567.498925096761;5576;5577.3028371453565 14:36:57 INFO - PROCESS | 1634 | |5;yui.html;704.5314865614366;725.260234560748;753.6533194730422;794.443889277506;794.5312265763199;14684.118952862837;15328;15335.539933801976;15385.38458461663;15406.537803865887;10667.893321066787;13737.17576945384;13773.51792687256;13852.307384630778;13881.93059034706;681.686424244848;700.7302188657378;703.5532436902578;703.6165289916981;826.5660528222686;689.4002218070286;693.3863530775275;808.8746244332137;839.1566475691922;842.1957031035378;871.6687658689721;876.242050626207;880.2034159086005;880.7489865388366;883.5538053283083;882.3955590420551;883.1654086887894;884.2837301785574;884.3544212724714;884.6682494064726;653.3466533466534;656.0651072222112;656.0913135307634;656.1732217406055;656.3895577113283;13692.726145477134;13728.93135534316;14117.364718587689;14138;14162;14083.225422601752;14254.857451425456;14286.071405358722;14349.28253587327;14350.425982960669;11504.367259800707;11521.827172592419;11599.94200029003;11664.331216521037;11674.649760507113;3691.667749902522;3730.65696349314;3771.4719939208535;3819.9045023874623;3846.6345697158727;92207.53896230544;92328.53835730845;93516.53241733884;94934;100407;10899.618513351994;10901.509432075576;10968;11044.613438529614;11094.500747466383;21009.369718908456;21020.369388918356;21089.261875834578;21272.574548508943;21364;7547.924520754832;7734.961325193338;7971.322437592869;8014.599270036475;8089.595520224083;4133.958660413417;4351.521332653406;4437.534058923831;4465.776711164429;4603.953960460352;3379.172102834821;3463.7748546344405;3497.3529896969144;3678.981605092011;3854.4411060396646;584.8420926349862;702.1013103227876;706.7349743846057;710.9573425594481;721.6283613938825;637.6238019568477;658.6871236162784;665.8867992441296;669.8425869920565;700.719712115158;9152.130547597968;9411.4823684698;9464.722262494475;9542.570584323723;9706.854397184048;595.2648479128273;671.6675245753383;674.8852695041854;690.7619313424468;696.4880812602732;3793.298239825586;4416.933745993812;4632.25883858581;4689.882752931136;4736.786844592001;78346.6082669583;96076.51961740147;113273;116175.41912290384;119146;98328.01671983332;99752;102729.48635256776;104606;106313;74719.62640186764;85086.72369914457;87011.1298887003;89793.55103224573;91804;9468.28987825902;9607;9607.663731769355;9626.518674066408;9751.122398984126;51870.74064629653;54086;55673;55688.88622227614;56264.71867640636;55052.72473637606;72455;73098;75510.48979020499;77845.22154778606;12829.486820527074;12978.740425191254;13319;13341.3329333531;13664.043516954116;13807.723845523235;14491.058081224686;14860.671848031083;15233.3906643733;15682;13399;13797.06553830949;13926.42361163188;14338.856611433752;14596.905232107421;10394.428306443218;13361.933190333986;13563.050586459249;13885.375158118111;14607.634809129431;13333.799189410163;13469.461221551028;13595.45618175262;13604.251766152956;13642.93178534101;11244.325340479598;11474.827877582009;11539.307641541534;11622.418879056182;11955.521779128738;11188.832167517656;11227.270227435518;11686.88313116892;11693.941530292293;11710.648680539598 14:36:57 INFO - PROCESS | 1634 | __end_tp_report 14:36:57 INFO - PROCESS | 1634 | __start_cc_report 14:36:57 INFO - PROCESS | 1634 | _x_x_mozilla_cycle_collect,1129 14:36:57 INFO - PROCESS | 1634 | __end_cc_report 14:36:57 INFO - PROCESS | 1634 | __startTimestamp1486679817703__endTimestamp 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | ------- Summary: start ------- 14:36:57 INFO - PROCESS | 1634 | Number of tests: 6 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | [#0] dojo.html Cycles:165 Average:5685.91 Median:5932.35 stddev:667.91 (11.3%) stddev-sans-first:620.45 14:36:57 INFO - PROCESS | 1634 | Values: 2468.9 3383.8 3403.0 3410.4 3461.4 5647.1 5697.9 5718.0 5761.6 5768.7 5643.2 5717.7 5720.2 5721.0 5764.5 5102.3 5127.7 5156.7 5157.4 5197.6 4144.8 5070.3 5076.5 5088.4 5094.9 5072.7 5134.5 5138.9 5151.2 5155.0 5121.3 5164.1 5195.9 5202.3 5236.0 5072.9 5136.1 5150.6 5154.9 5157.4 5526.1 5568.8 5572.9 5614.7 5623.6 6137.4 6162.7 6167.9 6203.2 6227.8 6256.0 6266.1 6273.1 6292.4 6306.4 5633.2 5682.1 5684.9 5729.0 5741.5 6243.2 6251.7 6292.0 6304.8 6325.6 6097.9 6118.0 6125.9 6137.8 6140.5 6091.8 6108.0 6118.7 6121.4 6204.0 6116.6 6163.1 6167.9 6181.4 6188.5 6123.3 6193.8 6198.3 6209.3 6212.7 4855.7 4888.9 4895.4 4940.3 4960.0 4380.9 4406.4 4412.9 4417.0 4437.9 5720.9 5723.4 5738.4 5744.4 5759.2 6028.2 6245.2 6255.9 6267.1 6281.9 5275.9 5622.7 5665.0 5688.1 5723.1 5343.8 5348.3 5358.8 5370.2 5384.0 6249.1 6257.2 6258.9 6259.3 6277.9 4722.5 6113.6 6141.3 6143.2 6166.4 6269.4 6282.7 6291.1 6297.3 6302.6 6153.4 6153.8 6165.9 6174.6 6180.2 6062.5 6108.7 6133.6 6227.8 6253.1 5938.2 6060.8 6067.8 6078.7 6090.9 6031.5 6041.8 6049.8 6051.2 6072.8 5716.7 5775.4 5800.6 5842.3 5845.6 5976.2 6054.2 6076.1 6117.9 6119.1 5927.4 5932.3 5950.2 5956.4 5961.7 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | [#1] ext.html Cycles:180 Average:68283.52 Median:19064.34 stddev:153445.25 (804.9%) stddev-sans-first:153791.24 14:36:57 INFO - PROCESS | 1634 | Values: 474.7 485.8 491.4 539.1 548.5 27985.4 40423.8 40451.2 40458.6 42424.8 41983.8 42300.4 42341.6 42346.2 42414.0 8798.6 9390.2 9580.0 9592.1 9596.0 8799.1 9014.3 9035.8 9061.0 11536.4 11518.4 11776.6 11823.8 11839.8 11863.7 11632.4 11730.8 11745.2 11749.5 11755.5 11669.9 11707.8 11718.9 11721.9 11729.5 39465.6 39693.4 39750.0 39769.8 39898.8 3306.4 3358.1 3448.0 3522.6 4025.6 24382.9 29338.9 30408.4 31200.8 31513.5 3236.1 3247.8 3337.8 3339.6 3352.6 508571.0 513392.0 513851.0 514479.0 514529.0 33126.3 33305.0 33423.0 35319.8 58130.0 35822.5 35981.6 35988.5 36005.9 36037.8 15074.9 15241.4 15248.7 15260.5 15261.7 12908.2 12982.5 13022.8 13029.9 13057.7 7373.8 7401.8 7740.9 7743.3 7901.4 3223.9 3292.1 3305.3 3311.8 3346.2 985.5 1001.4 1013.1 1026.2 1054.7 29500.6 29523.4 29841.5 30146.5 30189.5 1013.3 1035.4 1059.5 1079.3 1100.7 14594.3 15305.2 15673.1 15818.6 15952.9 659545.0 662537.0 662639.0 663156.0 664776.0 55942.7 56321.4 56485.0 56509.0 56549.4 1212.9 1244.5 1276.9 1352.1 1363.8 26823.5 28641.6 29966.9 30626.2 31177.8 47866.5 48407.5 48552.5 48574.3 48588.0 527567.0 531834.0 532847.0 532916.0 533261.0 24148.6 24731.8 25499.4 25719.4 25915.7 45114.0 45318.6 45429.1 45531.3 46952.5 36721.8 36965.0 37694.8 38527.0 38898.8 37552.1 37962.1 37997.0 38035.2 38085.0 35991.3 36729.1 37561.8 37615.0 39382.8 31539.5 33289.8 33790.0 34434.8 34680.7 25336.7 25597.5 25648.6 25720.5 26096.0 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | [#2] jquery.html Cycles:180 Average:35813.21 Median:2095.78 stddev:103476.47 (4937.4%) stddev-sans-first:103732.53 14:36:57 INFO - PROCESS | 1634 | Values: 375.8 383.6 389.3 394.5 409.3 19475.2 20068.4 20282.6 20713.7 20784.7 19796.5 19896.7 20403.0 20664.3 20907.3 5074.9 5955.8 6218.3 6868.7 6943.5 6641.9 6888.7 6976.1 6977.2 6983.6 6621.9 6709.4 6716.0 6719.7 6726.3 6501.0 6697.2 6699.8 6747.9 6817.9 5933.7 5942.7 5945.5 5957.3 5961.5 24036.2 25025.1 25281.9 25507.4 25771.6 2078.9 2138.5 2199.0 2241.4 2694.5 7846.5 10322.2 10323.4 10416.8 10505.9 1889.3 1932.4 1950.0 1953.7 1977.7 121249.4 123689.0 126467.0 128010.0 128309.0 9349.2 9792.8 10064.4 10207.8 10352.2 12573.2 12623.3 12625.0 12637.9 12650.5 7978.2 8148.6 8164.9 8237.5 8247.8 8528.0 8559.4 8576.2 8690.7 8718.1 3524.6 3808.0 3933.9 3939.5 3947.7 1902.7 1948.7 1951.7 1953.2 1955.8 720.3 766.9 810.3 881.9 897.8 19524.2 20428.4 20976.9 21006.6 21399.4 915.3 919.5 923.0 944.4 952.3 10948.6 11300.8 11482.8 11487.9 11492.9 608443.0 609818.0 619307.0 630348.0 631628.0 92663.0 130402.0 131034.0 135109.0 135258.0 889.7 954.5 993.3 1022.8 1023.0 15251.0 19546.1 19881.9 19918.5 20065.5 56414.4 56609.0 56831.0 57951.0 59235.1 76087.2 77924.6 80894.0 81017.0 81726.6 5618.4 7080.3 7434.4 8187.5 8327.1 12147.5 12973.6 13193.0 13384.3 13463.3 11086.1 11164.9 11283.5 11363.9 11704.8 8857.0 11099.4 11143.8 11643.6 11650.6 9939.5 11032.7 11500.9 11551.5 11984.6 7280.3 7417.5 7546.8 7571.9 7633.9 7988.4 8087.2 8265.4 10979.2 11184.3 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | [#3] mootools.html Cycles:180 Average:5444.98 Median:4994.66 stddev:2967.38 (59.4%) stddev-sans-first:2960.86 14:36:57 INFO - PROCESS | 1634 | Values: 1494.9 1521.9 1677.2 1834.4 1845.2 7429.7 8096.2 8356.9 8548.7 8548.9 7456.5 7695.5 8147.2 8352.2 8353.5 1973.0 1975.9 2335.1 2361.4 2365.4 2097.2 2304.1 2351.9 2385.0 2404.9 2330.7 2331.9 2353.6 2355.6 2358.6 2288.1 2311.0 2336.5 2337.4 2338.2 2357.8 2378.2 2378.7 2380.9 2382.1 8429.7 8446.2 8502.6 8508.2 8532.0 5066.1 5234.5 5234.7 5235.5 5240.6 3187.9 3423.8 3434.6 3551.1 3551.2 1037.6 1045.9 1062.8 1078.7 1083.4 10782.6 10838.7 10877.2 10878.6 10886.0 4481.3 4579.3 4673.3 4679.3 4744.9 9448.4 9456.1 9461.1 9462.9 9466.1 5226.8 5242.1 5246.6 5254.9 5257.7 4102.4 4234.1 4811.0 4830.8 4842.8 3792.7 3812.1 3864.7 3894.7 3898.4 1263.2 1272.2 1276.6 1287.7 1288.1 755.9 848.4 888.4 914.8 921.3 5467.2 5620.7 5641.5 5821.8 5880.3 987.3 1009.5 1021.5 1028.5 1029.6 3755.2 3780.0 3806.2 3867.1 3959.3 9766.9 10242.6 10245.3 10252.2 10264.4 10198.1 10202.5 10209.8 10221.8 10243.8 7587.5 7651.5 7827.0 7871.0 7877.4 5508.6 5541.6 5636.1 5733.5 5743.4 9264.5 9285.4 9285.7 9387.8 9407.5 7329.6 9373.6 9565.7 9650.5 9652.1 6303.8 6493.6 6617.1 6703.1 6838.5 6786.9 7901.2 8075.8 8079.8 8083.6 6107.4 7103.5 7215.6 7235.2 7346.8 7043.0 7080.5 7088.6 7113.9 7159.7 6676.3 6684.2 6784.1 6788.5 6789.2 4161.4 4867.1 4920.3 4931.5 4942.2 4834.0 4850.7 4911.3 5047.1 5065.4 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | [#4] prototype.html Cycles:180 Average:4507.55 Median:5124.57 stddev:1415.52 (27.6%) stddev-sans-first:1383.92 14:36:57 INFO - PROCESS | 1634 | Values: 305.7 308.0 313.8 320.2 323.5 5322.5 5339.4 5347.7 5350.4 5402.1 4464.9 5109.2 5174.4 5182.1 5209.7 3169.8 4012.5 4024.8 4060.0 4089.7 4017.9 4023.0 4044.2 4062.5 4066.0 3139.3 3192.4 3912.9 4022.7 4023.2 4012.3 4018.0 4032.3 4033.3 4040.6 3189.8 3493.4 3540.0 3548.0 3576.6 5119.6 5129.5 5142.5 5146.5 5160.8 3973.3 4266.5 4518.8 4600.1 4608.8 4761.3 4963.3 5409.0 5563.7 5572.5 3767.1 3813.0 3830.8 3833.0 3834.4 4878.5 5600.9 5691.2 5712.3 5911.9 3878.9 3883.0 3895.0 3907.9 3922.8 3810.7 3982.7 3989.4 3990.1 3996.3 4051.3 4309.3 4532.4 4588.5 4640.3 5072.4 5092.0 5358.0 5601.5 5621.6 1149.8 1294.7 1297.6 1298.9 1302.8 676.7 691.8 763.6 826.0 877.7 4835.0 5008.8 5260.4 5264.6 5310.9 4365.5 5307.6 5736.2 5803.2 5826.5 5103.1 5118.8 5229.5 5290.3 5299.7 2456.0 2551.8 2722.5 2897.1 2911.6 5393.4 5777.6 5797.8 5810.5 5820.2 4387.8 6034.3 6041.3 6046.0 6061.8 5583.6 6118.1 6126.4 6164.2 6204.6 5054.9 5553.4 5760.2 5851.4 5895.6 5242.8 5737.6 5753.4 5766.9 5795.3 5233.6 5345.9 5778.6 6075.9 6090.6 3204.5 3650.4 3779.3 3823.4 3837.3 4724.8 5044.0 5312.5 5786.8 5912.9 4596.9 5157.1 5748.1 5750.3 5785.2 4552.9 5417.5 5634.5 5662.3 5711.4 4905.6 5138.4 5282.8 5334.7 5551.6 5195.6 5250.7 5477.3 5556.5 5574.8 4560.3 5183.4 5567.5 5576.0 5577.3 14:36:57 INFO - PROCESS | 1634 | 14:36:57 INFO - PROCESS | 1634 | [#5] yui.html Cycles:180 Average:20967.46 Median:4427.23 stddev:30497.90 (688.9%) stddev-sans-first:30545.50 14:36:57 INFO - PROCESS | 1634 | Values: 704.5 725.3 753.7 794.4 794.5 14684.1 15328.0 15335.5 15385.4 15406.5 10667.9 13737.2 13773.5 13852.3 13881.9 681.7 700.7 703.6 703.6 826.6 689.4 693.4 808.9 839.2 842.2 871.7 876.2 880.2 880.7 883.6 882.4 883.2 884.3 884.4 884.7 653.3 656.1 656.1 656.2 656.4 13692.7 13728.9 14117.4 14138.0 14162.0 14083.2 14254.9 14286.1 14349.3 14350.4 11504.4 11521.8 11599.9 11664.3 11674.6 3691.7 3730.7 3771.5 3819.9 3846.6 92207.5 92328.5 93516.5 94934.0 100407.0 10899.6 10901.5 10968.0 11044.6 11094.5 21009.4 21020.4 21089.3 21272.6 21364.0 7547.9 7735.0 7971.3 8014.6 8089.6 4134.0 4351.5 4437.5 4465.8 4604.0 3379.2 3463.8 3497.4 3679.0 3854.4 584.8 702.1 706.7 711.0 721.6 637.6 658.7 665.9 669.8 700.7 9152.1 9411.5 9464.7 9542.6 9706.9 595.3 671.7 674.9 690.8 696.5 3793.3 4416.9 4632.3 4689.9 4736.8 78346.6 96076.5 113273.0 116175.4 119146.0 98328.0 99752.0 102729.5 104606.0 106313.0 74719.6 85086.7 87011.1 89793.6 91804.0 9468.3 9607.0 9607.7 9626.5 9751.1 51870.7 54086.0 55673.0 55688.9 56264.7 55052.7 72455.0 73098.0 75510.5 77845.2 12829.5 12978.7 13319.0 13341.3 13664.0 13807.7 14491.1 14860.7 15233.4 15682.0 13399.0 13797.1 13926.4 14338.9 14596.9 10394.4 13361.9 13563.1 13885.4 14607.6 13333.8 13469.5 13595.5 13604.3 13642.9 11244.3 11474.8 11539.3 11622.4 11955.5 11188.8 11227.3 11686.9 11693.9 11710.6 14:36:57 INFO - PROCESS | 1634 | -------- Summary: end -------- 14:36:57 INFO - PROCESS | 1634 | 14:36:58 INFO - TEST-INFO | 1634: exit 0 14:36:58 INFO - TEST-OK | dromaeo_css | took 1116482ms 14:36:58 INFO - TEST-START | kraken 14:36:58 INFO - operating with platform_type : mac_ 14:36:58 INFO - Initialising browser for kraken test... 14:36:58 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpis2six/profile http://localhost:49239/getInfo.html) 14:37:00 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 14:37:00 INFO - PROCESS | 1644 | colorDepth:24 14:37:00 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 14:37:00 INFO - PROCESS | 1644 | __metrics 14:37:00 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:37:00 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:37:01 INFO - TEST-INFO | 1644: exit 0 14:37:01 INFO - Browser initialized. 14:37:01 INFO - Running cycle 1/1 for kraken test... 14:37:01 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/tmpis2six/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:37:13 INFO - PROCESS | 1646 | RSS: Main: 167673856 14:37:13 INFO - PROCESS | 1646 | 14:37:16 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 14:37:17 INFO - PROCESS | 1646 | RSS: Main: 218148864 14:37:17 INFO - PROCESS | 1646 | 14:37:19 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 14:37:20 INFO - PROCESS | 1646 | RSS: Main: 231481344 14:37:20 INFO - PROCESS | 1646 | 14:37:23 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 14:37:24 INFO - PROCESS | 1646 | RSS: Main: 329592832 14:37:24 INFO - PROCESS | 1646 | 14:37:26 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 14:37:26 INFO - PROCESS | 1646 | RSS: Main: 232722432 14:37:26 INFO - PROCESS | 1646 | 14:37:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:37:29 INFO - PROCESS | 1646 | RSS: Main: 233734144 14:37:29 INFO - PROCESS | 1646 | 14:37:31 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 14:37:32 INFO - PROCESS | 1646 | RSS: Main: 275206144 14:37:32 INFO - PROCESS | 1646 | 14:37:35 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 14:37:36 INFO - PROCESS | 1646 | RSS: Main: 273367040 14:37:36 INFO - PROCESS | 1646 | 14:37:38 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 14:37:39 INFO - PROCESS | 1646 | RSS: Main: 272179200 14:37:39 INFO - PROCESS | 1646 | 14:37:40 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:37:41 INFO - PROCESS | 1646 | RSS: Main: 247611392 14:37:41 INFO - PROCESS | 1646 | 14:37:43 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:37:43 INFO - PROCESS | 1646 | RSS: Main: 247541760 14:37:44 INFO - PROCESS | 1646 | 14:37:46 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:37:46 INFO - PROCESS | 1646 | RSS: Main: 250695680 14:37:46 INFO - PROCESS | 1646 | 14:37:49 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:37:50 INFO - PROCESS | 1646 | RSS: Main: 264040448 14:37:50 INFO - PROCESS | 1646 | 14:37:53 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:53 INFO - PROCESS | 1646 | RSS: Main: 264777728 14:37:53 INFO - PROCESS | 1646 | 14:37:55 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 14:37:56 INFO - PROCESS | 1646 | RSS: Main: 308088832 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | __start_tp_report 14:37:56 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 14:37:56 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 14:37:56 INFO - PROCESS | 1646 | |i|pagename|runs| 14:37:56 INFO - PROCESS | 1646 | |0;ai-astar;104;112;113;112;111;111;112;112;111;112 14:37:56 INFO - PROCESS | 1646 | |1;audio-beat-detection;142;107;99;141;109;109;108;108;142;111 14:37:56 INFO - PROCESS | 1646 | |2;audio-dft;186;185;182;185;186;182;183;181;184;181 14:37:56 INFO - PROCESS | 1646 | |3;audio-fft;82;58;59;87;61;58;59;59;81;57 14:37:56 INFO - PROCESS | 1646 | |4;audio-oscillator;84;71;94;70;67;69;88;68;68;91 14:37:56 INFO - PROCESS | 1646 | |5;imaging-gaussian-blur;88;85;88;86;88;85;89;87;87;86 14:37:56 INFO - PROCESS | 1646 | |6;imaging-darkroom;96;97;101;96;95;96;97;99;96;97 14:37:56 INFO - PROCESS | 1646 | |7;imaging-desaturate;84;81;80;78;83;81;82;82;84;81 14:37:56 INFO - PROCESS | 1646 | |8;json-parse-financial;54;53;53;54;58;58;57;56;56;57 14:37:56 INFO - PROCESS | 1646 | |9;json-stringify-tinderbox;63;70;68;76;72;67;69;68;69;68 14:37:56 INFO - PROCESS | 1646 | |10;stanford-crypto-aes;83;83;82;82;83;82;83;82;86;91 14:37:56 INFO - PROCESS | 1646 | |11;stanford-crypto-ccm;137;137;127;150;147;150;137;138;195;160 14:37:56 INFO - PROCESS | 1646 | |12;stanford-crypto-pbkdf2;166;162;162;163;163;163;222;209;162;184 14:37:56 INFO - PROCESS | 1646 | |13;stanford-crypto-sha256-iterative;66;66;66;66;66;67;69;84;80;82 14:37:56 INFO - PROCESS | 1646 | __end_tp_report 14:37:56 INFO - PROCESS | 1646 | __start_cc_report 14:37:56 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,1907 14:37:56 INFO - PROCESS | 1646 | __end_cc_report 14:37:56 INFO - PROCESS | 1646 | __startTimestamp1486679876040__endTimestamp 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | ------- Summary: start ------- 14:37:56 INFO - PROCESS | 1646 | Number of tests: 14 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.54 (2.3%) stddev-sans-first:0.67 14:37:56 INFO - PROCESS | 1646 | Values: 104.0 112.0 113.0 112.0 111.0 111.0 112.0 112.0 111.0 112.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#1] audio-beat-detection Cycles:10 Average:117.60 Median:126.00 stddev:16.91 (13.4%) stddev-sans-first:15.46 14:37:56 INFO - PROCESS | 1646 | Values: 142.0 107.0 99.0 141.0 109.0 109.0 108.0 108.0 142.0 111.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#2] audio-dft Cycles:10 Average:183.50 Median:184.50 stddev:1.96 (1.1%) stddev-sans-first:1.86 14:37:56 INFO - PROCESS | 1646 | Values: 186.0 185.0 182.0 185.0 186.0 182.0 183.0 181.0 184.0 181.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#3] audio-fft Cycles:10 Average:66.10 Median:60.00 stddev:12.03 (20.1%) stddev-sans-first:11.30 14:37:56 INFO - PROCESS | 1646 | Values: 82.0 58.0 59.0 87.0 61.0 58.0 59.0 59.0 81.0 57.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#4] audio-oscillator Cycles:10 Average:77.00 Median:77.50 stddev:10.88 (14.0%) stddev-sans-first:11.24 14:37:56 INFO - PROCESS | 1646 | Values: 84.0 71.0 94.0 70.0 67.0 69.0 88.0 68.0 68.0 91.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.50 stddev:1.37 (1.6%) stddev-sans-first:1.39 14:37:56 INFO - PROCESS | 1646 | Values: 88.0 85.0 88.0 86.0 88.0 85.0 89.0 87.0 87.0 86.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:96.50 stddev:1.76 (1.8%) stddev-sans-first:1.83 14:37:56 INFO - PROCESS | 1646 | Values: 96.0 97.0 101.0 96.0 95.0 96.0 97.0 99.0 96.0 97.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#7] imaging-desaturate Cycles:10 Average:81.60 Median:82.00 stddev:1.84 (2.2%) stddev-sans-first:1.73 14:37:56 INFO - PROCESS | 1646 | Values: 84.0 81.0 80.0 78.0 83.0 81.0 82.0 82.0 84.0 81.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.50 stddev:1.96 (3.5%) stddev-sans-first:1.99 14:37:56 INFO - PROCESS | 1646 | Values: 54.0 53.0 53.0 54.0 58.0 58.0 57.0 56.0 56.0 57.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:3.37 (4.9%) stddev-sans-first:2.78 14:37:56 INFO - PROCESS | 1646 | Values: 63.0 70.0 68.0 76.0 72.0 67.0 69.0 68.0 69.0 68.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.83 (3.4%) stddev-sans-first:2.99 14:37:56 INFO - PROCESS | 1646 | Values: 83.0 83.0 82.0 82.0 83.0 82.0 83.0 82.0 86.0 91.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:148.50 stddev:19.05 (12.8%) stddev-sans-first:19.80 14:37:56 INFO - PROCESS | 1646 | Values: 137.0 137.0 127.0 150.0 147.0 150.0 137.0 138.0 195.0 160.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:164.50 stddev:22.27 (13.5%) stddev-sans-first:23.35 14:37:56 INFO - PROCESS | 1646 | Values: 166.0 162.0 162.0 163.0 163.0 163.0 222.0 209.0 162.0 184.0 14:37:56 INFO - PROCESS | 1646 | 14:37:56 INFO - PROCESS | 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:68.00 stddev:7.57 (11.1%) stddev-sans-first:7.79 14:37:56 INFO - PROCESS | 1646 | Values: 66.0 66.0 66.0 66.0 66.0 67.0 69.0 84.0 80.0 82.0 14:37:56 INFO - PROCESS | 1646 | -------- Summary: end -------- 14:37:56 INFO - PROCESS | 1646 | 14:37:57 INFO - TEST-INFO | 1646: exit 0 14:37:57 INFO - TEST-OK | kraken | took 58789ms 14:37:57 INFO - SUITE-END | took 1175s 14:37:57 INFO - Completed test suite (00:19:35) 14:37:57 INFO - javascript benchmark 14:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2468.8518688878667, 3383.8477268522915, 3403.0301364111224, 3410.437277849155, 3461.4288642373995, 5647.09646456567, 5697.943020569793, 5717.999350113734, 5761.62549434287, 5768.682722450264, 5643.181738647893, 5717.685527295997, 5720.1991721159075, 5721.0, 5764.510016648579, 5102.285680004802, 5127.717975511346, 5156.664816786897, 5157.406898206698, 5197.584193264549, 4144.772037537934, 5070.264811602316, 5076.46697096805, 5088.363954505687, 5094.898102037957, 5072.74636268187, 5134.460881607433, 5138.8715282118055, 5151.201563757605, 5155.0, 5121.334226550562, 5164.070467315882, 5195.922061169085, 5202.271681964528, 5236.031334203185, 5072.873178170538, 5136.075506408845, 5150.613703972217, 5154.948450515484, 5157.355330583677, 5526.06056970312, 5568.832935011957, 5572.944270557324, 5614.747336369873, 5623.634463759883, 6137.355577664371, 6162.691865406757, 6167.938320616781, 6203.2245969253845, 6227.813165605039, 6256.03031530109, 6266.060090986343, 6273.05904114382, 6292.370762923717, 6306.400891915261, 5633.183188437694, 5682.147677848356, 5684.91472627915, 5729.0, 5741.540676745851, 6243.159884588562, 6251.718672659741, 6291.9685401573615, 6304.842378940563, 6325.58883672569, 6097.939020609826, 6118.0, 6125.877482450326, 6137.84655383619, 6140.478059364915, 6091.786787462506, 6108.008189064015, 6118.680093383066, 6121.392004143319, 6204.038374052029, 6116.602420842631, 6163.106349579286, 6167.876642467126, 6181.381861813783, 6188.504919606421, 6123.265208174958, 6193.752249910043, 6198.256209254828, 6209.316975132731, 6212.72042758077, 4855.660103792771, 4888.877778055577, 4895.388076490439, 4940.333055037596, 4959.975200123977, 4380.8685739427865, 4406.383106365111, 4412.911741765147, 4416.955830441719, 4437.889052773707, 5720.856978575485, 5723.399043100498, 5738.368779434259, 5744.425557444222, 5759.164921086419, 6028.216331876915, 6245.219347581552, 6255.874882502325, 6267.091271765568, 6281.8743625127245, 5275.918436720463, 5622.662640241599, 5664.971675141598, 5688.146777983336, 5723.112917497794, 5343.839684809462, 5348.331458567679, 5358.839234822962, 5370.194470829407, 5383.977044361559, 6249.062640603855, 6257.155284036597, 6258.874822503524, 6259.3427690091885, 6277.937220627827, 4722.48052714208, 6113.57204995646, 6141.271221159771, 6143.204841797061, 6166.445019948226, 6269.404406581368, 6282.654454005074, 6291.1192433058495, 6297.275813281532, 6302.621842689453, 6153.384661533811, 6153.815385538441, 6165.876682466236, 6174.598651087665, 6180.196574445294, 6062.484688801324, 6108.706347747117, 6133.579501509479, 6227.813165605039, 6253.1245625613365, 5938.198343223782, 6060.818175454743, 6067.848303792264, 6078.696065196811, 6090.878182436238, 6031.547633927561, 6041.75832966694, 6049.78825741097, 6051.183090282755, 6072.757089716539, 5716.685582293014, 5775.422457754191, 5800.56495762811, 5842.3281322646735, 5845.561582881216, 5976.223090998143, 6054.152418661479, 6076.149339092619, 6117.9492029047315, 6119.106526814713, 5927.40725927421, 5932.347441781487, 5950.19672344228, 5956.37458066914, 5961.672108034099], "value": 5641.133118948829, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.66536092055105, 485.7716873069658, 491.43730428659165, 539.0727947929562, 548.4515484515484, 27985.440291194165, 40423.78728638138, 40451.190976180456, 40458.59541404585, 42424.787876060655, 41983.79008104963, 42300.36549451761, 42341.57658423415, 42346.15307693844, 42414.0, 8798.648054077828, 9390.24878009761, 9579.994100619439, 9592.08875156859, 9596.0, 8799.120087991181, 9014.323925705598, 9035.819283614324, 9061.0, 11536.365499897502, 11518.424078796026, 11776.646700598996, 11823.822642660367, 11839.7632047359, 11863.703407414841, 11632.360220187886, 11730.824037639442, 11745.236559623598, 11749.530018799238, 11755.471003804849, 11669.883301166965, 11707.765844683145, 11718.945294923413, 11721.941390292994, 11729.53081876724, 39465.60534394648, 39693.40459893075, 39750.0062498437, 39769.801150994346, 39898.80050599758, 3306.35526072416, 3358.0933148050135, 3448.0173150651945, 3522.6477352264824, 4025.63769260765, 24382.878085609635, 29338.853305733548, 30408.391832163456, 31200.843995779876, 31513.52729709056, 3236.1262459136137, 3247.8376081196084, 3337.7830441021256, 3339.5658564386476, 3352.63121056686, 508571.0, 513392.0, 513851.0, 514479.0, 514529.0, 33126.3374732504, 33305.0, 33422.99731008073, 35319.82340088283, 58130.0, 35822.462663060076, 35981.64018359783, 35988.460173097425, 36005.91982240537, 36037.8198109013, 15074.944753867343, 15241.3903443861, 15248.695026099416, 15260.542183734506, 15261.694766104616, 12908.225506469642, 12982.545610903762, 13022.80465792995, 13029.869701302865, 13057.738845223043, 7373.81565460857, 7401.81495462607, 7740.922590774133, 7743.264389882952, 7901.446898717149, 3223.854926528312, 3292.111129994888, 3305.25631732863, 3311.8012919224443, 3346.2303670156, 985.5466485416789, 1001.3741411617739, 1013.0730381700662, 1026.235454586338, 1054.7468607534136, 29500.557491637643, 29523.409531809673, 29841.52377143446, 30146.547801782992, 30189.547156792665, 1013.3312014070679, 1035.3787727363522, 1059.523214553454, 1079.2930630437077, 1100.7138144082437, 14594.270286485633, 15305.158216297988, 15673.059616423052, 15818.60453488672, 15952.92023539875, 659545.0, 662537.0, 662639.0, 663156.0, 664776.0, 55942.720286398304, 56321.43678563162, 56485.0, 56509.0, 56549.43450565442, 1212.9454174562165, 1244.5333000124954, 1276.8659290774522, 1352.0670737191306, 1363.7817949128091, 26823.463530729667, 28641.570376443953, 29966.85016574903, 30626.234344141576, 31177.8441107793, 47866.5213347876, 48407.5159248403, 48552.5144748548, 48574.271385928536, 48588.0, 527567.0, 531834.0, 532847.0, 532916.0, 533261.0, 24148.63777043381, 24731.752682472947, 25499.36251593725, 25719.357016074748, 25915.740842591335, 45114.0, 45318.5617725875, 45429.09141817079, 45531.317030245234, 46952.53047469482, 36721.81639091788, 36965.0, 37694.8115259422, 38527.0, 38898.80550597229, 37552.061198470255, 37962.0509487265, 37997.0, 38035.23929521339, 38085.0, 35991.28017439689, 36729.08177295589, 37561.81219093887, 37615.0, 39382.803085985535, 31539.52690709687, 33289.83355083209, 33790.0, 34434.7947821825, 34680.65319346774, 25336.74663253344, 25597.488050239263, 25648.61527077058, 25720.485590287713, 26096.0], "value": 18648.920829751773, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.79894756305373, 383.593391005534, 389.2968263845675, 394.51080659981596, 409.30213985155314, 19475.220991160353, 20068.397948061545, 20282.594348113027, 20713.689294660573, 20784.688229676565, 19796.50508737282, 19896.70154947677, 20403.0, 20664.276750313744, 20907.268245611405, 5074.898502029957, 5955.761769529225, 6218.253809542861, 6868.656567171622, 6943.548669336477, 6641.900371494431, 6888.724451021953, 6976.093107895967, 6977.162740471151, 6983.615901125436, 6621.9006714899315, 6709.429698475636, 6715.9664201678925, 6719.697613607375, 6726.293739157391, 6500.9674951625175, 6697.19633643961, 6699.765508207213, 6747.865042699168, 6817.863642727168, 5933.673647949361, 5942.70286485674, 5945.4946329562035, 5957.314908785502, 5961.463468287831, 24036.158734444387, 25025.124120655688, 25281.873590632113, 25507.362315942064, 25771.613425798627, 2078.9480262993393, 2138.540213854029, 2198.967015494769, 2241.4060274027397, 2694.4880472710124, 7846.489978151402, 10322.174226061898, 10323.432211228379, 10416.791664166674, 10505.94940505951, 1889.3481748796644, 1932.439592518168, 1949.9902500487406, 1953.7167110769, 1977.7033444983224, 121249.39375303067, 123689.0, 126467.0, 128010.0, 128309.0, 9349.158575728217, 9792.804143917225, 10064.39613623185, 10207.846882296772, 10352.223583231287, 12573.182743121668, 12623.305718185587, 12624.990000799913, 12637.93681031589, 12650.493980240872, 7978.202179781975, 8148.633311500878, 8164.918350816416, 8237.50574965492, 8247.752567422987, 8528.0, 8559.443636163629, 8576.185262400188, 8690.695825646071, 8718.084601116918, 3524.559430071241, 3807.971847601132, 3933.940990885139, 3939.546952100488, 3947.6644485219076, 1902.73361729358, 1948.7174359717762, 1951.7170010348705, 1953.2284747524932, 1955.823975842181, 720.2833180984953, 766.9424793140537, 810.2586133687728, 881.9162179592928, 897.7531178925717, 19524.21903123859, 20428.387148385274, 20976.895115524323, 21006.579868402852, 21399.358019259445, 915.3226612306845, 919.4758987377264, 923.0492592629603, 944.3719926249105, 952.2762700347647, 10948.616798412017, 11300.773984520429, 11482.770344593062, 11487.885121148849, 11492.885071149349, 608443.0, 609818.0, 619307.0, 630348.0, 631628.0, 92663.0, 130402.0, 131034.0, 135109.0, 135258.0, 889.7019498467956, 954.4845783277092, 993.299723694779, 1022.7852151048214, 1023.0127926550765, 15251.0, 19546.120424580644, 19881.900590496956, 19918.50203744918, 20065.498362541053, 56414.43585564092, 56609.0, 56831.0, 57951.0, 59235.11147332707, 76087.23912760802, 77924.61037694775, 80894.0, 81017.0, 81726.59136704278, 5618.381977982337, 7080.256573059754, 7434.405247580073, 8187.5087494750505, 8327.125651806715, 12147.514099435924, 12973.610791676265, 13193.0, 13384.263865487103, 13463.326833658082, 11086.113110950942, 11164.939330763564, 11283.492242848928, 11363.943180284046, 11704.765904682028, 8856.955715221382, 11099.445027748741, 11143.777124457303, 11643.5924742637, 11650.592229271935, 9939.453330066915, 11032.724181895517, 11500.94249528747, 11551.537938482703, 11984.58053968107, 7280.3083707047745, 7417.517861338995, 7546.849063018819, 7571.886421703569, 7633.923660763543, 7988.400869934662, 8087.231712987257, 8265.380096492667, 10979.231453798158, 11184.273022253528], "value": 9532.011931106932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.86546210841, 1521.9086854788713, 1677.2200926569144, 1834.4496651004695, 1845.2065611786927, 7429.7399591014255, 8096.230858068481, 8356.91643083569, 8548.743537693863, 8548.871766923501, 7456.515326503773, 7695.538267703928, 8147.1852814718495, 8352.164783521644, 8353.457025293352, 1972.9704054439194, 1975.87156834806, 2335.1243283768586, 2361.3978435498925, 2365.396823809926, 2097.2030628361204, 2304.0553373117027, 2351.905923763047, 2385.022140922222, 2404.8797560121925, 2330.7319658239267, 2331.9183828566, 2353.62342025276, 2355.5759963206615, 2358.6108292131776, 2288.119074156445, 2310.9653355199684, 2336.5210131922913, 2337.415646088478, 2338.240071976606, 2357.799587035104, 2378.1676413255395, 2378.655095011231, 2380.8809559521956, 2382.1424287256573, 8429.662813487454, 8446.197611226924, 8502.617382217815, 8508.234258916666, 8532.018817835966, 5066.062778385974, 5234.502722241381, 5234.738263086831, 5235.450277720823, 5240.633155679104, 3187.888423905152, 3423.803680981595, 3434.587849458056, 3551.147724546116, 3551.200979779555, 1037.6108959140322, 1045.8535804987307, 1062.829947208443, 1078.687180717591, 1083.3608171179042, 10782.5686972521, 10838.67483975482, 10877.238593298473, 10878.61924832635, 10886.0, 4481.282994720829, 4579.267317229227, 4673.322368256584, 4679.274712419512, 4744.857654270378, 9448.385854919408, 9456.05439456049, 9461.148496635198, 9462.858057129148, 9466.05339466048, 5226.817061402832, 5242.108841496878, 5246.606504512177, 5254.92117618236, 5257.6845389276, 4102.384642303678, 4234.089670720809, 4810.989692164615, 4830.758462076882, 4842.782074806642, 3792.6965842733066, 3812.1041555234497, 3864.6908247340143, 3894.7273690841935, 3898.3957486589625, 1263.216805580546, 1272.1730874931368, 1276.6297773645538, 1287.7231395250067, 1288.0597164070282, 755.9395248380226, 848.4018766769412, 888.4269646078243, 914.7621618379269, 921.2860033474111, 5467.17992301158, 5620.707237335354, 5641.5204707600315, 5821.825345239649, 5880.294364676266, 987.3286165407592, 1009.4649835587151, 1021.4994652620163, 1028.475477506462, 1029.583018877356, 3755.211405604799, 3779.9726363935897, 3806.1816709407613, 3867.0912335601674, 3959.2675355059405, 9766.9023309766, 10242.590296388062, 10245.282830201962, 10252.23108266883, 10264.384136951807, 10198.082172604501, 10202.489875506195, 10209.846852297222, 10221.795564088676, 10243.795124097476, 7587.544747315179, 7651.5409075455655, 7827.0, 7870.9606451967375, 7877.4091943104495, 5508.641938274, 5541.556675466034, 5636.098224284095, 5733.455321744427, 5743.368229494668, 9264.490453024879, 9285.396449230779, 9285.67500137519, 9387.81224375495, 9407.52962351866, 7329.596872172082, 9373.578188981648, 9565.713028608874, 9650.469224192737, 9652.131308182297, 6303.842403939938, 6493.577917435352, 6617.073609694743, 6703.095082164041, 6838.487113466609, 6786.93213067863, 7901.249381308767, 8075.757727268191, 8079.757607271791, 8083.555404452812, 6107.389261073857, 7103.538270012433, 7215.639218038972, 7235.2041275458605, 7346.77959661211, 7043.013978043181, 7080.468964827555, 7088.574685518885, 7113.857722845618, 7159.7136114556915, 6676.265610782907, 6684.231313399021, 6784.118064651564, 6788.490863185182, 6789.1852977643, 4161.396597493407, 4867.075255701406, 4920.31115643803, 4931.482194369683, 4942.184539550934, 4834.0, 4850.684705494132, 4911.3369695090705, 5047.1419858623385, 5065.366829146356], "value": 4435.621132443795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.66529650033215, 307.98306093164865, 313.7834893923194, 320.2234581140735, 323.5098825279703, 5322.498425739896, 5339.385970613375, 5347.7326133693305, 5350.41145473998, 5402.135658294674, 4464.866054018376, 5109.208072748721, 5174.4386528668365, 5182.144946083901, 5209.661372010816, 3169.793963392384, 4012.538558065831, 4024.8390064397463, 4059.9594004059877, 4089.6708569714815, 4017.8593749218785, 4023.011465782438, 4044.169081642862, 4062.512498500184, 4066.0, 3139.2936589267347, 3192.4413227685177, 3912.8826135215845, 4022.7385219960756, 4023.1752490739473, 4012.277789997799, 4017.97991010046, 4032.3145065338963, 4033.2740106780766, 4040.6161414665708, 3189.81018981019, 3493.371193185226, 3540.044188069233, 3548.006558163718, 3576.5529308836394, 5119.593790918262, 5129.538341549279, 5142.51146141116, 5146.459621739701, 5160.767765450564, 3973.3443981742976, 4266.485397683839, 4518.847693838083, 4600.148972440109, 4608.815647374101, 4761.262004389325, 4963.255511673278, 5408.972295263888, 5563.693996830173, 5572.461486955813, 3767.0770661188185, 3812.951438354447, 3830.7893065881367, 3832.96509942314, 3834.3673293906472, 4878.487668822676, 5600.943990560124, 5691.231683722727, 5712.314867114212, 5911.9113213301835, 3878.9224215516097, 3882.9805850970565, 3895.0, 3907.9218415631526, 3922.764634121962, 3810.7141964352786, 3982.7212095153063, 3989.3816458448987, 3990.10222699896, 3996.320625493673, 4051.311277082844, 4309.306683322923, 4532.391001194528, 4588.49526552079, 4640.257558790645, 5072.391313042459, 5092.0, 5357.973210133924, 5601.467860553241, 5621.606487545832, 1149.8444063715913, 1294.6633875192517, 1297.5985935189972, 1298.9090763646454, 1302.798066299725, 676.7191615479619, 691.7924622613195, 763.6410886883156, 825.9793505162298, 877.6928075173765, 4834.975825120852, 5008.821162794124, 5260.447652996457, 5264.605154613343, 5310.867228319323, 4365.476142862877, 5307.6019298552765, 5736.225609542658, 5803.216565763568, 5826.504747096459, 5103.086342621517, 5118.769655365518, 5229.4770522948165, 5290.259363689087, 5299.682019078868, 2455.980767981268, 2551.8389132944835, 2722.5235583773156, 2897.058456001808, 2911.5778212159116, 5393.4336894626285, 5777.64225407029, 5797.768089276466, 5810.477057064884, 5820.1560773688425, 4387.8244870204835, 6034.250067480381, 6041.2750469943885, 6046.0, 6061.848453788691, 5583.609147359727, 6118.1434599156155, 6126.356732543108, 6164.167837341902, 6204.5967012144965, 5054.873628159178, 5553.444655534414, 5760.1935728998815, 5851.414858514285, 5895.64626122434, 5242.842714718565, 5737.5983681141915, 5753.367129615655, 5766.942330576809, 5795.304563452244, 5233.581313494835, 5345.919811202757, 5778.572999340203, 6075.908861367171, 6090.573659843769, 3204.4872820348633, 3650.4341827016856, 3779.263043706451, 3823.4073718573663, 3837.270918525471, 4724.834630787906, 5043.982407037214, 5312.5484333832055, 5786.797462088806, 5912.940870591239, 4596.931046034245, 5157.149070403341, 5748.080307150836, 5750.281214848144, 5785.161151632906, 4552.930061435493, 5417.458254174551, 5634.464725851038, 5662.348829884451, 5711.371749107512, 4905.607551395951, 5138.434772175133, 5282.837775689342, 5334.733263336895, 5551.584345991746, 5195.636305458582, 5250.737463126905, 5477.315335583052, 5556.499915007668, 5574.832755017356, 4560.315952607136, 5183.403908550414, 5567.498925096761, 5576.0, 5577.3028371453565], "value": 4048.8243428983537, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.5314865614366, 725.260234560748, 753.6533194730422, 794.443889277506, 794.5312265763199, 14684.118952862837, 15328.0, 15335.539933801976, 15385.38458461663, 15406.537803865887, 10667.893321066787, 13737.17576945384, 13773.51792687256, 13852.307384630778, 13881.93059034706, 681.686424244848, 700.7302188657378, 703.5532436902578, 703.6165289916981, 826.5660528222686, 689.4002218070286, 693.3863530775275, 808.8746244332137, 839.1566475691922, 842.1957031035378, 871.6687658689721, 876.242050626207, 880.2034159086005, 880.7489865388366, 883.5538053283083, 882.3955590420551, 883.1654086887894, 884.2837301785574, 884.3544212724714, 884.6682494064726, 653.3466533466534, 656.0651072222112, 656.0913135307634, 656.1732217406055, 656.3895577113283, 13692.726145477134, 13728.93135534316, 14117.364718587689, 14138.0, 14162.0, 14083.225422601752, 14254.857451425456, 14286.071405358722, 14349.28253587327, 14350.425982960669, 11504.367259800707, 11521.827172592419, 11599.94200029003, 11664.331216521037, 11674.649760507113, 3691.667749902522, 3730.65696349314, 3771.4719939208535, 3819.9045023874623, 3846.6345697158727, 92207.53896230544, 92328.53835730845, 93516.53241733884, 94934.0, 100407.0, 10899.618513351994, 10901.509432075576, 10968.0, 11044.613438529614, 11094.500747466383, 21009.369718908456, 21020.369388918356, 21089.261875834578, 21272.574548508943, 21364.0, 7547.924520754832, 7734.961325193338, 7971.322437592869, 8014.599270036475, 8089.595520224083, 4133.958660413417, 4351.521332653406, 4437.534058923831, 4465.776711164429, 4603.953960460352, 3379.172102834821, 3463.7748546344405, 3497.3529896969144, 3678.981605092011, 3854.4411060396646, 584.8420926349862, 702.1013103227876, 706.7349743846057, 710.9573425594481, 721.6283613938825, 637.6238019568477, 658.6871236162784, 665.8867992441296, 669.8425869920565, 700.719712115158, 9152.130547597968, 9411.4823684698, 9464.722262494475, 9542.570584323723, 9706.854397184048, 595.2648479128273, 671.6675245753383, 674.8852695041854, 690.7619313424468, 696.4880812602732, 3793.298239825586, 4416.933745993812, 4632.25883858581, 4689.882752931136, 4736.786844592001, 78346.6082669583, 96076.51961740147, 113273.0, 116175.41912290384, 119146.0, 98328.01671983332, 99752.0, 102729.48635256776, 104606.0, 106313.0, 74719.62640186764, 85086.72369914457, 87011.1298887003, 89793.55103224573, 91804.0, 9468.28987825902, 9607.0, 9607.663731769355, 9626.518674066408, 9751.122398984126, 51870.74064629653, 54086.0, 55673.0, 55688.88622227614, 56264.71867640636, 55052.72473637606, 72455.0, 73098.0, 75510.48979020499, 77845.22154778606, 12829.486820527074, 12978.740425191254, 13319.0, 13341.3329333531, 13664.043516954116, 13807.723845523235, 14491.058081224686, 14860.671848031083, 15233.3906643733, 15682.0, 13399.0, 13797.06553830949, 13926.42361163188, 14338.856611433752, 14596.905232107421, 10394.428306443218, 13361.933190333986, 13563.050586459249, 13885.375158118111, 14607.634809129431, 13333.799189410163, 13469.461221551028, 13595.45618175262, 13604.251766152956, 13642.93178534101, 11244.325340479598, 11474.827877582009, 11539.307641541534, 11622.418879056182, 11955.521779128738, 11188.832167517656, 11227.270227435518, 11686.88313116892, 11693.941530292293, 11710.648680539598], "value": 7484.007976080766, "unit": "score"}], "name": "dromaeo_css", "value": 7160.5200012788155, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 111.0, 111.0, 112.0, 112.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 107.0, 99.0, 141.0, 109.0, 109.0, 108.0, 108.0, 142.0, 111.0], "value": 117.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 182.0, 185.0, 186.0, 182.0, 183.0, 181.0, 184.0, 181.0], "value": 183.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 87.0, 61.0, 58.0, 59.0, 59.0, 81.0, 57.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 94.0, 70.0, 67.0, 69.0, 88.0, 68.0, 68.0, 91.0], "value": 77.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 85.0, 89.0, 87.0, 87.0, 86.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 101.0, 96.0, 95.0, 96.0, 97.0, 99.0, 96.0, 97.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 80.0, 78.0, 83.0, 81.0, 82.0, 82.0, 84.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 58.0, 58.0, 57.0, 56.0, 56.0, 57.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 68.0, 76.0, 72.0, 67.0, 69.0, 68.0, 69.0, 68.0], "value": 69.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 82.0, 82.0, 83.0, 82.0, 83.0, 82.0, 86.0, 91.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 127.0, 150.0, 147.0, 150.0, 137.0, 138.0, 195.0, 160.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 163.0, 163.0, 163.0, 222.0, 209.0, 162.0, 184.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 66.0, 67.0, 69.0, 84.0, 80.0, 82.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1423.6, "alertThreshold": 2.0}]} 14:37:57 INFO - Return code: 0 14:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:37:57 INFO - # TBPL SUCCESS # 14:37:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:37:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:37:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:37:57 INFO - 2017-02-09 14:37:57.338 screenresolution[1650:9745] starting screenresolution argv=screenresolution get 14:37:57 INFO - 2017-02-09 14:37:57.341 screenresolution[1650:9745] Display 0: 1600x1200x32@60 14:37:57 INFO - 2017-02-09 14:37:57.347 screenresolution[1651:9748] starting screenresolution argv=screenresolution list 14:37:57 INFO - Available Modes on Display 0 14:37:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:37:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:37:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:37:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:37:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:37:57 INFO - Intel Iris: 14:37:57 INFO - Chipset Model: Intel Iris 14:37:57 INFO - Type: GPU 14:37:57 INFO - Bus: Built-In 14:37:57 INFO - VRAM (Dynamic, Max): 1536 MB 14:37:57 INFO - Vendor: Intel (0x8086) 14:37:57 INFO - Device ID: 0x0a2e 14:37:57 INFO - Revision ID: 0x0009 14:37:57 INFO - Displays: 14:37:57 INFO - Display: 14:37:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:37:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:37:57 INFO - Display Serial Number: 1600x1200 60 14:37:57 INFO - Main Display: Yes 14:37:57 INFO - Mirror: Off 14:37:57 INFO - Online: Yes 14:37:57 INFO - Rotation: Supported 14:37:57 INFO - Return code: 0 14:37:57 INFO - Running post-action listener: _resource_record_post_action 14:37:57 INFO - [mozharness: 2017-02-09 22:37:57.588962Z] Finished run-tests step (success) 14:37:57 INFO - Running post-run listener: _resource_record_post_run 14:37:57 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 38073344; Write bytes: 495202304; Read time: 241; Write time: 1556 14:37:57 INFO - TinderboxPrint: CPU usage
53.2% 14:37:57 INFO - TinderboxPrint: I/O read bytes / time
38,073,344 / 241 14:37:57 INFO - TinderboxPrint: I/O write bytes / time
495,202,304 / 1,556 14:37:57 INFO - TinderboxPrint: CPU idle
2,239.7 (46.8%) 14:37:57 INFO - TinderboxPrint: CPU system
953.5 (19.9%) 14:37:57 INFO - TinderboxPrint: CPU user
1,596.5 (33.3%) 14:37:57 INFO - TinderboxPrint: Swap in / out
229,429,248 / 0 14:37:57 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181127680; Write bytes: 176227840; Read time: 16613; Write time: 392 14:37:57 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 37143552; Write bytes: 301242880; Read time: 229; Write time: 1109 14:37:58 INFO - Running post-run listener: _upload_blobber_files 14:37:58 INFO - Blob upload gear active. 14:37:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:37:58 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 14:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:37:58 INFO - (blobuploader) - INFO - Open directory for files ... 14:37:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:37:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:37:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:37:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:37:59 INFO - (blobuploader) - INFO - Done attempting. 14:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:00 INFO - (blobuploader) - INFO - Done attempting. 14:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:38:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:38:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:38:02 INFO - (blobuploader) - INFO - Done attempting. 14:38:02 INFO - (blobuploader) - INFO - Iteration through files over. 14:38:02 INFO - Return code: 0 14:38:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:38:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:38:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b2ba0ef5141bae86c985b72de6b827df5825d734f2a46c059849ba42f20835fd8bcd62a4a16ec08433ee94c473fd545286f79ef530256815906f19880538678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23cc3be9d9b08abe0eee557f8ae7503dc01006e6f5cc7a9dd73ec5c182f17dfdae566f70998b3fd15b7117dadde641bec0639d54639ce1f841b877b013675d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eec23f979785648a4d105be8bf3fb2d5dc981659bb8d9d6a6a6e6343551bb905271f30779bb2490c1b642e37ba9a16f22cd5657940db7d2f83643eeef5fa6664"} 14:38:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:38:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:38:02 INFO - Contents: 14:38:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b2ba0ef5141bae86c985b72de6b827df5825d734f2a46c059849ba42f20835fd8bcd62a4a16ec08433ee94c473fd545286f79ef530256815906f19880538678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23cc3be9d9b08abe0eee557f8ae7503dc01006e6f5cc7a9dd73ec5c182f17dfdae566f70998b3fd15b7117dadde641bec0639d54639ce1f841b877b013675d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eec23f979785648a4d105be8bf3fb2d5dc981659bb8d9d6a6a6e6343551bb905271f30779bb2490c1b642e37ba9a16f22cd5657940db7d2f83643eeef5fa6664"} 14:38:02 INFO - Running post-run listener: copy_logs_to_upload_dir 14:38:02 INFO - Copying logs to upload dir... 14:38:02 INFO - mkdir: /builds/slave/test/build/upload/logs 14:38:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.006056 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-09 14:38:02.990021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 14:38:02.994196) ========= 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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b2ba0ef5141bae86c985b72de6b827df5825d734f2a46c059849ba42f20835fd8bcd62a4a16ec08433ee94c473fd545286f79ef530256815906f19880538678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23cc3be9d9b08abe0eee557f8ae7503dc01006e6f5cc7a9dd73ec5c182f17dfdae566f70998b3fd15b7117dadde641bec0639d54639ce1f841b877b013675d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eec23f979785648a4d105be8bf3fb2d5dc981659bb8d9d6a6a6e6343551bb905271f30779bb2490c1b642e37ba9a16f22cd5657940db7d2f83643eeef5fa6664"} build_url:https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010927 build_url: 'https://queue.taskcluster.net/v1/task/OVn728suQuid6q4sBzE3ag/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9b2ba0ef5141bae86c985b72de6b827df5825d734f2a46c059849ba42f20835fd8bcd62a4a16ec08433ee94c473fd545286f79ef530256815906f19880538678", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23cc3be9d9b08abe0eee557f8ae7503dc01006e6f5cc7a9dd73ec5c182f17dfdae566f70998b3fd15b7117dadde641bec0639d54639ce1f841b877b013675d39", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eec23f979785648a4d105be8bf3fb2d5dc981659bb8d9d6a6a6e6343551bb905271f30779bb2490c1b642e37ba9a16f22cd5657940db7d2f83643eeef5fa6664"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 14:38:03.029526) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:38:03.029919) ========= 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.ek5Y0YXeby/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.VUZDtZzjzU/Listeners TMPDIR=/var/folders/71/7903fjj12g39x3jmfxdbc1h400000w/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.004924 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 14:38:03.080277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 14:38:03.080661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 14:38:03.081067) ========= ========= Total master_lag: 0.19 =========