builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0101 starttime: 1475233902.81 results: success (0) buildid: 20160930020447 builduid: 4b66a12063f640ad8cbc3b6106c96061 revision: 7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:42.807989) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:42.808509) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:42.808804) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:42.914378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:42.914942) ========= 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.tKAaECYMed/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.kjLeoHM8VC/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-09-30 04:11:42-- 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% 8.00M=0.001s 2016-09-30 04:11:43 (8.00 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.585282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:43.519734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:43.520067) ========= 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.tKAaECYMed/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.kjLeoHM8VC/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.021526 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:43.568725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 04:11:43.569103) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6 --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 7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tKAaECYMed/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.kjLeoHM8VC/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-09-30 04:11:43,648 truncating revision to first 12 chars 2016-09-30 04:11:43,649 Setting DEBUG logging. 2016-09-30 04:11:43,649 attempt 1/10 2016-09-30 04:11:43,649 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/7f9e6e421e24?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 04:11:44,738 unpacking tar archive at: autoland-7f9e6e421e24/testing/mozharness/ program finished with exit code 0 elapsedTime=1.361405 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 04:11:44.952756) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:44.953122) ========= script_repo_revision: 7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:44.953525) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:44.953802) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 04:11:44.971608) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-30 04:11:44.971962) ========= /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.tKAaECYMed/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.kjLeoHM8VC/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:11:45 INFO - MultiFileLogger online at 20160930 04:11:45 in /builds/slave/test 04:11:45 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 04:11:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:11:45 INFO - {'append_to_log': False, 04:11:45 INFO - 'base_work_dir': '/builds/slave/test', 04:11:45 INFO - 'blob_upload_branch': 'Autoland', 04:11:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:11:45 INFO - 'branch': 'Autoland', 04:11:45 INFO - 'buildbot_json_path': 'buildprops.json', 04:11:45 INFO - 'config_files': ('talos/mac_config.py',), 04:11:45 INFO - 'default_actions': ('clobber', 04:11:45 INFO - 'read-buildbot-config', 04:11:45 INFO - 'download-and-extract', 04:11:45 INFO - 'populate-webroot', 04:11:45 INFO - 'create-virtualenv', 04:11:45 INFO - 'install', 04:11:45 INFO - 'run-tests'), 04:11:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:11:45 INFO - 'download_minidump_stackwalk': True, 04:11:45 INFO - 'download_symbols': 'ondemand', 04:11:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:11:45 INFO - 'tooltool.py': '/tools/tooltool.py', 04:11:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:11:45 INFO - '/tools/misc-python/virtualenv.py')}, 04:11:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:11:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:11:45 INFO - 'installer_path': 'installer.exe', 04:11:45 INFO - 'log_level': 'info', 04:11:45 INFO - 'log_name': 'talos', 04:11:45 INFO - 'log_to_console': True, 04:11:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:11:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:11:45 INFO - 'opt_config_files': (), 04:11:45 INFO - 'pip_index': False, 04:11:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:45 INFO - 'cmd': ('bash', 04:11:45 INFO - '-c', 04:11:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:45 INFO - 'enabled': True, 04:11:45 INFO - 'halt_on_failure': False, 04:11:45 INFO - 'name': 'check_screen_resolution'},), 04:11:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:11:45 INFO - 'cmd': ('bash', 04:11:45 INFO - '-c', 04:11:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:11:45 INFO - 'enabled': True, 04:11:45 INFO - 'halt_on_failure': False, 04:11:45 INFO - 'name': 'check_screen_resolution'},), 04:11:45 INFO - 'run_cmd_checks_enabled': True, 04:11:45 INFO - 'sps_profile': False, 04:11:45 INFO - 'sps_profile_interval': 0, 04:11:45 INFO - 'suite': 'dromaeojs', 04:11:45 INFO - 'system_bits': '32', 04:11:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:11:45 INFO - 'title': 't-yosemite-r7-0101', 04:11:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:11:45 INFO - 'use_talos_json': True, 04:11:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:11:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:11:45 INFO - 'work_dir': 'build'} 04:11:45 INFO - [mozharness: 2016-09-30 11:11:45.168317Z] Running clobber step. 04:11:45 INFO - Running pre-action listener: _resource_record_pre_action 04:11:45 INFO - Running main action method: clobber 04:11:45 INFO - rmtree: /builds/slave/test/build 04:11:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:11:46 INFO - Running post-action listener: _resource_record_post_action 04:11:46 INFO - [mozharness: 2016-09-30 11:11:46.077665Z] Finished clobber step (success) 04:11:46 INFO - [mozharness: 2016-09-30 11:11:46.077802Z] Running read-buildbot-config step. 04:11:46 INFO - Running pre-action listener: _resource_record_pre_action 04:11:46 INFO - Running main action method: read_buildbot_config 04:11:46 INFO - Using buildbot properties: 04:11:46 INFO - { 04:11:46 INFO - "project": "", 04:11:46 INFO - "product": "firefox", 04:11:46 INFO - "script_repo_revision": "production", 04:11:46 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 04:11:46 INFO - "repository": "", 04:11:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 04:11:46 INFO - "buildid": "20160930020447", 04:11:46 INFO - "pgo_build": "False", 04:11:46 INFO - "basedir": "/builds/slave/test", 04:11:46 INFO - "buildnumber": 208, 04:11:46 INFO - "slavename": "t-yosemite-r7-0101", 04:11:46 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:11:46 INFO - "platform": "yosemite_r7", 04:11:46 INFO - "scheduler": "tests-autoland-macosx64-talos", 04:11:46 INFO - "branch": "autoland", 04:11:46 INFO - "repo_path": "integration/autoland", 04:11:46 INFO - "revision": "7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6", 04:11:46 INFO - "stage_platform": "macosx64", 04:11:46 INFO - "builduid": "4b66a12063f640ad8cbc3b6106c96061", 04:11:46 INFO - "slavebuilddir": "test" 04:11:46 INFO - } 04:11:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:11:46 INFO - Running post-action listener: _resource_record_post_action 04:11:46 INFO - [mozharness: 2016-09-30 11:11:46.081111Z] Finished read-buildbot-config step (success) 04:11:46 INFO - [mozharness: 2016-09-30 11:11:46.081239Z] Running download-and-extract step. 04:11:46 INFO - Running pre-action listener: _resource_record_pre_action 04:11:46 INFO - Running main action method: download_and_extract 04:11:46 INFO - mkdir: /builds/slave/test/build/tests 04:11:46 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')]} 04:11:46 INFO - trying https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:11:46 INFO - Downloading https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/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 04:11:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/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 04:11:46 INFO - Downloaded 1199 bytes. 04:11:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:11:46 INFO - Using the following test package requirements: 04:11:46 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:11:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:11:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:11:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'jsshell-mac.zip'], 04:11:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:11:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:11:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:11:46 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:11:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:11:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:11:46 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:11:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:11:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:11:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:46 INFO - Fetch https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:11:47 INFO - Http code: 200 04:11:47 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 04:11:47 INFO - x-amz-cf-id: Bfu6phxJif3bqUH4dp6syrHxmauaTs0GHRdakYd1pugUbeF6puNr3g== 04:11:47 INFO - x-amz-version-id: YFXlg_7a07Yq_mAo7kg6ahMf_5uhC9ef 04:11:47 INFO - Expected file size: 16473419 04:11:47 INFO - Obtained file size: 16473419 04:11:54 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 04:11:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:11:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:11:54 INFO - Fetch https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:11:54 INFO - Http code: 200 04:11:54 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 04:11:54 INFO - x-amz-cf-id: bKAUHqo40evJv0CClotPWh0EqTW4FgCv_opKr58z1rjSi3iGxqhluw== 04:11:54 INFO - x-amz-version-id: YFXlg_7a07Yq_mAo7kg6ahMf_5uhC9ef 04:11:54 INFO - Expected file size: 16473419 04:11:54 INFO - Obtained file size: 16473419 04:12:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:12:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:12:01 INFO - Fetch https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:12:02 INFO - Http code: 200 04:12:02 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 04:12:02 INFO - x-amz-cf-id: RFnFUhVukiA6vbLenAuwnJ7Hyl0cSOkQBV6RPOlwDIHDMzQioXoxhw== 04:12:02 INFO - x-amz-version-id: .V9w7OO_z7sZ8iYr6Q_JkYNKBGqGgzR6 04:12:02 INFO - Expected file size: 14414067 04:12:02 INFO - Obtained file size: 14414067 04:12:02 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')]} 04:12:02 INFO - trying https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:12:02 INFO - Downloading https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:12:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/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 04:12:05 INFO - Downloaded 111778399 bytes. 04:12:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:12:05 INFO - mkdir: /builds/slave/test/properties 04:12:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:05 INFO - Contents: 04:12:05 INFO - build_url:https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:12:06 INFO - Running post-action listener: _resource_record_post_action 04:12:06 INFO - Running post-action listener: set_extra_try_arguments 04:12:06 INFO - [mozharness: 2016-09-30 11:12:06.363732Z] Finished download-and-extract step (success) 04:12:06 INFO - [mozharness: 2016-09-30 11:12:06.363840Z] Running populate-webroot step. 04:12:06 INFO - Running pre-action listener: _resource_record_pre_action 04:12:06 INFO - Running main action method: populate_webroot 04:12:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:06 INFO - '--tppagecycles', 04:12:06 INFO - '7'], 04:12:06 INFO - 'tests': ['tsvgm']}}, 04:12:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['damp', 'tps']}, 04:12:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'tests': ['damp', 'tps']}, 04:12:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['dromaeo_dom']}, 04:12:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['basic_compositor_video']}, 04:12:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:12:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['a11yr', 04:12:06 INFO - 'ts_paint', 04:12:06 INFO - 'tpaint', 04:12:06 INFO - 'sessionrestore', 04:12:06 INFO - 'sessionrestore_no_auto_restore', 04:12:06 INFO - 'tabpaint']}, 04:12:06 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:06 INFO - 'ts_paint', 04:12:06 INFO - 'tpaint', 04:12:06 INFO - 'sessionrestore', 04:12:06 INFO - 'sessionrestore_no_auto_restore', 04:12:06 INFO - 'tabpaint']}, 04:12:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:06 INFO - 'ts_paint', 04:12:06 INFO - 'tpaint', 04:12:06 INFO - 'sessionrestore', 04:12:06 INFO - 'sessionrestore_no_auto_restore', 04:12:06 INFO - 'tabpaint']}, 04:12:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:06 INFO - 'ts_paint', 04:12:06 INFO - 'tpaint', 04:12:06 INFO - 'sessionrestore', 04:12:06 INFO - 'sessionrestore_no_auto_restore', 04:12:06 INFO - 'tabpaint']}, 04:12:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['a11yr', 04:12:06 INFO - 'ts_paint', 04:12:06 INFO - 'tpaint', 04:12:06 INFO - 'sessionrestore', 04:12:06 INFO - 'sessionrestore_no_auto_restore', 04:12:06 INFO - 'tabpaint']}, 04:12:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['a11yr', 04:12:06 INFO - 'ts_paint', 04:12:06 INFO - 'tpaint', 04:12:06 INFO - 'sessionrestore', 04:12:06 INFO - 'sessionrestore_no_auto_restore', 04:12:06 INFO - 'tabpaint']}, 04:12:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['tsvgx', 04:12:06 INFO - 'tsvgr_opacity', 04:12:06 INFO - 'tart', 04:12:06 INFO - 'tscrollx', 04:12:06 INFO - 'cart']}, 04:12:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:06 INFO - 'tsvgr_opacity', 04:12:06 INFO - 'tart', 04:12:06 INFO - 'tscrollx', 04:12:06 INFO - 'cart']}, 04:12:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'talos_options': ['--disable-e10s'], 04:12:06 INFO - 'tests': ['tp5o']}, 04:12:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'tests': ['tp5o']}, 04:12:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'talos_options': ['--disable-e10s', 04:12:06 INFO - '--xperf_path', 04:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:06 INFO - 'tests': ['tp5n']}, 04:12:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:06 INFO - 'talos_options': ['--xperf_path', 04:12:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:06 INFO - 'tests': ['tp5n']}}, 04:12:06 INFO - 'talos.zip': {'path': '', 04:12:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:06 INFO - Running post-action listener: _resource_record_post_action 04:12:06 INFO - [mozharness: 2016-09-30 11:12:06.382867Z] Finished populate-webroot step (success) 04:12:06 INFO - [mozharness: 2016-09-30 11:12:06.382998Z] Running create-virtualenv step. 04:12:06 INFO - Running pre-action listener: _resource_record_pre_action 04:12:06 INFO - Running main action method: create_virtualenv 04:12:06 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:06 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:12:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:06 INFO - Using real prefix '/tools/python27' 04:12:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:07 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:10 INFO - Installing pip.................done. 04:12:10 INFO - Return code: 0 04:12:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:12:10 INFO - Reading from file tmpfile_stdout 04:12:10 INFO - Output received: 04:12:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:12:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:10 INFO - 'HOME': '/Users/cltbld', 04:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:10 INFO - 'LOGNAME': 'cltbld', 04:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:10 INFO - 'MOZ_NO_REMOTE': '1', 04:12:10 INFO - 'NO_EM_RESTART': '1', 04:12:10 INFO - 'PAGER': '/bin/cat', 04:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:10 INFO - 'PWD': '/builds/slave/test', 04:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:10 INFO - 'SHELL': '/bin/bash', 04:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:10 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:10 INFO - 'USER': 'cltbld', 04:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:10 INFO - 'XPC_FLAGS': '0x0', 04:12:10 INFO - 'XPC_SERVICE_NAME': '0', 04:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:12:10 INFO - Cleaning up... 04:12:10 INFO - Return code: 0 04:12:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:12:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:12:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:10 INFO - 'HOME': '/Users/cltbld', 04:12:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:10 INFO - 'LOGNAME': 'cltbld', 04:12:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:10 INFO - 'MOZ_NO_REMOTE': '1', 04:12:10 INFO - 'NO_EM_RESTART': '1', 04:12:10 INFO - 'PAGER': '/bin/cat', 04:12:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:10 INFO - 'PWD': '/builds/slave/test', 04:12:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:10 INFO - 'SHELL': '/bin/bash', 04:12:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:10 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:10 INFO - 'USER': 'cltbld', 04:12:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:10 INFO - 'XPC_FLAGS': '0x0', 04:12:10 INFO - 'XPC_SERVICE_NAME': '0', 04:12:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:10 INFO - Downloading/unpacking psutil>=3.1.1 04:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:14 INFO - Installing collected packages: psutil 04:12:14 INFO - Running setup.py install for psutil 04:12:14 INFO - building 'psutil._psutil_osx' extension 04:12:14 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:12:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:12:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:12:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:12:15 INFO - building 'psutil._psutil_posix' extension 04:12:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:12:15 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:12:15 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:12:15 INFO - ^ 04:12:15 INFO - 1 warning generated. 04:12:15 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:12:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:15 INFO - Successfully installed psutil 04:12:15 INFO - Cleaning up... 04:12:15 INFO - Return code: 0 04:12:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:12:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:15 INFO - 'HOME': '/Users/cltbld', 04:12:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:15 INFO - 'LOGNAME': 'cltbld', 04:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:15 INFO - 'MOZ_NO_REMOTE': '1', 04:12:15 INFO - 'NO_EM_RESTART': '1', 04:12:15 INFO - 'PAGER': '/bin/cat', 04:12:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:15 INFO - 'PWD': '/builds/slave/test', 04:12:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:15 INFO - 'SHELL': '/bin/bash', 04:12:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:15 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:15 INFO - 'USER': 'cltbld', 04:12:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:15 INFO - 'XPC_FLAGS': '0x0', 04:12:15 INFO - 'XPC_SERVICE_NAME': '0', 04:12:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:12:16 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 04:12:16 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 04:12:16 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 04:12:16 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 04:12:16 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 04:12:16 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 04:12:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:12:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:12:18 INFO - Installing collected packages: mozsystemmonitor 04:12:18 INFO - Running setup.py install for mozsystemmonitor 04:12:18 INFO - Successfully installed mozsystemmonitor 04:12:18 INFO - Cleaning up... 04:12:18 INFO - Return code: 0 04:12:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:12: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')]} 04:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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')]} 04:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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', '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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:12: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 jsonschema==2.5.1 04:12:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:18 INFO - 'HOME': '/Users/cltbld', 04:12:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:18 INFO - 'LOGNAME': 'cltbld', 04:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:18 INFO - 'MOZ_NO_REMOTE': '1', 04:12:18 INFO - 'NO_EM_RESTART': '1', 04:12:18 INFO - 'PAGER': '/bin/cat', 04:12:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:18 INFO - 'PWD': '/builds/slave/test', 04:12:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:18 INFO - 'SHELL': '/bin/bash', 04:12:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:18 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:18 INFO - 'USER': 'cltbld', 04:12:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:18 INFO - 'XPC_FLAGS': '0x0', 04:12:18 INFO - 'XPC_SERVICE_NAME': '0', 04:12:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:19 INFO - Downloading/unpacking jsonschema==2.5.1 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:12:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:12:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:12:21 INFO - warning: no files found matching '*.txt' 04:12:21 INFO - no previously-included directories found matching 'build' 04:12:21 INFO - no previously-included directories found matching 'dist' 04:12:21 INFO - no previously-included directories found matching '.git*' 04:12:21 INFO - Installing collected packages: jsonschema, functools32 04:12:22 INFO - Running setup.py install for functools32 04:12:22 INFO - warning: no files found matching '*.txt' 04:12:22 INFO - no previously-included directories found matching 'build' 04:12:22 INFO - no previously-included directories found matching 'dist' 04:12:22 INFO - no previously-included directories found matching '.git*' 04:12:22 INFO - Successfully installed jsonschema functools32 04:12:22 INFO - Cleaning up... 04:12:22 INFO - Return code: 0 04:12:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:22 INFO - 'HOME': '/Users/cltbld', 04:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:22 INFO - 'LOGNAME': 'cltbld', 04:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:22 INFO - 'MOZ_NO_REMOTE': '1', 04:12:22 INFO - 'NO_EM_RESTART': '1', 04:12:22 INFO - 'PAGER': '/bin/cat', 04:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:22 INFO - 'PWD': '/builds/slave/test', 04:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:22 INFO - 'SHELL': '/bin/bash', 04:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:22 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:22 INFO - 'USER': 'cltbld', 04:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:22 INFO - 'XPC_FLAGS': '0x0', 04:12:22 INFO - 'XPC_SERVICE_NAME': '0', 04:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:12:22 INFO - Cleaning up... 04:12:22 INFO - Return code: 0 04:12:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:12:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:12:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:22 INFO - 'HOME': '/Users/cltbld', 04:12:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:22 INFO - 'LOGNAME': 'cltbld', 04:12:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:22 INFO - 'MOZ_NO_REMOTE': '1', 04:12:22 INFO - 'NO_EM_RESTART': '1', 04:12:22 INFO - 'PAGER': '/bin/cat', 04:12:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:22 INFO - 'PWD': '/builds/slave/test', 04:12:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:22 INFO - 'SHELL': '/bin/bash', 04:12:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:22 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:22 INFO - 'USER': 'cltbld', 04:12:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:22 INFO - 'XPC_FLAGS': '0x0', 04:12:22 INFO - 'XPC_SERVICE_NAME': '0', 04:12:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:22 INFO - Downloading/unpacking blobuploader==1.2.4 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12: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 04:12:25 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:26 INFO - Downloading docopt-0.6.1.tar.gz 04:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:26 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:26 INFO - Running setup.py install for blobuploader 04:12:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:26 INFO - Running setup.py install for requests 04:12:27 INFO - Running setup.py install for docopt 04:12:27 INFO - Successfully installed blobuploader requests docopt 04:12:27 INFO - Cleaning up... 04:12:27 INFO - Return code: 0 04:12:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:27 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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:27 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 04:12:27 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 04:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:27 INFO - 'HOME': '/Users/cltbld', 04:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:27 INFO - 'LOGNAME': 'cltbld', 04:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:27 INFO - 'MOZ_NO_REMOTE': '1', 04:12:27 INFO - 'NO_EM_RESTART': '1', 04:12:27 INFO - 'PAGER': '/bin/cat', 04:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:27 INFO - 'PWD': '/builds/slave/test', 04:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:27 INFO - 'SHELL': '/bin/bash', 04:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:27 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:27 INFO - 'USER': 'cltbld', 04:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:27 INFO - 'XPC_FLAGS': '0x0', 04:12:27 INFO - 'XPC_SERVICE_NAME': '0', 04:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:27 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-pO4qqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:27 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-m9Xo8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:27 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-FlElO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-OaFagc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-G_QqHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-H9NFLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-cW3gY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-DN2Jxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-RICj2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-nwjDUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-28SMm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-MfwSI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:28 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-vclAdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:29 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-UGekvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:29 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-U7dGus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:29 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-5zOKNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:29 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-F6Euqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:29 INFO - Running setup.py install for manifestparser 04:12:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:29 INFO - Running setup.py install for mozcrash 04:12:29 INFO - Running setup.py install for mozdebug 04:12:29 INFO - Running setup.py install for mozdevice 04:12:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Running setup.py install for mozfile 04:12:30 INFO - Running setup.py install for mozhttpd 04:12:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Running setup.py install for mozinfo 04:12:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Running setup.py install for mozInstall 04:12:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Running setup.py install for mozleak 04:12:30 INFO - Running setup.py install for mozlog 04:12:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:30 INFO - Running setup.py install for moznetwork 04:12:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:31 INFO - Running setup.py install for mozprocess 04:12:31 INFO - Running setup.py install for mozprofile 04:12:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:31 INFO - Running setup.py install for mozrunner 04:12:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:31 INFO - Running setup.py install for mozscreenshot 04:12:31 INFO - Running setup.py install for moztest 04:12:31 INFO - Running setup.py install for mozversion 04:12:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:32 INFO - Cleaning up... 04:12:32 INFO - Return code: 0 04:12:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:32 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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:32 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 04:12:32 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 04:12:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:32 INFO - 'HOME': '/Users/cltbld', 04:12:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:32 INFO - 'LOGNAME': 'cltbld', 04:12:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:32 INFO - 'MOZ_NO_REMOTE': '1', 04:12:32 INFO - 'NO_EM_RESTART': '1', 04:12:32 INFO - 'PAGER': '/bin/cat', 04:12:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:32 INFO - 'PWD': '/builds/slave/test', 04:12:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:32 INFO - 'SHELL': '/bin/bash', 04:12:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:32 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:32 INFO - 'USER': 'cltbld', 04:12:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:32 INFO - 'XPC_FLAGS': '0x0', 04:12:32 INFO - 'XPC_SERVICE_NAME': '0', 04:12:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-0eSXDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:32 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)) 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-2ZuP2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:32 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)) 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-X3b2g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:32 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)) 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-gnXzBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:32 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)) 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-OmKufI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:32 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)) 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Yv9U0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:32 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)) 04:12:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:32 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-pH8YeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-slYVTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-UUyDom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-y0tMHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-DSR0Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-46bQtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Vbl4NV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-2OjU25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-HjaIgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:33 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)) 04:12:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:33 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-HFFc0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:34 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)) 04:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:34 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-HywQEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:34 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)) 04:12:34 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)) 04:12:34 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)) 04:12:34 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)) 04:12:34 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)) 04:12:34 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)) 04:12:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:12:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:12:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:12:36 INFO - Downloading blessings-1.6.tar.gz 04:12:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:12:36 INFO - Installing collected packages: blessings 04:12:36 INFO - Running setup.py install for blessings 04:12:36 INFO - Successfully installed blessings 04:12:36 INFO - Cleaning up... 04:12:37 INFO - Return code: 0 04:12:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:37 INFO - Reading from file tmpfile_stdout 04:12:37 INFO - Current package versions: 04:12:37 INFO - blessings == 1.6 04:12:37 INFO - blobuploader == 1.2.4 04:12:37 INFO - docopt == 0.6.1 04:12:37 INFO - functools32 == 3.2.3-2 04:12:37 INFO - jsonschema == 2.5.1 04:12:37 INFO - manifestparser == 1.1 04:12:37 INFO - mozInstall == 1.12 04:12:37 INFO - mozcrash == 0.17 04:12:37 INFO - mozdebug == 0.1 04:12:37 INFO - mozdevice == 0.48 04:12:37 INFO - mozfile == 1.2 04:12:37 INFO - mozhttpd == 0.7 04:12:37 INFO - mozinfo == 0.9 04:12:37 INFO - mozleak == 0.1 04:12:37 INFO - mozlog == 3.4 04:12:37 INFO - moznetwork == 0.27 04:12:37 INFO - mozprocess == 0.23 04:12:37 INFO - mozprofile == 0.28 04:12:37 INFO - mozrunner == 6.12 04:12:37 INFO - mozscreenshot == 0.1 04:12:37 INFO - mozsystemmonitor == 0.3 04:12:37 INFO - moztest == 0.7 04:12:37 INFO - mozversion == 1.4 04:12:37 INFO - psutil == 3.1.1 04:12:37 INFO - requests == 1.2.3 04:12:37 INFO - wsgiref == 0.1.2 04:12:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:37 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 04:12:37 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 04:12:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:37 INFO - 'HOME': '/Users/cltbld', 04:12:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:37 INFO - 'LOGNAME': 'cltbld', 04:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:37 INFO - 'MOZ_NO_REMOTE': '1', 04:12:37 INFO - 'NO_EM_RESTART': '1', 04:12:37 INFO - 'PAGER': '/bin/cat', 04:12:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:37 INFO - 'PWD': '/builds/slave/test', 04:12:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:37 INFO - 'SHELL': '/bin/bash', 04:12:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:37 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:37 INFO - 'USER': 'cltbld', 04:12:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:37 INFO - 'XPC_FLAGS': '0x0', 04:12:37 INFO - 'XPC_SERVICE_NAME': '0', 04:12:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 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)) 04:12:37 INFO - Cleaning up... 04:12:37 INFO - Return code: 0 04:12:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:12:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:37 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 0x109b28490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109a9e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fceb358a340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, '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.tKAaECYMed/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.kjLeoHM8VC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 04:12:37 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 04:12:37 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 04:12:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:12:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:12:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:12:37 INFO - 'HOME': '/Users/cltbld', 04:12:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:12:37 INFO - 'LOGNAME': 'cltbld', 04:12:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:37 INFO - 'MOZ_NO_REMOTE': '1', 04:12:37 INFO - 'NO_EM_RESTART': '1', 04:12:37 INFO - 'PAGER': '/bin/cat', 04:12:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:12:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:37 INFO - 'PWD': '/builds/slave/test', 04:12:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:12:37 INFO - 'SHELL': '/bin/bash', 04:12:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:12:37 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:12:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:12:37 INFO - 'USER': 'cltbld', 04:12:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:12:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:12:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:37 INFO - 'XPC_FLAGS': '0x0', 04:12:37 INFO - 'XPC_SERVICE_NAME': '0', 04:12:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:12:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:12:37 INFO - Cleaning up... 04:12:37 INFO - Return code: 0 04:12:37 INFO - Running post-action listener: _resource_record_post_action 04:12:37 INFO - Running post-action listener: _start_resource_monitoring 04:12:37 INFO - Starting resource monitoring. 04:12:37 INFO - [mozharness: 2016-09-30 11:12:37.834921Z] Finished create-virtualenv step (success) 04:12:37 INFO - [mozharness: 2016-09-30 11:12:37.836027Z] Running install step. 04:12:37 INFO - Running pre-action listener: _resource_record_pre_action 04:12:37 INFO - Running main action method: install 04:12:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:12:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:12:38 INFO - Reading from file tmpfile_stdout 04:12:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:12:38 INFO - Reading from file tmpfile_stdout 04:12:38 INFO - Output received: 04:12:38 INFO - Usage: mozinstall [options] installer 04:12:38 INFO - Options: 04:12:38 INFO - -h, --help show this help message and exit 04:12:38 INFO - -d DEST, --destination=DEST 04:12:38 INFO - Directory to install application into. [default: 04:12:38 INFO - "/builds/slave/test"] 04:12:38 INFO - --app=APP Application being installed. [default: firefox] 04:12:38 INFO - mkdir: /builds/slave/test/build/application 04:12:38 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'] 04:12:38 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 04:13:12 INFO - Reading from file tmpfile_stdout 04:13:12 INFO - Output received: 04:13:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:13:12 INFO - Running post-action listener: _resource_record_post_action 04:13:12 INFO - [mozharness: 2016-09-30 11:13:12.076950Z] Finished install step (success) 04:13:12 INFO - [mozharness: 2016-09-30 11:13:12.077086Z] Running run-tests step. 04:13:12 INFO - Running pre-action listener: _resource_record_pre_action 04:13:12 INFO - Running main action method: run_tests 04:13:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:13:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:13:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:13:12 INFO - 2016-09-30 04:13:12.091 screenresolution[2240:26590] starting screenresolution argv=screenresolution get 04:13:12 INFO - 2016-09-30 04:13:12.094 screenresolution[2240:26590] Display 0: 1600x1200x32@60 04:13:12 INFO - 2016-09-30 04:13:12.100 screenresolution[2241:26592] starting screenresolution argv=screenresolution list 04:13:12 INFO - Available Modes on Display 0 04:13:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:13:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:13:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:13:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:13:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:13:12 INFO - Intel Iris: 04:13:12 INFO - Chipset Model: Intel Iris 04:13:12 INFO - Type: GPU 04:13:12 INFO - Bus: Built-In 04:13:12 INFO - VRAM (Dynamic, Max): 1536 MB 04:13:12 INFO - Vendor: Intel (0x8086) 04:13:12 INFO - Device ID: 0x0a2e 04:13:12 INFO - Revision ID: 0x0009 04:13:12 INFO - Displays: 04:13:12 INFO - Display: 04:13:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:13:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:13:12 INFO - Display Serial Number: 1600x1200 60 04:13:12 INFO - Main Display: Yes 04:13:12 INFO - Mirror: Off 04:13:12 INFO - Online: Yes 04:13:12 INFO - Rotation: Supported 04:13:12 INFO - Return code: 0 04:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:12 INFO - Python 2.7.3 04:13:12 INFO - Return code: 0 04:13:12 INFO - grabbing minidump binary from tooltool 04:13:12 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')]} 04:13:12 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 0x10993cd30>, '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 0x109762db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109934b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:12 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 04:13:12 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 04:13:12 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 04:13:12 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:12 INFO - Return code: 0 04:13:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:13:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:13:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:12 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/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 04:13:12 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/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --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 04:13:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tKAaECYMed/Render', 04:13:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:13:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:13:12 INFO - 'HOME': '/Users/cltbld', 04:13:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:13:12 INFO - 'LOGNAME': 'cltbld', 04:13:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:12 INFO - 'MOZ_NO_REMOTE': '1', 04:13:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:12 INFO - 'NO_EM_RESTART': '1', 04:13:12 INFO - 'PAGER': '/bin/cat', 04:13:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:12 INFO - 'PWD': '/builds/slave/test', 04:13:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:13:12 INFO - 'SHELL': '/bin/bash', 04:13:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kjLeoHM8VC/Listeners', 04:13:12 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 04:13:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:13:12 INFO - 'USER': 'cltbld', 04:13:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:13:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:12 INFO - 'XPC_FLAGS': '0x0', 04:13:12 INFO - 'XPC_SERVICE_NAME': '0', 04:13:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:13:12 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/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--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 04:13:12 INFO - mozversion application_buildid: 20160930020447 04:13:12 INFO - mozversion application_changeset: 7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6 04:13:12 INFO - mozversion application_display_name: Nightly 04:13:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:12 INFO - mozversion application_name: Firefox 04:13:12 INFO - mozversion application_remotingname: firefox 04:13:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:13:12 INFO - mozversion application_vendor: Mozilla 04:13:12 INFO - mozversion application_version: 52.0a1 04:13:12 INFO - mozversion platform_buildid: 20160930020447 04:13:12 INFO - mozversion platform_changeset: 7f9e6e421e24f20ac3ac8b80fe875af7c37e36d6 04:13:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:13:12 INFO - mozversion platform_version: 52.0a1 04:13:12 INFO - using testdate: 1475233992 04:13:12 INFO - actual date: 1475233992 04:13:12 INFO - starting webserver on 'localhost:54509' 04:13:12 INFO - SUITE-START | Running 2 tests 04:13:12 INFO - TEST-START | dromaeo_css 04:13:12 INFO - operating with platform_type : mac_ 04:13:12 INFO - Initialising browser for dromaeo_css test... 04:13:12 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpq_NCRG/profile http://localhost:54509/getInfo.html) 04:13:15 INFO - PROCESS | 2251 | __metrics Screen width/height:1600/1200 04:13:15 INFO - PROCESS | 2251 | colorDepth:24 04:13:15 INFO - PROCESS | 2251 | Browser inner width/height: 1024/689 04:13:15 INFO - PROCESS | 2251 | __metrics 04:13:15 INFO - PROCESS | 2251 | 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" 04:13:15 INFO - PROCESS | 2251 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:13:15 INFO - TEST-INFO | 2251: exit 0 04:13:15 INFO - Browser initialized. 04:13:15 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:15 INFO - TEST-INFO | started process 2253 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpq_NCRG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:27 INFO - PROCESS | 2253 | RSS: Main: 236142592 04:13:27 INFO - PROCESS | 2253 | 04:14:19 INFO - PROCESS | 2253 | 1475234059756 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] 04:16:30 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:54509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54509/tests/dromaeo/cssquery-ext.html) 04:16:32 INFO - PROCESS | 2253 | RSS: Main: 327409664 04:16:32 INFO - PROCESS | 2253 | 04:19:35 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:54509/tests/dromaeo/cssquery-ext.html (next: http://localhost:54509/tests/dromaeo/cssquery-jquery.html) 04:19:36 INFO - PROCESS | 2253 | RSS: Main: 372473856 04:19:36 INFO - PROCESS | 2253 | 04:22:38 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:54509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54509/tests/dromaeo/cssquery-mootools.html) 04:22:39 INFO - PROCESS | 2253 | RSS: Main: 340041728 04:22:39 INFO - PROCESS | 2253 | 04:25:41 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:54509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54509/tests/dromaeo/cssquery-prototype.html) 04:25:42 INFO - PROCESS | 2253 | RSS: Main: 341651456 04:25:42 INFO - PROCESS | 2253 | 04:28:45 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:54509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54509/tests/dromaeo/cssquery-yui.html) 04:28:46 INFO - PROCESS | 2253 | RSS: Main: 327991296 04:28:46 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | Cycle 1(1): loaded http://localhost:54509/tests/dromaeo/cssquery-yui.html (next: http://localhost:54509/tests/dromaeo/cssquery-dojo.html) 04:31:49 INFO - PROCESS | 2253 | RSS: Main: 448524288 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | __start_tp_report 04:31:49 INFO - PROCESS | 2253 | _x_x_mozilla_page_load 04:31:49 INFO - PROCESS | 2253 | _x_x_mozilla_page_load_details 04:31:49 INFO - PROCESS | 2253 | |i|pagename|runs| 04:31:49 INFO - PROCESS | 2253 | |0;dojo.html;3283.4746440569515;3296.324253528027;3323.2522682396466;3340.8162551059713;3368.5620869287004;5577.274954255941;5639;5668.348139963905;5702.1446782982575;5734.59857809953;5617.691026993513;5645.01212287849;5727.455891690293;5731.942680573193;5743.5118014968675;5031.144705400091;5076.720780357097;5136.306598609177;5165.405978312486;5174.715390653512;5248.632595718302;5265;5270.393904700951;5279.9208011879855;5312.840614781543;5222.712750798704;5256.553192978601;5279.762410691509;5279.868003299929;5338.199270109476;5109.41241757199;5114.948850511521;5139.357580302462;5160.458151894035;5182.144946083891;4403.251447253942;5101.183810590288;5101.4133374662015;5117.283580298761;5124.743762811844;5678.687672178028;5685.744141513601;5699.971500142473;5709.800156994527;5716.971415142939;6045.6674882881425;6085.817425477243;6097.359777223416;6203.627782333075;6241.65670888101;5713.657180569179;6198.2252218472695;6264.5301602380005;6288.151099601541;6291.1192433059405;5731.197632331477;5747.913781293284;5751.798687046017;5752.942470575241;5763.452472015152;6122.794608434074;6184.257889053342;6237.594556353823;6275.5920865144535;6286.5599408041;6043.8186854394435;6097.603655762361;6102.458955353584;6106.053561697944;6116.241443683883;6215.751369945242;6224.1597384352535;6229.314775374705;6229.688515574203;6247.437730604267;5958.314793798682;6096.085587161872;6170.444659980533;6180.443760061616;6182.474489668339;6101.023836186189;6101.55020674385;6128.632282063001;6129.419919118773;6156.753729850845;4891.241857512091;4897.975510122498;4898.97962726875;4905.656604037755;4937.753112344369;4373.125374925028;4398.054418300081;4400.1199760047475;4412.558744125626;4415.779211039435;5417.5395091416885;5457.727113644302;5598.804041858515;5600.991821472093;5651.858703532444;4332.458442694663;5908.940910590839;5918.348981612019;5955.40445955401;5967.492763115184;5431.864203394946;5480.945190548044;5485.753141108659;5491.478309560585;5500.22996780451;5175.14610089331;5187.170052791535;5215.556677682363;5260.789568417221;5314.468553144655;6196.907046394217;6214.1921550198185;6259.34276900937;6272.96496078142;6307.3377295383325;6218.06728990655;6239.532035097295;6241.344658810941;6242.188515493139;6256.061590761422;6284.183056202664;6294.4964402846745;6303.558750887577;6320.652364120017;6385.489160867027;5963.4334738199805;5965.045592705146;6015.939840601538;6029.246344206974;6043.7884674036195;5193.221016847352;6131.296552205906;6139.0321984548755;6146.569740118149;6150.876982460236;5945.554083443845;5950.077737950624;5959.195508606283;5967.433093856077;5968.70156492165;5784.768609255751;5803.274590676166;5877.970610147093;5947.464728174485;5955.731992060454;5780.826575202751;5788.189653448437;5812.447817457335;5854.590178687621;5902.4097590240635;4703.6942598730975;5886.470217680258;5892.322382926019;5990.610610310316;6011.87976240464;5769.192313076089;5769.884602308014;5784.161296612052;5793.36273009977;5823.242978412779 04:31:49 INFO - PROCESS | 2253 | |1;ext.html;462.9513901040391;497.2491537777954;497.36089125473774;504.8640558742829;528.6484487815604;39491.40762888559;40143;42116.368254476205;43756.56243437572;43796.905077373085;42226.57773422265;42706.65113418761;42731;42745;42802;8783.429077109968;9027.864582031274;9827.410355378683;10031.799364012715;10032.59869605215;8877.20105190536;8961.641534338618;8992.190702836744;12010.939945300304;12358;12237.20458170216;12316.81524777129;12317.260964342124;12322.01423886087;12334.198277112004;12199.695007624792;12274.509019639203;12281.017518598535;12289.385530723517;12294.077944154134;11948.342841143734;12018.699532511757;12036.277823330629;12050.97566706831;12078.69803254917;39700.60299396998;39889.40165897514;40057.39913901294;40081;40126.39810402846;3129.4836352001894;3232.046546268856;3285.720713739311;3653.488511608377;4029.3351596986463;30012.69987300121;31301.686983130334;31313.06060818179;31343;31374.37251254985;3282;3340.315235376742;3377.4427219508752;3403.0981789825714;3414;465533;465627;465734;466187;470363;57799.13301300484;58276.4172358271;58328;58340.416595834344;58393.4160658388;60629;60683.69658151681;60704.089438658455;60753.190787336476;60848.39151608427;14018.088824226392;15148.772768408482;16000.679986400439;16012.199390030451;16035.759463608056;12396.566120185931;12460.252384856938;12466.252024878537;12471.875281247072;12500.187487813444;13992.440302387791;14277;14295.428182872569;15567.922160389126;15970.76043859343;4912.543728135932;5624.325080990226;6153.015517517176;6320.399562041599;6323.9683801580695;817.4972391979009;834.9499030058216;955.527014128011;996.940183588987;1018.271935566059;28533.44840756122;28705.56941645877;28927.710722892924;29349.266268343035;29375.97184098546;1001.8998100190068;1025.6102680981328;1045.0176833776377;1068.5725709716176;1110.5335758981087;13027.413766380536;14049.22729249901;14958.326875290639;15243.085414875142;15277.465288714842;587316;593377;594149;594546;597804;48380;49000.77498062577;54895.72552137214;55215;55615.72192139094;1296.1056870759146;1341.5438750824767;1341.704824938512;1346.9461221551421;1350.6690860739182;29948.70051299459;30135.246618833826;30300.848495758262;30433.23916902095;30691.539626905167;48743.26885096655;49152.26271606;49179;49241;49282.01435971189;584899.7365303044;637512;645968;658791.412085873;827024;20725.689114663594;25021.624675629515;25219.74780252174;25521.61717574201;25539.489210216063;46799.53200468088;46848.765756171;47009.764951176396;47940.7602961983;49110;39077.21845563016;39102.80448597739;39103.608963909996;39178.824635260986;40634;38757.612423876526;39522;39822;40319.1936161281;40668.389974151;37645.62354376531;38483;38585.8424247273;38649.22701545897;38693.613063869;32032;33768.324633507684;34120.65879341175;34169.829150854086;34630.13424664403;25085.372865678502;25274;25311.987520498973;25415.596903220485;25652.486950260518 04:31:49 INFO - PROCESS | 2253 | |2;jquery.html;310.76692480639537;336.61625746648826;348.36075800905337;368.4675643694861;385.7280617164899;12591.685207869796;15982;18735;19660.508487287825;20747.481312967182;16560.83439165608;19824.306149284777;21259.68110478344;21349.35951921445;21405.14379424821;5589.692566908829;6033.27600687918;6105.450509454148;6121.387861213888;6122.755089796425;4105.9178816423655;4139.668826493873;6010.308814486346;6110.175126357952;6129;6652.93347066528;6748.190217173921;6755.763548275811;6757.526973111884;6769.356911093439;6428.967855160741;6681.331866813329;6725.831854203635;6728.966355168217;6735.158105236846;5602.60781745278;5818.505427038707;5827.271591051119;5828.41715828418;5837.211976383219;25930.740692593023;26372;26388;26522.602160967603;26693.733062669515;2391.1033362489065;2567.422329975759;2607.6610040694777;2776.1671498550354;2867.6702179249446;11955.282683039046;15215.087094774239;15476.613084672861;15656.921715391463;16083.839161608468;1726.2577091850499;1816.1010299901502;1856.071964017991;1894.1571000904603;1936.5158710322419;121874.39062804719;122108;122714;125722;126292.73707262901;10131.504630902327;10723.088537474401;10822.94364070824;11007.229493935347;11034.503447344729;13614.659633509043;13671.931640341734;13672.111312764639;13687.863121368659;13690;8105.392095592854;8343.08226095129;8354.331653467709;8502.0222674392;8507.27688146502;7006.649667516705;8017.398695097891;8317.41778075529;8372.790680232922;8524.318054555744;5392.56859451243;6575.276719560845;6576.934230657728;6579.2104947406615;6584.144061272004;1644.1696943043926;1650.5873531617096;1687.3419366447094;1769.1242834796858;1806.3226290141197;773.6905237904771;846.9957650211833;887.662688178488;926.8934072581604;1065.984010239847;20271.898640507;20948.685769713466;22490.66264006041;22507;22631.43421414445;911.7948461596088;917.7797328641211;934.9392289501161;948.8292107420592;960.3805545423163;11286.266392684449;11642.825357619642;11782.351970641697;11806.409679516162;11908.345041022654;593451;606640;606671;607242;608766;69465;70495;90680;119852;125021;899.6536333511646;905.6739573753443;905.9773505662412;911.8221946720325;936.0826390137703;14620.780688289897;19743;20033.79966200319;20076;20087.899560502105;53903.87913148245;54233.72883135559;54502.72748636232;54521.454785451635;54613.45386546083;75699;76317.23682763102;76548;76759.61620191863;77162;7935.761927142195;7991.520508769492;8073.717419890276;8129;8191.877121843297;13243.139195952232;13379.53171638988;13460.798088028492;13785.793213101611;13819;11641;11732;11779.823302650639;11882.405879706153;11898.464569094585;10384.844227336747;10653.840192396965;11418.972292493716;11823.70440738954;11858.347790871585;11268.830967535658;11662.825057624312;11771.293722376684;11807.760185180432;12100.757984840078;7840.686372545034;7942.570337339334;8080.595970201584;8115.391345648982;8264.752057438287;9748.9025109748;11211.60759373418;11800.291982481078;11832.46753896094;11944.402779860799 04:31:49 INFO - PROCESS | 2253 | |3;mootools.html;1357.5723647051177;1557.852004059614;1728.7493313469547;1891.6973284274518;1912.9043547822614;7976.561289129096;8281.83436331273;8588.484690918549;8990.056044115372;9002.729918102468;8133.389995750313;8604.698835540757;8797.07630698777;8812.60343284552;8929.241014513775;2144.8498605097648;2372.90508379665;2406.3142004528713;2407.145463360508;2409.5542324669905;2081.750189977205;2311.6185829338137;2346.530693861226;2405.1461731085474;2406.578848701479;2155.7628660847295;2281.532285881399;2363.078399424226;2366.077229880348;2366.1127077345996;2352.8235382346393;2368.100121953655;2375.845570037942;2376.489054853215;2377.215518878766;2363;2363.72817126031;2365.66880636711;2368;2368.2303251443177;8888.955555222246;8966.820663586757;8967;8970.327225458052;8981.05698901619;5168.8449346519665;5209.765560549784;5266.973665131688;5271.578273738091;5279.392869819982;3475.4091804393315;3532.2229109595846;3674.5590529136407;3678.9632103678887;3685.7972811495356;954.5942974235921;1054.230411799383;1090.2150451674781;1092;1112.9332240065542;11536.596219132374;11678.065754739686;11678.182527223098;11678.416079196091;11700.590479333183;4483.30508771141;4578.587927086578;4748.62011039123;4757.904841903142;4786.44955830077;9909.256805739598;9910.801783964425;9912.752181195383;9914.80170396588;9931.751706207402;5341.839744807662;5348.171033489815;5348.598855085884;5350.170723537858;5354.116570765858;4764.118638051971;4791;4810.8797280068275;4823.059503396804;4860.781264843091;3828.655421012122;3830.291396091732;3887.1642596841248;3924.274009308287;3925.468073092839;1177.2171505948447;1272.5164437513686;1274.0571976737333;1278.3799857069314;1291.8578956314798;769.9076110866732;784.7606480023647;813.0609146435876;835.6949713354581;857.1557016338901;5656.434356564393;5842.883142337129;5924.851878702981;6065.514758819284;6163.599366041193;941.1576638908139;947.5830634520789;950.2587981374539;958.6836344006462;1012.1396812709138;3270.280538281574;3891.0235061959174;3994.141259629194;4029.9395509067385;4068.3694027425795;10173.643922462677;10547.736306592396;10711.892881071246;10722.946385268024;10905.34567925927;10864.402457864735;10873.40196289196;10879.673609791718;10881.292715973437;10882.564697412015;8093.231143041402;8283.875741863876;8297.294729947902;8312.21034001769;8319.66721331152;5698.886022279614;5907.734151963086;6067.24159480065;6100.786472473442;6128.816135515942;9872.210223182272;10103.444310562989;10125;10136.290459667753;10153.695389138338;9719.514024298898;10084.64703735395;10094.192464602667;10240;10266.691999239736;7450.739224127129;7607.429442791702;7608.733694320672;7611;7619.314261716472;7752.26353496417;8136.918630813616;8163.1428699985645;8175.83648327042;8224.753257402288;6043.244594425697;7257.237990011184;7406.518576292524;7506.13679426851;7517.962410187914;7371.8157046074275;7390.815229619087;7405.925940740739;7427.628618568941;7462.4776265660885;5592.636478628876;6949.930500694928;6968.198657154492;7020.297970202939;7020.7542736004;4916;4953.603711703127;4993.825216117419;5080.288759573737;5205.869853253699;4916.188828843201;4923.433805112458;4931.926021109614;5001.774920128676;5032.597392208541 04:31:49 INFO - PROCESS | 2253 | |4;prototype.html;274.6703955253696;296.3110767465643;298.5000124790975;306.7408040206025;310.91449851290895;4536.614387777035;4717.174494463468;5245.554127899133;5267.736613169341;5314.627976041674;3787.0343062519087;4617.245446730238;4788.545088216622;4900.632452566063;5133.281340612308;3875.3218186817335;4073.6130067643676;4078.6125318094732;4095.365218391154;4096.446979657752;3769.2649933263024;4088.2641124597562;4096.774677392742;4107.952472119605;4118.97940510297;3308.4210263203963;3935.940960885589;3946.52641682997;3959.148783011652;3980.2437536868047;3314.342828585707;3940.8423663053445;3953.5255769307723;3954.228925359556;3991.5409727881083;3441.5525981622227;3449.6025262442613;3456.948145777815;3461.152017755641;3467.323871844991;3992.4210989406665;4517.599544141294;4831.492693267227;5111.565516931066;5129.281900533928;3939.9015024624327;4235.941014746313;4414.646828253732;4507.506682321195;4551.110045121339;4523.7285762854335;4981.476944920767;5016.3227964224725;5045.041442125985;5497.065498865202;3500.842462089212;3782.924341513154;3784.7539909905768;3788.488554045196;3794.829232684536;5031.371078615173;5699.458551437607;5779.3642699303045;5797.652140871562;5845.85385365365;3804.8287827047848;3834.9424758628643;3843.385058390644;3848.8652897149027;3863.265979463893;3437.5187473753695;3690.8708195213576;3929.4891664083484;3937.2322397132857;3937.310970580137;3761.9059523511582;4191.350340697197;4265.616094551443;4346.239408103569;4530.682852200314;5575.33096028471;5592.273004509388;5610.803621873215;5616.634918730269;5620.57845661577;1093.8413929980109;1280.9487620495263;1289.8000809874484;1293.1852932652369;1317.5981325695564;832.7793134819278;837.0290463062818;855.9058503564603;859.1837754133473;890.6660002499062;4765.833195838199;5035.8669299408075;5163.573120633297;5210.296609957683;5220.216967454912;4779;5515.297504222902;5618.634788738719;5692.459216374438;5698.572607054488;4303.526612072669;4663.883402914954;5096.898062038813;5122.334096567497;5124.052050370693;2895.826250424981;2929.721676440735;2932.5161348377706;2939.6619388770564;2951.7638588912837;5596.944030559724;5747.712614369265;5793.478586927196;5814.563907706939;5834.416558344216;4550.635949124062;5692.089265717465;5708.771649133988;5743.885122297531;5766;4844.539768721966;5211.973940130275;5805.7387417566315;5822.505087067647;5865.237519122486;3972.9404058939717;4892.535209155125;5606;5624.762552238501;5757.280339957505;4712.929306060343;5096.337476128079;5208.062548741263;5654.604177707521;5655.349634791887;4815.3499277597075;5905.881882362414;5934.851628709317;5953.743073702323;5966.463018328372;3222.5971753530807;3917.941230881482;3990.561038285728;4001.2797696414923;4061.878143655695;5148.825430442382;5651.96529249478;5652.095664693629;5671.801486948102;5679.630823996427;5215.400228973716;5502.202180683858;5528.889422211614;5531.285301556531;5542.584306177134;5247.638562646748;5448.591355648421;5485.040117979417;5637.379888212211;5657.5473962082115;5126.461721519336;5330.600204984719;5374.865628359323;5416.729163541886;5574.470425309589;5366.813885169574;5597.776088956559;5604.383517812956;5613.775448982158;5650.519705824887;4551.5676010778925;5218.791248350023;5434.196062756166;5494.230807687007;5512.6692398456225 04:31:49 INFO - PROCESS | 2253 | |5;yui.html;711.6406214861495;770.7263921307936;787.1616728184483;803.2650125135501;852.29259714437;15066.849331506695;15408.61478463039;15787.28957196926;15790.842091579096;15802.525924222278;14354.210518421509;14414.135151890894;14624.780628290584;14660.633484162901;15000.774988375184;849.4266370200106;878.8198419324056;880.1682410122437;880.5509190312922;881.6341218394359;694.930506949306;714.6426786606696;853.2661910756744;885.9734207973739;886.441541828647;938.3619138985487;941.722191953372;941.8540126280403;943.094629156011;943.8584212368131;932.39394393644;933.7385532051037;933.869258303838;935.4434111703525;937.3579098317674;533.7037943941111;551.3631755322609;632.8607706304606;684.7055766020609;686.4748467422426;15253;15269.465568705153;15281.388744450209;15364.846351536453;15382.384704611803;13781.379837907318;14080.92959535206;14143.504977325847;14205.431782728678;14346.78479822793;10954;12725.809112863315;12779;12850.421731022127;12864.614061578168;4521.977390113028;4589.678722489427;4653.069386122789;4660.5339466053465;4673.182193116191;107201;110430;114818.42590787075;115107;115713;11045.613403530839;11165.38590377537;11354.54581816718;11549.36478493691;11660.416979151008;21508.462288442915;22044.779552204593;22257.777422225572;22269.554608907732;22294.21970231034;7932.643031063616;8111.553864537507;8170.673173073129;8240.50556966584;8280.337572994145;4342.804573794187;4467.374567560479;4530.750808705553;4641.466231383367;4658.068386322749;3406.540117084162;3496.4405695088662;3510.262844802569;3525.823708814549;3528.9117772055392;579.1688926390559;614.5698011391954;643.8969764837603;656.2420404432887;677.109600874848;505.84066019203834;551.0769461152554;594.8483136800088;625.9874802503924;645.686841881687;7108.395786358217;8658.220760131619;8898.555072246361;8970.68602598919;9048.547572621343;511.88482591416636;621.201755743876;624.6470744029699;633.9049142628643;655.4788942790493;4427.817250823637;4575.565321294472;4583.197940360424;4586.105709386704;4819.831305904277;131118.3776324487;148561;148662;152751;154573;126318;127793;128489;134111.32944335215;138104.23791524113;112404;113115.99999999836;113423;115067.42466287782;117023;9105.229051393357;9173.77065573366;9226.907730922605;9235.26117910579;9486.620535178792;61107;61448;61668.38331616626;61875.381246188765;63751;83566.16433835827;90208.5489572548;94059.05940940777;95707;97628.67784916017;11700.88299117032;11739.79332542764;11958.58144964922;12179.147459678092;12391.566295179986;12936.482540698267;13201.867981320063;13213.339333033118;13663.931680341535;13917.443302267797;12045.33750643688;12352.135350525377;12402.75194496087;12485.875141248835;12800.6799830005;11629.302241865515;11990;12233.388330583613;12345.012399008237;12776.233425994471;11875.762484750085;12877.420516076612;13520.526781562598;13771.380287886868;13967.511137110152;10888.727781805519;10982.395968221505;11310.660680179608;11334.829977550178;11479.942600286946;9859.654912078044;10955.890441095806;11144.554217831195;11262.549498019987;11698 04:31:49 INFO - PROCESS | 2253 | __end_tp_report 04:31:49 INFO - PROCESS | 2253 | __start_cc_report 04:31:49 INFO - PROCESS | 2253 | _x_x_mozilla_cycle_collect,1824 04:31:49 INFO - PROCESS | 2253 | __end_cc_report 04:31:49 INFO - PROCESS | 2253 | __startTimestamp1475235109467__endTimestamp 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | ------- Summary: start ------- 04:31:49 INFO - PROCESS | 2253 | Number of tests: 6 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | [#0] dojo.html Cycles:165 Average:5638.22 Median:5784.16 stddev:638.96 (11.0%) stddev-sans-first:613.63 04:31:49 INFO - PROCESS | 2253 | Values: 3283.5 3296.3 3323.3 3340.8 3368.6 5577.3 5639.0 5668.3 5702.1 5734.6 5617.7 5645.0 5727.5 5731.9 5743.5 5031.1 5076.7 5136.3 5165.4 5174.7 5248.6 5265.0 5270.4 5279.9 5312.8 5222.7 5256.6 5279.8 5279.9 5338.2 5109.4 5114.9 5139.4 5160.5 5182.1 4403.3 5101.2 5101.4 5117.3 5124.7 5678.7 5685.7 5700.0 5709.8 5717.0 6045.7 6085.8 6097.4 6203.6 6241.7 5713.7 6198.2 6264.5 6288.2 6291.1 5731.2 5747.9 5751.8 5752.9 5763.5 6122.8 6184.3 6237.6 6275.6 6286.6 6043.8 6097.6 6102.5 6106.1 6116.2 6215.8 6224.2 6229.3 6229.7 6247.4 5958.3 6096.1 6170.4 6180.4 6182.5 6101.0 6101.6 6128.6 6129.4 6156.8 4891.2 4898.0 4899.0 4905.7 4937.8 4373.1 4398.1 4400.1 4412.6 4415.8 5417.5 5457.7 5598.8 5601.0 5651.9 4332.5 5908.9 5918.3 5955.4 5967.5 5431.9 5480.9 5485.8 5491.5 5500.2 5175.1 5187.2 5215.6 5260.8 5314.5 6196.9 6214.2 6259.3 6273.0 6307.3 6218.1 6239.5 6241.3 6242.2 6256.1 6284.2 6294.5 6303.6 6320.7 6385.5 5963.4 5965.0 6015.9 6029.2 6043.8 5193.2 6131.3 6139.0 6146.6 6150.9 5945.6 5950.1 5959.2 5967.4 5968.7 5784.8 5803.3 5878.0 5947.5 5955.7 5780.8 5788.2 5812.4 5854.6 5902.4 4703.7 5886.5 5892.3 5990.6 6011.9 5769.2 5769.9 5784.2 5793.4 5823.2 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | [#1] ext.html Cycles:180 Average:70702.47 Median:38534.42 stddev:156581.56 (406.3%) stddev-sans-first:156932.01 04:31:49 INFO - PROCESS | 2253 | Values: 463.0 497.2 497.4 504.9 528.6 39491.4 40143.0 42116.4 43756.6 43796.9 42226.6 42706.7 42731.0 42745.0 42802.0 8783.4 9027.9 9827.4 10031.8 10032.6 8877.2 8961.6 8992.2 12010.9 12358.0 12237.2 12316.8 12317.3 12322.0 12334.2 12199.7 12274.5 12281.0 12289.4 12294.1 11948.3 12018.7 12036.3 12051.0 12078.7 39700.6 39889.4 40057.4 40081.0 40126.4 3129.5 3232.0 3285.7 3653.5 4029.3 30012.7 31301.7 31313.1 31343.0 31374.4 3282.0 3340.3 3377.4 3403.1 3414.0 465533.0 465627.0 465734.0 466187.0 470363.0 57799.1 58276.4 58328.0 58340.4 58393.4 60629.0 60683.7 60704.1 60753.2 60848.4 14018.1 15148.8 16000.7 16012.2 16035.8 12396.6 12460.3 12466.3 12471.9 12500.2 13992.4 14277.0 14295.4 15567.9 15970.8 4912.5 5624.3 6153.0 6320.4 6324.0 817.5 834.9 955.5 996.9 1018.3 28533.4 28705.6 28927.7 29349.3 29376.0 1001.9 1025.6 1045.0 1068.6 1110.5 13027.4 14049.2 14958.3 15243.1 15277.5 587316.0 593377.0 594149.0 594546.0 597804.0 48380.0 49000.8 54895.7 55215.0 55615.7 1296.1 1341.5 1341.7 1346.9 1350.7 29948.7 30135.2 30300.8 30433.2 30691.5 48743.3 49152.3 49179.0 49241.0 49282.0 584899.7 637512.0 645968.0 658791.4 827024.0 20725.7 25021.6 25219.7 25521.6 25539.5 46799.5 46848.8 47009.8 47940.8 49110.0 39077.2 39102.8 39103.6 39178.8 40634.0 38757.6 39522.0 39822.0 40319.2 40668.4 37645.6 38483.0 38585.8 38649.2 38693.6 32032.0 33768.3 34120.7 34169.8 34630.1 25085.4 25274.0 25312.0 25415.6 25652.5 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | [#2] jquery.html Cycles:180 Average:34670.23 Median:2821.92 stddev:100294.50 (3554.1%) stddev-sans-first:100542.67 04:31:49 INFO - PROCESS | 2253 | Values: 310.8 336.6 348.4 368.5 385.7 12591.7 15982.0 18735.0 19660.5 20747.5 16560.8 19824.3 21259.7 21349.4 21405.1 5589.7 6033.3 6105.5 6121.4 6122.8 4105.9 4139.7 6010.3 6110.2 6129.0 6652.9 6748.2 6755.8 6757.5 6769.4 6429.0 6681.3 6725.8 6729.0 6735.2 5602.6 5818.5 5827.3 5828.4 5837.2 25930.7 26372.0 26388.0 26522.6 26693.7 2391.1 2567.4 2607.7 2776.2 2867.7 11955.3 15215.1 15476.6 15656.9 16083.8 1726.3 1816.1 1856.1 1894.2 1936.5 121874.4 122108.0 122714.0 125722.0 126292.7 10131.5 10723.1 10822.9 11007.2 11034.5 13614.7 13671.9 13672.1 13687.9 13690.0 8105.4 8343.1 8354.3 8502.0 8507.3 7006.6 8017.4 8317.4 8372.8 8524.3 5392.6 6575.3 6576.9 6579.2 6584.1 1644.2 1650.6 1687.3 1769.1 1806.3 773.7 847.0 887.7 926.9 1066.0 20271.9 20948.7 22490.7 22507.0 22631.4 911.8 917.8 934.9 948.8 960.4 11286.3 11642.8 11782.4 11806.4 11908.3 593451.0 606640.0 606671.0 607242.0 608766.0 69465.0 70495.0 90680.0 119852.0 125021.0 899.7 905.7 906.0 911.8 936.1 14620.8 19743.0 20033.8 20076.0 20087.9 53903.9 54233.7 54502.7 54521.5 54613.5 75699.0 76317.2 76548.0 76759.6 77162.0 7935.8 7991.5 8073.7 8129.0 8191.9 13243.1 13379.5 13460.8 13785.8 13819.0 11641.0 11732.0 11779.8 11882.4 11898.5 10384.8 10653.8 11419.0 11823.7 11858.3 11268.8 11662.8 11771.3 11807.8 12100.8 7840.7 7942.6 8080.6 8115.4 8264.8 9748.9 11211.6 11800.3 11832.5 11944.4 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | [#3] mootools.html Cycles:180 Average:5705.29 Median:4927.68 stddev:3205.00 (65.0%) stddev-sans-first:3197.33 04:31:49 INFO - PROCESS | 2253 | Values: 1357.6 1557.9 1728.7 1891.7 1912.9 7976.6 8281.8 8588.5 8990.1 9002.7 8133.4 8604.7 8797.1 8812.6 8929.2 2144.8 2372.9 2406.3 2407.1 2409.6 2081.8 2311.6 2346.5 2405.1 2406.6 2155.8 2281.5 2363.1 2366.1 2366.1 2352.8 2368.1 2375.8 2376.5 2377.2 2363.0 2363.7 2365.7 2368.0 2368.2 8889.0 8966.8 8967.0 8970.3 8981.1 5168.8 5209.8 5267.0 5271.6 5279.4 3475.4 3532.2 3674.6 3679.0 3685.8 954.6 1054.2 1090.2 1092.0 1112.9 11536.6 11678.1 11678.2 11678.4 11700.6 4483.3 4578.6 4748.6 4757.9 4786.4 9909.3 9910.8 9912.8 9914.8 9931.8 5341.8 5348.2 5348.6 5350.2 5354.1 4764.1 4791.0 4810.9 4823.1 4860.8 3828.7 3830.3 3887.2 3924.3 3925.5 1177.2 1272.5 1274.1 1278.4 1291.9 769.9 784.8 813.1 835.7 857.2 5656.4 5842.9 5924.9 6065.5 6163.6 941.2 947.6 950.3 958.7 1012.1 3270.3 3891.0 3994.1 4029.9 4068.4 10173.6 10547.7 10711.9 10722.9 10905.3 10864.4 10873.4 10879.7 10881.3 10882.6 8093.2 8283.9 8297.3 8312.2 8319.7 5698.9 5907.7 6067.2 6100.8 6128.8 9872.2 10103.4 10125.0 10136.3 10153.7 9719.5 10084.6 10094.2 10240.0 10266.7 7450.7 7607.4 7608.7 7611.0 7619.3 7752.3 8136.9 8163.1 8175.8 8224.8 6043.2 7257.2 7406.5 7506.1 7518.0 7371.8 7390.8 7405.9 7427.6 7462.5 5592.6 6949.9 6968.2 7020.3 7020.8 4916.0 4953.6 4993.8 5080.3 5205.9 4916.2 4923.4 4931.9 5001.8 5032.6 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | [#4] prototype.html Cycles:180 Average:4441.82 Median:4941.05 stddev:1369.85 (27.7%) stddev-sans-first:1337.51 04:31:49 INFO - PROCESS | 2253 | Values: 274.7 296.3 298.5 306.7 310.9 4536.6 4717.2 5245.6 5267.7 5314.6 3787.0 4617.2 4788.5 4900.6 5133.3 3875.3 4073.6 4078.6 4095.4 4096.4 3769.3 4088.3 4096.8 4108.0 4119.0 3308.4 3935.9 3946.5 3959.1 3980.2 3314.3 3940.8 3953.5 3954.2 3991.5 3441.6 3449.6 3456.9 3461.2 3467.3 3992.4 4517.6 4831.5 5111.6 5129.3 3939.9 4235.9 4414.6 4507.5 4551.1 4523.7 4981.5 5016.3 5045.0 5497.1 3500.8 3782.9 3784.8 3788.5 3794.8 5031.4 5699.5 5779.4 5797.7 5845.9 3804.8 3834.9 3843.4 3848.9 3863.3 3437.5 3690.9 3929.5 3937.2 3937.3 3761.9 4191.4 4265.6 4346.2 4530.7 5575.3 5592.3 5610.8 5616.6 5620.6 1093.8 1280.9 1289.8 1293.2 1317.6 832.8 837.0 855.9 859.2 890.7 4765.8 5035.9 5163.6 5210.3 5220.2 4779.0 5515.3 5618.6 5692.5 5698.6 4303.5 4663.9 5096.9 5122.3 5124.1 2895.8 2929.7 2932.5 2939.7 2951.8 5596.9 5747.7 5793.5 5814.6 5834.4 4550.6 5692.1 5708.8 5743.9 5766.0 4844.5 5212.0 5805.7 5822.5 5865.2 3972.9 4892.5 5606.0 5624.8 5757.3 4712.9 5096.3 5208.1 5654.6 5655.3 4815.3 5905.9 5934.9 5953.7 5966.5 3222.6 3917.9 3990.6 4001.3 4061.9 5148.8 5652.0 5652.1 5671.8 5679.6 5215.4 5502.2 5528.9 5531.3 5542.6 5247.6 5448.6 5485.0 5637.4 5657.5 5126.5 5330.6 5374.9 5416.7 5574.5 5366.8 5597.8 5604.4 5613.8 5650.5 4551.6 5218.8 5434.2 5494.2 5512.7 04:31:49 INFO - PROCESS | 2253 | 04:31:49 INFO - PROCESS | 2253 | [#5] yui.html Cycles:180 Average:24999.06 Median:3503.35 stddev:40085.79 (1144.2%) stddev-sans-first:40156.76 04:31:49 INFO - PROCESS | 2253 | Values: 711.6 770.7 787.2 803.3 852.3 15066.8 15408.6 15787.3 15790.8 15802.5 14354.2 14414.1 14624.8 14660.6 15000.8 849.4 878.8 880.2 880.6 881.6 694.9 714.6 853.3 886.0 886.4 938.4 941.7 941.9 943.1 943.9 932.4 933.7 933.9 935.4 937.4 533.7 551.4 632.9 684.7 686.5 15253.0 15269.5 15281.4 15364.8 15382.4 13781.4 14080.9 14143.5 14205.4 14346.8 10954.0 12725.8 12779.0 12850.4 12864.6 4522.0 4589.7 4653.1 4660.5 4673.2 107201.0 110430.0 114818.4 115107.0 115713.0 11045.6 11165.4 11354.5 11549.4 11660.4 21508.5 22044.8 22257.8 22269.6 22294.2 7932.6 8111.6 8170.7 8240.5 8280.3 4342.8 4467.4 4530.8 4641.5 4658.1 3406.5 3496.4 3510.3 3525.8 3528.9 579.2 614.6 643.9 656.2 677.1 505.8 551.1 594.8 626.0 645.7 7108.4 8658.2 8898.6 8970.7 9048.5 511.9 621.2 624.6 633.9 655.5 4427.8 4575.6 4583.2 4586.1 4819.8 131118.4 148561.0 148662.0 152751.0 154573.0 126318.0 127793.0 128489.0 134111.3 138104.2 112404.0 113116.0 113423.0 115067.4 117023.0 9105.2 9173.8 9226.9 9235.3 9486.6 61107.0 61448.0 61668.4 61875.4 63751.0 83566.2 90208.5 94059.1 95707.0 97628.7 11700.9 11739.8 11958.6 12179.1 12391.6 12936.5 13201.9 13213.3 13663.9 13917.4 12045.3 12352.1 12402.8 12485.9 12800.7 11629.3 11990.0 12233.4 12345.0 12776.2 11875.8 12877.4 13520.5 13771.4 13967.5 10888.7 10982.4 11310.7 11334.8 11479.9 9859.7 10955.9 11144.6 11262.5 11698.0 04:31:49 INFO - PROCESS | 2253 | -------- Summary: end -------- 04:31:49 INFO - PROCESS | 2253 | 04:31:50 INFO - TEST-INFO | 2253: exit 0 04:31:50 INFO - TEST-OK | dromaeo_css | took 1117449ms 04:31:50 INFO - TEST-START | kraken 04:31:50 INFO - operating with platform_type : mac_ 04:31:50 INFO - Initialising browser for kraken test... 04:31:50 INFO - TEST-INFO | started process 2257 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpxDzzW1/profile http://localhost:54509/getInfo.html) 04:31:52 INFO - PROCESS | 2257 | __metrics Screen width/height:1600/1200 04:31:52 INFO - PROCESS | 2257 | colorDepth:24 04:31:52 INFO - PROCESS | 2257 | Browser inner width/height: 1024/689 04:31:52 INFO - PROCESS | 2257 | __metrics 04:31:52 INFO - PROCESS | 2257 | 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" 04:31:52 INFO - PROCESS | 2257 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:31:53 INFO - TEST-INFO | 2257: exit 0 04:31:53 INFO - Browser initialized. 04:31:53 INFO - Running cycle 1/1 for kraken test... 04:31:53 INFO - TEST-INFO | started process 2258 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpxDzzW1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:05 INFO - PROCESS | 2258 | RSS: Main: 236339200 04:32:05 INFO - PROCESS | 2258 | 04:32:08 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54509/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:09 INFO - PROCESS | 2258 | RSS: Main: 294916096 04:32:09 INFO - PROCESS | 2258 | 04:32:11 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54509/tests/kraken/driver.html?testName=audio-dft) 04:32:12 INFO - PROCESS | 2258 | RSS: Main: 293519360 04:32:12 INFO - PROCESS | 2258 | 04:32:16 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54509/tests/kraken/driver.html?testName=audio-fft) 04:32:16 INFO - PROCESS | 2258 | RSS: Main: 385961984 04:32:16 INFO - PROCESS | 2258 | 04:32:18 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54509/tests/kraken/driver.html?testName=audio-oscillator) 04:32:19 INFO - PROCESS | 2258 | RSS: Main: 287731712 04:32:19 INFO - PROCESS | 2258 | 04:32:21 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:21 INFO - PROCESS | 2258 | RSS: Main: 290295808 04:32:21 INFO - PROCESS | 2258 | 04:32:24 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54509/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:25 INFO - PROCESS | 2258 | RSS: Main: 329830400 04:32:25 INFO - PROCESS | 2258 | 04:32:28 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54509/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:28 INFO - PROCESS | 2258 | RSS: Main: 330039296 04:32:28 INFO - PROCESS | 2258 | 04:32:31 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54509/tests/kraken/driver.html?testName=json-parse-financial) 04:32:32 INFO - PROCESS | 2258 | RSS: Main: 328257536 04:32:32 INFO - PROCESS | 2258 | 04:32:33 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:34 INFO - PROCESS | 2258 | RSS: Main: 304979968 04:32:34 INFO - PROCESS | 2258 | 04:32:36 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:36 INFO - PROCESS | 2258 | RSS: Main: 304918528 04:32:36 INFO - PROCESS | 2258 | 04:32:39 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:39 INFO - PROCESS | 2258 | RSS: Main: 310636544 04:32:39 INFO - PROCESS | 2258 | 04:32:42 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:43 INFO - PROCESS | 2258 | RSS: Main: 324251648 04:32:43 INFO - PROCESS | 2258 | 04:32:46 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:46 INFO - PROCESS | 2258 | RSS: Main: 320155648 04:32:46 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:54509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54509/tests/kraken/driver.html?testName=ai-astar) 04:32:48 INFO - PROCESS | 2258 | RSS: Main: 363638784 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | __start_tp_report 04:32:48 INFO - PROCESS | 2258 | _x_x_mozilla_page_load 04:32:48 INFO - PROCESS | 2258 | _x_x_mozilla_page_load_details 04:32:48 INFO - PROCESS | 2258 | |i|pagename|runs| 04:32:48 INFO - PROCESS | 2258 | |0;ai-astar;114;113;113;121;167;150;111;113;112;111 04:32:48 INFO - PROCESS | 2258 | |1;audio-beat-detection;150;109;113;147;112;109;109;110;146;138 04:32:48 INFO - PROCESS | 2258 | |2;audio-dft;185;184;182;186;186;185;188;179;184;184 04:32:48 INFO - PROCESS | 2258 | |3;audio-fft;80;58;63;89;66;77;83;81;90;57 04:32:48 INFO - PROCESS | 2258 | |4;audio-oscillator;92;72;94;69;68;69;91;68;69;89 04:32:48 INFO - PROCESS | 2258 | |5;imaging-gaussian-blur;87;84;87;84;87;86;126;84;88;83 04:32:48 INFO - PROCESS | 2258 | |6;imaging-darkroom;95;117;161;101;95;94;96;95;95;95 04:32:48 INFO - PROCESS | 2258 | |7;imaging-desaturate;86;86;85;84;85;83;86;86;84;84 04:32:48 INFO - PROCESS | 2258 | |8;json-parse-financial;56;53;52;53;53;53;55;54;53;54 04:32:48 INFO - PROCESS | 2258 | |9;json-stringify-tinderbox;64;79;79;75;73;70;71;72;70;72 04:32:48 INFO - PROCESS | 2258 | |10;stanford-crypto-aes;88;88;87;85;85;84;82;86;83;87 04:32:48 INFO - PROCESS | 2258 | |11;stanford-crypto-ccm;145;150;153;143;135;136;137;138;175;154 04:32:48 INFO - PROCESS | 2258 | |12;stanford-crypto-pbkdf2;169;169;170;170;169;169;169;169;167;169 04:32:48 INFO - PROCESS | 2258 | |13;stanford-crypto-sha256-iterative;71;69;69;68;68;67;67;67;66;74 04:32:48 INFO - PROCESS | 2258 | __end_tp_report 04:32:48 INFO - PROCESS | 2258 | __start_cc_report 04:32:48 INFO - PROCESS | 2258 | _x_x_mozilla_cycle_collect,1961 04:32:48 INFO - PROCESS | 2258 | __end_cc_report 04:32:48 INFO - PROCESS | 2258 | __startTimestamp1475235168851__endTimestamp 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | ------- Summary: start ------- 04:32:48 INFO - PROCESS | 2258 | Number of tests: 14 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#0] ai-astar Cycles:10 Average:122.50 Median:113.50 stddev:19.60 (17.3%) stddev-sans-first:20.54 04:32:48 INFO - PROCESS | 2258 | Values: 114.0 113.0 113.0 121.0 167.0 150.0 111.0 113.0 112.0 111.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:125.50 stddev:18.32 (14.6%) stddev-sans-first:16.90 04:32:48 INFO - PROCESS | 2258 | Values: 150.0 109.0 113.0 147.0 112.0 109.0 109.0 110.0 146.0 138.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#2] audio-dft Cycles:10 Average:184.30 Median:185.00 stddev:2.45 (1.3%) stddev-sans-first:2.59 04:32:48 INFO - PROCESS | 2258 | Values: 185.0 184.0 182.0 186.0 186.0 185.0 188.0 179.0 184.0 184.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#3] audio-fft Cycles:10 Average:74.40 Median:80.50 stddev:12.40 (15.4%) stddev-sans-first:12.99 04:32:48 INFO - PROCESS | 2258 | Values: 80.0 58.0 63.0 89.0 66.0 77.0 83.0 81.0 90.0 57.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.50 stddev:11.65 (14.5%) stddev-sans-first:11.22 04:32:48 INFO - PROCESS | 2258 | Values: 92.0 72.0 94.0 69.0 68.0 69.0 91.0 68.0 69.0 89.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:86.50 stddev:12.90 (14.9%) stddev-sans-first:13.65 04:32:48 INFO - PROCESS | 2258 | Values: 87.0 84.0 87.0 84.0 87.0 86.0 126.0 84.0 88.0 83.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#6] imaging-darkroom Cycles:10 Average:104.40 Median:95.00 stddev:21.07 (22.2%) stddev-sans-first:22.07 04:32:48 INFO - PROCESS | 2258 | Values: 95.0 117.0 161.0 101.0 95.0 94.0 96.0 95.0 95.0 95.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#7] imaging-desaturate Cycles:10 Average:84.90 Median:85.50 stddev:1.10 (1.3%) stddev-sans-first:1.09 04:32:48 INFO - PROCESS | 2258 | Values: 86.0 86.0 85.0 84.0 85.0 83.0 86.0 86.0 84.0 84.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.50 stddev:1.17 (2.2%) stddev-sans-first:0.87 04:32:48 INFO - PROCESS | 2258 | Values: 56.0 53.0 52.0 53.0 53.0 53.0 55.0 54.0 53.0 54.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#9] json-stringify-tinderbox Cycles:10 Average:72.50 Median:72.50 stddev:4.45 (6.1%) stddev-sans-first:3.50 04:32:48 INFO - PROCESS | 2258 | Values: 64.0 79.0 79.0 75.0 73.0 70.0 71.0 72.0 70.0 72.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:2.07 (2.4%) stddev-sans-first:1.99 04:32:48 INFO - PROCESS | 2258 | Values: 88.0 88.0 87.0 85.0 85.0 84.0 82.0 86.0 83.0 87.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:147.50 stddev:12.21 (8.3%) stddev-sans-first:12.94 04:32:48 INFO - PROCESS | 2258 | Values: 145.0 150.0 153.0 143.0 135.0 136.0 137.0 138.0 175.0 154.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 04:32:48 INFO - PROCESS | 2258 | Values: 169.0 169.0 170.0 170.0 169.0 169.0 169.0 169.0 167.0 169.0 04:32:48 INFO - PROCESS | 2258 | 04:32:48 INFO - PROCESS | 2258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:2.37 (3.5%) stddev-sans-first:2.35 04:32:48 INFO - PROCESS | 2258 | Values: 71.0 69.0 69.0 68.0 68.0 67.0 67.0 67.0 66.0 74.0 04:32:48 INFO - PROCESS | 2258 | -------- Summary: end -------- 04:32:48 INFO - PROCESS | 2258 | 04:32:49 INFO - TEST-INFO | 2258: exit 0 04:32:49 INFO - TEST-OK | kraken | took 59726ms 04:32:49 INFO - SUITE-END | took 1177s 04:32:50 INFO - Completed test suite (00:19:37) 04:32:50 INFO - javascript benchmark 04:32:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.4746440569515, 3296.324253528027, 3323.2522682396466, 3340.8162551059713, 3368.5620869287004, 5577.274954255941, 5639.0, 5668.348139963905, 5702.1446782982575, 5734.59857809953, 5617.691026993513, 5645.01212287849, 5727.455891690293, 5731.942680573193, 5743.5118014968675, 5031.144705400091, 5076.720780357097, 5136.306598609177, 5165.405978312486, 5174.715390653512, 5248.632595718302, 5265.0, 5270.393904700951, 5279.9208011879855, 5312.840614781543, 5222.712750798704, 5256.553192978601, 5279.762410691509, 5279.868003299929, 5338.199270109476, 5109.41241757199, 5114.948850511521, 5139.357580302462, 5160.458151894035, 5182.144946083891, 4403.251447253942, 5101.183810590288, 5101.4133374662015, 5117.283580298761, 5124.743762811844, 5678.687672178028, 5685.744141513601, 5699.971500142473, 5709.800156994527, 5716.971415142939, 6045.6674882881425, 6085.817425477243, 6097.359777223416, 6203.627782333075, 6241.65670888101, 5713.657180569179, 6198.2252218472695, 6264.5301602380005, 6288.151099601541, 6291.1192433059405, 5731.197632331477, 5747.913781293284, 5751.798687046017, 5752.942470575241, 5763.452472015152, 6122.794608434074, 6184.257889053342, 6237.594556353823, 6275.5920865144535, 6286.5599408041, 6043.8186854394435, 6097.603655762361, 6102.458955353584, 6106.053561697944, 6116.241443683883, 6215.751369945242, 6224.1597384352535, 6229.314775374705, 6229.688515574203, 6247.437730604267, 5958.314793798682, 6096.085587161872, 6170.444659980533, 6180.443760061616, 6182.474489668339, 6101.023836186189, 6101.55020674385, 6128.632282063001, 6129.419919118773, 6156.753729850845, 4891.241857512091, 4897.975510122498, 4898.97962726875, 4905.656604037755, 4937.753112344369, 4373.125374925028, 4398.054418300081, 4400.1199760047475, 4412.558744125626, 4415.779211039435, 5417.5395091416885, 5457.727113644302, 5598.804041858515, 5600.991821472093, 5651.858703532444, 4332.458442694663, 5908.940910590839, 5918.348981612019, 5955.40445955401, 5967.492763115184, 5431.864203394946, 5480.945190548044, 5485.753141108659, 5491.478309560585, 5500.22996780451, 5175.14610089331, 5187.170052791535, 5215.556677682363, 5260.789568417221, 5314.468553144655, 6196.907046394217, 6214.1921550198185, 6259.34276900937, 6272.96496078142, 6307.3377295383325, 6218.06728990655, 6239.532035097295, 6241.344658810941, 6242.188515493139, 6256.061590761422, 6284.183056202664, 6294.4964402846745, 6303.558750887577, 6320.652364120017, 6385.489160867027, 5963.4334738199805, 5965.045592705146, 6015.939840601538, 6029.246344206974, 6043.7884674036195, 5193.221016847352, 6131.296552205906, 6139.0321984548755, 6146.569740118149, 6150.876982460236, 5945.554083443845, 5950.077737950624, 5959.195508606283, 5967.433093856077, 5968.70156492165, 5784.768609255751, 5803.274590676166, 5877.970610147093, 5947.464728174485, 5955.731992060454, 5780.826575202751, 5788.189653448437, 5812.447817457335, 5854.590178687621, 5902.4097590240635, 4703.6942598730975, 5886.470217680258, 5892.322382926019, 5990.610610310316, 6011.87976240464, 5769.192313076089, 5769.884602308014, 5784.161296612052, 5793.36273009977, 5823.242978412779], "value": 5598.71422317034, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.9513901040391, 497.2491537777954, 497.36089125473774, 504.8640558742829, 528.6484487815604, 39491.40762888559, 40143.0, 42116.368254476205, 43756.56243437572, 43796.905077373085, 42226.57773422265, 42706.65113418761, 42731.0, 42745.0, 42802.0, 8783.429077109968, 9027.864582031274, 9827.410355378683, 10031.799364012715, 10032.59869605215, 8877.20105190536, 8961.641534338618, 8992.190702836744, 12010.939945300304, 12358.0, 12237.20458170216, 12316.81524777129, 12317.260964342124, 12322.01423886087, 12334.198277112004, 12199.695007624792, 12274.509019639203, 12281.017518598535, 12289.385530723517, 12294.077944154134, 11948.342841143734, 12018.699532511757, 12036.277823330629, 12050.97566706831, 12078.69803254917, 39700.60299396998, 39889.40165897514, 40057.39913901294, 40081.0, 40126.39810402846, 3129.4836352001894, 3232.046546268856, 3285.720713739311, 3653.488511608377, 4029.3351596986463, 30012.69987300121, 31301.686983130334, 31313.06060818179, 31343.0, 31374.37251254985, 3282.0, 3340.315235376742, 3377.4427219508752, 3403.0981789825714, 3414.0, 465533.0, 465627.0, 465734.0, 466187.0, 470363.0, 57799.13301300484, 58276.4172358271, 58328.0, 58340.416595834344, 58393.4160658388, 60629.0, 60683.69658151681, 60704.089438658455, 60753.190787336476, 60848.39151608427, 14018.088824226392, 15148.772768408482, 16000.679986400439, 16012.199390030451, 16035.759463608056, 12396.566120185931, 12460.252384856938, 12466.252024878537, 12471.875281247072, 12500.187487813444, 13992.440302387791, 14277.0, 14295.428182872569, 15567.922160389126, 15970.76043859343, 4912.543728135932, 5624.325080990226, 6153.015517517176, 6320.399562041599, 6323.9683801580695, 817.4972391979009, 834.9499030058216, 955.527014128011, 996.940183588987, 1018.271935566059, 28533.44840756122, 28705.56941645877, 28927.710722892924, 29349.266268343035, 29375.97184098546, 1001.8998100190068, 1025.6102680981328, 1045.0176833776377, 1068.5725709716176, 1110.5335758981087, 13027.413766380536, 14049.22729249901, 14958.326875290639, 15243.085414875142, 15277.465288714842, 587316.0, 593377.0, 594149.0, 594546.0, 597804.0, 48380.0, 49000.77498062577, 54895.72552137214, 55215.0, 55615.72192139094, 1296.1056870759146, 1341.5438750824767, 1341.704824938512, 1346.9461221551421, 1350.6690860739182, 29948.70051299459, 30135.246618833826, 30300.848495758262, 30433.23916902095, 30691.539626905167, 48743.26885096655, 49152.26271606, 49179.0, 49241.0, 49282.01435971189, 584899.7365303044, 637512.0, 645968.0, 658791.412085873, 827024.0, 20725.689114663594, 25021.624675629515, 25219.74780252174, 25521.61717574201, 25539.489210216063, 46799.53200468088, 46848.765756171, 47009.764951176396, 47940.7602961983, 49110.0, 39077.21845563016, 39102.80448597739, 39103.608963909996, 39178.824635260986, 40634.0, 38757.612423876526, 39522.0, 39822.0, 40319.1936161281, 40668.389974151, 37645.62354376531, 38483.0, 38585.8424247273, 38649.22701545897, 38693.613063869, 32032.0, 33768.324633507684, 34120.65879341175, 34169.829150854086, 34630.13424664403, 25085.372865678502, 25274.0, 25311.987520498973, 25415.596903220485, 25652.486950260518], "value": 19964.475085707727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.76692480639537, 336.61625746648826, 348.36075800905337, 368.4675643694861, 385.7280617164899, 12591.685207869796, 15982.0, 18735.0, 19660.508487287825, 20747.481312967182, 16560.83439165608, 19824.306149284777, 21259.68110478344, 21349.35951921445, 21405.14379424821, 5589.692566908829, 6033.27600687918, 6105.450509454148, 6121.387861213888, 6122.755089796425, 4105.9178816423655, 4139.668826493873, 6010.308814486346, 6110.175126357952, 6129.0, 6652.93347066528, 6748.190217173921, 6755.763548275811, 6757.526973111884, 6769.356911093439, 6428.967855160741, 6681.331866813329, 6725.831854203635, 6728.966355168217, 6735.158105236846, 5602.60781745278, 5818.505427038707, 5827.271591051119, 5828.41715828418, 5837.211976383219, 25930.740692593023, 26372.0, 26388.0, 26522.602160967603, 26693.733062669515, 2391.1033362489065, 2567.422329975759, 2607.6610040694777, 2776.1671498550354, 2867.6702179249446, 11955.282683039046, 15215.087094774239, 15476.613084672861, 15656.921715391463, 16083.839161608468, 1726.2577091850499, 1816.1010299901502, 1856.071964017991, 1894.1571000904603, 1936.5158710322419, 121874.39062804719, 122108.0, 122714.0, 125722.0, 126292.73707262901, 10131.504630902327, 10723.088537474401, 10822.94364070824, 11007.229493935347, 11034.503447344729, 13614.659633509043, 13671.931640341734, 13672.111312764639, 13687.863121368659, 13690.0, 8105.392095592854, 8343.08226095129, 8354.331653467709, 8502.0222674392, 8507.27688146502, 7006.649667516705, 8017.398695097891, 8317.41778075529, 8372.790680232922, 8524.318054555744, 5392.56859451243, 6575.276719560845, 6576.934230657728, 6579.2104947406615, 6584.144061272004, 1644.1696943043926, 1650.5873531617096, 1687.3419366447094, 1769.1242834796858, 1806.3226290141197, 773.6905237904771, 846.9957650211833, 887.662688178488, 926.8934072581604, 1065.984010239847, 20271.898640507, 20948.685769713466, 22490.66264006041, 22507.0, 22631.43421414445, 911.7948461596088, 917.7797328641211, 934.9392289501161, 948.8292107420592, 960.3805545423163, 11286.266392684449, 11642.825357619642, 11782.351970641697, 11806.409679516162, 11908.345041022654, 593451.0, 606640.0, 606671.0, 607242.0, 608766.0, 69465.0, 70495.0, 90680.0, 119852.0, 125021.0, 899.6536333511646, 905.6739573753443, 905.9773505662412, 911.8221946720325, 936.0826390137703, 14620.780688289897, 19743.0, 20033.79966200319, 20076.0, 20087.899560502105, 53903.87913148245, 54233.72883135559, 54502.72748636232, 54521.454785451635, 54613.45386546083, 75699.0, 76317.23682763102, 76548.0, 76759.61620191863, 77162.0, 7935.761927142195, 7991.520508769492, 8073.717419890276, 8129.0, 8191.877121843297, 13243.139195952232, 13379.53171638988, 13460.798088028492, 13785.793213101611, 13819.0, 11641.0, 11732.0, 11779.823302650639, 11882.405879706153, 11898.464569094585, 10384.844227336747, 10653.840192396965, 11418.972292493716, 11823.70440738954, 11858.347790871585, 11268.830967535658, 11662.825057624312, 11771.293722376684, 11807.760185180432, 12100.757984840078, 7840.686372545034, 7942.570337339334, 8080.595970201584, 8115.391345648982, 8264.752057438287, 9748.9025109748, 11211.60759373418, 11800.291982481078, 11832.46753896094, 11944.402779860799], "value": 9715.211571523021, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.5723647051177, 1557.852004059614, 1728.7493313469547, 1891.6973284274518, 1912.9043547822614, 7976.561289129096, 8281.83436331273, 8588.484690918549, 8990.056044115372, 9002.729918102468, 8133.389995750313, 8604.698835540757, 8797.07630698777, 8812.60343284552, 8929.241014513775, 2144.8498605097648, 2372.90508379665, 2406.3142004528713, 2407.145463360508, 2409.5542324669905, 2081.750189977205, 2311.6185829338137, 2346.530693861226, 2405.1461731085474, 2406.578848701479, 2155.7628660847295, 2281.532285881399, 2363.078399424226, 2366.077229880348, 2366.1127077345996, 2352.8235382346393, 2368.100121953655, 2375.845570037942, 2376.489054853215, 2377.215518878766, 2363.0, 2363.72817126031, 2365.66880636711, 2368.0, 2368.2303251443177, 8888.955555222246, 8966.820663586757, 8967.0, 8970.327225458052, 8981.05698901619, 5168.8449346519665, 5209.765560549784, 5266.973665131688, 5271.578273738091, 5279.392869819982, 3475.4091804393315, 3532.2229109595846, 3674.5590529136407, 3678.9632103678887, 3685.7972811495356, 954.5942974235921, 1054.230411799383, 1090.2150451674781, 1092.0, 1112.9332240065542, 11536.596219132374, 11678.065754739686, 11678.182527223098, 11678.416079196091, 11700.590479333183, 4483.30508771141, 4578.587927086578, 4748.62011039123, 4757.904841903142, 4786.44955830077, 9909.256805739598, 9910.801783964425, 9912.752181195383, 9914.80170396588, 9931.751706207402, 5341.839744807662, 5348.171033489815, 5348.598855085884, 5350.170723537858, 5354.116570765858, 4764.118638051971, 4791.0, 4810.8797280068275, 4823.059503396804, 4860.781264843091, 3828.655421012122, 3830.291396091732, 3887.1642596841248, 3924.274009308287, 3925.468073092839, 1177.2171505948447, 1272.5164437513686, 1274.0571976737333, 1278.3799857069314, 1291.8578956314798, 769.9076110866732, 784.7606480023647, 813.0609146435876, 835.6949713354581, 857.1557016338901, 5656.434356564393, 5842.883142337129, 5924.851878702981, 6065.514758819284, 6163.599366041193, 941.1576638908139, 947.5830634520789, 950.2587981374539, 958.6836344006462, 1012.1396812709138, 3270.280538281574, 3891.0235061959174, 3994.141259629194, 4029.9395509067385, 4068.3694027425795, 10173.643922462677, 10547.736306592396, 10711.892881071246, 10722.946385268024, 10905.34567925927, 10864.402457864735, 10873.40196289196, 10879.673609791718, 10881.292715973437, 10882.564697412015, 8093.231143041402, 8283.875741863876, 8297.294729947902, 8312.21034001769, 8319.66721331152, 5698.886022279614, 5907.734151963086, 6067.24159480065, 6100.786472473442, 6128.816135515942, 9872.210223182272, 10103.444310562989, 10125.0, 10136.290459667753, 10153.695389138338, 9719.514024298898, 10084.64703735395, 10094.192464602667, 10240.0, 10266.691999239736, 7450.739224127129, 7607.429442791702, 7608.733694320672, 7611.0, 7619.314261716472, 7752.26353496417, 8136.918630813616, 8163.1428699985645, 8175.83648327042, 8224.753257402288, 6043.244594425697, 7257.237990011184, 7406.518576292524, 7506.13679426851, 7517.962410187914, 7371.8157046074275, 7390.815229619087, 7405.925940740739, 7427.628618568941, 7462.4776265660885, 5592.636478628876, 6949.930500694928, 6968.198657154492, 7020.297970202939, 7020.7542736004, 4916.0, 4953.603711703127, 4993.825216117419, 5080.288759573737, 5205.869853253699, 4916.188828843201, 4923.433805112458, 4931.926021109614, 5001.774920128676, 5032.597392208541], "value": 4577.008836201008, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.6703955253696, 296.3110767465643, 298.5000124790975, 306.7408040206025, 310.91449851290895, 4536.614387777035, 4717.174494463468, 5245.554127899133, 5267.736613169341, 5314.627976041674, 3787.0343062519087, 4617.245446730238, 4788.545088216622, 4900.632452566063, 5133.281340612308, 3875.3218186817335, 4073.6130067643676, 4078.6125318094732, 4095.365218391154, 4096.446979657752, 3769.2649933263024, 4088.2641124597562, 4096.774677392742, 4107.952472119605, 4118.97940510297, 3308.4210263203963, 3935.940960885589, 3946.52641682997, 3959.148783011652, 3980.2437536868047, 3314.342828585707, 3940.8423663053445, 3953.5255769307723, 3954.228925359556, 3991.5409727881083, 3441.5525981622227, 3449.6025262442613, 3456.948145777815, 3461.152017755641, 3467.323871844991, 3992.4210989406665, 4517.599544141294, 4831.492693267227, 5111.565516931066, 5129.281900533928, 3939.9015024624327, 4235.941014746313, 4414.646828253732, 4507.506682321195, 4551.110045121339, 4523.7285762854335, 4981.476944920767, 5016.3227964224725, 5045.041442125985, 5497.065498865202, 3500.842462089212, 3782.924341513154, 3784.7539909905768, 3788.488554045196, 3794.829232684536, 5031.371078615173, 5699.458551437607, 5779.3642699303045, 5797.652140871562, 5845.85385365365, 3804.8287827047848, 3834.9424758628643, 3843.385058390644, 3848.8652897149027, 3863.265979463893, 3437.5187473753695, 3690.8708195213576, 3929.4891664083484, 3937.2322397132857, 3937.310970580137, 3761.9059523511582, 4191.350340697197, 4265.616094551443, 4346.239408103569, 4530.682852200314, 5575.33096028471, 5592.273004509388, 5610.803621873215, 5616.634918730269, 5620.57845661577, 1093.8413929980109, 1280.9487620495263, 1289.8000809874484, 1293.1852932652369, 1317.5981325695564, 832.7793134819278, 837.0290463062818, 855.9058503564603, 859.1837754133473, 890.6660002499062, 4765.833195838199, 5035.8669299408075, 5163.573120633297, 5210.296609957683, 5220.216967454912, 4779.0, 5515.297504222902, 5618.634788738719, 5692.459216374438, 5698.572607054488, 4303.526612072669, 4663.883402914954, 5096.898062038813, 5122.334096567497, 5124.052050370693, 2895.826250424981, 2929.721676440735, 2932.5161348377706, 2939.6619388770564, 2951.7638588912837, 5596.944030559724, 5747.712614369265, 5793.478586927196, 5814.563907706939, 5834.416558344216, 4550.635949124062, 5692.089265717465, 5708.771649133988, 5743.885122297531, 5766.0, 4844.539768721966, 5211.973940130275, 5805.7387417566315, 5822.505087067647, 5865.237519122486, 3972.9404058939717, 4892.535209155125, 5606.0, 5624.762552238501, 5757.280339957505, 4712.929306060343, 5096.337476128079, 5208.062548741263, 5654.604177707521, 5655.349634791887, 4815.3499277597075, 5905.881882362414, 5934.851628709317, 5953.743073702323, 5966.463018328372, 3222.5971753530807, 3917.941230881482, 3990.561038285728, 4001.2797696414923, 4061.878143655695, 5148.825430442382, 5651.96529249478, 5652.095664693629, 5671.801486948102, 5679.630823996427, 5215.400228973716, 5502.202180683858, 5528.889422211614, 5531.285301556531, 5542.584306177134, 5247.638562646748, 5448.591355648421, 5485.040117979417, 5637.379888212211, 5657.5473962082115, 5126.461721519336, 5330.600204984719, 5374.865628359323, 5416.729163541886, 5574.470425309589, 5366.813885169574, 5597.776088956559, 5604.383517812956, 5613.775448982158, 5650.519705824887, 4551.5676010778925, 5218.791248350023, 5434.196062756166, 5494.230807687007, 5512.6692398456225], "value": 4004.1254809653155, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.6406214861495, 770.7263921307936, 787.1616728184483, 803.2650125135501, 852.29259714437, 15066.849331506695, 15408.61478463039, 15787.28957196926, 15790.842091579096, 15802.525924222278, 14354.210518421509, 14414.135151890894, 14624.780628290584, 14660.633484162901, 15000.774988375184, 849.4266370200106, 878.8198419324056, 880.1682410122437, 880.5509190312922, 881.6341218394359, 694.930506949306, 714.6426786606696, 853.2661910756744, 885.9734207973739, 886.441541828647, 938.3619138985487, 941.722191953372, 941.8540126280403, 943.094629156011, 943.8584212368131, 932.39394393644, 933.7385532051037, 933.869258303838, 935.4434111703525, 937.3579098317674, 533.7037943941111, 551.3631755322609, 632.8607706304606, 684.7055766020609, 686.4748467422426, 15253.0, 15269.465568705153, 15281.388744450209, 15364.846351536453, 15382.384704611803, 13781.379837907318, 14080.92959535206, 14143.504977325847, 14205.431782728678, 14346.78479822793, 10954.0, 12725.809112863315, 12779.0, 12850.421731022127, 12864.614061578168, 4521.977390113028, 4589.678722489427, 4653.069386122789, 4660.5339466053465, 4673.182193116191, 107201.0, 110430.0, 114818.42590787075, 115107.0, 115713.0, 11045.613403530839, 11165.38590377537, 11354.54581816718, 11549.36478493691, 11660.416979151008, 21508.462288442915, 22044.779552204593, 22257.777422225572, 22269.554608907732, 22294.21970231034, 7932.643031063616, 8111.553864537507, 8170.673173073129, 8240.50556966584, 8280.337572994145, 4342.804573794187, 4467.374567560479, 4530.750808705553, 4641.466231383367, 4658.068386322749, 3406.540117084162, 3496.4405695088662, 3510.262844802569, 3525.823708814549, 3528.9117772055392, 579.1688926390559, 614.5698011391954, 643.8969764837603, 656.2420404432887, 677.109600874848, 505.84066019203834, 551.0769461152554, 594.8483136800088, 625.9874802503924, 645.686841881687, 7108.395786358217, 8658.220760131619, 8898.555072246361, 8970.68602598919, 9048.547572621343, 511.88482591416636, 621.201755743876, 624.6470744029699, 633.9049142628643, 655.4788942790493, 4427.817250823637, 4575.565321294472, 4583.197940360424, 4586.105709386704, 4819.831305904277, 131118.3776324487, 148561.0, 148662.0, 152751.0, 154573.0, 126318.0, 127793.0, 128489.0, 134111.32944335215, 138104.23791524113, 112404.0, 113115.99999999836, 113423.0, 115067.42466287782, 117023.0, 9105.229051393357, 9173.77065573366, 9226.907730922605, 9235.26117910579, 9486.620535178792, 61107.0, 61448.0, 61668.38331616626, 61875.381246188765, 63751.0, 83566.16433835827, 90208.5489572548, 94059.05940940777, 95707.0, 97628.67784916017, 11700.88299117032, 11739.79332542764, 11958.58144964922, 12179.147459678092, 12391.566295179986, 12936.482540698267, 13201.867981320063, 13213.339333033118, 13663.931680341535, 13917.443302267797, 12045.33750643688, 12352.135350525377, 12402.75194496087, 12485.875141248835, 12800.6799830005, 11629.302241865515, 11990.0, 12233.388330583613, 12345.012399008237, 12776.233425994471, 11875.762484750085, 12877.420516076612, 13520.526781562598, 13771.380287886868, 13967.511137110152, 10888.727781805519, 10982.395968221505, 11310.660680179608, 11334.829977550178, 11479.942600286946, 9859.654912078044, 10955.890441095806, 11144.554217831195, 11262.549498019987, 11698.0], "value": 7794.8062884794535, "unit": "score"}], "name": "dromaeo_css", "value": 7330.329035638781, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 121.0, 167.0, 150.0, 111.0, 113.0, 112.0, 111.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 109.0, 113.0, 147.0, 112.0, 109.0, 109.0, 110.0, 146.0, 138.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 186.0, 186.0, 185.0, 188.0, 179.0, 184.0, 184.0], "value": 184.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 63.0, 89.0, 66.0, 77.0, 83.0, 81.0, 90.0, 57.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 72.0, 94.0, 69.0, 68.0, 69.0, 91.0, 68.0, 69.0, 89.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 84.0, 87.0, 86.0, 126.0, 84.0, 88.0, 83.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 117.0, 161.0, 101.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 104.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 84.0, 85.0, 83.0, 86.0, 86.0, 84.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 52.0, 53.0, 53.0, 53.0, 55.0, 54.0, 53.0, 54.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 79.0, 79.0, 75.0, 73.0, 70.0, 71.0, 72.0, 70.0, 72.0], "value": 72.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 87.0, 85.0, 85.0, 84.0, 82.0, 86.0, 83.0, 87.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 150.0, 153.0, 143.0, 135.0, 136.0, 137.0, 138.0, 175.0, 154.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 169.0, 170.0, 170.0, 169.0, 169.0, 169.0, 169.0, 167.0, 169.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 68.0, 68.0, 67.0, 67.0, 67.0, 66.0, 74.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1458.2999999999997, "alertThreshold": 2.0}]} 04:32:50 INFO - Return code: 0 04:32:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:32:50 INFO - # TBPL SUCCESS # 04:32:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:32:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:32:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:32:50 INFO - 2016-09-30 04:32:50.173 screenresolution[2262:28782] starting screenresolution argv=screenresolution get 04:32:50 INFO - 2016-09-30 04:32:50.175 screenresolution[2262:28782] Display 0: 1600x1200x32@60 04:32:50 INFO - 2016-09-30 04:32:50.182 screenresolution[2263:28785] starting screenresolution argv=screenresolution list 04:32:50 INFO - Available Modes on Display 0 04:32:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:32:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:32:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:32:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:32:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:32:50 INFO - Intel Iris: 04:32:50 INFO - Chipset Model: Intel Iris 04:32:50 INFO - Type: GPU 04:32:50 INFO - Bus: Built-In 04:32:50 INFO - VRAM (Dynamic, Max): 1536 MB 04:32:50 INFO - Vendor: Intel (0x8086) 04:32:50 INFO - Device ID: 0x0a2e 04:32:50 INFO - Revision ID: 0x0009 04:32:50 INFO - Displays: 04:32:50 INFO - Display: 04:32:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:32:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:32:50 INFO - Display Serial Number: 1600x1200 60 04:32:50 INFO - Main Display: Yes 04:32:50 INFO - Mirror: Off 04:32:50 INFO - Online: Yes 04:32:50 INFO - Rotation: Supported 04:32:50 INFO - Return code: 0 04:32:50 INFO - Running post-action listener: _resource_record_post_action 04:32:50 INFO - [mozharness: 2016-09-30 11:32:50.421660Z] Finished run-tests step (success) 04:32:50 INFO - Running post-run listener: _resource_record_post_run 04:32:50 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 450560; Write bytes: 707741696; Read time: 3; Write time: 1933 04:32:50 INFO - TinderboxPrint: CPU usage
53.6% 04:32:50 INFO - TinderboxPrint: I/O read bytes / time
450,560 / 3 04:32:50 INFO - TinderboxPrint: I/O write bytes / time
707,741,696 / 1,933 04:32:50 INFO - TinderboxPrint: CPU idle
2,250.0 (46.4%) 04:32:50 INFO - TinderboxPrint: CPU system
969.2 (20.0%) 04:32:50 INFO - TinderboxPrint: CPU user
1,630.5 (33.6%) 04:32:50 INFO - TinderboxPrint: Swap in / out
407,093,248 / 0 04:32:50 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 405961216; Write bytes: 400147968; Read time: 29889; Write time: 769 04:32:50 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 450560; Write bytes: 296788480; Read time: 3; Write time: 1129 04:32:50 INFO - Running post-run listener: _upload_blobber_files 04:32:50 INFO - Blob upload gear active. 04:32:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:50 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 04:32:50 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'] 04:32:50 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 04:32:51 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:51 INFO - (blobuploader) - INFO - Done attempting. 04:32:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:32:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:32:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:52 INFO - (blobuploader) - INFO - Done attempting. 04:32:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:32:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:55 INFO - (blobuploader) - INFO - Done attempting. 04:32:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:55 INFO - Return code: 0 04:32:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa0de0785e5d3f05faf866df864b31e2cbd0dd72545883eacc1bf49bfc14e9a434a7cb3392d9dc76fcb89e0357fbffdd4e7b287524855eaaa705e45dc7ab4f84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9804e070ac124be81bc4bd380a28af9d46ec48df024b1dca475896e48f7dec128f3623fe524f0fcb37a915b637c90c0589360af1753ffb8d66e2419990d74136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7382af895328a00b810e0c9e3c29cb4a3172de58e9ffe0fa7861dfa1434cac8162779ed4c5ab9ad908731797c63418209236a5c8cc0bf85739c01b3ebe8090f"} 04:32:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:55 INFO - Contents: 04:32:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/aa0de0785e5d3f05faf866df864b31e2cbd0dd72545883eacc1bf49bfc14e9a434a7cb3392d9dc76fcb89e0357fbffdd4e7b287524855eaaa705e45dc7ab4f84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9804e070ac124be81bc4bd380a28af9d46ec48df024b1dca475896e48f7dec128f3623fe524f0fcb37a915b637c90c0589360af1753ffb8d66e2419990d74136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7382af895328a00b810e0c9e3c29cb4a3172de58e9ffe0fa7861dfa1434cac8162779ed4c5ab9ad908731797c63418209236a5c8cc0bf85739c01b3ebe8090f"} 04:32:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:55 INFO - Copying logs to upload dir... 04:32:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.284610 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-30 04:32:55.293500) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 04:32:55.297166) ========= 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.tKAaECYMed/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.kjLeoHM8VC/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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/aa0de0785e5d3f05faf866df864b31e2cbd0dd72545883eacc1bf49bfc14e9a434a7cb3392d9dc76fcb89e0357fbffdd4e7b287524855eaaa705e45dc7ab4f84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9804e070ac124be81bc4bd380a28af9d46ec48df024b1dca475896e48f7dec128f3623fe524f0fcb37a915b637c90c0589360af1753ffb8d66e2419990d74136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7382af895328a00b810e0c9e3c29cb4a3172de58e9ffe0fa7861dfa1434cac8162779ed4c5ab9ad908731797c63418209236a5c8cc0bf85739c01b3ebe8090f"} build_url:https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011633 build_url: 'https://queue.taskcluster.net/v1/task/KxDadyF6Rr-5wZLs8GelCw/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/aa0de0785e5d3f05faf866df864b31e2cbd0dd72545883eacc1bf49bfc14e9a434a7cb3392d9dc76fcb89e0357fbffdd4e7b287524855eaaa705e45dc7ab4f84", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9804e070ac124be81bc4bd380a28af9d46ec48df024b1dca475896e48f7dec128f3623fe524f0fcb37a915b637c90c0589360af1753ffb8d66e2419990d74136", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7382af895328a00b810e0c9e3c29cb4a3172de58e9ffe0fa7861dfa1434cac8162779ed4c5ab9ad908731797c63418209236a5c8cc0bf85739c01b3ebe8090f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 04:32:55.330859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:32:55.331340) ========= 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.tKAaECYMed/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.kjLeoHM8VC/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.005313 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 04:32:55.380480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 04:32:55.380800) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 04:32:55.381112) ========= ========= Total master_lag: 0.17 =========