builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0184 starttime: 1475601155.96 results: success (0) buildid: 20161004081403 builduid: 57406a53af214c129e7930466c562528 revision: 067c15e2620f0f518d7ee70a06cdfd226f13b3f2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:35.957626) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:35.958114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:35.958407) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:35.983963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:35.984464) ========= 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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 --2016-10-04 10:12:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.8M=0s 2016-10-04 10:12:36 (72.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.142366 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:36.149325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:36.149743) ========= 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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.031105 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:36.261923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 10:12:36.262294) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 067c15e2620f0f518d7ee70a06cdfd226f13b3f2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 067c15e2620f0f518d7ee70a06cdfd226f13b3f2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AMYgJ87KHr/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.yb3dzbyyBH/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 2016-10-04 10:12:36,359 truncating revision to first 12 chars 2016-10-04 10:12:36,359 Setting DEBUG logging. 2016-10-04 10:12:36,359 attempt 1/10 2016-10-04 10:12:36,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/067c15e2620f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 10:12:37,968 unpacking tar archive at: autoland-067c15e2620f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.868742 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 10:12:38.152760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:38.153083) ========= script_repo_revision: 067c15e2620f0f518d7ee70a06cdfd226f13b3f2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:38.153494) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:38.153757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 10:12:38.171718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-04 10:12:38.172042) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AMYgJ87KHr/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.yb3dzbyyBH/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:12:38 INFO - MultiFileLogger online at 20161004 10:12:38 in /builds/slave/test 10:12:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 10:12:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:12:38 INFO - {'append_to_log': False, 10:12:38 INFO - 'base_work_dir': '/builds/slave/test', 10:12:38 INFO - 'blob_upload_branch': 'Autoland', 10:12:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:12:38 INFO - 'branch': 'Autoland', 10:12:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:12:38 INFO - 'config_files': ('talos/mac_config.py',), 10:12:38 INFO - 'default_actions': ('clobber', 10:12:38 INFO - 'read-buildbot-config', 10:12:38 INFO - 'download-and-extract', 10:12:38 INFO - 'populate-webroot', 10:12:38 INFO - 'create-virtualenv', 10:12:38 INFO - 'install', 10:12:38 INFO - 'run-tests'), 10:12:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:12:38 INFO - 'download_minidump_stackwalk': True, 10:12:38 INFO - 'download_symbols': 'ondemand', 10:12:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:12:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:12:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:12:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:12:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:12:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:12:38 INFO - 'installer_path': 'installer.exe', 10:12:38 INFO - 'log_level': 'info', 10:12:38 INFO - 'log_name': 'talos', 10:12:38 INFO - 'log_to_console': True, 10:12:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:12:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:12:38 INFO - 'opt_config_files': (), 10:12:38 INFO - 'pip_index': False, 10:12:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:38 INFO - 'cmd': ('bash', 10:12:38 INFO - '-c', 10:12:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:38 INFO - 'enabled': True, 10:12:38 INFO - 'halt_on_failure': False, 10:12:38 INFO - 'name': 'check_screen_resolution'},), 10:12:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:12:38 INFO - 'cmd': ('bash', 10:12:38 INFO - '-c', 10:12:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:12:38 INFO - 'enabled': True, 10:12:38 INFO - 'halt_on_failure': False, 10:12:38 INFO - 'name': 'check_screen_resolution'},), 10:12:38 INFO - 'run_cmd_checks_enabled': True, 10:12:38 INFO - 'sps_profile': False, 10:12:38 INFO - 'sps_profile_interval': 0, 10:12:38 INFO - 'suite': 'dromaeojs', 10:12:38 INFO - 'system_bits': '32', 10:12:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:12:38 INFO - 'title': 't-yosemite-r7-0184', 10:12:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:12:38 INFO - 'use_talos_json': True, 10:12:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:12:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:12:38 INFO - 'work_dir': 'build'} 10:12:38 INFO - [mozharness: 2016-10-04 17:12:38.396737Z] Running clobber step. 10:12:38 INFO - Running pre-action listener: _resource_record_pre_action 10:12:38 INFO - Running main action method: clobber 10:12:38 INFO - rmtree: /builds/slave/test/build 10:12:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:12:40 INFO - Running post-action listener: _resource_record_post_action 10:12:40 INFO - [mozharness: 2016-10-04 17:12:40.667471Z] Finished clobber step (success) 10:12:40 INFO - [mozharness: 2016-10-04 17:12:40.667595Z] Running read-buildbot-config step. 10:12:40 INFO - Running pre-action listener: _resource_record_pre_action 10:12:40 INFO - Running main action method: read_buildbot_config 10:12:40 INFO - Using buildbot properties: 10:12:40 INFO - { 10:12:40 INFO - "project": "", 10:12:40 INFO - "product": "firefox", 10:12:40 INFO - "script_repo_revision": "production", 10:12:40 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 10:12:40 INFO - "repository": "", 10:12:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 10:12:40 INFO - "buildid": "20161004081403", 10:12:40 INFO - "pgo_build": "False", 10:12:40 INFO - "basedir": "/builds/slave/test", 10:12:40 INFO - "buildnumber": 356, 10:12:40 INFO - "slavename": "t-yosemite-r7-0184", 10:12:40 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:12:40 INFO - "platform": "yosemite_r7", 10:12:40 INFO - "scheduler": "tests-autoland-macosx64-talos", 10:12:40 INFO - "branch": "autoland", 10:12:40 INFO - "repo_path": "integration/autoland", 10:12:40 INFO - "revision": "067c15e2620f0f518d7ee70a06cdfd226f13b3f2", 10:12:40 INFO - "stage_platform": "macosx64", 10:12:40 INFO - "builduid": "57406a53af214c129e7930466c562528", 10:12:40 INFO - "slavebuilddir": "test" 10:12:40 INFO - } 10:12:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:12:40 INFO - Running post-action listener: _resource_record_post_action 10:12:40 INFO - [mozharness: 2016-10-04 17:12:40.670641Z] Finished read-buildbot-config step (success) 10:12:40 INFO - [mozharness: 2016-10-04 17:12:40.670744Z] Running download-and-extract step. 10:12:40 INFO - Running pre-action listener: _resource_record_pre_action 10:12:40 INFO - Running main action method: download_and_extract 10:12:40 INFO - mkdir: /builds/slave/test/build/tests 10:12:40 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')]} 10:12:40 INFO - trying https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:12:40 INFO - Downloading https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:12:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 10:12:41 INFO - Downloaded 1057 bytes. 10:12:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:12:41 INFO - Using the following test package requirements: 10:12:41 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:12:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:12:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:12:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'jsshell-mac.zip'], 10:12:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:12:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:12:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:12:41 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:12:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:12:41 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:12:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:12:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:12:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:12:41 INFO - Fetch https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:12:42 INFO - Http code: 200 10:12:42 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:12:42 INFO - x-amz-cf-id: sjxS0QS8izACAsl9mB_TA03yjR03tTZ47JAFvm7h6rirPgdfg2DQaA== 10:12:42 INFO - x-amz-version-id: 6zudPjRtvWk0GN69m1KDUmcnjRr1LGbV 10:12:43 INFO - Expected file size: 16477119 10:12:43 INFO - Obtained file size: 16477119 10:12:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:12:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:12:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:12:49 INFO - Fetch https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:12:50 INFO - Http code: 200 10:12:50 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 10:12:50 INFO - x-amz-cf-id: 7NA7r3LuPocVz0csR2g86kYomEZUiv1lt4zyU-mlroBVvIsykL03hQ== 10:12:50 INFO - x-amz-version-id: 6zudPjRtvWk0GN69m1KDUmcnjRr1LGbV 10:12:50 INFO - Expected file size: 16477119 10:12:50 INFO - Obtained file size: 16477119 10:12:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:12:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:12:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:12:58 INFO - Http code: 200 10:12:58 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 10:12:58 INFO - x-amz-cf-id: ZvP_SfFweZKLxNwPGRplJGOP2h9oa3LdQczAxwexJF8PMhGNcEbLpg== 10:12:58 INFO - x-amz-version-id: DPzi9k3lUGA6WBlOj98lCYlu2ijX99sH 10:12:58 INFO - Expected file size: 14409006 10:12:58 INFO - Obtained file size: 14409006 10:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:12:59 INFO - trying https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:12:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 10:13:02 INFO - Downloaded 111629272 bytes. 10:13:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:13:02 INFO - mkdir: /builds/slave/test/properties 10:13:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:13:02 INFO - Writing to file /builds/slave/test/properties/build_url 10:13:02 INFO - Contents: 10:13:02 INFO - build_url:https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:13:02 INFO - Running post-action listener: _resource_record_post_action 10:13:02 INFO - Running post-action listener: set_extra_try_arguments 10:13:02 INFO - [mozharness: 2016-10-04 17:13:02.731944Z] Finished download-and-extract step (success) 10:13:02 INFO - [mozharness: 2016-10-04 17:13:02.732111Z] Running populate-webroot step. 10:13:02 INFO - Running pre-action listener: _resource_record_pre_action 10:13:02 INFO - Running main action method: populate_webroot 10:13:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:13:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:13:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:13:02 INFO - '--tppagecycles', 10:13:02 INFO - '7'], 10:13:02 INFO - 'tests': ['tsvgm']}}, 10:13:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:13:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:13:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:13:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:13:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:13:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['damp', 'tps']}, 10:13:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'tests': ['damp', 'tps']}, 10:13:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['dromaeo_dom']}, 10:13:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:13:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['basic_compositor_video']}, 10:13:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:13:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['a11yr', 10:13:02 INFO - 'ts_paint', 10:13:02 INFO - 'tpaint', 10:13:02 INFO - 'sessionrestore', 10:13:02 INFO - 'sessionrestore_no_auto_restore', 10:13:02 INFO - 'tabpaint']}, 10:13:02 INFO - 'other-e10s': {'tests': ['a11yr', 10:13:02 INFO - 'ts_paint', 10:13:02 INFO - 'tpaint', 10:13:02 INFO - 'sessionrestore', 10:13:02 INFO - 'sessionrestore_no_auto_restore', 10:13:02 INFO - 'tabpaint']}, 10:13:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:13:02 INFO - 'ts_paint', 10:13:02 INFO - 'tpaint', 10:13:02 INFO - 'sessionrestore', 10:13:02 INFO - 'sessionrestore_no_auto_restore', 10:13:02 INFO - 'tabpaint']}, 10:13:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:13:02 INFO - 'ts_paint', 10:13:02 INFO - 'tpaint', 10:13:02 INFO - 'sessionrestore', 10:13:02 INFO - 'sessionrestore_no_auto_restore', 10:13:02 INFO - 'tabpaint']}, 10:13:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['a11yr', 10:13:02 INFO - 'ts_paint', 10:13:02 INFO - 'tpaint', 10:13:02 INFO - 'sessionrestore', 10:13:02 INFO - 'sessionrestore_no_auto_restore', 10:13:02 INFO - 'tabpaint']}, 10:13:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['a11yr', 10:13:02 INFO - 'ts_paint', 10:13:02 INFO - 'tpaint', 10:13:02 INFO - 'sessionrestore', 10:13:02 INFO - 'sessionrestore_no_auto_restore', 10:13:02 INFO - 'tabpaint']}, 10:13:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['tsvgx', 10:13:02 INFO - 'tsvgr_opacity', 10:13:02 INFO - 'tart', 10:13:02 INFO - 'tscrollx', 10:13:02 INFO - 'cart']}, 10:13:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:13:02 INFO - 'tsvgr_opacity', 10:13:02 INFO - 'tart', 10:13:02 INFO - 'tscrollx', 10:13:02 INFO - 'cart']}, 10:13:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'talos_options': ['--disable-e10s'], 10:13:02 INFO - 'tests': ['tp5o']}, 10:13:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'tests': ['tp5o']}, 10:13:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'talos_options': ['--disable-e10s', 10:13:02 INFO - '--xperf_path', 10:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:02 INFO - 'tests': ['tp5n']}, 10:13:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:13:02 INFO - 'talos_options': ['--xperf_path', 10:13:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:13:02 INFO - 'tests': ['tp5n']}}, 10:13:02 INFO - 'talos.zip': {'path': '', 10:13:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:13:02 INFO - Running post-action listener: _resource_record_post_action 10:13:02 INFO - [mozharness: 2016-10-04 17:13:02.750998Z] Finished populate-webroot step (success) 10:13:02 INFO - [mozharness: 2016-10-04 17:13:02.751112Z] Running create-virtualenv step. 10:13:02 INFO - Running pre-action listener: _resource_record_pre_action 10:13:02 INFO - Running main action method: create_virtualenv 10:13:02 INFO - Creating virtualenv /builds/slave/test/build/venv 10:13:02 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 10:13:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:13:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:13:02 INFO - Using real prefix '/tools/python27' 10:13:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:13:03 INFO - Installing distribute.............................................................................................................................................................................................done. 10:13:06 INFO - Installing pip.................done. 10:13:06 INFO - Return code: 0 10:13:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:13:06 INFO - Reading from file tmpfile_stdout 10:13:06 INFO - Output received: 10:13:06 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) 10:13:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:06 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 10:13:06 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 10:13:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:06 INFO - 'HOME': '/Users/cltbld', 10:13:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:06 INFO - 'LOGNAME': 'cltbld', 10:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:06 INFO - 'MOZ_NO_REMOTE': '1', 10:13:06 INFO - 'NO_EM_RESTART': '1', 10:13:06 INFO - 'PAGER': '/bin/cat', 10:13:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:06 INFO - 'PWD': '/builds/slave/test', 10:13:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:06 INFO - 'SHELL': '/bin/bash', 10:13:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:06 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:06 INFO - 'USER': 'cltbld', 10:13:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:06 INFO - 'XPC_FLAGS': '0x0', 10:13:06 INFO - 'XPC_SERVICE_NAME': '0', 10:13:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:06 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 10:13:06 INFO - Cleaning up... 10:13:06 INFO - Return code: 0 10:13:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:06 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:06 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 10:13:06 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 10:13:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:06 INFO - 'HOME': '/Users/cltbld', 10:13:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:06 INFO - 'LOGNAME': 'cltbld', 10:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:06 INFO - 'MOZ_NO_REMOTE': '1', 10:13:06 INFO - 'NO_EM_RESTART': '1', 10:13:06 INFO - 'PAGER': '/bin/cat', 10:13:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:06 INFO - 'PWD': '/builds/slave/test', 10:13:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:06 INFO - 'SHELL': '/bin/bash', 10:13:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:06 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:06 INFO - 'USER': 'cltbld', 10:13:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:06 INFO - 'XPC_FLAGS': '0x0', 10:13:06 INFO - 'XPC_SERVICE_NAME': '0', 10:13:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:07 INFO - Downloading/unpacking psutil>=3.1.1 10:13:07 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 10:13:07 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 10:13:07 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 10:13:07 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 10:13:07 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 10:13:07 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 10:13:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:13:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:10 INFO - Installing collected packages: psutil 10:13:10 INFO - Running setup.py install for psutil 10:13:10 INFO - building 'psutil._psutil_osx' extension 10:13:10 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 10:13:11 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 10:13:11 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 10:13:11 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 10:13:11 INFO - building 'psutil._psutil_posix' extension 10:13:11 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 10:13:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:13:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:13:11 INFO - ^ 10:13:11 INFO - 1 warning generated. 10:13:11 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 10:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:13:11 INFO - Successfully installed psutil 10:13:11 INFO - Cleaning up... 10:13:11 INFO - Return code: 0 10:13:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:13:11 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')]} 10:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:11 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')]} 10:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:11 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:11 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 10:13:11 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 10:13:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:11 INFO - 'HOME': '/Users/cltbld', 10:13:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:11 INFO - 'LOGNAME': 'cltbld', 10:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:11 INFO - 'MOZ_NO_REMOTE': '1', 10:13:11 INFO - 'NO_EM_RESTART': '1', 10:13:11 INFO - 'PAGER': '/bin/cat', 10:13:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:11 INFO - 'PWD': '/builds/slave/test', 10:13:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:11 INFO - 'SHELL': '/bin/bash', 10:13:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:11 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:11 INFO - 'USER': 'cltbld', 10:13:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:11 INFO - 'XPC_FLAGS': '0x0', 10:13:11 INFO - 'XPC_SERVICE_NAME': '0', 10:13:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:13:12 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 10:13:12 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 10:13:12 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 10:13:12 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 10:13:12 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 10:13:12 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 10:13:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:13:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:13:14 INFO - Installing collected packages: mozsystemmonitor 10:13:14 INFO - Running setup.py install for mozsystemmonitor 10:13:14 INFO - Successfully installed mozsystemmonitor 10:13:14 INFO - Cleaning up... 10:13:15 INFO - Return code: 0 10:13:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:13:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:13:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:15 INFO - 'HOME': '/Users/cltbld', 10:13:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:15 INFO - 'LOGNAME': 'cltbld', 10:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:15 INFO - 'MOZ_NO_REMOTE': '1', 10:13:15 INFO - 'NO_EM_RESTART': '1', 10:13:15 INFO - 'PAGER': '/bin/cat', 10:13:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:15 INFO - 'PWD': '/builds/slave/test', 10:13:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:15 INFO - 'SHELL': '/bin/bash', 10:13:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:15 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:15 INFO - 'USER': 'cltbld', 10:13:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:15 INFO - 'XPC_FLAGS': '0x0', 10:13:15 INFO - 'XPC_SERVICE_NAME': '0', 10:13:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:15 INFO - Downloading/unpacking jsonschema==2.5.1 10:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:13:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:17 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 10:13:18 INFO - Downloading functools32-3.2.3-2.tar.gz 10:13:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:13:18 INFO - warning: no files found matching '*.txt' 10:13:18 INFO - no previously-included directories found matching 'build' 10:13:18 INFO - no previously-included directories found matching 'dist' 10:13:18 INFO - no previously-included directories found matching '.git*' 10:13:18 INFO - Installing collected packages: jsonschema, functools32 10:13:18 INFO - Running setup.py install for functools32 10:13:18 INFO - warning: no files found matching '*.txt' 10:13:18 INFO - no previously-included directories found matching 'build' 10:13:18 INFO - no previously-included directories found matching 'dist' 10:13:18 INFO - no previously-included directories found matching '.git*' 10:13:18 INFO - Successfully installed jsonschema functools32 10:13:18 INFO - Cleaning up... 10:13:18 INFO - Return code: 0 10:13:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:13:18 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')]} 10:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:18 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')]} 10:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:18 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:18 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 10:13:18 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 10:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:18 INFO - 'HOME': '/Users/cltbld', 10:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:18 INFO - 'LOGNAME': 'cltbld', 10:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:18 INFO - 'MOZ_NO_REMOTE': '1', 10:13:18 INFO - 'NO_EM_RESTART': '1', 10:13:18 INFO - 'PAGER': '/bin/cat', 10:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:18 INFO - 'PWD': '/builds/slave/test', 10:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:18 INFO - 'SHELL': '/bin/bash', 10:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:18 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:18 INFO - 'USER': 'cltbld', 10:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:18 INFO - 'XPC_FLAGS': '0x0', 10:13:18 INFO - 'XPC_SERVICE_NAME': '0', 10:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:13:18 INFO - Cleaning up... 10:13:18 INFO - Return code: 0 10:13:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:13:18 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')]} 10:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:18 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')]} 10:13:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:18 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:18 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 10:13:18 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 10:13:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:18 INFO - 'HOME': '/Users/cltbld', 10:13:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:18 INFO - 'LOGNAME': 'cltbld', 10:13:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:18 INFO - 'MOZ_NO_REMOTE': '1', 10:13:18 INFO - 'NO_EM_RESTART': '1', 10:13:18 INFO - 'PAGER': '/bin/cat', 10:13:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:18 INFO - 'PWD': '/builds/slave/test', 10:13:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:18 INFO - 'SHELL': '/bin/bash', 10:13:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:18 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:18 INFO - 'USER': 'cltbld', 10:13:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:18 INFO - 'XPC_FLAGS': '0x0', 10:13:18 INFO - 'XPC_SERVICE_NAME': '0', 10:13:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:19 INFO - Downloading/unpacking blobuploader==1.2.4 10:13:19 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 10:13:19 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 10:13:19 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 10:13:19 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 10:13:19 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 10:13:19 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 10:13:21 INFO - Downloading blobuploader-1.2.4.tar.gz 10:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:13:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 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 10:13:21 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 10:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:13:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:13:22 INFO - Downloading docopt-0.6.1.tar.gz 10:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:13:22 INFO - Installing collected packages: blobuploader, requests, docopt 10:13:22 INFO - Running setup.py install for blobuploader 10:13:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:13:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:13:23 INFO - Running setup.py install for requests 10:13:23 INFO - Running setup.py install for docopt 10:13:23 INFO - Successfully installed blobuploader requests docopt 10:13:23 INFO - Cleaning up... 10:13:23 INFO - Return code: 0 10:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:23 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:23 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 10:13:23 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 10:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:23 INFO - 'HOME': '/Users/cltbld', 10:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:23 INFO - 'LOGNAME': 'cltbld', 10:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:23 INFO - 'MOZ_NO_REMOTE': '1', 10:13:23 INFO - 'NO_EM_RESTART': '1', 10:13:23 INFO - 'PAGER': '/bin/cat', 10:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:23 INFO - 'PWD': '/builds/slave/test', 10:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:23 INFO - 'SHELL': '/bin/bash', 10:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:23 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:23 INFO - 'USER': 'cltbld', 10:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:23 INFO - 'XPC_FLAGS': '0x0', 10:13:23 INFO - 'XPC_SERVICE_NAME': '0', 10:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-fgDbqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-eoYLzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-S_H_sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-I2AWKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-qO43h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-vkGhXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-mikrIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-azUaSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Y19fz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:24 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-iLRI32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-lkyAhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-1R5DNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-TJ2z_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-fQH2Iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Pd0_7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-r6OTco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:25 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-AuMTV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:13:25 INFO - Running setup.py install for manifestparser 10:13:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:13:25 INFO - Running setup.py install for mozcrash 10:13:26 INFO - Running setup.py install for mozdebug 10:13:26 INFO - Running setup.py install for mozdevice 10:13:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for mozfile 10:13:26 INFO - Running setup.py install for mozhttpd 10:13:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for mozinfo 10:13:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:13:26 INFO - Running setup.py install for mozInstall 10:13:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Running setup.py install for mozleak 10:13:27 INFO - Running setup.py install for mozlog 10:13:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Running setup.py install for moznetwork 10:13:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Running setup.py install for mozprocess 10:13:27 INFO - Running setup.py install for mozprofile 10:13:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Running setup.py install for mozrunner 10:13:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:13:27 INFO - Running setup.py install for mozscreenshot 10:13:28 INFO - Running setup.py install for moztest 10:13:28 INFO - Running setup.py install for mozversion 10:13:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:13:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:13:28 INFO - Cleaning up... 10:13:28 INFO - Return code: 0 10:13:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:28 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:28 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 10:13:28 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 10:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:28 INFO - 'HOME': '/Users/cltbld', 10:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:28 INFO - 'LOGNAME': 'cltbld', 10:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:28 INFO - 'MOZ_NO_REMOTE': '1', 10:13:28 INFO - 'NO_EM_RESTART': '1', 10:13:28 INFO - 'PAGER': '/bin/cat', 10:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:28 INFO - 'PWD': '/builds/slave/test', 10:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:28 INFO - 'SHELL': '/bin/bash', 10:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:28 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:28 INFO - 'USER': 'cltbld', 10:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:28 INFO - 'XPC_FLAGS': '0x0', 10:13:28 INFO - 'XPC_SERVICE_NAME': '0', 10:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:13:28 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-hMevgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:13:28 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:13:28 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-vEh95U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 10:13:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:13:28 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-uDkE0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-rzRpfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-eIStyS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-_8WqBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-6CmKfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-weKoFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-tpZabF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Ab1HF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-AyaTgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-rbj6Y9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:13:29 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)) 10:13:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:13:29 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-W2dSZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:13:30 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)) 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:13:30 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-BknRHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:30 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-WR92bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:13:30 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)) 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:13:30 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-NaTRSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 10:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:13:30 INFO - Running setup.py (path:/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/pip-Fvu7uG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:13:30 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)) 10:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:13:30 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)) 10:13:30 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)) 10:13:30 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)) 10:13:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13: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 10:13:32 INFO - Downloading blessings-1.6.tar.gz 10:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:13:33 INFO - Installing collected packages: blessings 10:13:33 INFO - Running setup.py install for blessings 10:13:33 INFO - Successfully installed blessings 10:13:33 INFO - Cleaning up... 10:13:33 INFO - Return code: 0 10:13:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:13:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:33 INFO - Reading from file tmpfile_stdout 10:13:33 INFO - Current package versions: 10:13:33 INFO - blessings == 1.6 10:13:33 INFO - blobuploader == 1.2.4 10:13:33 INFO - docopt == 0.6.1 10:13:33 INFO - functools32 == 3.2.3-2 10:13:33 INFO - jsonschema == 2.5.1 10:13:33 INFO - manifestparser == 1.1 10:13:33 INFO - mozInstall == 1.12 10:13:33 INFO - mozcrash == 0.17 10:13:33 INFO - mozdebug == 0.1 10:13:33 INFO - mozdevice == 0.48 10:13:33 INFO - mozfile == 1.2 10:13:33 INFO - mozhttpd == 0.7 10:13:33 INFO - mozinfo == 0.9 10:13:33 INFO - mozleak == 0.1 10:13:33 INFO - mozlog == 3.4 10:13:33 INFO - moznetwork == 0.27 10:13:33 INFO - mozprocess == 0.23 10:13:33 INFO - mozprofile == 0.28 10:13:33 INFO - mozrunner == 6.12 10:13:33 INFO - mozscreenshot == 0.1 10:13:33 INFO - mozsystemmonitor == 0.3 10:13:33 INFO - moztest == 0.7 10:13:33 INFO - mozversion == 1.4 10:13:33 INFO - psutil == 3.1.1 10:13:33 INFO - requests == 1.2.3 10:13:33 INFO - wsgiref == 0.1.2 10:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:34 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 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13:34 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 10:13:34 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 10:13:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:34 INFO - 'HOME': '/Users/cltbld', 10:13:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:34 INFO - 'LOGNAME': 'cltbld', 10:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:34 INFO - 'MOZ_NO_REMOTE': '1', 10:13:34 INFO - 'NO_EM_RESTART': '1', 10:13:34 INFO - 'PAGER': '/bin/cat', 10:13:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:34 INFO - 'PWD': '/builds/slave/test', 10:13:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:34 INFO - 'SHELL': '/bin/bash', 10:13:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:34 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:34 INFO - 'USER': 'cltbld', 10:13:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:34 INFO - 'XPC_FLAGS': '0x0', 10:13:34 INFO - 'XPC_SERVICE_NAME': '0', 10:13:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 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)) 10:13:34 INFO - Cleaning up... 10:13:34 INFO - Return code: 0 10:13:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f92c490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f8a2570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb5ead8a5e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, '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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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 10:13: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', 'jsonschema'] in /builds/slave/test/build 10:13: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 jsonschema 10:13:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:13:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:13:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:13:35 INFO - 'HOME': '/Users/cltbld', 10:13:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:13:35 INFO - 'LOGNAME': 'cltbld', 10:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:13:35 INFO - 'MOZ_NO_REMOTE': '1', 10:13:35 INFO - 'NO_EM_RESTART': '1', 10:13:35 INFO - 'PAGER': '/bin/cat', 10:13:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:13:35 INFO - 'PWD': '/builds/slave/test', 10:13:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:13:35 INFO - 'SHELL': '/bin/bash', 10:13:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:13:35 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:13:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:13:35 INFO - 'USER': 'cltbld', 10:13:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:13:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:13:35 INFO - 'XPC_FLAGS': '0x0', 10:13:35 INFO - 'XPC_SERVICE_NAME': '0', 10:13:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:13:35 INFO - Cleaning up... 10:13:35 INFO - Return code: 0 10:13:35 INFO - Running post-action listener: _resource_record_post_action 10:13:35 INFO - Running post-action listener: _start_resource_monitoring 10:13:35 INFO - Starting resource monitoring. 10:13:35 INFO - [mozharness: 2016-10-04 17:13:35.303236Z] Finished create-virtualenv step (success) 10:13:35 INFO - [mozharness: 2016-10-04 17:13:35.304128Z] Running install step. 10:13:35 INFO - Running pre-action listener: _resource_record_pre_action 10:13:35 INFO - Running main action method: install 10:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:13:35 INFO - Reading from file tmpfile_stdout 10:13:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:13:35 INFO - Reading from file tmpfile_stdout 10:13:35 INFO - Output received: 10:13:35 INFO - Usage: mozinstall [options] installer 10:13:35 INFO - Options: 10:13:35 INFO - -h, --help show this help message and exit 10:13:35 INFO - -d DEST, --destination=DEST 10:13:35 INFO - Directory to install application into. [default: 10:13:35 INFO - "/builds/slave/test"] 10:13:35 INFO - --app=APP Application being installed. [default: firefox] 10:13:35 INFO - mkdir: /builds/slave/test/build/application 10:13:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:14:09 INFO - Reading from file tmpfile_stdout 10:14:09 INFO - Output received: 10:14:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:14:09 INFO - Running post-action listener: _resource_record_post_action 10:14:09 INFO - [mozharness: 2016-10-04 17:14:09.818464Z] Finished install step (success) 10:14:09 INFO - [mozharness: 2016-10-04 17:14:09.818584Z] Running run-tests step. 10:14:09 INFO - Running pre-action listener: _resource_record_pre_action 10:14:09 INFO - Running main action method: run_tests 10:14:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:14:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:14:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:14:09 INFO - 2016-10-04 10:14:09.833 screenresolution[1634:7337] starting screenresolution argv=screenresolution get 10:14:09 INFO - 2016-10-04 10:14:09.835 screenresolution[1634:7337] Display 0: 1600x1200x32@60 10:14:09 INFO - 2016-10-04 10:14:09.841 screenresolution[1635:7339] starting screenresolution argv=screenresolution list 10:14:09 INFO - Available Modes on Display 0 10:14:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:14:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:14:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:14:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:14:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:14:10 INFO - Intel Iris: 10:14:10 INFO - Chipset Model: Intel Iris 10:14:10 INFO - Type: GPU 10:14:10 INFO - Bus: Built-In 10:14:10 INFO - VRAM (Dynamic, Max): 1536 MB 10:14:10 INFO - Vendor: Intel (0x8086) 10:14:10 INFO - Device ID: 0x0a2e 10:14:10 INFO - Revision ID: 0x0009 10:14:10 INFO - Displays: 10:14:10 INFO - Display: 10:14:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:14:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:14:10 INFO - Display Serial Number: 1600x1200 60 10:14:10 INFO - Main Display: Yes 10:14:10 INFO - Mirror: Off 10:14:10 INFO - Online: Yes 10:14:10 INFO - Rotation: Supported 10:14:10 INFO - Return code: 0 10:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:14:10 INFO - Python 2.7.3 10:14:10 INFO - Return code: 0 10:14:10 INFO - grabbing minidump binary from tooltool 10:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:14:10 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 0x10f740d30>, '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 0x10f566db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f738b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:14:10 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 10:14:10 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 10:14:10 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 10:14:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:14:10 INFO - Return code: 0 10:14:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:14:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:14:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:14:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:14:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:14:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 10:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0184 --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 10:14:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AMYgJ87KHr/Render', 10:14:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:14:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:14:10 INFO - 'HOME': '/Users/cltbld', 10:14:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:14:10 INFO - 'LOGNAME': 'cltbld', 10:14:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:14:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:10 INFO - 'MOZ_NO_REMOTE': '1', 10:14:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:14:10 INFO - 'NO_EM_RESTART': '1', 10:14:10 INFO - 'PAGER': '/bin/cat', 10:14:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:10 INFO - 'PWD': '/builds/slave/test', 10:14:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:14:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:14:10 INFO - 'SHELL': '/bin/bash', 10:14:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yb3dzbyyBH/Listeners', 10:14:10 INFO - 'TMPDIR': '/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/', 10:14:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:14:10 INFO - 'USER': 'cltbld', 10:14:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:14:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:10 INFO - 'XPC_FLAGS': '0x0', 10:14:10 INFO - 'XPC_SERVICE_NAME': '0', 10:14:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:14:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0184', '--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 10:14:10 INFO - mozversion application_buildid: 20161004081403 10:14:10 INFO - mozversion application_changeset: 067c15e2620f0f518d7ee70a06cdfd226f13b3f2 10:14:10 INFO - mozversion application_display_name: Nightly 10:14:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:14:10 INFO - mozversion application_name: Firefox 10:14:10 INFO - mozversion application_remotingname: firefox 10:14:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 10:14:10 INFO - mozversion application_vendor: Mozilla 10:14:10 INFO - mozversion application_version: 52.0a1 10:14:10 INFO - mozversion platform_buildid: 20161004081403 10:14:10 INFO - mozversion platform_changeset: 067c15e2620f0f518d7ee70a06cdfd226f13b3f2 10:14:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 10:14:10 INFO - mozversion platform_version: 52.0a1 10:14:10 INFO - using testdate: 1475601250 10:14:10 INFO - actual date: 1475601250 10:14:10 INFO - starting webserver on 'localhost:49267' 10:14:10 INFO - SUITE-START | Running 2 tests 10:14:10 INFO - TEST-START | dromaeo_css 10:14:10 INFO - operating with platform_type : mac_ 10:14:10 INFO - Initialising browser for dromaeo_css test... 10:14:10 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmp2kyfgE/profile http://localhost:49267/getInfo.html) 10:14:12 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 10:14:12 INFO - PROCESS | 1645 | colorDepth:24 10:14:12 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 10:14:12 INFO - PROCESS | 1645 | __metrics 10:14:12 INFO - PROCESS | 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:14:12 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:14:13 INFO - TEST-INFO | 1645: exit 0 10:14:13 INFO - Browser initialized. 10:14:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:14:13 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmp2kyfgE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:14:25 INFO - PROCESS | 1647 | RSS: Main: 235905024 10:14:25 INFO - PROCESS | 1647 | 10:15:16 INFO - PROCESS | 1647 | 1475601316369 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:17:29 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 10:17:31 INFO - PROCESS | 1647 | RSS: Main: 396312576 10:17:31 INFO - PROCESS | 1647 | 10:20:34 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 10:20:34 INFO - PROCESS | 1647 | RSS: Main: 378695680 10:20:34 INFO - PROCESS | 1647 | 10:23:37 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 10:23:37 INFO - PROCESS | 1647 | RSS: Main: 339009536 10:23:37 INFO - PROCESS | 1647 | 10:26:40 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 10:26:40 INFO - PROCESS | 1647 | RSS: Main: 339005440 10:26:40 INFO - PROCESS | 1647 | 10:29:43 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 10:29:44 INFO - PROCESS | 1647 | RSS: Main: 330629120 10:29:44 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 10:32:47 INFO - PROCESS | 1647 | RSS: Main: 515403776 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | __start_tp_report 10:32:47 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 10:32:47 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 10:32:47 INFO - PROCESS | 1647 | |i|pagename|runs| 10:32:47 INFO - PROCESS | 1647 | |0;dojo.html;3343.515190297407;3344.0970937846782;3346.832658367081;3376.290978894432;3406.2676524547232;5521.4478552144765;5604.187392828047;5675.404082571327;5709.229254050707;5770.163326317686;5590.161475778636;5670.0927851543765;5736.996025695497;5778.0466223073145;5787.971060144693;4227.8097485613225;4526.615237704799;4682.695624784378;5118.692878427288;5189.766460509267;5196.792128314863;5298.629095963284;5310.787568497255;5315.202719592054;5365.03429382711;4789.257665061921;5085.694858308513;5173.327467429229;5245.501677340647;5259.86850328741;5141.897162056775;5204.453532379083;5219.634625576211;5221.086309895753;5228.633995620308;5123.2827404163445;5170.715610641413;5180.611454140917;5189.896202075975;5191.974040129813;5427.647202931837;5590.440955904418;5670.518005969498;5686.715664216773;5781.19063331134;5569.774649577086;5842.474177324061;6220.409061139185;6226.813195604139;6238.719257633372;5169.276301317818;6213.627182369072;6259.843503912393;6290.9685451572905;6291.653959032252;5536.667799932017;5669.518090962273;5671.149327600893;5676.744546495418;5739.253896993364;6280.937190628127;6354.4281014708895;6371.299157092716;6372.74509019634;6374.203224596926;5748.080307150836;5909.670324177112;6086.330503644595;6104.26748790148;6107.877842443127;6057.818265452043;6093.943752790023;6110.188288888696;6239.656818875005;6260.7495700171485;5668.149777533403;6101.913673707429;6119.682653590127;6128.289244084599;6135.662538560422;6218.471429928416;6218.782342617987;6237.157983672146;6250.468710159596;6256.124142620037;4866.926996095061;4874.683145595525;4903.289023091632;4936.358273424504;4976.178930476503;4341.6526677865695;4349.478062632505;4371.907023244189;4389.1660584488845;4479.417675702203;5736.4550367715;5761.8559536011935;5766.826995190151;5773.769049237983;5804.303483581997;6254.843628909313;6267.62394256346;6268.780592679234;6287.559870808999;6291.150694656254;5619.690916999604;5686.090225563973;5698.088305871041;5729.312482502127;5745.540356771448;5359.3032905722;5368.597355198298;5385;5416.51251387377;5449.4005659377435;5487.64330318528;6136.23297087864;6304.810855674337;6306;6325.778597749057;6233.968830156002;6293;6304.6847657617855;6309;6319.431251187231;6235.37646235391;6261.154744109487;6302.716377763103;6334.049892516159;6341.8731625368155;6124.663143527148;6150.876982460415;6170.753169873155;6184.505239580732;6204.565680402328;6205.441510263918;6245.656488893154;6263.655498947602;6274.6548939808745;6290.402411770874;5913.379095194942;5971.880562388815;5974.9103763444455;6026.216591843032;6047.0929360596265;6104.236970378703;6130.398136742091;6134.008014331881;6138.846528836815;6158.969205153946;5960.195373624679;5965;5972.104184372379;5982.252218472691;6014.8195554133445;5834.03738383162;5916.970415147896;6073.817785466443;6110.175126357884;6136.20229370179;5768.798092066758;5793.739281732416;5874.383189765013;5876.265466816648;5950.940490595039 10:32:47 INFO - PROCESS | 1647 | |1;ext.html;463.1824829176504;528.4081828352246;528.8439910226485;532.9467053294671;551.4210079416616;30243;40128.59871401285;41259.58740412595;41269.58730412699;41431.79284103575;41758;42155;42203.15593688132;42224.155516889645;42225.36661950065;8756.168164024439;9813.705588832347;9947.900520994806;9991.150752186073;9998.750031249205;8901.955490222539;11768.588099416522;12082.758344833142;12090.93954530226;12308.446119924625;12117.818232726517;12191.756164876697;12196.268223906549;12243.938780306085;12247.917853964802;11888.28670279786;12116.515339386415;12164.391780410944;12184.39078046094;12200.69498262546;11767.58813441534;11974.760504789943;12012.03903687703;12012.55849298081;12040.217385869979;39930.60763316033;40176;40218.59781402178;40233.79883100595;40304.79847600743;3286.342731453719;3360.2439451123546;3462.671046250602;3792.6965842732793;3849.4225866120028;25197;30215.69784302151;31373.37253254945;31552;32010.359792804247;3185.347003864202;3297.8186199759243;3312.072619666473;3373.8819141329936;3380.188754698879;493836.53081734723;497403;497772;499429;501948.49025755003;47895;57067.42932570704;57582.71208644014;57625.42374576285;57641.8471630565;59972.700136499036;60065.69967150224;60069.69965150146;60091.39908600858;60146.69926650339;15990.280437380346;16176.75734863978;16187.352505899868;16195.352185912667;16266.83733162677;9613.279004074582;11286;11560;12658.620241392773;12711.364431778375;15269.618259543378;15469.690606187813;15644.765328520081;15769.763453548207;15838.60403489899;5388.515033646991;5564.610477266552;5864.944310024237;6034.943884820227;6088.330283668793;853.4495250563352;982.6904525074578;988.5502096546054;1018.4856647393019;1023.698009087321;24187.879060604937;28792;29816.40367192644;29916;30089.097327080224;1020.1532727835878;1068.1294744783133;1107.457345900503;1167.626359564948;1225.0934308611563;14775.630609234855;14986.925065374822;15234.771478427832;15372.923135384475;15478.380864765284;667037;669611;670062;671043;671840;56286.02998895019;56311.155332670045;56356;56421.15368269479;56522.86954260892;1180.9586664466703;1233.2415564427993;1235.71578536937;1339.2098661789591;1357.3891748713118;28961.841526339555;30877.592046650567;32094.839525803156;32134.035978919735;32326.83836580802;52712.47287527229;53198.468015319355;53354;53452.930941380175;53491;549785;557231;557381;557419;557831;25320.620190696787;25591.48817023612;26041.348966275993;38982;39144;45545.772271138434;46041.30938035865;46378.76810615925;47008.52991470041;47882.80292992703;39004.609953901236;39043.219135616564;39159.6084039156;40617;41274.38088428616;38586.7907832439;38848.53241877107;38924.6107538921;39796.40305395363;40217.59782402139;38172.80913595414;38538;38578;38700.2259954805;39955.80022099871;30475.542866857457;31161.37677246488;34106.82946585251;34353.62585496652;34515.654843451244;24931.127410540543;24964.251072467854;25974.480510390065;26036.08873689412;26416.339591510365 10:32:47 INFO - PROCESS | 1647 | |2;jquery.html;352.90295168828555;363.3387235231879;375.23077690734;382.29466634060157;406.30319002910005;15032.74508823677;15387.769183462244;16559.751603725952;20267.89866050668;21050.789492105076;19916.800831991677;22103.89480525971;22385.440363990907;22476;22705.54588908221;6801.21785994612;6864.897026544606;6945.062416573774;7052.435805135602;7220.133583969905;6672.5662831916015;6927.965360173217;7053.0125782390505;7067.681954312068;7068.823279418004;6924.723011079551;6984.476164287698;6991.335823096823;7000.29997000301;7007.7547285845;6085.6348619082555;6678.866422671519;6986.126734158231;6989.685464154125;6998.930010699879;6609.93390066098;6775.728970841161;6830.214525329601;6833.043373927654;6845.486588505882;27811.44377112467;28263.85868070667;28932.710672893212;29024.70975290241;29220.561691574432;2288.9084436622516;2574.6395504629368;2695.784337253015;2938.2323793208066;3348.614909285439;12941.228794085813;16141.031538107634;16585.25366358505;17106.973581585145;17309.480715578553;1929.6912494000892;1981.7621885373846;2000.0699674651357;2014.8589598728095;2021.9191232350836;127837.36081319627;128478;133549;139486.3025684865;139758;15731.561607950785;20303.59392812165;20346.389608311776;20871.37385878426;20895.68656470154;34950.47574286388;35119.64880351215;35132.824335878155;35136.29727405438;35136.47295290573;10501.947490262653;10571.682849514527;10767.461626918779;10815.242932994772;10840.62057827988;7466.216047314953;8720.171583699539;8967.327450441244;9120.635174592942;9142.81714365709;9514.904850951401;9575.473348965734;9626.326157169071;9678.419294842191;9739.707808765748;3017.336186039068;3716.1638631307737;3723.1995121049104;3740.8690695825517;3803.7337386382687;822.5229366967145;831.2850948184556;892.9107089291019;916.848719961199;990.9355891867006;16172.353105875869;20221.494462638257;21117.944102794798;21179.682304765134;21260.78739212619;815.5432957543794;857.725527831088;905.6422713028317;988.4415305352453;1025.6153942271649;11018.559257629606;11426.542938282375;11427;11427.142964277546;11445.256058356346;488487;584702;592714;593973;596692;76855.61572192103;111897.44051279692;135048;138629.6137038637;140534;952.8046750416148;969.781799095212;980.6420656460341;980.8332583460829;980.9460479673686;18548.25806967706;18758.906205468884;18926;18980.810191898458;19009.809901900804;53113.7344313276;53241.46758532365;53358.733206333716;53503.46496534985;54624.45375546194;66139.66930165511;69544.9136525905;81540;82179.17820821954;84283;6725.798226053226;7919.524828510308;8084.038820977561;8535.189157030072;8567.228949394335;12884.355782210665;13098.672533186747;13417.060805743504;13785.655358616115;14025;9611.519424028911;10952.685677718724;11303.660890173307;11653;12018.278903265833;10660.360378377321;11385.601503947322;11390.601328953448;11755.294682319089;12013.279203247834;11612.88387116118;11657.417129143678;11975.580854670045;12020.879791201976;12093.334866582423;7216.458765592706;7325.415582213996;7474.439417043634;7731.729389471341;8376.246137847624;9706.417614943126;11385.03227225695;11750.529978800752;11777.646670599896;11785.823212651989 10:32:47 INFO - PROCESS | 1647 | |3;mootools.html;1495.9850401495985;1524.9085054896705;1713.72580387138;1880.4264699266719;1887.8112188781115;8449.788755281113;9001.819963600741;9006.234470070036;9008.234300084492;9016.413933094344;7907.525548467096;8159.551224682655;8176.95911520443;8561.871571926411;8798.648054077828;2339.099446713011;2370.182287110944;2372.169740590788;2372.644103384489;2376.9049238030457;2320.187934223017;2330.7086614173227;2392.676988606533;2393.365758074112;2394.449276666368;1824.616830465604;2076.802703743142;2155.838312126589;2287.748347681754;2370.3718514593647;2345.1440224318085;2375.406148462884;2375.560521303547;2376.6553849691786;2378.7383387827326;2335.077644330497;2365.9645105323434;2368.75640288848;2369.4431808524982;2379.452725873059;8927.553622318857;8979.281657467387;9045.231155351803;9058.909410905873;9059.954700226457;4928.975355123202;5395.757190926379;5403.297571315743;5404.432534583891;5408.891822163535;3076.9538456923165;3438.5186073949667;3509.91225219369;3664.725145614063;3667.3948798448223;1053.1416895230363;1055.654041097599;1061.3995710509282;1076.1713480619878;1079.2499213046935;10149.949250253776;11758.35329056893;11861.347625880573;11869.52521899123;11895.405229738479;4549.363089167519;4659.5573420525;4715.3869996900185;4783.832565860248;4810.687305325143;10060.798784024279;10073.69778906634;10079.344842585355;10085.092341689284;10093.990600939847;5384;5387.488188622075;5388.568914486832;5389.757460914268;5391.595630327741;4770.165221086366;4919.065377578248;4927.975360123177;4931.3096166536;4931.334269873593;3660.5424321959754;3757.812109394519;3770.340190466712;3786.450964610116;3801.3727734923427;1085.9891401086047;1101.54285971321;1130.4291332876844;1138.7836311100864;1143.3711458697683;610.607814183662;735.2647352647352;835.913312693496;870.6038752367657;885.4952676974063;5394.568434525228;5946.821595352147;6101.023836186189;6106.969465152646;6131.172291740647;903.96947479873;921.6635927886407;946.8437707778139;948.9430634161972;964.9807003859884;3764.1906989997283;3809.485719427897;3883.456316115746;3953.248882712333;4008.0981779100052;10493.790124197474;10942.343459392461;10966.122710183166;10967.232293739362;10979.1765617579;9676.854847177297;10584.312019718695;10923;10943.616973405893;10944.069754070993;7786.727464538714;8199.303059239912;8214.46605970622;8348.081711011784;8360.749177524684;5948.4943779779205;5980.37206093354;5986.38504452591;6048.909266361096;6124.112003759519;9891.307608467338;10216.387016779017;10233.799733057429;10264.58941642326;10331.121854642139;9988;10242.54727003381;10256.282060255711;10280.383177009404;10555.261131721012;7018.543794653331;8017.997750281214;8234.888290081002;8351.707690230813;8377.748667539983;8264.421490495608;8283.130271321425;8353.415260931919;8442.915570844212;8444.577771111297;7515.511491753018;7556.924430755622;7582.35549978258;7593.392528597588;7617.809554761176;7392.112946446246;7440.218777028334;7456.254374562501;7463.626818659154;7482.2517748224745;6972.965135174494;7096.645167741695;7104.644767761694;7111.53775004623;7121.216666166614;4424.358468022183;4900.975495122501;5081.339425874613;5098.260752190986;5246.160614301693;5056.191009438472;5089.872753181052;5106.310648062464;5163.070647283525;5317.920231196613 10:32:47 INFO - PROCESS | 1647 | |4;prototype.html;300.43218317380155;305.8256793627632;308.52025100967995;312.29265713159697;315.462137056319;4269.459671495463;4408.713433626812;4502.864914052576;5341.447937121814;5352.545033672132;4785.090832741786;5009.048280826641;5271.367435907687;5298.549623282016;5328.92006619901;3483.7735547189477;3813.368775544879;3822.1591249924973;4010.9598904011023;4027.375756757707;3367.8989630311007;4015.317396042665;4060.457026330005;4073.1853629274115;4079.3269110596866;4017.4978127734034;4019;4023.637872591466;4029;4040.4141399497057;3861.4014827701753;4033.495813023372;4057.8376864925367;4070.14526949341;4077.938830917539;3227.2254658881934;3501.299740052;3520.6831385175456;3523.735719821024;3525.9118522036897;5134.101532231882;5143.614228932845;5145.588352931794;5150.845474635767;5228.562145410005;3865.61343865614;4408.382826404306;4629.1436084324505;4639.86080417588;4673.182193116191;4312.78436078198;4933.827316043958;5553.250726021331;5558.44415558441;5559.305086864142;3233.4341490239112;3404.591449026108;3864.3044252034624;3871.922561548753;3907.8241479133508;5348.866278343073;5583.832485025456;5830.105215804881;5847.912281315784;5849.941500584982;3889.6110388961442;3890.5720370759195;3916.8629097981434;3937.114149316381;3948.7038472114705;3368.2589830237307;3959.9112692100207;3961.920761584752;3983.788997106634;4021.5978402160135;4618.360482028831;4621.867642427559;4627.699199552018;4657.743824089707;4686.555381794378;4683.718976861331;5081.441041485434;5136.768845401966;5608.270924779753;5677.858053548694;1033.6227277043824;1256.8805963433458;1363.175278956237;1363.7477066742683;1364.4240901758485;713.3900515059653;792.6235038356734;829.1252728371626;843.9620217090246;847.9745607631781;4362.760048197316;4499.1451624191295;4556.8177272908715;5097.559147575372;5124.7950081996305;4644;5674.517665998354;5709.600327977085;5758;5773.971130144322;4467.798949047301;5238.345206849144;5244.819915518978;5279.096496926675;5305.975593911434;2629.8685065746636;2910.3742695320607;2976.64280286367;2983.4480621085168;3001.9736677742435;5709.685967271756;5867.2959244890035;5891.469767720926;5895.67573783446;5933;4730.716157030589;5395.70682459953;5659.745311460994;5795.304563452412;5947.936812541545;5133.640645154804;5259.316288882421;5420.268263784339;5802.970985145132;5822.69120850576;4843.4430040545785;5485.890282194414;5624.268845050117;5761.8559536011935;5858.502027327554;4747.430308363018;5216.139337009351;5453.727313634382;5564.666120032811;5680.68756218412;5945.821625351074;5959.688868448934;5965.254343207099;5969.940300597113;6010.669413182317;3447.396705576464;3673.651003154696;3857.977635926538;3919.1965647042857;3929.4085895212484;5185.559227465707;5473.972630136824;5608.074667679787;5622.831315060391;5636.731735359512;5471.835844924659;5559.860228653036;5604.094607833356;5617.185508101221;5618.410066942912;5123.359580052494;5159.690418574897;5511.58663100261;5519.944800551943;5537.4495141358875;4738.739369334719;5465.125579907355;5567.721613919207;5578.330600327987;5588.832335029955;5376.327959005124;5510.972445137749;5533.861653458695;5539.612227144223;5688.402717714746;4411.845585404495;5530.806421775219;5549;5575.470330318613;5575.470330318613 10:32:47 INFO - PROCESS | 1647 | |5;yui.html;637.3276193615735;765.2080097099503;780.6292011294636;799.4763429953383;803.7588723382984;15069;15797.447089351876;15812;15884.205789710497;16238.83761162388;14167.504137355168;14287.499937502163;14317.570472885804;14326.856731432683;14327.99704020719;679.1374953808672;698.7205117952809;846.9830603387928;874.8031692869117;883.8497455432592;876.447837862146;879.8856148700692;880.2825697056878;880.7930136417937;880.9471431714086;928.679605536089;928.8095940332249;929.2287401456774;933.7665583604099;934.3926447808944;720.8666396716624;742.6175519607433;898.3352319283748;915.4095608332589;934.7616357828778;677.4681874728363;680.357062575866;683.4429939599211;685.095673710702;685.5612408058846;12698.301593412358;15402.768958465633;15417.845821541754;15430.151341676203;15436.845631543652;14587.70824583513;14815.92592037033;14846.925765371105;14877.330520126512;14895.553133406016;11858.940705296418;12075.335856527887;12262.509499620004;12265.26408415489;12462.75074498505;3688.221789169404;3767.6232376762377;3850.7689538627774;3935.0752573145287;3986.80065996699;102291;104152.47923760409;111548.63385246058;113180.43409782981;113366;11202.327860328407;11212.327260364404;11285.830712539318;11396.829047564293;11416.714582135513;23311.18410855612;23313.95087221045;23361.299161025196;23375.298741037797;24005.639915401283;8060.959695201486;8068.435209535393;8099.06860711014;8131.552764598004;8154.347652187811;4389.495208051051;4404.515503294635;4427.756473393994;4533.682642215013;4596.655250856199;3677.154254521475;3786.3563194257044;3789.6020917803785;3789.9242015159543;3799.6200379961783;659.7855696898528;664.764008776887;676.9593824370553;693.8820400531922;695.4297476069676;658.308775785433;661.4179522020592;666.3935818405325;667.9365460281266;673.71367168953;9389.577469013911;9394.530273486298;9431.528423578931;9445.574949127305;9664.275179361575;544.3440654011906;561.4890449690762;601.503759398498;610.517691024086;673.9123913891261;4222.577742225814;4574.977125114353;4590.495045544987;4650.488446270908;4666.859994200179;98196;137601;165411;166276;171495.28504715042;101485.49257253666;120435;123219.15171272439;133621;140890;80642.98392540116;92901.60647590291;98876;100107.49946250222;102082;9403.529823508661;9742.707718768448;9776.657816976656;9919.305648604528;9952.751181220527;54686.45313546814;55011.72494137504;61713.38286617077;62571;63893.40266493375;91997.5400122995;97217.51391242999;97548;98540;99702;12395.814062788884;12498.625041248777;12540.122191446511;12972.351382430652;12984.35078246065;14353.425862965365;14602.780958285846;14642.633934151732;15183.16492592918;15249.542513724606;13660.795088073886;13672.453101876212;13675.316234188449;13710.794338084737;13721.382537786023;13367.465301387836;13506.797398038841;13637.249951252776;13694.589162324748;14040.859591403956;13078.28069456189;13178.60464186076;13591.79612305836;13680.315984200552;13755.449782009007;9082.545872706207;9335.953320233355;11169.218154729417;11332.376719280519;11351.262167959056;9504.714858554255;11305.71735706614;11425.350651423742;11568.537258509901;11642.476088576204 10:32:47 INFO - PROCESS | 1647 | __end_tp_report 10:32:47 INFO - PROCESS | 1647 | __start_cc_report 10:32:47 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,1754 10:32:47 INFO - PROCESS | 1647 | __end_cc_report 10:32:47 INFO - PROCESS | 1647 | __startTimestamp1475602367940__endTimestamp 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | ------- Summary: start ------- 10:32:47 INFO - PROCESS | 1647 | Number of tests: 6 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | [#0] dojo.html Cycles:165 Average:5693.93 Median:5834.04 stddev:654.34 (11.2%) stddev-sans-first:629.83 10:32:47 INFO - PROCESS | 1647 | Values: 3343.5 3344.1 3346.8 3376.3 3406.3 5521.4 5604.2 5675.4 5709.2 5770.2 5590.2 5670.1 5737.0 5778.0 5788.0 4227.8 4526.6 4682.7 5118.7 5189.8 5196.8 5298.6 5310.8 5315.2 5365.0 4789.3 5085.7 5173.3 5245.5 5259.9 5141.9 5204.5 5219.6 5221.1 5228.6 5123.3 5170.7 5180.6 5189.9 5192.0 5427.6 5590.4 5670.5 5686.7 5781.2 5569.8 5842.5 6220.4 6226.8 6238.7 5169.3 6213.6 6259.8 6291.0 6291.7 5536.7 5669.5 5671.1 5676.7 5739.3 6280.9 6354.4 6371.3 6372.7 6374.2 5748.1 5909.7 6086.3 6104.3 6107.9 6057.8 6093.9 6110.2 6239.7 6260.7 5668.1 6101.9 6119.7 6128.3 6135.7 6218.5 6218.8 6237.2 6250.5 6256.1 4866.9 4874.7 4903.3 4936.4 4976.2 4341.7 4349.5 4371.9 4389.2 4479.4 5736.5 5761.9 5766.8 5773.8 5804.3 6254.8 6267.6 6268.8 6287.6 6291.2 5619.7 5686.1 5698.1 5729.3 5745.5 5359.3 5368.6 5385.0 5416.5 5449.4 5487.6 6136.2 6304.8 6306.0 6325.8 6234.0 6293.0 6304.7 6309.0 6319.4 6235.4 6261.2 6302.7 6334.0 6341.9 6124.7 6150.9 6170.8 6184.5 6204.6 6205.4 6245.7 6263.7 6274.7 6290.4 5913.4 5971.9 5974.9 6026.2 6047.1 6104.2 6130.4 6134.0 6138.8 6159.0 5960.2 5965.0 5972.1 5982.3 6014.8 5834.0 5917.0 6073.8 6110.2 6136.2 5768.8 5793.7 5874.4 5876.3 5950.9 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | [#1] ext.html Cycles:180 Average:70742.47 Median:38558.00 stddev:154747.07 (401.3%) stddev-sans-first:155091.21 10:32:47 INFO - PROCESS | 1647 | Values: 463.2 528.4 528.8 532.9 551.4 30243.0 40128.6 41259.6 41269.6 41431.8 41758.0 42155.0 42203.2 42224.2 42225.4 8756.2 9813.7 9947.9 9991.2 9998.8 8902.0 11768.6 12082.8 12090.9 12308.4 12117.8 12191.8 12196.3 12243.9 12247.9 11888.3 12116.5 12164.4 12184.4 12200.7 11767.6 11974.8 12012.0 12012.6 12040.2 39930.6 40176.0 40218.6 40233.8 40304.8 3286.3 3360.2 3462.7 3792.7 3849.4 25197.0 30215.7 31373.4 31552.0 32010.4 3185.3 3297.8 3312.1 3373.9 3380.2 493836.5 497403.0 497772.0 499429.0 501948.5 47895.0 57067.4 57582.7 57625.4 57641.8 59972.7 60065.7 60069.7 60091.4 60146.7 15990.3 16176.8 16187.4 16195.4 16266.8 9613.3 11286.0 11560.0 12658.6 12711.4 15269.6 15469.7 15644.8 15769.8 15838.6 5388.5 5564.6 5864.9 6034.9 6088.3 853.4 982.7 988.6 1018.5 1023.7 24187.9 28792.0 29816.4 29916.0 30089.1 1020.2 1068.1 1107.5 1167.6 1225.1 14775.6 14986.9 15234.8 15372.9 15478.4 667037.0 669611.0 670062.0 671043.0 671840.0 56286.0 56311.2 56356.0 56421.2 56522.9 1181.0 1233.2 1235.7 1339.2 1357.4 28961.8 30877.6 32094.8 32134.0 32326.8 52712.5 53198.5 53354.0 53452.9 53491.0 549785.0 557231.0 557381.0 557419.0 557831.0 25320.6 25591.5 26041.3 38982.0 39144.0 45545.8 46041.3 46378.8 47008.5 47882.8 39004.6 39043.2 39159.6 40617.0 41274.4 38586.8 38848.5 38924.6 39796.4 40217.6 38172.8 38538.0 38578.0 38700.2 39955.8 30475.5 31161.4 34106.8 34353.6 34515.7 24931.1 24964.3 25974.5 26036.1 26416.3 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | [#2] jquery.html Cycles:180 Average:35969.27 Median:35126.24 stddev:95892.11 (273.0%) stddev-sans-first:96123.83 10:32:47 INFO - PROCESS | 1647 | Values: 352.9 363.3 375.2 382.3 406.3 15032.7 15387.8 16559.8 20267.9 21050.8 19916.8 22103.9 22385.4 22476.0 22705.5 6801.2 6864.9 6945.1 7052.4 7220.1 6672.6 6928.0 7053.0 7067.7 7068.8 6924.7 6984.5 6991.3 7000.3 7007.8 6085.6 6678.9 6986.1 6989.7 6998.9 6609.9 6775.7 6830.2 6833.0 6845.5 27811.4 28263.9 28932.7 29024.7 29220.6 2288.9 2574.6 2695.8 2938.2 3348.6 12941.2 16141.0 16585.3 17107.0 17309.5 1929.7 1981.8 2000.1 2014.9 2021.9 127837.4 128478.0 133549.0 139486.3 139758.0 15731.6 20303.6 20346.4 20871.4 20895.7 34950.5 35119.6 35132.8 35136.3 35136.5 10501.9 10571.7 10767.5 10815.2 10840.6 7466.2 8720.2 8967.3 9120.6 9142.8 9514.9 9575.5 9626.3 9678.4 9739.7 3017.3 3716.2 3723.2 3740.9 3803.7 822.5 831.3 892.9 916.8 990.9 16172.4 20221.5 21117.9 21179.7 21260.8 815.5 857.7 905.6 988.4 1025.6 11018.6 11426.5 11427.0 11427.1 11445.3 488487.0 584702.0 592714.0 593973.0 596692.0 76855.6 111897.4 135048.0 138629.6 140534.0 952.8 969.8 980.6 980.8 980.9 18548.3 18758.9 18926.0 18980.8 19009.8 53113.7 53241.5 53358.7 53503.5 54624.5 66139.7 69544.9 81540.0 82179.2 84283.0 6725.8 7919.5 8084.0 8535.2 8567.2 12884.4 13098.7 13417.1 13785.7 14025.0 9611.5 10952.7 11303.7 11653.0 12018.3 10660.4 11385.6 11390.6 11755.3 12013.3 11612.9 11657.4 11975.6 12020.9 12093.3 7216.5 7325.4 7474.4 7731.7 8376.2 9706.4 11385.0 11750.5 11777.6 11785.8 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | [#3] mootools.html Cycles:180 Average:5752.00 Median:4923.52 stddev:3252.14 (66.1%) stddev-sans-first:3245.54 10:32:47 INFO - PROCESS | 1647 | Values: 1496.0 1524.9 1713.7 1880.4 1887.8 8449.8 9001.8 9006.2 9008.2 9016.4 7907.5 8159.6 8177.0 8561.9 8798.6 2339.1 2370.2 2372.2 2372.6 2376.9 2320.2 2330.7 2392.7 2393.4 2394.4 1824.6 2076.8 2155.8 2287.7 2370.4 2345.1 2375.4 2375.6 2376.7 2378.7 2335.1 2366.0 2368.8 2369.4 2379.5 8927.6 8979.3 9045.2 9058.9 9060.0 4929.0 5395.8 5403.3 5404.4 5408.9 3077.0 3438.5 3509.9 3664.7 3667.4 1053.1 1055.7 1061.4 1076.2 1079.2 10149.9 11758.4 11861.3 11869.5 11895.4 4549.4 4659.6 4715.4 4783.8 4810.7 10060.8 10073.7 10079.3 10085.1 10094.0 5384.0 5387.5 5388.6 5389.8 5391.6 4770.2 4919.1 4928.0 4931.3 4931.3 3660.5 3757.8 3770.3 3786.5 3801.4 1086.0 1101.5 1130.4 1138.8 1143.4 610.6 735.3 835.9 870.6 885.5 5394.6 5946.8 6101.0 6107.0 6131.2 904.0 921.7 946.8 948.9 965.0 3764.2 3809.5 3883.5 3953.2 4008.1 10493.8 10942.3 10966.1 10967.2 10979.2 9676.9 10584.3 10923.0 10943.6 10944.1 7786.7 8199.3 8214.5 8348.1 8360.7 5948.5 5980.4 5986.4 6048.9 6124.1 9891.3 10216.4 10233.8 10264.6 10331.1 9988.0 10242.5 10256.3 10280.4 10555.3 7018.5 8018.0 8234.9 8351.7 8377.7 8264.4 8283.1 8353.4 8442.9 8444.6 7515.5 7556.9 7582.4 7593.4 7617.8 7392.1 7440.2 7456.3 7463.6 7482.3 6973.0 7096.6 7104.6 7111.5 7121.2 4424.4 4901.0 5081.3 5098.3 5246.2 5056.2 5089.9 5106.3 5163.1 5317.9 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | [#4] prototype.html Cycles:180 Average:4492.57 Median:5124.08 stddev:1387.44 (27.1%) stddev-sans-first:1355.19 10:32:47 INFO - PROCESS | 1647 | Values: 300.4 305.8 308.5 312.3 315.5 4269.5 4408.7 4502.9 5341.4 5352.5 4785.1 5009.0 5271.4 5298.5 5328.9 3483.8 3813.4 3822.2 4011.0 4027.4 3367.9 4015.3 4060.5 4073.2 4079.3 4017.5 4019.0 4023.6 4029.0 4040.4 3861.4 4033.5 4057.8 4070.1 4077.9 3227.2 3501.3 3520.7 3523.7 3525.9 5134.1 5143.6 5145.6 5150.8 5228.6 3865.6 4408.4 4629.1 4639.9 4673.2 4312.8 4933.8 5553.3 5558.4 5559.3 3233.4 3404.6 3864.3 3871.9 3907.8 5348.9 5583.8 5830.1 5847.9 5849.9 3889.6 3890.6 3916.9 3937.1 3948.7 3368.3 3959.9 3961.9 3983.8 4021.6 4618.4 4621.9 4627.7 4657.7 4686.6 4683.7 5081.4 5136.8 5608.3 5677.9 1033.6 1256.9 1363.2 1363.7 1364.4 713.4 792.6 829.1 844.0 848.0 4362.8 4499.1 4556.8 5097.6 5124.8 4644.0 5674.5 5709.6 5758.0 5774.0 4467.8 5238.3 5244.8 5279.1 5306.0 2629.9 2910.4 2976.6 2983.4 3002.0 5709.7 5867.3 5891.5 5895.7 5933.0 4730.7 5395.7 5659.7 5795.3 5947.9 5133.6 5259.3 5420.3 5803.0 5822.7 4843.4 5485.9 5624.3 5761.9 5858.5 4747.4 5216.1 5453.7 5564.7 5680.7 5945.8 5959.7 5965.3 5969.9 6010.7 3447.4 3673.7 3858.0 3919.2 3929.4 5185.6 5474.0 5608.1 5622.8 5636.7 5471.8 5559.9 5604.1 5617.2 5618.4 5123.4 5159.7 5511.6 5519.9 5537.4 4738.7 5465.1 5567.7 5578.3 5588.8 5376.3 5511.0 5533.9 5539.6 5688.4 4411.8 5530.8 5549.0 5575.5 5575.5 10:32:47 INFO - PROCESS | 1647 | 10:32:47 INFO - PROCESS | 1647 | [#5] yui.html Cycles:180 Average:24428.54 Median:3892.92 stddev:38767.66 (995.8%) stddev-sans-first:38835.25 10:32:47 INFO - PROCESS | 1647 | Values: 637.3 765.2 780.6 799.5 803.8 15069.0 15797.4 15812.0 15884.2 16238.8 14167.5 14287.5 14317.6 14326.9 14328.0 679.1 698.7 847.0 874.8 883.8 876.4 879.9 880.3 880.8 880.9 928.7 928.8 929.2 933.8 934.4 720.9 742.6 898.3 915.4 934.8 677.5 680.4 683.4 685.1 685.6 12698.3 15402.8 15417.8 15430.2 15436.8 14587.7 14815.9 14846.9 14877.3 14895.6 11858.9 12075.3 12262.5 12265.3 12462.8 3688.2 3767.6 3850.8 3935.1 3986.8 102291.0 104152.5 111548.6 113180.4 113366.0 11202.3 11212.3 11285.8 11396.8 11416.7 23311.2 23314.0 23361.3 23375.3 24005.6 8061.0 8068.4 8099.1 8131.6 8154.3 4389.5 4404.5 4427.8 4533.7 4596.7 3677.2 3786.4 3789.6 3789.9 3799.6 659.8 664.8 677.0 693.9 695.4 658.3 661.4 666.4 667.9 673.7 9389.6 9394.5 9431.5 9445.6 9664.3 544.3 561.5 601.5 610.5 673.9 4222.6 4575.0 4590.5 4650.5 4666.9 98196.0 137601.0 165411.0 166276.0 171495.3 101485.5 120435.0 123219.2 133621.0 140890.0 80643.0 92901.6 98876.0 100107.5 102082.0 9403.5 9742.7 9776.7 9919.3 9952.8 54686.5 55011.7 61713.4 62571.0 63893.4 91997.5 97217.5 97548.0 98540.0 99702.0 12395.8 12498.6 12540.1 12972.4 12984.4 14353.4 14602.8 14642.6 15183.2 15249.5 13660.8 13672.5 13675.3 13710.8 13721.4 13367.5 13506.8 13637.2 13694.6 14040.9 13078.3 13178.6 13591.8 13680.3 13755.4 9082.5 9336.0 11169.2 11332.4 11351.3 9504.7 11305.7 11425.4 11568.5 11642.5 10:32:47 INFO - PROCESS | 1647 | -------- Summary: end -------- 10:32:47 INFO - PROCESS | 1647 | 10:32:48 INFO - TEST-INFO | 1647: exit 0 10:32:48 INFO - TEST-OK | dromaeo_css | took 1118139ms 10:32:48 INFO - TEST-START | kraken 10:32:48 INFO - operating with platform_type : mac_ 10:32:48 INFO - Initialising browser for kraken test... 10:32:48 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpIEv7Xu/profile http://localhost:49267/getInfo.html) 10:32:50 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 10:32:50 INFO - PROCESS | 1657 | colorDepth:24 10:32:50 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 10:32:50 INFO - PROCESS | 1657 | __metrics 10:32:50 INFO - PROCESS | 1657 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:32:50 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:51 INFO - TEST-INFO | 1657: exit 0 10:32:51 INFO - Browser initialized. 10:32:51 INFO - Running cycle 1/1 for kraken test... 10:32:51 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/T/tmpIEv7Xu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:33:03 INFO - PROCESS | 1658 | RSS: Main: 235925504 10:33:03 INFO - PROCESS | 1658 | 10:33:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 10:33:07 INFO - PROCESS | 1658 | RSS: Main: 294719488 10:33:07 INFO - PROCESS | 1658 | 10:33:09 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 10:33:10 INFO - PROCESS | 1658 | RSS: Main: 293535744 10:33:10 INFO - PROCESS | 1658 | 10:33:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 10:33:14 INFO - PROCESS | 1658 | RSS: Main: 384098304 10:33:14 INFO - PROCESS | 1658 | 10:33:16 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 10:33:17 INFO - PROCESS | 1658 | RSS: Main: 286380032 10:33:17 INFO - PROCESS | 1658 | 10:33:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:33:19 INFO - PROCESS | 1658 | RSS: Main: 290947072 10:33:19 INFO - PROCESS | 1658 | 10:33:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 10:33:23 INFO - PROCESS | 1658 | RSS: Main: 328675328 10:33:23 INFO - PROCESS | 1658 | 10:33:26 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 10:33:26 INFO - PROCESS | 1658 | RSS: Main: 328261632 10:33:26 INFO - PROCESS | 1658 | 10:33:29 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 10:33:30 INFO - PROCESS | 1658 | RSS: Main: 328491008 10:33:30 INFO - PROCESS | 1658 | 10:33:31 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:33:32 INFO - PROCESS | 1658 | RSS: Main: 302858240 10:33:32 INFO - PROCESS | 1658 | 10:33:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:33:35 INFO - PROCESS | 1658 | RSS: Main: 305397760 10:33:35 INFO - PROCESS | 1658 | 10:33:37 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:33:37 INFO - PROCESS | 1658 | RSS: Main: 312999936 10:33:37 INFO - PROCESS | 1658 | 10:33:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:33:41 INFO - PROCESS | 1658 | RSS: Main: 322215936 10:33:41 INFO - PROCESS | 1658 | 10:33:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:33:45 INFO - PROCESS | 1658 | RSS: Main: 322359296 10:33:45 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 10:33:47 INFO - PROCESS | 1658 | RSS: Main: 365891584 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | __start_tp_report 10:33:47 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 10:33:47 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 10:33:47 INFO - PROCESS | 1658 | |i|pagename|runs| 10:33:47 INFO - PROCESS | 1658 | |0;ai-astar;113;112;113;111;110;112;112;112;113;112 10:33:47 INFO - PROCESS | 1658 | |1;audio-beat-detection;148;113;111;150;112;98;116;141;173;111 10:33:47 INFO - PROCESS | 1658 | |2;audio-dft;183;183;182;182;184;182;181;183;183;182 10:33:47 INFO - PROCESS | 1658 | |3;audio-fft;79;59;59;88;62;60;59;59;82;58 10:33:47 INFO - PROCESS | 1658 | |4;audio-oscillator;90;73;111;101;98;72;92;68;69;90 10:33:47 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;88;85;88;84;87;87;88;85;87;84 10:33:47 INFO - PROCESS | 1658 | |6;imaging-darkroom;97;97;95;113;168;127;97;108;155;96 10:33:47 INFO - PROCESS | 1658 | |7;imaging-desaturate;138;134;85;84;86;84;87;84;86;84 10:33:47 INFO - PROCESS | 1658 | |8;json-parse-financial;55;54;52;54;56;54;57;53;55;54 10:33:47 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;64;74;64;80;75;73;66;85;69;70 10:33:47 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;87;89;87;87;82;85;88;91;89;91 10:33:47 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;148;144;151;154;147;145;145;147;204;159 10:33:47 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;173;172;171;171;170;168;174;171;170;198 10:33:47 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;69;85;89;85;68;68;84;85;84;87 10:33:47 INFO - PROCESS | 1658 | __end_tp_report 10:33:47 INFO - PROCESS | 1658 | __start_cc_report 10:33:47 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1924 10:33:47 INFO - PROCESS | 1658 | __end_cc_report 10:33:47 INFO - PROCESS | 1658 | __startTimestamp1475602427407__endTimestamp 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | ------- Summary: start ------- 10:33:47 INFO - PROCESS | 1658 | Number of tests: 14 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 10:33:47 INFO - PROCESS | 1658 | Values: 113.0 112.0 113.0 111.0 110.0 112.0 112.0 112.0 113.0 112.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:144.50 stddev:23.98 (16.6%) stddev-sans-first:24.24 10:33:47 INFO - PROCESS | 1658 | Values: 148.0 113.0 111.0 150.0 112.0 98.0 116.0 141.0 173.0 111.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:182.50 Median:183.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 10:33:47 INFO - PROCESS | 1658 | Values: 183.0 183.0 182.0 182.0 184.0 182.0 181.0 183.0 183.0 182.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:66.50 Median:61.00 stddev:11.64 (19.1%) stddev-sans-first:11.43 10:33:47 INFO - PROCESS | 1658 | Values: 79.0 59.0 59.0 88.0 62.0 60.0 59.0 59.0 82.0 58.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:86.40 Median:81.50 stddev:15.05 (18.5%) stddev-sans-first:15.91 10:33:47 INFO - PROCESS | 1658 | Values: 90.0 73.0 111.0 101.0 98.0 72.0 92.0 68.0 69.0 90.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.64 (1.9%) stddev-sans-first:1.62 10:33:47 INFO - PROCESS | 1658 | Values: 88.0 85.0 88.0 84.0 87.0 87.0 88.0 85.0 87.0 84.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:115.30 Median:95.50 stddev:26.54 (27.8%) stddev-sans-first:27.31 10:33:47 INFO - PROCESS | 1658 | Values: 97.0 97.0 95.0 113.0 168.0 127.0 97.0 108.0 155.0 96.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:84.50 stddev:21.55 (25.5%) stddev-sans-first:16.37 10:33:47 INFO - PROCESS | 1658 | Values: 138.0 134.0 85.0 84.0 86.0 84.0 87.0 84.0 86.0 84.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.43 (2.6%) stddev-sans-first:1.50 10:33:47 INFO - PROCESS | 1658 | Values: 55.0 54.0 52.0 54.0 56.0 54.0 57.0 53.0 55.0 54.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:73.50 stddev:6.86 (9.3%) stddev-sans-first:6.64 10:33:47 INFO - PROCESS | 1658 | Values: 64.0 74.0 64.0 80.0 75.0 73.0 66.0 85.0 69.0 70.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:87.60 Median:88.50 stddev:2.72 (3.1%) stddev-sans-first:2.87 10:33:47 INFO - PROCESS | 1658 | Values: 87.0 89.0 87.0 87.0 82.0 85.0 88.0 91.0 89.0 91.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:154.40 Median:149.50 stddev:18.04 (12.1%) stddev-sans-first:18.98 10:33:47 INFO - PROCESS | 1658 | Values: 148.0 144.0 151.0 154.0 147.0 145.0 145.0 147.0 204.0 159.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:171.50 stddev:8.66 (5.1%) stddev-sans-first:9.18 10:33:47 INFO - PROCESS | 1658 | Values: 173.0 172.0 171.0 171.0 170.0 168.0 174.0 171.0 170.0 198.0 10:33:47 INFO - PROCESS | 1658 | 10:33:47 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:85.00 stddev:8.46 (10.0%) stddev-sans-first:7.91 10:33:47 INFO - PROCESS | 1658 | Values: 69.0 85.0 89.0 85.0 68.0 68.0 84.0 85.0 84.0 87.0 10:33:47 INFO - PROCESS | 1658 | -------- Summary: end -------- 10:33:47 INFO - PROCESS | 1658 | 10:33:48 INFO - TEST-INFO | 1658: exit 0 10:33:48 INFO - TEST-OK | kraken | took 59721ms 10:33:48 INFO - SUITE-END | took 1177s 10:33:48 INFO - Completed test suite (00:19:38) 10:33:48 INFO - javascript benchmark 10:33:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3343.515190297407, 3344.0970937846782, 3346.832658367081, 3376.290978894432, 3406.2676524547232, 5521.4478552144765, 5604.187392828047, 5675.404082571327, 5709.229254050707, 5770.163326317686, 5590.161475778636, 5670.0927851543765, 5736.996025695497, 5778.0466223073145, 5787.971060144693, 4227.8097485613225, 4526.615237704799, 4682.695624784378, 5118.692878427288, 5189.766460509267, 5196.792128314863, 5298.629095963284, 5310.787568497255, 5315.202719592054, 5365.03429382711, 4789.257665061921, 5085.694858308513, 5173.327467429229, 5245.501677340647, 5259.86850328741, 5141.897162056775, 5204.453532379083, 5219.634625576211, 5221.086309895753, 5228.633995620308, 5123.2827404163445, 5170.715610641413, 5180.611454140917, 5189.896202075975, 5191.974040129813, 5427.647202931837, 5590.440955904418, 5670.518005969498, 5686.715664216773, 5781.19063331134, 5569.774649577086, 5842.474177324061, 6220.409061139185, 6226.813195604139, 6238.719257633372, 5169.276301317818, 6213.627182369072, 6259.843503912393, 6290.9685451572905, 6291.653959032252, 5536.667799932017, 5669.518090962273, 5671.149327600893, 5676.744546495418, 5739.253896993364, 6280.937190628127, 6354.4281014708895, 6371.299157092716, 6372.74509019634, 6374.203224596926, 5748.080307150836, 5909.670324177112, 6086.330503644595, 6104.26748790148, 6107.877842443127, 6057.818265452043, 6093.943752790023, 6110.188288888696, 6239.656818875005, 6260.7495700171485, 5668.149777533403, 6101.913673707429, 6119.682653590127, 6128.289244084599, 6135.662538560422, 6218.471429928416, 6218.782342617987, 6237.157983672146, 6250.468710159596, 6256.124142620037, 4866.926996095061, 4874.683145595525, 4903.289023091632, 4936.358273424504, 4976.178930476503, 4341.6526677865695, 4349.478062632505, 4371.907023244189, 4389.1660584488845, 4479.417675702203, 5736.4550367715, 5761.8559536011935, 5766.826995190151, 5773.769049237983, 5804.303483581997, 6254.843628909313, 6267.62394256346, 6268.780592679234, 6287.559870808999, 6291.150694656254, 5619.690916999604, 5686.090225563973, 5698.088305871041, 5729.312482502127, 5745.540356771448, 5359.3032905722, 5368.597355198298, 5385.0, 5416.51251387377, 5449.4005659377435, 5487.64330318528, 6136.23297087864, 6304.810855674337, 6306.0, 6325.778597749057, 6233.968830156002, 6293.0, 6304.6847657617855, 6309.0, 6319.431251187231, 6235.37646235391, 6261.154744109487, 6302.716377763103, 6334.049892516159, 6341.8731625368155, 6124.663143527148, 6150.876982460415, 6170.753169873155, 6184.505239580732, 6204.565680402328, 6205.441510263918, 6245.656488893154, 6263.655498947602, 6274.6548939808745, 6290.402411770874, 5913.379095194942, 5971.880562388815, 5974.9103763444455, 6026.216591843032, 6047.0929360596265, 6104.236970378703, 6130.398136742091, 6134.008014331881, 6138.846528836815, 6158.969205153946, 5960.195373624679, 5965.0, 5972.104184372379, 5982.252218472691, 6014.8195554133445, 5834.03738383162, 5916.970415147896, 6073.817785466443, 6110.175126357884, 6136.20229370179, 5768.798092066758, 5793.739281732416, 5874.383189765013, 5876.265466816648, 5950.940490595039], "value": 5651.766022072751, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.1824829176504, 528.4081828352246, 528.8439910226485, 532.9467053294671, 551.4210079416616, 30243.0, 40128.59871401285, 41259.58740412595, 41269.58730412699, 41431.79284103575, 41758.0, 42155.0, 42203.15593688132, 42224.155516889645, 42225.36661950065, 8756.168164024439, 9813.705588832347, 9947.900520994806, 9991.150752186073, 9998.750031249205, 8901.955490222539, 11768.588099416522, 12082.758344833142, 12090.93954530226, 12308.446119924625, 12117.818232726517, 12191.756164876697, 12196.268223906549, 12243.938780306085, 12247.917853964802, 11888.28670279786, 12116.515339386415, 12164.391780410944, 12184.39078046094, 12200.69498262546, 11767.58813441534, 11974.760504789943, 12012.03903687703, 12012.55849298081, 12040.217385869979, 39930.60763316033, 40176.0, 40218.59781402178, 40233.79883100595, 40304.79847600743, 3286.342731453719, 3360.2439451123546, 3462.671046250602, 3792.6965842732793, 3849.4225866120028, 25197.0, 30215.69784302151, 31373.37253254945, 31552.0, 32010.359792804247, 3185.347003864202, 3297.8186199759243, 3312.072619666473, 3373.8819141329936, 3380.188754698879, 493836.53081734723, 497403.0, 497772.0, 499429.0, 501948.49025755003, 47895.0, 57067.42932570704, 57582.71208644014, 57625.42374576285, 57641.8471630565, 59972.700136499036, 60065.69967150224, 60069.69965150146, 60091.39908600858, 60146.69926650339, 15990.280437380346, 16176.75734863978, 16187.352505899868, 16195.352185912667, 16266.83733162677, 9613.279004074582, 11286.0, 11560.0, 12658.620241392773, 12711.364431778375, 15269.618259543378, 15469.690606187813, 15644.765328520081, 15769.763453548207, 15838.60403489899, 5388.515033646991, 5564.610477266552, 5864.944310024237, 6034.943884820227, 6088.330283668793, 853.4495250563352, 982.6904525074578, 988.5502096546054, 1018.4856647393019, 1023.698009087321, 24187.879060604937, 28792.0, 29816.40367192644, 29916.0, 30089.097327080224, 1020.1532727835878, 1068.1294744783133, 1107.457345900503, 1167.626359564948, 1225.0934308611563, 14775.630609234855, 14986.925065374822, 15234.771478427832, 15372.923135384475, 15478.380864765284, 667037.0, 669611.0, 670062.0, 671043.0, 671840.0, 56286.02998895019, 56311.155332670045, 56356.0, 56421.15368269479, 56522.86954260892, 1180.9586664466703, 1233.2415564427993, 1235.71578536937, 1339.2098661789591, 1357.3891748713118, 28961.841526339555, 30877.592046650567, 32094.839525803156, 32134.035978919735, 32326.83836580802, 52712.47287527229, 53198.468015319355, 53354.0, 53452.930941380175, 53491.0, 549785.0, 557231.0, 557381.0, 557419.0, 557831.0, 25320.620190696787, 25591.48817023612, 26041.348966275993, 38982.0, 39144.0, 45545.772271138434, 46041.30938035865, 46378.76810615925, 47008.52991470041, 47882.80292992703, 39004.609953901236, 39043.219135616564, 39159.6084039156, 40617.0, 41274.38088428616, 38586.7907832439, 38848.53241877107, 38924.6107538921, 39796.40305395363, 40217.59782402139, 38172.80913595414, 38538.0, 38578.0, 38700.2259954805, 39955.80022099871, 30475.542866857457, 31161.37677246488, 34106.82946585251, 34353.62585496652, 34515.654843451244, 24931.127410540543, 24964.251072467854, 25974.480510390065, 26036.08873689412, 26416.339591510365], "value": 20229.296452247992, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.90295168828555, 363.3387235231879, 375.23077690734, 382.29466634060157, 406.30319002910005, 15032.74508823677, 15387.769183462244, 16559.751603725952, 20267.89866050668, 21050.789492105076, 19916.800831991677, 22103.89480525971, 22385.440363990907, 22476.0, 22705.54588908221, 6801.21785994612, 6864.897026544606, 6945.062416573774, 7052.435805135602, 7220.133583969905, 6672.5662831916015, 6927.965360173217, 7053.0125782390505, 7067.681954312068, 7068.823279418004, 6924.723011079551, 6984.476164287698, 6991.335823096823, 7000.29997000301, 7007.7547285845, 6085.6348619082555, 6678.866422671519, 6986.126734158231, 6989.685464154125, 6998.930010699879, 6609.93390066098, 6775.728970841161, 6830.214525329601, 6833.043373927654, 6845.486588505882, 27811.44377112467, 28263.85868070667, 28932.710672893212, 29024.70975290241, 29220.561691574432, 2288.9084436622516, 2574.6395504629368, 2695.784337253015, 2938.2323793208066, 3348.614909285439, 12941.228794085813, 16141.031538107634, 16585.25366358505, 17106.973581585145, 17309.480715578553, 1929.6912494000892, 1981.7621885373846, 2000.0699674651357, 2014.8589598728095, 2021.9191232350836, 127837.36081319627, 128478.0, 133549.0, 139486.3025684865, 139758.0, 15731.561607950785, 20303.59392812165, 20346.389608311776, 20871.37385878426, 20895.68656470154, 34950.47574286388, 35119.64880351215, 35132.824335878155, 35136.29727405438, 35136.47295290573, 10501.947490262653, 10571.682849514527, 10767.461626918779, 10815.242932994772, 10840.62057827988, 7466.216047314953, 8720.171583699539, 8967.327450441244, 9120.635174592942, 9142.81714365709, 9514.904850951401, 9575.473348965734, 9626.326157169071, 9678.419294842191, 9739.707808765748, 3017.336186039068, 3716.1638631307737, 3723.1995121049104, 3740.8690695825517, 3803.7337386382687, 822.5229366967145, 831.2850948184556, 892.9107089291019, 916.848719961199, 990.9355891867006, 16172.353105875869, 20221.494462638257, 21117.944102794798, 21179.682304765134, 21260.78739212619, 815.5432957543794, 857.725527831088, 905.6422713028317, 988.4415305352453, 1025.6153942271649, 11018.559257629606, 11426.542938282375, 11427.0, 11427.142964277546, 11445.256058356346, 488487.0, 584702.0, 592714.0, 593973.0, 596692.0, 76855.61572192103, 111897.44051279692, 135048.0, 138629.6137038637, 140534.0, 952.8046750416148, 969.781799095212, 980.6420656460341, 980.8332583460829, 980.9460479673686, 18548.25806967706, 18758.906205468884, 18926.0, 18980.810191898458, 19009.809901900804, 53113.7344313276, 53241.46758532365, 53358.733206333716, 53503.46496534985, 54624.45375546194, 66139.66930165511, 69544.9136525905, 81540.0, 82179.17820821954, 84283.0, 6725.798226053226, 7919.524828510308, 8084.038820977561, 8535.189157030072, 8567.228949394335, 12884.355782210665, 13098.672533186747, 13417.060805743504, 13785.655358616115, 14025.0, 9611.519424028911, 10952.685677718724, 11303.660890173307, 11653.0, 12018.278903265833, 10660.360378377321, 11385.601503947322, 11390.601328953448, 11755.294682319089, 12013.279203247834, 11612.88387116118, 11657.417129143678, 11975.580854670045, 12020.879791201976, 12093.334866582423, 7216.458765592706, 7325.415582213996, 7474.439417043634, 7731.729389471341, 8376.246137847624, 9706.417614943126, 11385.03227225695, 11750.529978800752, 11777.646670599896, 11785.823212651989], "value": 10907.763017552943, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.9850401495985, 1524.9085054896705, 1713.72580387138, 1880.4264699266719, 1887.8112188781115, 8449.788755281113, 9001.819963600741, 9006.234470070036, 9008.234300084492, 9016.413933094344, 7907.525548467096, 8159.551224682655, 8176.95911520443, 8561.871571926411, 8798.648054077828, 2339.099446713011, 2370.182287110944, 2372.169740590788, 2372.644103384489, 2376.9049238030457, 2320.187934223017, 2330.7086614173227, 2392.676988606533, 2393.365758074112, 2394.449276666368, 1824.616830465604, 2076.802703743142, 2155.838312126589, 2287.748347681754, 2370.3718514593647, 2345.1440224318085, 2375.406148462884, 2375.560521303547, 2376.6553849691786, 2378.7383387827326, 2335.077644330497, 2365.9645105323434, 2368.75640288848, 2369.4431808524982, 2379.452725873059, 8927.553622318857, 8979.281657467387, 9045.231155351803, 9058.909410905873, 9059.954700226457, 4928.975355123202, 5395.757190926379, 5403.297571315743, 5404.432534583891, 5408.891822163535, 3076.9538456923165, 3438.5186073949667, 3509.91225219369, 3664.725145614063, 3667.3948798448223, 1053.1416895230363, 1055.654041097599, 1061.3995710509282, 1076.1713480619878, 1079.2499213046935, 10149.949250253776, 11758.35329056893, 11861.347625880573, 11869.52521899123, 11895.405229738479, 4549.363089167519, 4659.5573420525, 4715.3869996900185, 4783.832565860248, 4810.687305325143, 10060.798784024279, 10073.69778906634, 10079.344842585355, 10085.092341689284, 10093.990600939847, 5384.0, 5387.488188622075, 5388.568914486832, 5389.757460914268, 5391.595630327741, 4770.165221086366, 4919.065377578248, 4927.975360123177, 4931.3096166536, 4931.334269873593, 3660.5424321959754, 3757.812109394519, 3770.340190466712, 3786.450964610116, 3801.3727734923427, 1085.9891401086047, 1101.54285971321, 1130.4291332876844, 1138.7836311100864, 1143.3711458697683, 610.607814183662, 735.2647352647352, 835.913312693496, 870.6038752367657, 885.4952676974063, 5394.568434525228, 5946.821595352147, 6101.023836186189, 6106.969465152646, 6131.172291740647, 903.96947479873, 921.6635927886407, 946.8437707778139, 948.9430634161972, 964.9807003859884, 3764.1906989997283, 3809.485719427897, 3883.456316115746, 3953.248882712333, 4008.0981779100052, 10493.790124197474, 10942.343459392461, 10966.122710183166, 10967.232293739362, 10979.1765617579, 9676.854847177297, 10584.312019718695, 10923.0, 10943.616973405893, 10944.069754070993, 7786.727464538714, 8199.303059239912, 8214.46605970622, 8348.081711011784, 8360.749177524684, 5948.4943779779205, 5980.37206093354, 5986.38504452591, 6048.909266361096, 6124.112003759519, 9891.307608467338, 10216.387016779017, 10233.799733057429, 10264.58941642326, 10331.121854642139, 9988.0, 10242.54727003381, 10256.282060255711, 10280.383177009404, 10555.261131721012, 7018.543794653331, 8017.997750281214, 8234.888290081002, 8351.707690230813, 8377.748667539983, 8264.421490495608, 8283.130271321425, 8353.415260931919, 8442.915570844212, 8444.577771111297, 7515.511491753018, 7556.924430755622, 7582.35549978258, 7593.392528597588, 7617.809554761176, 7392.112946446246, 7440.218777028334, 7456.254374562501, 7463.626818659154, 7482.2517748224745, 6972.965135174494, 7096.645167741695, 7104.644767761694, 7111.53775004623, 7121.216666166614, 4424.358468022183, 4900.975495122501, 5081.339425874613, 5098.260752190986, 5246.160614301693, 5056.191009438472, 5089.872753181052, 5106.310648062464, 5163.070647283525, 5317.920231196613], "value": 4581.434895700469, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.43218317380155, 305.8256793627632, 308.52025100967995, 312.29265713159697, 315.462137056319, 4269.459671495463, 4408.713433626812, 4502.864914052576, 5341.447937121814, 5352.545033672132, 4785.090832741786, 5009.048280826641, 5271.367435907687, 5298.549623282016, 5328.92006619901, 3483.7735547189477, 3813.368775544879, 3822.1591249924973, 4010.9598904011023, 4027.375756757707, 3367.8989630311007, 4015.317396042665, 4060.457026330005, 4073.1853629274115, 4079.3269110596866, 4017.4978127734034, 4019.0, 4023.637872591466, 4029.0, 4040.4141399497057, 3861.4014827701753, 4033.495813023372, 4057.8376864925367, 4070.14526949341, 4077.938830917539, 3227.2254658881934, 3501.299740052, 3520.6831385175456, 3523.735719821024, 3525.9118522036897, 5134.101532231882, 5143.614228932845, 5145.588352931794, 5150.845474635767, 5228.562145410005, 3865.61343865614, 4408.382826404306, 4629.1436084324505, 4639.86080417588, 4673.182193116191, 4312.78436078198, 4933.827316043958, 5553.250726021331, 5558.44415558441, 5559.305086864142, 3233.4341490239112, 3404.591449026108, 3864.3044252034624, 3871.922561548753, 3907.8241479133508, 5348.866278343073, 5583.832485025456, 5830.105215804881, 5847.912281315784, 5849.941500584982, 3889.6110388961442, 3890.5720370759195, 3916.8629097981434, 3937.114149316381, 3948.7038472114705, 3368.2589830237307, 3959.9112692100207, 3961.920761584752, 3983.788997106634, 4021.5978402160135, 4618.360482028831, 4621.867642427559, 4627.699199552018, 4657.743824089707, 4686.555381794378, 4683.718976861331, 5081.441041485434, 5136.768845401966, 5608.270924779753, 5677.858053548694, 1033.6227277043824, 1256.8805963433458, 1363.175278956237, 1363.7477066742683, 1364.4240901758485, 713.3900515059653, 792.6235038356734, 829.1252728371626, 843.9620217090246, 847.9745607631781, 4362.760048197316, 4499.1451624191295, 4556.8177272908715, 5097.559147575372, 5124.7950081996305, 4644.0, 5674.517665998354, 5709.600327977085, 5758.0, 5773.971130144322, 4467.798949047301, 5238.345206849144, 5244.819915518978, 5279.096496926675, 5305.975593911434, 2629.8685065746636, 2910.3742695320607, 2976.64280286367, 2983.4480621085168, 3001.9736677742435, 5709.685967271756, 5867.2959244890035, 5891.469767720926, 5895.67573783446, 5933.0, 4730.716157030589, 5395.70682459953, 5659.745311460994, 5795.304563452412, 5947.936812541545, 5133.640645154804, 5259.316288882421, 5420.268263784339, 5802.970985145132, 5822.69120850576, 4843.4430040545785, 5485.890282194414, 5624.268845050117, 5761.8559536011935, 5858.502027327554, 4747.430308363018, 5216.139337009351, 5453.727313634382, 5564.666120032811, 5680.68756218412, 5945.821625351074, 5959.688868448934, 5965.254343207099, 5969.940300597113, 6010.669413182317, 3447.396705576464, 3673.651003154696, 3857.977635926538, 3919.1965647042857, 3929.4085895212484, 5185.559227465707, 5473.972630136824, 5608.074667679787, 5622.831315060391, 5636.731735359512, 5471.835844924659, 5559.860228653036, 5604.094607833356, 5617.185508101221, 5618.410066942912, 5123.359580052494, 5159.690418574897, 5511.58663100261, 5519.944800551943, 5537.4495141358875, 4738.739369334719, 5465.125579907355, 5567.721613919207, 5578.330600327987, 5588.832335029955, 5376.327959005124, 5510.972445137749, 5533.861653458695, 5539.612227144223, 5688.402717714746, 4411.845585404495, 5530.806421775219, 5549.0, 5575.470330318613, 5575.470330318613], "value": 4044.891536539737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.3276193615735, 765.2080097099503, 780.6292011294636, 799.4763429953383, 803.7588723382984, 15069.0, 15797.447089351876, 15812.0, 15884.205789710497, 16238.83761162388, 14167.504137355168, 14287.499937502163, 14317.570472885804, 14326.856731432683, 14327.99704020719, 679.1374953808672, 698.7205117952809, 846.9830603387928, 874.8031692869117, 883.8497455432592, 876.447837862146, 879.8856148700692, 880.2825697056878, 880.7930136417937, 880.9471431714086, 928.679605536089, 928.8095940332249, 929.2287401456774, 933.7665583604099, 934.3926447808944, 720.8666396716624, 742.6175519607433, 898.3352319283748, 915.4095608332589, 934.7616357828778, 677.4681874728363, 680.357062575866, 683.4429939599211, 685.095673710702, 685.5612408058846, 12698.301593412358, 15402.768958465633, 15417.845821541754, 15430.151341676203, 15436.845631543652, 14587.70824583513, 14815.92592037033, 14846.925765371105, 14877.330520126512, 14895.553133406016, 11858.940705296418, 12075.335856527887, 12262.509499620004, 12265.26408415489, 12462.75074498505, 3688.221789169404, 3767.6232376762377, 3850.7689538627774, 3935.0752573145287, 3986.80065996699, 102291.0, 104152.47923760409, 111548.63385246058, 113180.43409782981, 113366.0, 11202.327860328407, 11212.327260364404, 11285.830712539318, 11396.829047564293, 11416.714582135513, 23311.18410855612, 23313.95087221045, 23361.299161025196, 23375.298741037797, 24005.639915401283, 8060.959695201486, 8068.435209535393, 8099.06860711014, 8131.552764598004, 8154.347652187811, 4389.495208051051, 4404.515503294635, 4427.756473393994, 4533.682642215013, 4596.655250856199, 3677.154254521475, 3786.3563194257044, 3789.6020917803785, 3789.9242015159543, 3799.6200379961783, 659.7855696898528, 664.764008776887, 676.9593824370553, 693.8820400531922, 695.4297476069676, 658.308775785433, 661.4179522020592, 666.3935818405325, 667.9365460281266, 673.71367168953, 9389.577469013911, 9394.530273486298, 9431.528423578931, 9445.574949127305, 9664.275179361575, 544.3440654011906, 561.4890449690762, 601.503759398498, 610.517691024086, 673.9123913891261, 4222.577742225814, 4574.977125114353, 4590.495045544987, 4650.488446270908, 4666.859994200179, 98196.0, 137601.0, 165411.0, 166276.0, 171495.28504715042, 101485.49257253666, 120435.0, 123219.15171272439, 133621.0, 140890.0, 80642.98392540116, 92901.60647590291, 98876.0, 100107.49946250222, 102082.0, 9403.529823508661, 9742.707718768448, 9776.657816976656, 9919.305648604528, 9952.751181220527, 54686.45313546814, 55011.72494137504, 61713.38286617077, 62571.0, 63893.40266493375, 91997.5400122995, 97217.51391242999, 97548.0, 98540.0, 99702.0, 12395.814062788884, 12498.625041248777, 12540.122191446511, 12972.351382430652, 12984.35078246065, 14353.425862965365, 14602.780958285846, 14642.633934151732, 15183.16492592918, 15249.542513724606, 13660.795088073886, 13672.453101876212, 13675.316234188449, 13710.794338084737, 13721.382537786023, 13367.465301387836, 13506.797398038841, 13637.249951252776, 13694.589162324748, 14040.859591403956, 13078.28069456189, 13178.60464186076, 13591.79612305836, 13680.315984200552, 13755.449782009007, 9082.545872706207, 9335.953320233355, 11169.218154729417, 11332.376719280519, 11351.262167959056, 9504.714858554255, 11305.71735706614, 11425.350651423742, 11568.537258509901, 11642.476088576204], "value": 7849.410637989326, "unit": "score"}], "name": "dromaeo_css", "value": 7524.0076582356605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 113.0, 111.0, 110.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 113.0, 111.0, 150.0, 112.0, 98.0, 116.0, 141.0, 173.0, 111.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 182.0, 184.0, 182.0, 181.0, 183.0, 183.0, 182.0], "value": 182.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 88.0, 62.0, 60.0, 59.0, 59.0, 82.0, 58.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 73.0, 111.0, 101.0, 98.0, 72.0, 92.0, 68.0, 69.0, 90.0], "value": 86.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 84.0, 87.0, 87.0, 88.0, 85.0, 87.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 95.0, 113.0, 168.0, 127.0, 97.0, 108.0, 155.0, 96.0], "value": 115.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 85.0, 84.0, 86.0, 84.0, 87.0, 84.0, 86.0, 84.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 52.0, 54.0, 56.0, 54.0, 57.0, 53.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 64.0, 80.0, 75.0, 73.0, 66.0, 85.0, 69.0, 70.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 87.0, 87.0, 82.0, 85.0, 88.0, 91.0, 89.0, 91.0], "value": 87.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 151.0, 154.0, 147.0, 145.0, 145.0, 147.0, 204.0, 159.0], "value": 154.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 171.0, 171.0, 170.0, 168.0, 174.0, 171.0, 170.0, 198.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 85.0, 89.0, 85.0, 68.0, 68.0, 84.0, 85.0, 84.0, 87.0], "value": 80.4, "unit": "score"}], "name": "kraken", "value": 1494.1000000000001, "alertThreshold": 2.0}]} 10:33:48 INFO - Return code: 0 10:33:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:33:48 INFO - # TBPL SUCCESS # 10:33:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:33:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:33:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:33:48 INFO - 2016-10-04 10:33:48.723 screenresolution[1662:9653] starting screenresolution argv=screenresolution get 10:33:48 INFO - 2016-10-04 10:33:48.726 screenresolution[1662:9653] Display 0: 1600x1200x32@60 10:33:48 INFO - 2016-10-04 10:33:48.732 screenresolution[1663:9656] starting screenresolution argv=screenresolution list 10:33:48 INFO - Available Modes on Display 0 10:33:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:33:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:33:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:33:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:33:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:33:48 INFO - Intel Iris: 10:33:48 INFO - Chipset Model: Intel Iris 10:33:48 INFO - Type: GPU 10:33:48 INFO - Bus: Built-In 10:33:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:33:48 INFO - Vendor: Intel (0x8086) 10:33:48 INFO - Device ID: 0x0a2e 10:33:48 INFO - Revision ID: 0x0009 10:33:48 INFO - Displays: 10:33:48 INFO - Display: 10:33:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:33:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:33:48 INFO - Display Serial Number: 1600x1200 60 10:33:48 INFO - Main Display: Yes 10:33:48 INFO - Mirror: Off 10:33:48 INFO - Online: Yes 10:33:48 INFO - Rotation: Supported 10:33:48 INFO - Return code: 0 10:33:48 INFO - Running post-action listener: _resource_record_post_action 10:33:48 INFO - [mozharness: 2016-10-04 17:33:48.967751Z] Finished run-tests step (success) 10:33:48 INFO - Running post-run listener: _resource_record_post_run 10:33:49 INFO - Total resource usage - Wall time: 1213s; CPU: 53.0%; Read bytes: 38351872; Write bytes: 707162624; Read time: 382; Write time: 1879 10:33:49 INFO - TinderboxPrint: CPU usage
53.4% 10:33:49 INFO - TinderboxPrint: I/O read bytes / time
38,351,872 / 382 10:33:49 INFO - TinderboxPrint: I/O write bytes / time
707,162,624 / 1,879 10:33:49 INFO - TinderboxPrint: CPU idle
2,262.4 (46.6%) 10:33:49 INFO - TinderboxPrint: CPU system
966.5 (19.9%) 10:33:49 INFO - TinderboxPrint: CPU user
1,624.7 (33.5%) 10:33:49 INFO - TinderboxPrint: Swap in / out
445,403,136 / 0 10:33:49 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 397722112; Write bytes: 392673280; Read time: 29497; Write time: 730 10:33:49 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 36340736; Write bytes: 295606784; Read time: 359; Write time: 1107 10:33:49 INFO - Running post-run listener: _upload_blobber_files 10:33:49 INFO - Blob upload gear active. 10:33:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:33:49 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 10:33:49 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:33:49 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:33:49 INFO - (blobuploader) - INFO - Open directory for files ... 10:33:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:33:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:33:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:50 INFO - (blobuploader) - INFO - Done attempting. 10:33:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:33:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:33:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:51 INFO - (blobuploader) - INFO - Done attempting. 10:33:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:33:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:33:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:33:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:33:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:33:54 INFO - (blobuploader) - INFO - Done attempting. 10:33:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:33:54 INFO - Return code: 0 10:33:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:33:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:33:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/97e55db1d22b0f94f587781a528f6e17d885e48ec979d7704790cab825b334f704b189eed86158c5f52fce97e0d52a66f452e51a3dc954e133027db177fb6f77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/113ac45cac29a683302d3a2c8b6368ad49ea7902580d38c8db88f7c086b5b9f603b4a3b1ee982ab3eb91df02627030a770ce2879f8724efe8baf1464f7f532ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb4e96e4e0b53e38c35e28d9aee9f04c4d3eaf00c801727b53dccbfb06765c43172b18c891e67ea4f5f5be64a28e12b775a83efa3737b808cab8b0f6df9471bc"} 10:33:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:33:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:33:54 INFO - Contents: 10:33:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/97e55db1d22b0f94f587781a528f6e17d885e48ec979d7704790cab825b334f704b189eed86158c5f52fce97e0d52a66f452e51a3dc954e133027db177fb6f77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/113ac45cac29a683302d3a2c8b6368ad49ea7902580d38c8db88f7c086b5b9f603b4a3b1ee982ab3eb91df02627030a770ce2879f8724efe8baf1464f7f532ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb4e96e4e0b53e38c35e28d9aee9f04c4d3eaf00c801727b53dccbfb06765c43172b18c891e67ea4f5f5be64a28e12b775a83efa3737b808cab8b0f6df9471bc"} 10:33:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:33:54 INFO - Copying logs to upload dir... 10:33:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:33:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.068469 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-10-04 10:33:54.277422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 10:33:54.280658) ========= 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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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/Autoland/sha512/97e55db1d22b0f94f587781a528f6e17d885e48ec979d7704790cab825b334f704b189eed86158c5f52fce97e0d52a66f452e51a3dc954e133027db177fb6f77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/113ac45cac29a683302d3a2c8b6368ad49ea7902580d38c8db88f7c086b5b9f603b4a3b1ee982ab3eb91df02627030a770ce2879f8724efe8baf1464f7f532ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb4e96e4e0b53e38c35e28d9aee9f04c4d3eaf00c801727b53dccbfb06765c43172b18c891e67ea4f5f5be64a28e12b775a83efa3737b808cab8b0f6df9471bc"} build_url:https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011436 build_url: 'https://queue.taskcluster.net/v1/task/fSZ6RZJjTuyr7vohtLCzFw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/97e55db1d22b0f94f587781a528f6e17d885e48ec979d7704790cab825b334f704b189eed86158c5f52fce97e0d52a66f452e51a3dc954e133027db177fb6f77", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/113ac45cac29a683302d3a2c8b6368ad49ea7902580d38c8db88f7c086b5b9f603b4a3b1ee982ab3eb91df02627030a770ce2879f8724efe8baf1464f7f532ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/eb4e96e4e0b53e38c35e28d9aee9f04c4d3eaf00c801727b53dccbfb06765c43172b18c891e67ea4f5f5be64a28e12b775a83efa3737b808cab8b0f6df9471bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 10:33:54.313775) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:33:54.314214) ========= 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.AMYgJ87KHr/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.yb3dzbyyBH/Listeners TMPDIR=/var/folders/rh/6mxcx3y93yzc1x537jkxkp4000000w/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.005186 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 10:33:54.362811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 10:33:54.363116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 10:33:54.363558) ========= ========= Total master_lag: 0.23 =========