builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0239 starttime: 1476202306.78 results: success (0) buildid: 20161011072447 builduid: 1e255b30d394451c9893b69a2de36469 revision: 50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:46.780164) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:46.780623) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-10-11 09:11:46.780894) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-10-11 09:11:48.709506) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:48.710175) ========= 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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-11 09:11:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 26.3M=0s 2016-10-11 09:11:49 (26.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.466764 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:49.212515) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:49.212947) ========= 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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.027241 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:49.261920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 09:11:49.265324) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e --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 50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-11 09:11:49,358 truncating revision to first 12 chars 2016-10-11 09:11:49,359 Setting DEBUG logging. 2016-10-11 09:11:49,359 attempt 1/10 2016-10-11 09:11:49,359 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/50d7b9b0b423?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 09:11:50,603 unpacking tar archive at: autoland-50d7b9b0b423/testing/mozharness/ program finished with exit code 0 elapsedTime=1.528647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 09:11:50.818842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:50.822274) ========= script_repo_revision: 50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:50.822790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:50.823068) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 09:11:50.843576) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-11 09:11:50.843941) ========= /tools/buildbot/bin/python -u 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', '-u', '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:11:51 INFO - MultiFileLogger online at 20161011 09:11:51 in /builds/slave/test 09:11:51 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 09:11:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:11:51 INFO - {'append_to_log': False, 09:11:51 INFO - 'base_work_dir': '/builds/slave/test', 09:11:51 INFO - 'blob_upload_branch': 'Autoland', 09:11:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:11:51 INFO - 'branch': 'Autoland', 09:11:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:11:51 INFO - 'config_files': ('talos/mac_config.py',), 09:11:51 INFO - 'default_actions': ('clobber', 09:11:51 INFO - 'read-buildbot-config', 09:11:51 INFO - 'download-and-extract', 09:11:51 INFO - 'populate-webroot', 09:11:51 INFO - 'create-virtualenv', 09:11:51 INFO - 'install', 09:11:51 INFO - 'run-tests'), 09:11:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:11:51 INFO - 'download_minidump_stackwalk': True, 09:11:51 INFO - 'download_symbols': 'ondemand', 09:11:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:11:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:11:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:11:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:11:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:11:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:11:51 INFO - 'installer_path': 'installer.exe', 09:11:51 INFO - 'log_level': 'info', 09:11:51 INFO - 'log_name': 'talos', 09:11:51 INFO - 'log_to_console': True, 09:11:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:11:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:11:51 INFO - 'opt_config_files': (), 09:11:51 INFO - 'pip_index': False, 09:11:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:11:51 INFO - 'cmd': ('bash', 09:11:51 INFO - '-c', 09:11:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:11:51 INFO - 'enabled': True, 09:11:51 INFO - 'halt_on_failure': False, 09:11:51 INFO - 'name': 'check_screen_resolution'},), 09:11:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:11:51 INFO - 'cmd': ('bash', 09:11:51 INFO - '-c', 09:11:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:11:51 INFO - 'enabled': True, 09:11:51 INFO - 'halt_on_failure': False, 09:11:51 INFO - 'name': 'check_screen_resolution'},), 09:11:51 INFO - 'run_cmd_checks_enabled': True, 09:11:51 INFO - 'sps_profile': False, 09:11:51 INFO - 'sps_profile_interval': 0, 09:11:51 INFO - 'suite': 'dromaeojs', 09:11:51 INFO - 'system_bits': '32', 09:11:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:11:51 INFO - 'title': 't-yosemite-r7-0239', 09:11:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:11:51 INFO - 'use_talos_json': True, 09:11:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:11:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:11:51 INFO - 'work_dir': 'build'} 09:11:51 INFO - [mozharness: 2016-10-11 16:11:51.057285Z] Running clobber step. 09:11:51 INFO - Running pre-action listener: _resource_record_pre_action 09:11:51 INFO - Running main action method: clobber 09:11:51 INFO - rmtree: /builds/slave/test/build 09:11:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:11:53 INFO - Running post-action listener: _resource_record_post_action 09:11:53 INFO - [mozharness: 2016-10-11 16:11:53.582523Z] Finished clobber step (success) 09:11:53 INFO - [mozharness: 2016-10-11 16:11:53.582631Z] Running read-buildbot-config step. 09:11:53 INFO - Running pre-action listener: _resource_record_pre_action 09:11:53 INFO - Running main action method: read_buildbot_config 09:11:53 INFO - Using buildbot properties: 09:11:53 INFO - { 09:11:53 INFO - "project": "", 09:11:53 INFO - "product": "firefox", 09:11:53 INFO - "script_repo_revision": "production", 09:11:53 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 09:11:53 INFO - "repository": "", 09:11:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 09:11:53 INFO - "buildid": "20161011072447", 09:11:53 INFO - "pgo_build": "False", 09:11:53 INFO - "basedir": "/builds/slave/test", 09:11:53 INFO - "buildnumber": 363, 09:11:53 INFO - "slavename": "t-yosemite-r7-0239", 09:11:53 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:11:53 INFO - "platform": "yosemite_r7", 09:11:53 INFO - "scheduler": "tests-autoland-macosx64-talos", 09:11:53 INFO - "branch": "autoland", 09:11:53 INFO - "repo_path": "integration/autoland", 09:11:53 INFO - "revision": "50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e", 09:11:53 INFO - "stage_platform": "macosx64", 09:11:53 INFO - "builduid": "1e255b30d394451c9893b69a2de36469", 09:11:53 INFO - "slavebuilddir": "test" 09:11:53 INFO - } 09:11:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:11:53 INFO - Running post-action listener: _resource_record_post_action 09:11:53 INFO - [mozharness: 2016-10-11 16:11:53.585949Z] Finished read-buildbot-config step (success) 09:11:53 INFO - [mozharness: 2016-10-11 16:11:53.586062Z] Running download-and-extract step. 09:11:53 INFO - Running pre-action listener: _resource_record_pre_action 09:11:53 INFO - Running main action method: download_and_extract 09:11:53 INFO - mkdir: /builds/slave/test/build/tests 09:11:53 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')]} 09:11:53 INFO - trying https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:11:53 INFO - Downloading https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/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 09:11:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/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 09:11:54 INFO - Downloaded 1199 bytes. 09:11:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:11:54 INFO - Using the following test package requirements: 09:11:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:11:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:11:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:11:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'jsshell-mac.zip'], 09:11:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:11:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:11:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:11:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:11:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:11:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:11:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:11:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:11:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:11:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:11:54 INFO - Fetch https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:11:55 INFO - Http code: 200 09:11:55 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:11:55 INFO - x-amz-cf-id: lfnAAmmGm96CJcl9W5CgAfp-ch_kmnbqsZaxdw4vfIwcxYn6csMp4Q== 09:11:55 INFO - x-amz-version-id: bwDO._wmHW3ZKDeNPDOvjMYn9Hg6Uriv 09:11:55 INFO - Expected file size: 16508470 09:11:55 INFO - Obtained file size: 16508470 09:12:02 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 09:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:12:02 INFO - Http code: 200 09:12:02 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 09:12:02 INFO - x-amz-cf-id: vetQNCre4Jj7u6Y6fYujo0f5v1AsSzWW24fmXWzF6MT60GQSUkaRYw== 09:12:02 INFO - x-amz-version-id: bwDO._wmHW3ZKDeNPDOvjMYn9Hg6Uriv 09:12:03 INFO - Expected file size: 16508470 09:12:03 INFO - Obtained file size: 16508470 09:12:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:12:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:12:09 INFO - Fetch https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:12:10 INFO - Http code: 200 09:12:10 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 09:12:10 INFO - x-amz-cf-id: dGGyQrXxd6TeIk5h__cLTb-JV03WBCfpMVeY8XBQvqKUNNTszLNI2w== 09:12:10 INFO - x-amz-version-id: te9yKt_LnLMeZE8e0DS6retagMuyyH6K 09:12:10 INFO - Expected file size: 14409006 09:12:10 INFO - Obtained file size: 14409006 09:12:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:11 INFO - trying https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/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 09:12:14 INFO - Downloaded 111691578 bytes. 09:12:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:12:14 INFO - mkdir: /builds/slave/test/properties 09:12:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:12:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:12:14 INFO - Contents: 09:12:14 INFO - build_url:https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:12:14 INFO - Running post-action listener: _resource_record_post_action 09:12:14 INFO - Running post-action listener: set_extra_try_arguments 09:12:14 INFO - [mozharness: 2016-10-11 16:12:14.770545Z] Finished download-and-extract step (success) 09:12:14 INFO - [mozharness: 2016-10-11 16:12:14.770667Z] Running populate-webroot step. 09:12:14 INFO - Running pre-action listener: _resource_record_pre_action 09:12:14 INFO - Running main action method: populate_webroot 09:12:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:12:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:12:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:12:14 INFO - '--tppagecycles', 09:12:14 INFO - '7'], 09:12:14 INFO - 'tests': ['tsvgm']}}, 09:12:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:12:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:12:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:12:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:12:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:12:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['damp', 'tps']}, 09:12:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'tests': ['damp', 'tps']}, 09:12:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['dromaeo_dom']}, 09:12:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:12:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['basic_compositor_video']}, 09:12:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:12:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['a11yr', 09:12:14 INFO - 'ts_paint', 09:12:14 INFO - 'tpaint', 09:12:14 INFO - 'sessionrestore', 09:12:14 INFO - 'sessionrestore_no_auto_restore', 09:12:14 INFO - 'tabpaint']}, 09:12:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:12:14 INFO - 'ts_paint', 09:12:14 INFO - 'tpaint', 09:12:14 INFO - 'sessionrestore', 09:12:14 INFO - 'sessionrestore_no_auto_restore', 09:12:14 INFO - 'tabpaint']}, 09:12:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:12:14 INFO - 'ts_paint', 09:12:14 INFO - 'tpaint', 09:12:14 INFO - 'sessionrestore', 09:12:14 INFO - 'sessionrestore_no_auto_restore', 09:12:14 INFO - 'tabpaint']}, 09:12:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:12:14 INFO - 'ts_paint', 09:12:14 INFO - 'tpaint', 09:12:14 INFO - 'sessionrestore', 09:12:14 INFO - 'sessionrestore_no_auto_restore', 09:12:14 INFO - 'tabpaint']}, 09:12:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['a11yr', 09:12:14 INFO - 'ts_paint', 09:12:14 INFO - 'tpaint', 09:12:14 INFO - 'sessionrestore', 09:12:14 INFO - 'sessionrestore_no_auto_restore', 09:12:14 INFO - 'tabpaint']}, 09:12:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['a11yr', 09:12:14 INFO - 'ts_paint', 09:12:14 INFO - 'tpaint', 09:12:14 INFO - 'sessionrestore', 09:12:14 INFO - 'sessionrestore_no_auto_restore', 09:12:14 INFO - 'tabpaint']}, 09:12:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['tsvgx', 09:12:14 INFO - 'tsvgr_opacity', 09:12:14 INFO - 'tart', 09:12:14 INFO - 'tscrollx', 09:12:14 INFO - 'cart']}, 09:12:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:12:14 INFO - 'tsvgr_opacity', 09:12:14 INFO - 'tart', 09:12:14 INFO - 'tscrollx', 09:12:14 INFO - 'cart']}, 09:12:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'talos_options': ['--disable-e10s'], 09:12:14 INFO - 'tests': ['tp5o']}, 09:12:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'tests': ['tp5o']}, 09:12:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'talos_options': ['--disable-e10s', 09:12:14 INFO - '--xperf_path', 09:12:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:14 INFO - 'tests': ['tp5n']}, 09:12:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:12:14 INFO - 'talos_options': ['--xperf_path', 09:12:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:12:14 INFO - 'tests': ['tp5n']}}, 09:12:14 INFO - 'talos.zip': {'path': '', 09:12:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:12:14 INFO - Running post-action listener: _resource_record_post_action 09:12:14 INFO - [mozharness: 2016-10-11 16:12:14.789299Z] Finished populate-webroot step (success) 09:12:14 INFO - [mozharness: 2016-10-11 16:12:14.789394Z] Running create-virtualenv step. 09:12:14 INFO - Running pre-action listener: _resource_record_pre_action 09:12:14 INFO - Running main action method: create_virtualenv 09:12:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:12:14 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 09:12:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:12:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:12:14 INFO - Using real prefix '/tools/python27' 09:12:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:12:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:12:18 INFO - Installing pip.................done. 09:12:18 INFO - Return code: 0 09:12:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:12:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:12:18 INFO - Reading from file tmpfile_stdout 09:12:18 INFO - Output received: 09:12:18 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) 09:12:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:12:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:12:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09: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', 'pip>=1.5'] in /builds/slave/test/build 09: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 pip>=1.5 09:12:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:18 INFO - 'HOME': '/Users/cltbld', 09:12:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:18 INFO - 'LOGNAME': 'cltbld', 09:12:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:18 INFO - 'MOZ_NO_REMOTE': '1', 09:12:18 INFO - 'NO_EM_RESTART': '1', 09:12:18 INFO - 'PAGER': '/bin/cat', 09:12:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:18 INFO - 'PWD': '/builds/slave/test', 09:12:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:18 INFO - 'SHELL': '/bin/bash', 09:12:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:18 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:18 INFO - 'USER': 'cltbld', 09:12:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:18 INFO - 'XPC_FLAGS': '0x0', 09:12:18 INFO - 'XPC_SERVICE_NAME': '0', 09:12:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:18 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 09:12:18 INFO - Cleaning up... 09:12:19 INFO - Return code: 0 09:12:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:12:19 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')]} 09:12:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:19 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')]} 09:12:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:19 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:19 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 09:12:19 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 09:12:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:19 INFO - 'HOME': '/Users/cltbld', 09:12:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:19 INFO - 'LOGNAME': 'cltbld', 09:12:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:19 INFO - 'MOZ_NO_REMOTE': '1', 09:12:19 INFO - 'NO_EM_RESTART': '1', 09:12:19 INFO - 'PAGER': '/bin/cat', 09:12:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:19 INFO - 'PWD': '/builds/slave/test', 09:12:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:19 INFO - 'SHELL': '/bin/bash', 09:12:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:19 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:19 INFO - 'USER': 'cltbld', 09:12:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:19 INFO - 'XPC_FLAGS': '0x0', 09:12:19 INFO - 'XPC_SERVICE_NAME': '0', 09:12:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:19 INFO - Downloading/unpacking psutil>=3.1.1 09: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 09: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 09: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 09: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 09: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 09: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 09:12:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:12:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:22 INFO - Installing collected packages: psutil 09:12:22 INFO - Running setup.py install for psutil 09:12:23 INFO - building 'psutil._psutil_osx' extension 09:12:23 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 09:12:23 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 09:12:23 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 09:12:23 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 09:12:23 INFO - building 'psutil._psutil_posix' extension 09:12:23 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 09:12:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:12:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:12:23 INFO - ^ 09:12:23 INFO - 1 warning generated. 09:12:23 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 09:12:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:12:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:12:24 INFO - Successfully installed psutil 09:12:24 INFO - Cleaning up... 09:12:24 INFO - Return code: 0 09:12:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:12:24 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')]} 09:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:24 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')]} 09:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:24 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:24 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 09:12:24 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 09:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:24 INFO - 'HOME': '/Users/cltbld', 09:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:24 INFO - 'LOGNAME': 'cltbld', 09:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:24 INFO - 'MOZ_NO_REMOTE': '1', 09:12:24 INFO - 'NO_EM_RESTART': '1', 09:12:24 INFO - 'PAGER': '/bin/cat', 09:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:24 INFO - 'PWD': '/builds/slave/test', 09:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:24 INFO - 'SHELL': '/bin/bash', 09:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:24 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:24 INFO - 'USER': 'cltbld', 09:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:24 INFO - 'XPC_FLAGS': '0x0', 09:12:24 INFO - 'XPC_SERVICE_NAME': '0', 09:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:12:24 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 09:12:24 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 09:12:24 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 09:12:24 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 09:12:24 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 09:12:24 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 09:12:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:12:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:12:27 INFO - Installing collected packages: mozsystemmonitor 09:12:27 INFO - Running setup.py install for mozsystemmonitor 09:12:27 INFO - Successfully installed mozsystemmonitor 09:12:27 INFO - Cleaning up... 09:12:27 INFO - Return code: 0 09:12:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09: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')]} 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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')]} 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:12:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:27 INFO - 'HOME': '/Users/cltbld', 09:12:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:27 INFO - 'LOGNAME': 'cltbld', 09:12:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:27 INFO - 'MOZ_NO_REMOTE': '1', 09:12:27 INFO - 'NO_EM_RESTART': '1', 09:12:27 INFO - 'PAGER': '/bin/cat', 09:12:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:27 INFO - 'PWD': '/builds/slave/test', 09:12:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:27 INFO - 'SHELL': '/bin/bash', 09:12:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:27 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:27 INFO - 'USER': 'cltbld', 09:12:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:27 INFO - 'XPC_FLAGS': '0x0', 09:12:27 INFO - 'XPC_SERVICE_NAME': '0', 09:12:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:12:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:12:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:12:30 INFO - warning: no files found matching '*.txt' 09:12:30 INFO - no previously-included directories found matching 'build' 09:12:30 INFO - no previously-included directories found matching 'dist' 09:12:30 INFO - no previously-included directories found matching '.git*' 09:12:30 INFO - Installing collected packages: jsonschema, functools32 09:12:30 INFO - Running setup.py install for functools32 09:12:30 INFO - warning: no files found matching '*.txt' 09:12:30 INFO - no previously-included directories found matching 'build' 09:12:30 INFO - no previously-included directories found matching 'dist' 09:12:30 INFO - no previously-included directories found matching '.git*' 09:12:30 INFO - Successfully installed jsonschema functools32 09:12:30 INFO - Cleaning up... 09:12:30 INFO - Return code: 0 09:12:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:12:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:30 INFO - 'HOME': '/Users/cltbld', 09:12:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:30 INFO - 'LOGNAME': 'cltbld', 09:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:30 INFO - 'MOZ_NO_REMOTE': '1', 09:12:30 INFO - 'NO_EM_RESTART': '1', 09:12:30 INFO - 'PAGER': '/bin/cat', 09:12:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:30 INFO - 'PWD': '/builds/slave/test', 09:12:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:30 INFO - 'SHELL': '/bin/bash', 09:12:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:30 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:30 INFO - 'USER': 'cltbld', 09:12:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:30 INFO - 'XPC_FLAGS': '0x0', 09:12:30 INFO - 'XPC_SERVICE_NAME': '0', 09:12:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:12:30 INFO - Cleaning up... 09:12:31 INFO - Return code: 0 09:12:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:12:31 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')]} 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:31 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')]} 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:31 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:31 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 09:12:31 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 09:12:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:31 INFO - 'HOME': '/Users/cltbld', 09:12:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:31 INFO - 'LOGNAME': 'cltbld', 09:12:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:31 INFO - 'MOZ_NO_REMOTE': '1', 09:12:31 INFO - 'NO_EM_RESTART': '1', 09:12:31 INFO - 'PAGER': '/bin/cat', 09:12:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:31 INFO - 'PWD': '/builds/slave/test', 09:12:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:31 INFO - 'SHELL': '/bin/bash', 09:12:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:31 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:31 INFO - 'USER': 'cltbld', 09:12:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:31 INFO - 'XPC_FLAGS': '0x0', 09:12:31 INFO - 'XPC_SERVICE_NAME': '0', 09:12:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:33 INFO - Downloading blobuploader-1.2.4.tar.gz 09:12:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:12:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:12:33 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 09:12:33 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 09:12:33 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 09:12:33 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 09:12:33 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 09:12:33 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 09:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:12:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09: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 09: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 09: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 09: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 09: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 09: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 09:12:34 INFO - Downloading docopt-0.6.1.tar.gz 09:12:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:12:34 INFO - Installing collected packages: blobuploader, requests, docopt 09:12:34 INFO - Running setup.py install for blobuploader 09:12:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:12:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:12:35 INFO - Running setup.py install for requests 09:12:35 INFO - Running setup.py install for docopt 09:12:35 INFO - Successfully installed blobuploader requests docopt 09:12:35 INFO - Cleaning up... 09:12:35 INFO - Return code: 0 09:12:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:35 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:35 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 09:12:35 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 09:12:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:35 INFO - 'HOME': '/Users/cltbld', 09:12:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:35 INFO - 'LOGNAME': 'cltbld', 09:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:35 INFO - 'MOZ_NO_REMOTE': '1', 09:12:35 INFO - 'NO_EM_RESTART': '1', 09:12:35 INFO - 'PAGER': '/bin/cat', 09:12:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:35 INFO - 'PWD': '/builds/slave/test', 09:12:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:35 INFO - 'SHELL': '/bin/bash', 09:12:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:35 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:35 INFO - 'USER': 'cltbld', 09:12:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:35 INFO - 'XPC_FLAGS': '0x0', 09:12:35 INFO - 'XPC_SERVICE_NAME': '0', 09:12:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-1ikdnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-BEOCK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Ro3FXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-jyoZp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-pcfhcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-K0nKS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-2qNBRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Defmn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:36 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-rWKyUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-qRiFhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-AcPmZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Cg1Vbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-dorDAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-hFl8cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-5IuVpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Akte8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:37 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-LLVM49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:12:37 INFO - Running setup.py install for manifestparser 09:12:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozcrash 09:12:38 INFO - Running setup.py install for mozdebug 09:12:38 INFO - Running setup.py install for mozdevice 09:12:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozfile 09:12:38 INFO - Running setup.py install for mozhttpd 09:12:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozinfo 09:12:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:12:38 INFO - Running setup.py install for mozInstall 09:12:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for mozleak 09:12:39 INFO - Running setup.py install for mozlog 09:12:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for moznetwork 09:12:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for mozprocess 09:12:39 INFO - Running setup.py install for mozprofile 09:12:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:12:39 INFO - Running setup.py install for mozrunner 09:12:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:12:40 INFO - Running setup.py install for mozscreenshot 09:12:40 INFO - Running setup.py install for moztest 09:12:40 INFO - Running setup.py install for mozversion 09:12:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:12:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:12:40 INFO - Cleaning up... 09:12:40 INFO - Return code: 0 09:12:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:40 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:40 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 09:12:40 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 09:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:40 INFO - 'HOME': '/Users/cltbld', 09:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:40 INFO - 'LOGNAME': 'cltbld', 09:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:40 INFO - 'MOZ_NO_REMOTE': '1', 09:12:40 INFO - 'NO_EM_RESTART': '1', 09:12:40 INFO - 'PAGER': '/bin/cat', 09:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:40 INFO - 'PWD': '/builds/slave/test', 09:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:40 INFO - 'SHELL': '/bin/bash', 09:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:40 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:40 INFO - 'USER': 'cltbld', 09:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:40 INFO - 'XPC_FLAGS': '0x0', 09:12:40 INFO - 'XPC_SERVICE_NAME': '0', 09:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:12:40 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-KxtthM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:12:40 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)) 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:12:40 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-a4b8os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:12:40 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)) 09:12:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:12:40 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-34XAbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-atdBhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-eXcQ07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-jJKoa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-yoCxZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-zW9cP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-WAXhmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-Pahhy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-As5pmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:12:41 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)) 09:12:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:12:41 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-fw4FJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:12:42 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)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:12:42 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-bRKd5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:12:42 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)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:12:42 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-TjCi_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:12:42 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)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:42 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-pyHMzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:12:42 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)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:12:42 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-sNTyOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:12:42 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)) 09:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:12:42 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-arsJyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:12:42 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)) 09:12:42 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)) 09:12:42 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)) 09:12:42 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)) 09:12:42 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)) 09:12:42 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)) 09:12:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:12:45 INFO - Downloading blessings-1.6.tar.gz 09:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:12:45 INFO - Installing collected packages: blessings 09:12:45 INFO - Running setup.py install for blessings 09:12:45 INFO - Successfully installed blessings 09:12:45 INFO - Cleaning up... 09:12:45 INFO - Return code: 0 09:12:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:12:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:45 INFO - Reading from file tmpfile_stdout 09:12:45 INFO - Current package versions: 09:12:45 INFO - blessings == 1.6 09:12:45 INFO - blobuploader == 1.2.4 09:12:45 INFO - docopt == 0.6.1 09:12:45 INFO - functools32 == 3.2.3-2 09:12:45 INFO - jsonschema == 2.5.1 09:12:45 INFO - manifestparser == 1.1 09:12:45 INFO - mozInstall == 1.12 09:12:45 INFO - mozcrash == 0.17 09:12:45 INFO - mozdebug == 0.1 09:12:45 INFO - mozdevice == 0.48 09:12:45 INFO - mozfile == 1.2 09:12:45 INFO - mozhttpd == 0.7 09:12:45 INFO - mozinfo == 0.9 09:12:45 INFO - mozleak == 0.1 09:12:45 INFO - mozlog == 3.4 09:12:45 INFO - moznetwork == 0.27 09:12:45 INFO - mozprocess == 0.23 09:12:45 INFO - mozprofile == 0.28 09:12:45 INFO - mozrunner == 6.12 09:12:45 INFO - mozscreenshot == 0.1 09:12:45 INFO - mozsystemmonitor == 0.3 09:12:45 INFO - moztest == 0.7 09:12:45 INFO - mozversion == 1.4 09:12:45 INFO - psutil == 3.1.1 09:12:45 INFO - requests == 1.2.3 09:12:45 INFO - wsgiref == 0.1.2 09:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:12:45 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')]} 09:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 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')]} 09:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:45 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:45 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 09:12:45 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 09:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:45 INFO - 'HOME': '/Users/cltbld', 09:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:45 INFO - 'LOGNAME': 'cltbld', 09:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:45 INFO - 'MOZ_NO_REMOTE': '1', 09:12:45 INFO - 'NO_EM_RESTART': '1', 09:12:45 INFO - 'PAGER': '/bin/cat', 09:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:45 INFO - 'PWD': '/builds/slave/test', 09:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:45 INFO - 'SHELL': '/bin/bash', 09:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:45 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:45 INFO - 'USER': 'cltbld', 09:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:45 INFO - 'XPC_FLAGS': '0x0', 09:12:45 INFO - 'XPC_SERVICE_NAME': '0', 09:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 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)) 09:12:46 INFO - Cleaning up... 09:12:46 INFO - Return code: 0 09:12:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:12: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')]} 09:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12: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')]} 09:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:12:46 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 0x108762490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f91b9572e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, '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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 09:12:46 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 09:12:46 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 09:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:12:46 INFO - 'HOME': '/Users/cltbld', 09:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:12:46 INFO - 'LOGNAME': 'cltbld', 09:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:12:46 INFO - 'MOZ_NO_REMOTE': '1', 09:12:46 INFO - 'NO_EM_RESTART': '1', 09:12:46 INFO - 'PAGER': '/bin/cat', 09:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:12:46 INFO - 'PWD': '/builds/slave/test', 09:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:12:46 INFO - 'SHELL': '/bin/bash', 09:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:12:46 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:12:46 INFO - 'USER': 'cltbld', 09:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:12:46 INFO - 'XPC_FLAGS': '0x0', 09:12:46 INFO - 'XPC_SERVICE_NAME': '0', 09:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:12:46 INFO - Cleaning up... 09:12:46 INFO - Return code: 0 09:12:46 INFO - Running post-action listener: _resource_record_post_action 09:12:46 INFO - Running post-action listener: _start_resource_monitoring 09:12:46 INFO - Starting resource monitoring. 09:12:46 INFO - [mozharness: 2016-10-11 16:12:46.328662Z] Finished create-virtualenv step (success) 09:12:46 INFO - [mozharness: 2016-10-11 16:12:46.329733Z] Running install step. 09:12:46 INFO - Running pre-action listener: _resource_record_pre_action 09:12:46 INFO - Running main action method: install 09:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:12:46 INFO - Reading from file tmpfile_stdout 09:12:46 INFO - Detecting whether we're running mozinstall >=1.0... 09:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:12:46 INFO - Reading from file tmpfile_stdout 09:12:46 INFO - Output received: 09:12:46 INFO - Usage: mozinstall [options] installer 09:12:46 INFO - Options: 09:12:46 INFO - -h, --help show this help message and exit 09:12:46 INFO - -d DEST, --destination=DEST 09:12:46 INFO - Directory to install application into. [default: 09:12:46 INFO - "/builds/slave/test"] 09:12:46 INFO - --app=APP Application being installed. [default: firefox] 09:12:46 INFO - mkdir: /builds/slave/test/build/application 09:12:46 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'] 09:12:46 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 09:13:20 INFO - Reading from file tmpfile_stdout 09:13:20 INFO - Output received: 09:13:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:13:20 INFO - Running post-action listener: _resource_record_post_action 09:13:20 INFO - [mozharness: 2016-10-11 16:13:20.299313Z] Finished install step (success) 09:13:20 INFO - [mozharness: 2016-10-11 16:13:20.299485Z] Running run-tests step. 09:13:20 INFO - Running pre-action listener: _resource_record_pre_action 09:13:20 INFO - Running main action method: run_tests 09:13:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:13:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:13:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:13:20 INFO - 2016-10-11 09:13:20.313 screenresolution[1679:7833] starting screenresolution argv=screenresolution get 09:13:20 INFO - 2016-10-11 09:13:20.316 screenresolution[1679:7833] Display 0: 1600x1200x32@60 09:13:20 INFO - 2016-10-11 09:13:20.322 screenresolution[1680:7835] starting screenresolution argv=screenresolution list 09:13:20 INFO - Available Modes on Display 0 09:13:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:13:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:13:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:13:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:13:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:13:20 INFO - Intel Iris: 09:13:20 INFO - Chipset Model: Intel Iris 09:13:20 INFO - Type: GPU 09:13:20 INFO - Bus: Built-In 09:13:20 INFO - VRAM (Dynamic, Max): 1536 MB 09:13:20 INFO - Vendor: Intel (0x8086) 09:13:20 INFO - Device ID: 0x0a2e 09:13:20 INFO - Revision ID: 0x0009 09:13:20 INFO - Displays: 09:13:20 INFO - Display: 09:13:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:13:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:13:20 INFO - Display Serial Number: 1600x1200 60 09:13:20 INFO - Main Display: Yes 09:13:20 INFO - Mirror: Off 09:13:20 INFO - Online: Yes 09:13:20 INFO - Rotation: Supported 09:13:20 INFO - Return code: 0 09:13:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:13:20 INFO - Python 2.7.3 09:13:20 INFO - Return code: 0 09:13:20 INFO - grabbing minidump binary from tooltool 09:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:13:20 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 0x108576d30>, '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 0x10839cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10856eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:13:20 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 09:13:20 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 09:13:20 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 09:13:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:13:20 INFO - Return code: 0 09:13:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:13:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:13:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:13:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:13:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:13:20 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/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 09:13:20 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/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0239 --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 09:13:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DZRMZ0YEsp/Render', 09:13:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:13:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:13:20 INFO - 'HOME': '/Users/cltbld', 09:13:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:13:20 INFO - 'LOGNAME': 'cltbld', 09:13:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:13:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:13:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:13:20 INFO - 'MOZ_NO_REMOTE': '1', 09:13:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:13:20 INFO - 'NO_EM_RESTART': '1', 09:13:20 INFO - 'PAGER': '/bin/cat', 09:13:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:13:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:13:20 INFO - 'PWD': '/builds/slave/test', 09:13:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:13:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:13:20 INFO - 'SHELL': '/bin/bash', 09:13:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CqcNqL0xUF/Listeners', 09:13:20 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 09:13:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:13:20 INFO - 'USER': 'cltbld', 09:13:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:13:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:13:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:13:20 INFO - 'XPC_FLAGS': '0x0', 09:13:20 INFO - 'XPC_SERVICE_NAME': '0', 09:13:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:13:20 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/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 09:13:20 INFO - mozversion application_buildid: 20161011072447 09:13:20 INFO - mozversion application_changeset: 50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e 09:13:20 INFO - mozversion application_display_name: Nightly 09:13:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:13:20 INFO - mozversion application_name: Firefox 09:13:20 INFO - mozversion application_remotingname: firefox 09:13:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:13:20 INFO - mozversion application_vendor: Mozilla 09:13:20 INFO - mozversion application_version: 52.0a1 09:13:20 INFO - mozversion platform_buildid: 20161011072447 09:13:20 INFO - mozversion platform_changeset: 50d7b9b0b42334bf8bd9f16d8bf623d9b5360d8e 09:13:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:13:20 INFO - mozversion platform_version: 52.0a1 09:13:20 INFO - using testdate: 1476202400 09:13:20 INFO - actual date: 1476202400 09:13:20 INFO - starting webserver on 'localhost:49275' 09:13:20 INFO - SUITE-START | Running 2 tests 09:13:20 INFO - TEST-START | dromaeo_css 09:13:20 INFO - operating with platform_type : mac_ 09:13:20 INFO - Initialising browser for dromaeo_css test... 09:13:20 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpRg1HWE/profile http://localhost:49275/getInfo.html) 09:13:23 INFO - PROCESS | 1690 | __metrics Screen width/height:1600/1200 09:13:23 INFO - PROCESS | 1690 | colorDepth:24 09:13:23 INFO - PROCESS | 1690 | Browser inner width/height: 1024/689 09:13:23 INFO - PROCESS | 1690 | __metrics 09:13:23 INFO - PROCESS | 1690 | 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" 09:13:23 INFO - PROCESS | 1690 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:24 INFO - TEST-INFO | 1690: exit 0 09:13:24 INFO - Browser initialized. 09:13:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:13:24 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpRg1HWE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:35 INFO - PROCESS | 1694 | RSS: Main: 234958848 09:13:35 INFO - PROCESS | 1694 | 09:14:27 INFO - PROCESS | 1694 | 1476202467843 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] 09:16:40 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 09:16:41 INFO - PROCESS | 1694 | RSS: Main: 387993600 09:16:41 INFO - PROCESS | 1694 | 09:19:44 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 09:19:45 INFO - PROCESS | 1694 | RSS: Main: 368185344 09:19:45 INFO - PROCESS | 1694 | 09:22:47 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 09:22:48 INFO - PROCESS | 1694 | RSS: Main: 338550784 09:22:48 INFO - PROCESS | 1694 | 09:25:50 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 09:25:51 INFO - PROCESS | 1694 | RSS: Main: 333123584 09:25:51 INFO - PROCESS | 1694 | 09:28:54 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 09:28:55 INFO - PROCESS | 1694 | RSS: Main: 333783040 09:28:55 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 09:31:58 INFO - PROCESS | 1694 | RSS: Main: 377610240 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | __start_tp_report 09:31:58 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 09:31:58 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 09:31:58 INFO - PROCESS | 1694 | |i|pagename|runs| 09:31:58 INFO - PROCESS | 1694 | |0;dojo.html;3296.077098412444;3301.603807543095;3312.6687331266867;3340.398728228921;3373.257883265681;5559.638623489471;5594;5617.4382561743805;5636.549076073915;5656.123300888364;5615.382307946123;5674.035413979623;5738;5764;5772.595918285721;4258.169656916903;5102.872428189288;5136.897262054776;5160.406553246387;5219.138842091051;5236.8690782730355;5283.101872681654;5285.973570132144;5297.814576489824;5346.438623944488;5225.529702326771;5251.789928402859;5295.232191332255;5299.311089558352;5337.412884582693;5113.463086375951;5129.948700512984;5169.689818610896;5173.870653233662;5185.066687996159;5141.126008578551;5142.51146141116;5163.14808056674;5193.584513238932;5200.6879587224885;5698.202251684767;5711.371749107595;5717.456841600041;5721.570882183812;5750.741216645261;5734.455226753452;5792.82621521355;5910.054391297414;5978.671173085479;5991.400859914017;6119.502553941423;6129.20320358355;6204.410580994843;6261.46777523911;6305.0857625644485;5756.0502517084215;5757.596968212227;5761.654300741969;5765.106408506688;5766.654000759968;6091.20956991861;6201.844953876099;6208.50331973441;6303.086052522451;6317.241930968221;6018.879622407528;6058.878822423527;6081.604695694766;6101.519919784808;6119.938800612026;6235.033569796688;6237.563370564017;6242.687865606701;6245.6252624842655;6251.468625166912;6070.605410648293;6107.541934354852;6140.140380346755;6171.382861713792;6180.3201647818705;6007.189029481052;6095.573309868267;6109.2974307955155;6112.144299798032;6112.449879510866;4859.854204373874;4875;4879.804807807719;4881.072596206709;4887.486813884562;4273.423087883159;4385.495667998157;4452.443444569429;4482.618977386894;4484.775761211927;5679.488846003796;5701.800436984769;5732.312122545238;5753.482186603226;5756.769729210785;6193.597416167935;6200.100985357098;6208.192934918522;6234.657093859791;6236.968815155986;4820.758962051884;5443.618946673774;5681.261436013292;5696.515796157373;5720.08478643415;5156.664816786972;5203.635745497779;5323.653962492425;5387.8114266001285;5404.729763511808;6251.499880009679;6268.27914789805;6286;6298.685065746694;6301.054841773771;6295.874082518232;6310.463610592968;6316;6317;6331.2085989251345;6220.098085777447;6281.780137695158;6287.528435367274;6301.149344838388;6314.715837787402;6085.361037091218;6138.478229350555;6140;6173.629582225081;6190.845228869314;6218.19163508741;6233.314335423009;6238.812835614939;6243.843903902439;6261.937380626136;5761.452661997104;5907;6002.189704390026;6104.043480857749;6133.38666133401;5974.641521508724;5986.970065149821;6007.158997740407;6052.6973651316375;6073.848153796191;5950.285965684146;5951.375105613848;5954.136650185612;5957.4042595740075;5982.312034116132;6034.547408944434;6059.272887253558;6072.392760724069;6115.449609535163;6120.60216085953;5733.140028995684;5780.421957804186;5810.389909059657;5816.912746308724;5916.49709774674 09:31:58 INFO - PROCESS | 1694 | |1;ext.html;486.84420985284703;520.8880090780482;524.7720334417462;525.8369905329348;530.3476723629935;30264.243393915163;30817.69182308176;40479.797601012026;41015.58984410155;41055.76832695024;41782.16435671285;42066.73799786012;42182;42187.15625687484;42269.36595951063;9302.209312208453;9487.146156845882;9493.71518854432;9503.382280151767;9509.904900951005;8528.701495447629;8779.165979231995;11096.833547496793;11389.772204555904;11402.942985285063;11325.490352934097;11397.430128493583;11422.600208992686;11424.485898134562;11459.02598279143;8593;11309.434528273594;11374;11377.146713996483;11384.203105782557;8487.702930397469;8624.65501379944;8629.61166747498;8645.610947507377;10934.617288394948;38055.858324250315;40573;40611.1877762446;40650.79674601608;40662.79668601668;3289.2434740009694;3304.1244070321386;3309.3050459403553;3968.0873399118077;3969.821358038895;29963.951261705955;30405.087847364393;30461.086167414793;31109.8444507776;31139.84430077858;3196.31279274957;3207.7273431758326;3214.774965752398;3248.805071695706;3282.786618869766;503065;507833.46083269716;507966;509442;518053;49107.50892491101;49378.50621493811;49817.501824981286;50749;59982;59678;59814.401855981756;60060;60079;60090.39909600936;15716.60708482297;15852;15861.968972016783;15865.04809711421;15876.841231587767;11086.16853735973;11392.658220253406;12265.386730663431;12385.1949623276;12405.937970310271;12216.511339546496;14818.184999825113;14853.960222784517;14855.777163342558;16322.673546529002;5961.672108034099;6985.825354366079;7165.498415110997;7171.533850299714;7209.170945341248;881.299367003234;939.8355287824603;982.9361091529028;1055.5883205549842;1090.3076546393097;29304;29756.55365169524;30071.548926766118;30259.69740302613;30301.545476817864;1049.41757324684;1074;1099.378850949211;1110.3892858927557;1176.952921883115;16139.596510087342;16204.83795162057;16354.345826167058;16409.507714768577;16540.6691866162;555893;557899;560498;562102;571956;56853.71573142108;57190;57195.71402142962;57289.71355143281;57463;1155.78040172367;1217.4764851113928;1250.2748405924542;1345.3407830163148;1364.1814911053289;24861.87569062143;29069.273268168465;30473.390532188787;30556.388872222877;31124;49078.5092149074;49672.751636241584;49691.75154124206;49899.50100499094;49999.500004999485;456412;531028;532459;533240;534500;24671;25750.227493175236;25942.48115037651;26130.86934565315;27297.90808367643;46202.76898615486;46622.76688616671;46803.29795053009;47757.52242477531;47775.52224477711;38600.472907782714;38731.41902871516;38807.61192388153;40298;40520.392194116524;38259.80870095632;38594.80702596469;38783.418248726855;39700.40449393204;40069;37581.4362784553;38563.84308470751;38664.42003370008;38794.22411551697;38822.835314940596;26236.606450903633;31225.97031192965;32771.67228327782;34239;34359.31281374308;24819.503609928062;25114;25334.366640834127;25646.87176564105;25856 09:31:58 INFO - PROCESS | 1694 | |2;jquery.html;353.6587193358409;357.5530586766542;378.20388083085106;386.55428696674437;408.4934680995565;11663.766724665502;14691.412343506261;15881.444149454772;20038.799612003913;20703.171873125095;19387.515312117204;19948.900255498702;20490.795092049077;20627.38117856463;20858.791412085873;5614.635048721841;5660.78293166969;5736.827895163152;6046.244219472566;6049.304330002062;5656.321241451032;5972.910406343908;6031.396860313956;6066.332703402622;6069.150318955328;5665.830025099253;6054.061620448815;6056.909146362808;6059.121427393025;6067.150598916155;5860.208871802295;6036.96981515094;6043.8186854394435;6056.666883321415;6061.727222275008;5058.317127187819;5316.3620365556;5377.7311134443125;5758.48173664368;5780.595358324919;13043;13114.737705245841;13172.275524846129;13289.933550332187;13305.534306299232;1797.766290382255;2096.444442222812;2159.416957421503;2161.427221786228;2240.8207343412487;9629.903700963041;10152;10261.589536418534;12498.437570309357;13910.608939106009;1540.6610545679932;1813.9365122220659;1827.6070644811296;1899.059965317163;1917;96324;110273;117958;122407.16389254079;123897.14154287693;8576.656933722581;9071.410358326688;9329.346945713734;11308.886911130949;11326.37704926237;11863.822042669366;14239.145651260958;14263.215523146118;14265.144091354552;14269.500567480089;7031.437485001187;8248.793780155544;8382.832343353099;8396.496210227406;8419.621117049624;8234.382421318425;8265.090840007595;8432.915670843213;8449.155084491624;8459.577021148918;4350.825966961349;4420.9336859947125;4467.597916187558;4486.798094085774;4508.301213311942;1654.0571874031687;1837.200817644329;1878.6054928465176;1888.6128343689786;1899.4111825334192;787.3779714025856;865.2645251536144;907.8683590879285;942.1191186240886;1020.1787561013307;19938.401847944584;21535.13859445636;21571.784282157292;21670.658175789125;21739.34781956544;913.9588718507683;915.5422288855572;920.2362039507193;972.7081875437341;980.1472718734747;9538.284628652878;9936.751581210383;11078.670559532908;11120.332780033224;11162.493063436494;550979;555250;559587.202063987;574212.128939361;578854;99549.50225248828;116310.41844790721;123795;126744.73255267514;138445;799.5322736199389;959.9040095990345;984.6996666016934;986.4673076538733;986.8865080515689;18791;19119.713204301668;19131.61736765285;19150;19190.94449805274;45635.08729825451;52770.47229527656;53600.73199633977;54801.45198548123;54803.72598136984;75463;76587.23412765801;78310.6084469574;79268.60365698134;80180;7475.887861682188;7737.961310193413;7959.880601791094;7973.282404583615;8116.59417029158;11471.655850324503;12144.33206173669;12487.875121249035;12655.240685558896;12715.173513721578;5333.3066701330135;6574.539782215199;8590.613422395882;9230.215431688383;11326.32042077478;10685.091767199876;10888.346699198073;11058.060064894253;11251.549938002388;11428.971392574707;10612.681619551426;10985.633409016586;11583.247088939192;11612.825807613062;11656.592019279284;6917.792466226021;7208.747693830691;7217.953396757546;7410.11078670563;8128.552929588929;9344.859827102735;10926.344419334866;10966.835497467704;11346.602868899548;11353.772924541297 09:31:58 INFO - PROCESS | 1694 | |3;mootools.html;1289.9742005159897;1369.6096612465449;1435.7989881416602;1627.6907387596357;1894.1665667106472;7781.9221807781905;8239.629216685256;8515.020772611144;8805.383623146367;8829.381943263958;8619.181177788116;8705.956470217656;8707.869381959275;8724.651013959434;8734.995475520316;2324.8488848224897;2357.9410514737096;2359.929202123939;2360.5160942006933;2368.7631236876346;2311.3528212100637;2340;2360.551495215912;2365.5387199496104;2367.0176876596192;1990.910409031597;2345.155743932183;2355.0462062864567;2356.3402247370764;2367.9052837886466;2293.690351802502;2319.246244970383;2336.6027775278244;2338.158263025301;2339.0760649543504;2307.8499897506777;2312.225404489481;2314.1206341590087;2314.953700925972;2315.490592069742;8745.125487451267;8801.559922003938;8815.206631403205;8836.204741573289;8844.513551754651;5074.4671809460215;5298.178782288752;5306.628536002481;5331.653442526223;5334.59990500714;3462.567179102612;3599.928001439983;3679.8528058877614;3680.245549662313;3688.2254726507467;1046.6650671785033;1078.6170909327234;1084.0731174845473;1103.3710784852638;1106.9944650276698;11538.884611153864;11571.710707232302;11643.18497705161;11647.767044659144;11669.883301166965;4301.741895486281;4359.280718681445;4540.387047748512;4549.45406551216;4553.931691024637;9075.047120052432;9075.636974520945;9077.183053525214;9087.727368178965;9101;5164.25118357836;5166.638335316567;5173.068847607392;5176.9741151294;5185.896282074337;4303.870883873489;4308.547602501755;4467;4472.955270447319;4854.8786280342565;3674.3937250353392;3693.372126738461;3760.8375184268607;3761.605031471711;3762.6989840813217;1144.4220668562323;1147.271482608533;1151.9366434846163;1161.2451906260828;1163.5345861655237;900.5587262241454;903.8327909336793;906.727981605529;955.4661494118784;955.9569819358146;5757.481826635623;5788.857619605028;5944.970275148683;5967.46292833647;6074.483668888194;416.7332906939561;436.1734513097662;436.79688944640895;438.4760211547234;443.4368352192762;3824;4022.434536800752;4029.899252518652;4033.616806403387;4035.2333056719717;8146.674133034612;10407.895921040692;10653.520591573399;10758.838617420744;10762;10261.333013354108;10669.83995240072;10696.78606427867;10699.572017119384;10701.036906678437;7895.131535531087;7993.760187194393;8148.388870834592;8219.671213151527;8227.259546640831;5377.327834020747;5385.299911011543;5493.9286839066;5971.716081042597;6207.317195108444;8765.430247034177;9623.951880240555;9711.951440243036;10030.548625311732;10158.187345012233;9903.158231550111;10103.646372376932;10215.846762298423;10232.283740138417;10276.434796086287;7482.700691972478;7614.428917831296;7621.504602201061;7629.809254768676;7638.923610763822;8063.798405039921;8207.835843282981;8302.418830682036;8340.082590915115;8343.249107580346;7528.247175282428;7537.585432801248;7545.434092442979;7578.658960346687;7610.657520411484;7391;7417.184109748031;7435.591042492715;7474.103107627119;7483.251674832473;6954.269801670954;6965.303469652994;7040.612766297698;7041.436685065285;7053.894191587233;5007.173816320266;5028.64799464034;5066.189409694432;5113.974430127974;5161.845144645667;4992.700437973734;5022.773975171199;5110.872228194325;5256.132738098171;5266.1574148136115 09:31:58 INFO - PROCESS | 1694 | |4;prototype.html;302.6474157606388;310.65982748889974;311.33374578402226;316.82416258976275;320.61366053905044;4605;5299.9330261198165;5316.388615309241;5405.108212125759;5436.374816896058;4384.627306678936;4629.560191781776;5131.461196574362;5352.2239275305055;5534.972325138378;3527.735419843509;3891.735186064533;4028.798560071985;4033.899152521196;4041.737287076345;2826.7879909006806;3334.933301333972;4032.2741906456827;4062.5124985001694;4143.316352801784;3838.596947320533;3973.1060511384994;4067.3492241241406;4080.9795951020205;4107.774072426016;3356.63077061523;3579.480975258586;3914.7063970202207;4099.508059032905;4121.9587804122175;2966.8664910078883;3345.3476572068457;3470.548828652259;3480.564929383827;3560.590532088817;4704.717716936961;5174.8356619760625;5186.585073194173;5195.584353251768;5210.687358758487;4013.13717550728;4244.808983595745;4684.3910291662205;4703.388559487279;4710.811567537295;5364.758585863646;5593.412691667398;5656.038473459522;5658.462446067617;5708.4291570843;3509.3858574749315;3939.247035069395;3942.6451619354107;3957.544882338539;3989.4614227079264;4765.237561990065;5575.944240557583;5779.913301300484;5855.795047173371;6000.489958353545;3385.6952874241438;3635.8727444539313;3789;3934.842606295716;3991.7604943703473;3400.259714314284;3963.5441924178513;4106.979465102655;4109.773962432095;4119.485064366954;4268.679849011274;4486.227939963761;4663.738087027788;4743.667943244009;4744;5590.580706447033;5668.619179944433;5677.460641239076;5694.544436445074;5699.74351154199;1252.642996745923;1263.3493750718387;1325.516186591887;1355.722076974218;1355.922041976631;740.6666999850089;813.9837203255902;824.6928618140315;829.5354601423222;832.9708460203864;3630.5098811660087;4394.638101852086;4435.844745433894;4444.4888837784065;4450.1767173073085;4188.748675079505;4215.683823713233;4421.447319085114;4775.498572649822;4794.400699912511;3948.874570747381;4405.634253381462;4417.835260722287;4418.558144185556;4438.424359352448;2034.379514248139;2117.3696253884423;2471.189841207716;2553.3744232663116;2561.8975240990153;4092.5293591237387;4435.512093669694;4951.019592163091;4954.009198160383;4980.8983994606315;4176.665866730655;4266.208192559133;4866.343043689057;4896.559309662076;4979.418934580195;4236.491621005499;4630.976845115752;4651.4880565851745;4978;5046.3506659004315;4626.930596041129;4781.7609119543185;4792.7124372537755;4799.9760001199775;4801.351817504592;3940.645341919241;4797.328374027708;4797.776566975399;4823.686460380064;4848.781804818862;5009.624278179224;5246.842594722164;5564.527015203591;6006;6010.978133717191;3692.3722967095123;3862.208247309351;3874.0121269076203;3879.592642772468;3887.358585833306;5093;5286.81496147633;5686.744096515584;5791.855203619774;5824.912626310524;4609.88475288107;4656.81129868961;5329.973350133225;5611.691356975405;5619.971900140473;5032.370953630796;5550.250716153268;5620.634658747168;5624.465675760796;5652.63257888236;4322.632576231055;5384.003959267548;5466.289382380265;5473.452654734654;5533.695646739468;4972;5712.542996560348;5740.282464691913;5744.214056182832;5775.884482310415;5595.496405323541;5596;5597.580181486323;5622.662640241599;5634.154876768517 09:31:58 INFO - PROCESS | 1694 | |5;yui.html;704.890741935;716.989245161323;742.6286856571714;792.9365650747941;800.3797057280607;15098;15345.693086138284;15379.923100384482;15406.922965385158;15411.922940385297;13728.656783580416;13795.172289662627;13808.654783630414;13829;13833.723325533509;672.9057931889515;689.9310068993086;690.506288004077;830.236182711905;833.8332333533288;833.6457005772553;841.7306461932184;845.18439705684;848.2747251100313;854.6666799948025;852.3735054734765;906.2342320738998;908.8364094462994;910.7267819654111;910.877031600732;709.0427922304899;727.4435057181261;739.5710487916995;898.4070513461116;898.5776684958059;541.9729013549306;544.3930018029907;655.4821690864212;675.2403546010738;677.3598948993204;14547.563573092719;14564.85435145656;14585.19781412022;14586.34361453737;14603.561893143222;11707.180497365187;13195.934020329933;13427.12723672958;13545;13662.11196272239;11989.460474278678;12229.327386993711;12275.263484190888;12310.384480775925;12625.242485450903;4364.214441400547;4386.0569977455;4415.624671902892;4448.132614140244;4461.152381047591;105027;105204.42193367105;106129.93870061355;113438.08900065457;114542;9660.227181825438;9700.320977531504;9706.174975127053;9849.409035457895;9910.603575856885;20531.38405847827;20730.792692073188;20735.377938661863;20763.169473220903;20776.68834967477;7628.847423051508;7647.808804779925;7663.425243106678;7718.652660630285;7784.844303113906;4081.428599996003;4122.505299364096;4176.18564379943;4193.412922190896;4345.261305578059;3330.7501937354796;3418.0087774545104;3439.914002149966;3446.603640581365;3448.517207590939;541.2719891745596;624.4224092714221;630.8044506203091;645.1902861908369;648.7502311610064;565.3583183087144;590.7991282963727;607.2257871214238;618.6628287583278;631.0156156396037;8566.143385661384;8620.91379086201;8645.524496152771;8949.328800340001;9077.04691007448;574.7068994812593;624.5503237668871;625.4496043481707;629.4775336470718;638.5242993969522;3757.385386283759;4199.895002624959;4370.409994650681;4389.604935555815;4476.104779044139;162537.18731406503;168308.15845920937;170433;170702;174443;95335;136601.31699341637;143128;146487;147933.26033369763;88436.11563884407;89427;98034;106026;107389.4630526858;9290.72127836166;9637.277204209853;9674.854877176707;9801.11789938909;9931.801363972825;49524.25713614371;60666.696666516385;61704.76590468255;61778.69110654418;62663;81555.96110097296;90430;90512.54743726239;91672.54163729139;91851;12815.735195942825;12838.55065072718;12998.207520469325;13024.609261722164;13176.077674563072;14447.927760361132;14530.491432799801;14625.561233163022;14719.411223550938;14727.631809204428;13195.340232988505;13360.732785344433;13474.93262533681;13609.047366684634;13648.317584120556;13685.726285474035;13752.518661846787;13778;13804.792928106288;13805.96455265839;10882.347059176474;13347.933260333637;13380.19718816874;13402.731945360843;13410.39653215588;10924;11037.889621103686;11224.607138750105;11725;11745;9555.665551705657;11142.970532791016;11310.434478275889;11375;11534.884651153381 09:31:58 INFO - PROCESS | 1694 | __end_tp_report 09:31:58 INFO - PROCESS | 1694 | __start_cc_report 09:31:58 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,1604 09:31:58 INFO - PROCESS | 1694 | __end_cc_report 09:31:58 INFO - PROCESS | 1694 | __startTimestamp1476203518387__endTimestamp 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | ------- Summary: start ------- 09:31:58 INFO - PROCESS | 1694 | Number of tests: 6 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | [#0] dojo.html Cycles:165 Average:5695.88 Median:5907.00 stddev:642.05 (10.9%) stddev-sans-first:615.80 09:31:58 INFO - PROCESS | 1694 | Values: 3296.1 3301.6 3312.7 3340.4 3373.3 5559.6 5594.0 5617.4 5636.5 5656.1 5615.4 5674.0 5738.0 5764.0 5772.6 4258.2 5102.9 5136.9 5160.4 5219.1 5236.9 5283.1 5286.0 5297.8 5346.4 5225.5 5251.8 5295.2 5299.3 5337.4 5113.5 5129.9 5169.7 5173.9 5185.1 5141.1 5142.5 5163.1 5193.6 5200.7 5698.2 5711.4 5717.5 5721.6 5750.7 5734.5 5792.8 5910.1 5978.7 5991.4 6119.5 6129.2 6204.4 6261.5 6305.1 5756.1 5757.6 5761.7 5765.1 5766.7 6091.2 6201.8 6208.5 6303.1 6317.2 6018.9 6058.9 6081.6 6101.5 6119.9 6235.0 6237.6 6242.7 6245.6 6251.5 6070.6 6107.5 6140.1 6171.4 6180.3 6007.2 6095.6 6109.3 6112.1 6112.4 4859.9 4875.0 4879.8 4881.1 4887.5 4273.4 4385.5 4452.4 4482.6 4484.8 5679.5 5701.8 5732.3 5753.5 5756.8 6193.6 6200.1 6208.2 6234.7 6237.0 4820.8 5443.6 5681.3 5696.5 5720.1 5156.7 5203.6 5323.7 5387.8 5404.7 6251.5 6268.3 6286.0 6298.7 6301.1 6295.9 6310.5 6316.0 6317.0 6331.2 6220.1 6281.8 6287.5 6301.1 6314.7 6085.4 6138.5 6140.0 6173.6 6190.8 6218.2 6233.3 6238.8 6243.8 6261.9 5761.5 5907.0 6002.2 6104.0 6133.4 5974.6 5987.0 6007.2 6052.7 6073.8 5950.3 5951.4 5954.1 5957.4 5982.3 6034.5 6059.3 6072.4 6115.4 6120.6 5733.1 5780.4 5810.4 5816.9 5916.5 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | [#1] ext.html Cycles:180 Average:66391.62 Median:38632.45 stddev:141326.74 (365.8%) stddev-sans-first:141636.58 09:31:58 INFO - PROCESS | 1694 | Values: 486.8 520.9 524.8 525.8 530.3 30264.2 30817.7 40479.8 41015.6 41055.8 41782.2 42066.7 42182.0 42187.2 42269.4 9302.2 9487.1 9493.7 9503.4 9509.9 8528.7 8779.2 11096.8 11389.8 11402.9 11325.5 11397.4 11422.6 11424.5 11459.0 8593.0 11309.4 11374.0 11377.1 11384.2 8487.7 8624.7 8629.6 8645.6 10934.6 38055.9 40573.0 40611.2 40650.8 40662.8 3289.2 3304.1 3309.3 3968.1 3969.8 29964.0 30405.1 30461.1 31109.8 31139.8 3196.3 3207.7 3214.8 3248.8 3282.8 503065.0 507833.5 507966.0 509442.0 518053.0 49107.5 49378.5 49817.5 50749.0 59982.0 59678.0 59814.4 60060.0 60079.0 60090.4 15716.6 15852.0 15862.0 15865.0 15876.8 11086.2 11392.7 12265.4 12385.2 12405.9 12216.5 14818.2 14854.0 14855.8 16322.7 5961.7 6985.8 7165.5 7171.5 7209.2 881.3 939.8 982.9 1055.6 1090.3 29304.0 29756.6 30071.5 30259.7 30301.5 1049.4 1074.0 1099.4 1110.4 1177.0 16139.6 16204.8 16354.3 16409.5 16540.7 555893.0 557899.0 560498.0 562102.0 571956.0 56853.7 57190.0 57195.7 57289.7 57463.0 1155.8 1217.5 1250.3 1345.3 1364.2 24861.9 29069.3 30473.4 30556.4 31124.0 49078.5 49672.8 49691.8 49899.5 49999.5 456412.0 531028.0 532459.0 533240.0 534500.0 24671.0 25750.2 25942.5 26130.9 27297.9 46202.8 46622.8 46803.3 47757.5 47775.5 38600.5 38731.4 38807.6 40298.0 40520.4 38259.8 38594.8 38783.4 39700.4 40069.0 37581.4 38563.8 38664.4 38794.2 38822.8 26236.6 31226.0 32771.7 34239.0 34359.3 24819.5 25114.0 25334.4 25646.9 25856.0 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | [#2] jquery.html Cycles:180 Average:33141.08 Median:4477.20 stddev:94315.83 (2106.6%) stddev-sans-first:94548.28 09:31:58 INFO - PROCESS | 1694 | Values: 353.7 357.6 378.2 386.6 408.5 11663.8 14691.4 15881.4 20038.8 20703.2 19387.5 19948.9 20490.8 20627.4 20858.8 5614.6 5660.8 5736.8 6046.2 6049.3 5656.3 5972.9 6031.4 6066.3 6069.2 5665.8 6054.1 6056.9 6059.1 6067.2 5860.2 6037.0 6043.8 6056.7 6061.7 5058.3 5316.4 5377.7 5758.5 5780.6 13043.0 13114.7 13172.3 13289.9 13305.5 1797.8 2096.4 2159.4 2161.4 2240.8 9629.9 10152.0 10261.6 12498.4 13910.6 1540.7 1813.9 1827.6 1899.1 1917.0 96324.0 110273.0 117958.0 122407.2 123897.1 8576.7 9071.4 9329.3 11308.9 11326.4 11863.8 14239.1 14263.2 14265.1 14269.5 7031.4 8248.8 8382.8 8396.5 8419.6 8234.4 8265.1 8432.9 8449.2 8459.6 4350.8 4420.9 4467.6 4486.8 4508.3 1654.1 1837.2 1878.6 1888.6 1899.4 787.4 865.3 907.9 942.1 1020.2 19938.4 21535.1 21571.8 21670.7 21739.3 914.0 915.5 920.2 972.7 980.1 9538.3 9936.8 11078.7 11120.3 11162.5 550979.0 555250.0 559587.2 574212.1 578854.0 99549.5 116310.4 123795.0 126744.7 138445.0 799.5 959.9 984.7 986.5 986.9 18791.0 19119.7 19131.6 19150.0 19190.9 45635.1 52770.5 53600.7 54801.5 54803.7 75463.0 76587.2 78310.6 79268.6 80180.0 7475.9 7738.0 7959.9 7973.3 8116.6 11471.7 12144.3 12487.9 12655.2 12715.2 5333.3 6574.5 8590.6 9230.2 11326.3 10685.1 10888.3 11058.1 11251.5 11429.0 10612.7 10985.6 11583.2 11612.8 11656.6 6917.8 7208.7 7218.0 7410.1 8128.6 9344.9 10926.3 10966.8 11346.6 11353.8 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | [#3] mootools.html Cycles:180 Average:5622.84 Median:4999.94 stddev:3169.93 (63.4%) stddev-sans-first:3162.10 09:31:58 INFO - PROCESS | 1694 | Values: 1290.0 1369.6 1435.8 1627.7 1894.2 7781.9 8239.6 8515.0 8805.4 8829.4 8619.2 8706.0 8707.9 8724.7 8735.0 2324.8 2357.9 2359.9 2360.5 2368.8 2311.4 2340.0 2360.6 2365.5 2367.0 1990.9 2345.2 2355.0 2356.3 2367.9 2293.7 2319.2 2336.6 2338.2 2339.1 2307.8 2312.2 2314.1 2315.0 2315.5 8745.1 8801.6 8815.2 8836.2 8844.5 5074.5 5298.2 5306.6 5331.7 5334.6 3462.6 3599.9 3679.9 3680.2 3688.2 1046.7 1078.6 1084.1 1103.4 1107.0 11538.9 11571.7 11643.2 11647.8 11669.9 4301.7 4359.3 4540.4 4549.5 4553.9 9075.0 9075.6 9077.2 9087.7 9101.0 5164.3 5166.6 5173.1 5177.0 5185.9 4303.9 4308.5 4467.0 4473.0 4854.9 3674.4 3693.4 3760.8 3761.6 3762.7 1144.4 1147.3 1151.9 1161.2 1163.5 900.6 903.8 906.7 955.5 956.0 5757.5 5788.9 5945.0 5967.5 6074.5 416.7 436.2 436.8 438.5 443.4 3824.0 4022.4 4029.9 4033.6 4035.2 8146.7 10407.9 10653.5 10758.8 10762.0 10261.3 10669.8 10696.8 10699.6 10701.0 7895.1 7993.8 8148.4 8219.7 8227.3 5377.3 5385.3 5493.9 5971.7 6207.3 8765.4 9624.0 9712.0 10030.5 10158.2 9903.2 10103.6 10215.8 10232.3 10276.4 7482.7 7614.4 7621.5 7629.8 7638.9 8063.8 8207.8 8302.4 8340.1 8343.2 7528.2 7537.6 7545.4 7578.7 7610.7 7391.0 7417.2 7435.6 7474.1 7483.3 6954.3 6965.3 7040.6 7041.4 7053.9 5007.2 5028.6 5066.2 5114.0 5161.8 4992.7 5022.8 5110.9 5256.1 5266.2 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | [#4] prototype.html Cycles:180 Average:4302.27 Median:4654.15 stddev:1335.44 (28.7%) stddev-sans-first:1305.01 09:31:58 INFO - PROCESS | 1694 | Values: 302.6 310.7 311.3 316.8 320.6 4605.0 5299.9 5316.4 5405.1 5436.4 4384.6 4629.6 5131.5 5352.2 5535.0 3527.7 3891.7 4028.8 4033.9 4041.7 2826.8 3334.9 4032.3 4062.5 4143.3 3838.6 3973.1 4067.3 4081.0 4107.8 3356.6 3579.5 3914.7 4099.5 4122.0 2966.9 3345.3 3470.5 3480.6 3560.6 4704.7 5174.8 5186.6 5195.6 5210.7 4013.1 4244.8 4684.4 4703.4 4710.8 5364.8 5593.4 5656.0 5658.5 5708.4 3509.4 3939.2 3942.6 3957.5 3989.5 4765.2 5575.9 5779.9 5855.8 6000.5 3385.7 3635.9 3789.0 3934.8 3991.8 3400.3 3963.5 4107.0 4109.8 4119.5 4268.7 4486.2 4663.7 4743.7 4744.0 5590.6 5668.6 5677.5 5694.5 5699.7 1252.6 1263.3 1325.5 1355.7 1355.9 740.7 814.0 824.7 829.5 833.0 3630.5 4394.6 4435.8 4444.5 4450.2 4188.7 4215.7 4421.4 4775.5 4794.4 3948.9 4405.6 4417.8 4418.6 4438.4 2034.4 2117.4 2471.2 2553.4 2561.9 4092.5 4435.5 4951.0 4954.0 4980.9 4176.7 4266.2 4866.3 4896.6 4979.4 4236.5 4631.0 4651.5 4978.0 5046.4 4626.9 4781.8 4792.7 4800.0 4801.4 3940.6 4797.3 4797.8 4823.7 4848.8 5009.6 5246.8 5564.5 6006.0 6011.0 3692.4 3862.2 3874.0 3879.6 3887.4 5093.0 5286.8 5686.7 5791.9 5824.9 4609.9 4656.8 5330.0 5611.7 5620.0 5032.4 5550.3 5620.6 5624.5 5652.6 4322.6 5384.0 5466.3 5473.5 5533.7 4972.0 5712.5 5740.3 5744.2 5775.9 5595.5 5596.0 5597.6 5622.7 5634.2 09:31:58 INFO - PROCESS | 1694 | 09:31:58 INFO - PROCESS | 1694 | [#5] yui.html Cycles:180 Average:24911.99 Median:4272.58 stddev:41150.17 (963.1%) stddev-sans-first:41225.47 09:31:58 INFO - PROCESS | 1694 | Values: 704.9 717.0 742.6 792.9 800.4 15098.0 15345.7 15379.9 15406.9 15411.9 13728.7 13795.2 13808.7 13829.0 13833.7 672.9 689.9 690.5 830.2 833.8 833.6 841.7 845.2 848.3 854.7 852.4 906.2 908.8 910.7 910.9 709.0 727.4 739.6 898.4 898.6 542.0 544.4 655.5 675.2 677.4 14547.6 14564.9 14585.2 14586.3 14603.6 11707.2 13195.9 13427.1 13545.0 13662.1 11989.5 12229.3 12275.3 12310.4 12625.2 4364.2 4386.1 4415.6 4448.1 4461.2 105027.0 105204.4 106129.9 113438.1 114542.0 9660.2 9700.3 9706.2 9849.4 9910.6 20531.4 20730.8 20735.4 20763.2 20776.7 7628.8 7647.8 7663.4 7718.7 7784.8 4081.4 4122.5 4176.2 4193.4 4345.3 3330.8 3418.0 3439.9 3446.6 3448.5 541.3 624.4 630.8 645.2 648.8 565.4 590.8 607.2 618.7 631.0 8566.1 8620.9 8645.5 8949.3 9077.0 574.7 624.6 625.4 629.5 638.5 3757.4 4199.9 4370.4 4389.6 4476.1 162537.2 168308.2 170433.0 170702.0 174443.0 95335.0 136601.3 143128.0 146487.0 147933.3 88436.1 89427.0 98034.0 106026.0 107389.5 9290.7 9637.3 9674.9 9801.1 9931.8 49524.3 60666.7 61704.8 61778.7 62663.0 81556.0 90430.0 90512.5 91672.5 91851.0 12815.7 12838.6 12998.2 13024.6 13176.1 14447.9 14530.5 14625.6 14719.4 14727.6 13195.3 13360.7 13474.9 13609.0 13648.3 13685.7 13752.5 13778.0 13804.8 13806.0 10882.3 13347.9 13380.2 13402.7 13410.4 10924.0 11037.9 11224.6 11725.0 11745.0 9555.7 11143.0 11310.4 11375.0 11534.9 09:31:58 INFO - PROCESS | 1694 | -------- Summary: end -------- 09:31:58 INFO - PROCESS | 1694 | 09:31:59 INFO - TEST-INFO | 1694: exit 0 09:31:59 INFO - TEST-OK | dromaeo_css | took 1118130ms 09:31:59 INFO - TEST-START | kraken 09:31:59 INFO - operating with platform_type : mac_ 09:31:59 INFO - Initialising browser for kraken test... 09:31:59 INFO - TEST-INFO | started process 1812 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpHHJdR2/profile http://localhost:49275/getInfo.html) 09:32:01 INFO - PROCESS | 1812 | __metrics Screen width/height:1600/1200 09:32:01 INFO - PROCESS | 1812 | colorDepth:24 09:32:01 INFO - PROCESS | 1812 | Browser inner width/height: 1024/689 09:32:01 INFO - PROCESS | 1812 | __metrics 09:32:01 INFO - PROCESS | 1812 | 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" 09:32:01 INFO - PROCESS | 1812 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:01 INFO - TEST-INFO | 1812: exit 0 09:32:01 INFO - Browser initialized. 09:32:01 INFO - Running cycle 1/1 for kraken test... 09:32:02 INFO - TEST-INFO | started process 1813 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpHHJdR2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:14 INFO - PROCESS | 1813 | RSS: Main: 235036672 09:32:14 INFO - PROCESS | 1813 | 09:32:16 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 09:32:17 INFO - PROCESS | 1813 | RSS: Main: 293769216 09:32:17 INFO - PROCESS | 1813 | 09:32:20 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 09:32:20 INFO - PROCESS | 1813 | RSS: Main: 293658624 09:32:20 INFO - PROCESS | 1813 | 09:32:24 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 09:32:24 INFO - PROCESS | 1813 | RSS: Main: 383164416 09:32:24 INFO - PROCESS | 1813 | 09:32:26 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 09:32:27 INFO - PROCESS | 1813 | RSS: Main: 285175808 09:32:27 INFO - PROCESS | 1813 | 09:32:29 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:32:30 INFO - PROCESS | 1813 | RSS: Main: 289570816 09:32:30 INFO - PROCESS | 1813 | 09:32:32 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 09:32:33 INFO - PROCESS | 1813 | RSS: Main: 327983104 09:32:33 INFO - PROCESS | 1813 | 09:32:36 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 09:32:36 INFO - PROCESS | 1813 | RSS: Main: 327639040 09:32:36 INFO - PROCESS | 1813 | 09:32:39 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 09:32:40 INFO - PROCESS | 1813 | RSS: Main: 328421376 09:32:40 INFO - PROCESS | 1813 | 09:32:41 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:32:42 INFO - PROCESS | 1813 | RSS: Main: 301842432 09:32:42 INFO - PROCESS | 1813 | 09:32:44 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:32:44 INFO - PROCESS | 1813 | RSS: Main: 304721920 09:32:44 INFO - PROCESS | 1813 | 09:32:47 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:32:47 INFO - PROCESS | 1813 | RSS: Main: 310935552 09:32:47 INFO - PROCESS | 1813 | 09:32:50 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:32:51 INFO - PROCESS | 1813 | RSS: Main: 319942656 09:32:51 INFO - PROCESS | 1813 | 09:32:54 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:32:54 INFO - PROCESS | 1813 | RSS: Main: 318304256 09:32:54 INFO - PROCESS | 1813 | 09:32:56 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 09:32:57 INFO - PROCESS | 1813 | RSS: Main: 362041344 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | __start_tp_report 09:32:57 INFO - PROCESS | 1813 | _x_x_mozilla_page_load 09:32:57 INFO - PROCESS | 1813 | _x_x_mozilla_page_load_details 09:32:57 INFO - PROCESS | 1813 | |i|pagename|runs| 09:32:57 INFO - PROCESS | 1813 | |0;ai-astar;113;115;113;113;114;114;113;114;114;113 09:32:57 INFO - PROCESS | 1813 | |1;audio-beat-detection;151;113;113;177;128;112;111;112;142;114 09:32:57 INFO - PROCESS | 1813 | |2;audio-dft;183;183;183;184;184;180;183;184;179;183 09:32:57 INFO - PROCESS | 1813 | |3;audio-fft;81;58;58;88;60;60;59;58;82;58 09:32:57 INFO - PROCESS | 1813 | |4;audio-oscillator;86;70;89;69;69;70;93;66;69;91 09:32:57 INFO - PROCESS | 1813 | |5;imaging-gaussian-blur;86;83;87;83;85;82;86;83;85;82 09:32:57 INFO - PROCESS | 1813 | |6;imaging-darkroom;92;92;92;92;92;92;92;92;91;92 09:32:57 INFO - PROCESS | 1813 | |7;imaging-desaturate;87;87;87;86;84;86;90;86;87;88 09:32:57 INFO - PROCESS | 1813 | |8;json-parse-financial;56;55;55;54;56;56;54;53;53;54 09:32:57 INFO - PROCESS | 1813 | |9;json-stringify-tinderbox;71;73;64;69;77;69;70;70;71;71 09:32:57 INFO - PROCESS | 1813 | |10;stanford-crypto-aes;86;86;89;86;87;84;85;88;92;90 09:32:57 INFO - PROCESS | 1813 | |11;stanford-crypto-ccm;165;161;145;141;146;147;145;146;204;147 09:32:57 INFO - PROCESS | 1813 | |12;stanford-crypto-pbkdf2;171;175;171;170;170;171;236;203;170;170 09:32:57 INFO - PROCESS | 1813 | |13;stanford-crypto-sha256-iterative;68;69;70;69;79;89;85;88;72;68 09:32:57 INFO - PROCESS | 1813 | __end_tp_report 09:32:57 INFO - PROCESS | 1813 | __start_cc_report 09:32:57 INFO - PROCESS | 1813 | _x_x_mozilla_cycle_collect,1984 09:32:57 INFO - PROCESS | 1813 | __end_cc_report 09:32:57 INFO - PROCESS | 1813 | __startTimestamp1476203577033__endTimestamp 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | ------- Summary: start ------- 09:32:57 INFO - PROCESS | 1813 | Number of tests: 14 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 09:32:57 INFO - PROCESS | 1813 | Values: 113.0 115.0 113.0 113.0 114.0 114.0 113.0 114.0 114.0 113.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:121.00 stddev:22.53 (18.6%) stddev-sans-first:22.20 09:32:57 INFO - PROCESS | 1813 | Values: 151.0 113.0 113.0 177.0 128.0 112.0 111.0 112.0 142.0 114.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#2] audio-dft Cycles:10 Average:182.60 Median:183.00 stddev:1.71 (0.9%) stddev-sans-first:1.81 09:32:57 INFO - PROCESS | 1813 | Values: 183.0 183.0 183.0 184.0 184.0 180.0 183.0 184.0 179.0 183.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:12.21 (20.3%) stddev-sans-first:11.72 09:32:57 INFO - PROCESS | 1813 | Values: 81.0 58.0 58.0 88.0 60.0 60.0 59.0 58.0 82.0 58.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.00 stddev:10.99 (14.1%) stddev-sans-first:11.19 09:32:57 INFO - PROCESS | 1813 | Values: 86.0 70.0 89.0 69.0 69.0 70.0 93.0 66.0 69.0 91.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#5] imaging-gaussian-blur Cycles:10 Average:84.20 Median:85.00 stddev:1.81 (2.1%) stddev-sans-first:1.80 09:32:57 INFO - PROCESS | 1813 | Values: 86.0 83.0 87.0 83.0 85.0 82.0 86.0 83.0 85.0 82.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#6] imaging-darkroom Cycles:10 Average:91.90 Median:92.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:32:57 INFO - PROCESS | 1813 | Values: 92.0 92.0 92.0 92.0 92.0 92.0 92.0 92.0 91.0 92.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#7] imaging-desaturate Cycles:10 Average:86.80 Median:87.00 stddev:1.55 (1.8%) stddev-sans-first:1.64 09:32:57 INFO - PROCESS | 1813 | Values: 87.0 87.0 87.0 86.0 84.0 86.0 90.0 86.0 87.0 88.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.13 09:32:57 INFO - PROCESS | 1813 | Values: 56.0 55.0 55.0 54.0 56.0 56.0 54.0 53.0 53.0 54.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.00 stddev:3.27 (4.6%) stddev-sans-first:3.47 09:32:57 INFO - PROCESS | 1813 | Values: 71.0 73.0 64.0 69.0 77.0 69.0 70.0 70.0 71.0 71.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.50 stddev:2.45 (2.8%) stddev-sans-first:2.55 09:32:57 INFO - PROCESS | 1813 | Values: 86.0 86.0 89.0 86.0 87.0 84.0 85.0 88.0 92.0 90.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:147.00 stddev:18.92 (12.9%) stddev-sans-first:19.70 09:32:57 INFO - PROCESS | 1813 | Values: 165.0 161.0 145.0 141.0 146.0 147.0 145.0 146.0 204.0 147.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:171.00 stddev:21.93 (12.8%) stddev-sans-first:22.98 09:32:57 INFO - PROCESS | 1813 | Values: 171.0 175.0 171.0 170.0 170.0 171.0 236.0 203.0 170.0 170.0 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - PROCESS | 1813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:75.50 stddev:8.69 (11.5%) stddev-sans-first:8.76 09:32:57 INFO - PROCESS | 1813 | Values: 68.0 69.0 70.0 69.0 79.0 89.0 85.0 88.0 72.0 68.0 09:32:57 INFO - PROCESS | 1813 | -------- Summary: end -------- 09:32:57 INFO - PROCESS | 1813 | 09:32:57 INFO - TEST-INFO | 1813: exit 0 09:32:58 INFO - TEST-OK | kraken | took 59006ms 09:32:58 INFO - SUITE-END | took 1177s 09:32:58 INFO - Completed test suite (00:19:37) 09:32:58 INFO - javascript benchmark 09:32:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.077098412444, 3301.603807543095, 3312.6687331266867, 3340.398728228921, 3373.257883265681, 5559.638623489471, 5594.0, 5617.4382561743805, 5636.549076073915, 5656.123300888364, 5615.382307946123, 5674.035413979623, 5738.0, 5764.0, 5772.595918285721, 4258.169656916903, 5102.872428189288, 5136.897262054776, 5160.406553246387, 5219.138842091051, 5236.8690782730355, 5283.101872681654, 5285.973570132144, 5297.814576489824, 5346.438623944488, 5225.529702326771, 5251.789928402859, 5295.232191332255, 5299.311089558352, 5337.412884582693, 5113.463086375951, 5129.948700512984, 5169.689818610896, 5173.870653233662, 5185.066687996159, 5141.126008578551, 5142.51146141116, 5163.14808056674, 5193.584513238932, 5200.6879587224885, 5698.202251684767, 5711.371749107595, 5717.456841600041, 5721.570882183812, 5750.741216645261, 5734.455226753452, 5792.82621521355, 5910.054391297414, 5978.671173085479, 5991.400859914017, 6119.502553941423, 6129.20320358355, 6204.410580994843, 6261.46777523911, 6305.0857625644485, 5756.0502517084215, 5757.596968212227, 5761.654300741969, 5765.106408506688, 5766.654000759968, 6091.20956991861, 6201.844953876099, 6208.50331973441, 6303.086052522451, 6317.241930968221, 6018.879622407528, 6058.878822423527, 6081.604695694766, 6101.519919784808, 6119.938800612026, 6235.033569796688, 6237.563370564017, 6242.687865606701, 6245.6252624842655, 6251.468625166912, 6070.605410648293, 6107.541934354852, 6140.140380346755, 6171.382861713792, 6180.3201647818705, 6007.189029481052, 6095.573309868267, 6109.2974307955155, 6112.144299798032, 6112.449879510866, 4859.854204373874, 4875.0, 4879.804807807719, 4881.072596206709, 4887.486813884562, 4273.423087883159, 4385.495667998157, 4452.443444569429, 4482.618977386894, 4484.775761211927, 5679.488846003796, 5701.800436984769, 5732.312122545238, 5753.482186603226, 5756.769729210785, 6193.597416167935, 6200.100985357098, 6208.192934918522, 6234.657093859791, 6236.968815155986, 4820.758962051884, 5443.618946673774, 5681.261436013292, 5696.515796157373, 5720.08478643415, 5156.664816786972, 5203.635745497779, 5323.653962492425, 5387.8114266001285, 5404.729763511808, 6251.499880009679, 6268.27914789805, 6286.0, 6298.685065746694, 6301.054841773771, 6295.874082518232, 6310.463610592968, 6316.0, 6317.0, 6331.2085989251345, 6220.098085777447, 6281.780137695158, 6287.528435367274, 6301.149344838388, 6314.715837787402, 6085.361037091218, 6138.478229350555, 6140.0, 6173.629582225081, 6190.845228869314, 6218.19163508741, 6233.314335423009, 6238.812835614939, 6243.843903902439, 6261.937380626136, 5761.452661997104, 5907.0, 6002.189704390026, 6104.043480857749, 6133.38666133401, 5974.641521508724, 5986.970065149821, 6007.158997740407, 6052.6973651316375, 6073.848153796191, 5950.285965684146, 5951.375105613848, 5954.136650185612, 5957.4042595740075, 5982.312034116132, 6034.547408944434, 6059.272887253558, 6072.392760724069, 6115.449609535163, 6120.60216085953, 5733.140028995684, 5780.421957804186, 5810.389909059657, 5816.912746308724, 5916.49709774674], "value": 5654.079260581468, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.84420985284703, 520.8880090780482, 524.7720334417462, 525.8369905329348, 530.3476723629935, 30264.243393915163, 30817.69182308176, 40479.797601012026, 41015.58984410155, 41055.76832695024, 41782.16435671285, 42066.73799786012, 42182.0, 42187.15625687484, 42269.36595951063, 9302.209312208453, 9487.146156845882, 9493.71518854432, 9503.382280151767, 9509.904900951005, 8528.701495447629, 8779.165979231995, 11096.833547496793, 11389.772204555904, 11402.942985285063, 11325.490352934097, 11397.430128493583, 11422.600208992686, 11424.485898134562, 11459.02598279143, 8593.0, 11309.434528273594, 11374.0, 11377.146713996483, 11384.203105782557, 8487.702930397469, 8624.65501379944, 8629.61166747498, 8645.610947507377, 10934.617288394948, 38055.858324250315, 40573.0, 40611.1877762446, 40650.79674601608, 40662.79668601668, 3289.2434740009694, 3304.1244070321386, 3309.3050459403553, 3968.0873399118077, 3969.821358038895, 29963.951261705955, 30405.087847364393, 30461.086167414793, 31109.8444507776, 31139.84430077858, 3196.31279274957, 3207.7273431758326, 3214.774965752398, 3248.805071695706, 3282.786618869766, 503065.0, 507833.46083269716, 507966.0, 509442.0, 518053.0, 49107.50892491101, 49378.50621493811, 49817.501824981286, 50749.0, 59982.0, 59678.0, 59814.401855981756, 60060.0, 60079.0, 60090.39909600936, 15716.60708482297, 15852.0, 15861.968972016783, 15865.04809711421, 15876.841231587767, 11086.16853735973, 11392.658220253406, 12265.386730663431, 12385.1949623276, 12405.937970310271, 12216.511339546496, 14818.184999825113, 14853.960222784517, 14855.777163342558, 16322.673546529002, 5961.672108034099, 6985.825354366079, 7165.498415110997, 7171.533850299714, 7209.170945341248, 881.299367003234, 939.8355287824603, 982.9361091529028, 1055.5883205549842, 1090.3076546393097, 29304.0, 29756.55365169524, 30071.548926766118, 30259.69740302613, 30301.545476817864, 1049.41757324684, 1074.0, 1099.378850949211, 1110.3892858927557, 1176.952921883115, 16139.596510087342, 16204.83795162057, 16354.345826167058, 16409.507714768577, 16540.6691866162, 555893.0, 557899.0, 560498.0, 562102.0, 571956.0, 56853.71573142108, 57190.0, 57195.71402142962, 57289.71355143281, 57463.0, 1155.78040172367, 1217.4764851113928, 1250.2748405924542, 1345.3407830163148, 1364.1814911053289, 24861.87569062143, 29069.273268168465, 30473.390532188787, 30556.388872222877, 31124.0, 49078.5092149074, 49672.751636241584, 49691.75154124206, 49899.50100499094, 49999.500004999485, 456412.0, 531028.0, 532459.0, 533240.0, 534500.0, 24671.0, 25750.227493175236, 25942.48115037651, 26130.86934565315, 27297.90808367643, 46202.76898615486, 46622.76688616671, 46803.29795053009, 47757.52242477531, 47775.52224477711, 38600.472907782714, 38731.41902871516, 38807.61192388153, 40298.0, 40520.392194116524, 38259.80870095632, 38594.80702596469, 38783.418248726855, 39700.40449393204, 40069.0, 37581.4362784553, 38563.84308470751, 38664.42003370008, 38794.22411551697, 38822.835314940596, 26236.606450903633, 31225.97031192965, 32771.67228327782, 34239.0, 34359.31281374308, 24819.503609928062, 25114.0, 25334.366640834127, 25646.87176564105, 25856.0], "value": 19631.325643483662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.6587193358409, 357.5530586766542, 378.20388083085106, 386.55428696674437, 408.4934680995565, 11663.766724665502, 14691.412343506261, 15881.444149454772, 20038.799612003913, 20703.171873125095, 19387.515312117204, 19948.900255498702, 20490.795092049077, 20627.38117856463, 20858.791412085873, 5614.635048721841, 5660.78293166969, 5736.827895163152, 6046.244219472566, 6049.304330002062, 5656.321241451032, 5972.910406343908, 6031.396860313956, 6066.332703402622, 6069.150318955328, 5665.830025099253, 6054.061620448815, 6056.909146362808, 6059.121427393025, 6067.150598916155, 5860.208871802295, 6036.96981515094, 6043.8186854394435, 6056.666883321415, 6061.727222275008, 5058.317127187819, 5316.3620365556, 5377.7311134443125, 5758.48173664368, 5780.595358324919, 13043.0, 13114.737705245841, 13172.275524846129, 13289.933550332187, 13305.534306299232, 1797.766290382255, 2096.444442222812, 2159.416957421503, 2161.427221786228, 2240.8207343412487, 9629.903700963041, 10152.0, 10261.589536418534, 12498.437570309357, 13910.608939106009, 1540.6610545679932, 1813.9365122220659, 1827.6070644811296, 1899.059965317163, 1917.0, 96324.0, 110273.0, 117958.0, 122407.16389254079, 123897.14154287693, 8576.656933722581, 9071.410358326688, 9329.346945713734, 11308.886911130949, 11326.37704926237, 11863.822042669366, 14239.145651260958, 14263.215523146118, 14265.144091354552, 14269.500567480089, 7031.437485001187, 8248.793780155544, 8382.832343353099, 8396.496210227406, 8419.621117049624, 8234.382421318425, 8265.090840007595, 8432.915670843213, 8449.155084491624, 8459.577021148918, 4350.825966961349, 4420.9336859947125, 4467.597916187558, 4486.798094085774, 4508.301213311942, 1654.0571874031687, 1837.200817644329, 1878.6054928465176, 1888.6128343689786, 1899.4111825334192, 787.3779714025856, 865.2645251536144, 907.8683590879285, 942.1191186240886, 1020.1787561013307, 19938.401847944584, 21535.13859445636, 21571.784282157292, 21670.658175789125, 21739.34781956544, 913.9588718507683, 915.5422288855572, 920.2362039507193, 972.7081875437341, 980.1472718734747, 9538.284628652878, 9936.751581210383, 11078.670559532908, 11120.332780033224, 11162.493063436494, 550979.0, 555250.0, 559587.202063987, 574212.128939361, 578854.0, 99549.50225248828, 116310.41844790721, 123795.0, 126744.73255267514, 138445.0, 799.5322736199389, 959.9040095990345, 984.6996666016934, 986.4673076538733, 986.8865080515689, 18791.0, 19119.713204301668, 19131.61736765285, 19150.0, 19190.94449805274, 45635.08729825451, 52770.47229527656, 53600.73199633977, 54801.45198548123, 54803.72598136984, 75463.0, 76587.23412765801, 78310.6084469574, 79268.60365698134, 80180.0, 7475.887861682188, 7737.961310193413, 7959.880601791094, 7973.282404583615, 8116.59417029158, 11471.655850324503, 12144.33206173669, 12487.875121249035, 12655.240685558896, 12715.173513721578, 5333.3066701330135, 6574.539782215199, 8590.613422395882, 9230.215431688383, 11326.32042077478, 10685.091767199876, 10888.346699198073, 11058.060064894253, 11251.549938002388, 11428.971392574707, 10612.681619551426, 10985.633409016586, 11583.247088939192, 11612.825807613062, 11656.592019279284, 6917.792466226021, 7208.747693830691, 7217.953396757546, 7410.11078670563, 8128.552929588929, 9344.859827102735, 10926.344419334866, 10966.835497467704, 11346.602868899548, 11353.772924541297], "value": 9085.345601717509, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.9742005159897, 1369.6096612465449, 1435.7989881416602, 1627.6907387596357, 1894.1665667106472, 7781.9221807781905, 8239.629216685256, 8515.020772611144, 8805.383623146367, 8829.381943263958, 8619.181177788116, 8705.956470217656, 8707.869381959275, 8724.651013959434, 8734.995475520316, 2324.8488848224897, 2357.9410514737096, 2359.929202123939, 2360.5160942006933, 2368.7631236876346, 2311.3528212100637, 2340.0, 2360.551495215912, 2365.5387199496104, 2367.0176876596192, 1990.910409031597, 2345.155743932183, 2355.0462062864567, 2356.3402247370764, 2367.9052837886466, 2293.690351802502, 2319.246244970383, 2336.6027775278244, 2338.158263025301, 2339.0760649543504, 2307.8499897506777, 2312.225404489481, 2314.1206341590087, 2314.953700925972, 2315.490592069742, 8745.125487451267, 8801.559922003938, 8815.206631403205, 8836.204741573289, 8844.513551754651, 5074.4671809460215, 5298.178782288752, 5306.628536002481, 5331.653442526223, 5334.59990500714, 3462.567179102612, 3599.928001439983, 3679.8528058877614, 3680.245549662313, 3688.2254726507467, 1046.6650671785033, 1078.6170909327234, 1084.0731174845473, 1103.3710784852638, 1106.9944650276698, 11538.884611153864, 11571.710707232302, 11643.18497705161, 11647.767044659144, 11669.883301166965, 4301.741895486281, 4359.280718681445, 4540.387047748512, 4549.45406551216, 4553.931691024637, 9075.047120052432, 9075.636974520945, 9077.183053525214, 9087.727368178965, 9101.0, 5164.25118357836, 5166.638335316567, 5173.068847607392, 5176.9741151294, 5185.896282074337, 4303.870883873489, 4308.547602501755, 4467.0, 4472.955270447319, 4854.8786280342565, 3674.3937250353392, 3693.372126738461, 3760.8375184268607, 3761.605031471711, 3762.6989840813217, 1144.4220668562323, 1147.271482608533, 1151.9366434846163, 1161.2451906260828, 1163.5345861655237, 900.5587262241454, 903.8327909336793, 906.727981605529, 955.4661494118784, 955.9569819358146, 5757.481826635623, 5788.857619605028, 5944.970275148683, 5967.46292833647, 6074.483668888194, 416.7332906939561, 436.1734513097662, 436.79688944640895, 438.4760211547234, 443.4368352192762, 3824.0, 4022.434536800752, 4029.899252518652, 4033.616806403387, 4035.2333056719717, 8146.674133034612, 10407.895921040692, 10653.520591573399, 10758.838617420744, 10762.0, 10261.333013354108, 10669.83995240072, 10696.78606427867, 10699.572017119384, 10701.036906678437, 7895.131535531087, 7993.760187194393, 8148.388870834592, 8219.671213151527, 8227.259546640831, 5377.327834020747, 5385.299911011543, 5493.9286839066, 5971.716081042597, 6207.317195108444, 8765.430247034177, 9623.951880240555, 9711.951440243036, 10030.548625311732, 10158.187345012233, 9903.158231550111, 10103.646372376932, 10215.846762298423, 10232.283740138417, 10276.434796086287, 7482.700691972478, 7614.428917831296, 7621.504602201061, 7629.809254768676, 7638.923610763822, 8063.798405039921, 8207.835843282981, 8302.418830682036, 8340.082590915115, 8343.249107580346, 7528.247175282428, 7537.585432801248, 7545.434092442979, 7578.658960346687, 7610.657520411484, 7391.0, 7417.184109748031, 7435.591042492715, 7474.103107627119, 7483.251674832473, 6954.269801670954, 6965.303469652994, 7040.612766297698, 7041.436685065285, 7053.894191587233, 5007.173816320266, 5028.64799464034, 5066.189409694432, 5113.974430127974, 5161.845144645667, 4992.700437973734, 5022.773975171199, 5110.872228194325, 5256.132738098171, 5266.1574148136115], "value": 4434.136053478372, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.6474157606388, 310.65982748889974, 311.33374578402226, 316.82416258976275, 320.61366053905044, 4605.0, 5299.9330261198165, 5316.388615309241, 5405.108212125759, 5436.374816896058, 4384.627306678936, 4629.560191781776, 5131.461196574362, 5352.2239275305055, 5534.972325138378, 3527.735419843509, 3891.735186064533, 4028.798560071985, 4033.899152521196, 4041.737287076345, 2826.7879909006806, 3334.933301333972, 4032.2741906456827, 4062.5124985001694, 4143.316352801784, 3838.596947320533, 3973.1060511384994, 4067.3492241241406, 4080.9795951020205, 4107.774072426016, 3356.63077061523, 3579.480975258586, 3914.7063970202207, 4099.508059032905, 4121.9587804122175, 2966.8664910078883, 3345.3476572068457, 3470.548828652259, 3480.564929383827, 3560.590532088817, 4704.717716936961, 5174.8356619760625, 5186.585073194173, 5195.584353251768, 5210.687358758487, 4013.13717550728, 4244.808983595745, 4684.3910291662205, 4703.388559487279, 4710.811567537295, 5364.758585863646, 5593.412691667398, 5656.038473459522, 5658.462446067617, 5708.4291570843, 3509.3858574749315, 3939.247035069395, 3942.6451619354107, 3957.544882338539, 3989.4614227079264, 4765.237561990065, 5575.944240557583, 5779.913301300484, 5855.795047173371, 6000.489958353545, 3385.6952874241438, 3635.8727444539313, 3789.0, 3934.842606295716, 3991.7604943703473, 3400.259714314284, 3963.5441924178513, 4106.979465102655, 4109.773962432095, 4119.485064366954, 4268.679849011274, 4486.227939963761, 4663.738087027788, 4743.667943244009, 4744.0, 5590.580706447033, 5668.619179944433, 5677.460641239076, 5694.544436445074, 5699.74351154199, 1252.642996745923, 1263.3493750718387, 1325.516186591887, 1355.722076974218, 1355.922041976631, 740.6666999850089, 813.9837203255902, 824.6928618140315, 829.5354601423222, 832.9708460203864, 3630.5098811660087, 4394.638101852086, 4435.844745433894, 4444.4888837784065, 4450.1767173073085, 4188.748675079505, 4215.683823713233, 4421.447319085114, 4775.498572649822, 4794.400699912511, 3948.874570747381, 4405.634253381462, 4417.835260722287, 4418.558144185556, 4438.424359352448, 2034.379514248139, 2117.3696253884423, 2471.189841207716, 2553.3744232663116, 2561.8975240990153, 4092.5293591237387, 4435.512093669694, 4951.019592163091, 4954.009198160383, 4980.8983994606315, 4176.665866730655, 4266.208192559133, 4866.343043689057, 4896.559309662076, 4979.418934580195, 4236.491621005499, 4630.976845115752, 4651.4880565851745, 4978.0, 5046.3506659004315, 4626.930596041129, 4781.7609119543185, 4792.7124372537755, 4799.9760001199775, 4801.351817504592, 3940.645341919241, 4797.328374027708, 4797.776566975399, 4823.686460380064, 4848.781804818862, 5009.624278179224, 5246.842594722164, 5564.527015203591, 6006.0, 6010.978133717191, 3692.3722967095123, 3862.208247309351, 3874.0121269076203, 3879.592642772468, 3887.358585833306, 5093.0, 5286.81496147633, 5686.744096515584, 5791.855203619774, 5824.912626310524, 4609.88475288107, 4656.81129868961, 5329.973350133225, 5611.691356975405, 5619.971900140473, 5032.370953630796, 5550.250716153268, 5620.634658747168, 5624.465675760796, 5652.63257888236, 4322.632576231055, 5384.003959267548, 5466.289382380265, 5473.452654734654, 5533.695646739468, 4972.0, 5712.542996560348, 5740.282464691913, 5744.214056182832, 5775.884482310415, 5595.496405323541, 5596.0, 5597.580181486323, 5622.662640241599, 5634.154876768517], "value": 3884.339328887973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.890741935, 716.989245161323, 742.6286856571714, 792.9365650747941, 800.3797057280607, 15098.0, 15345.693086138284, 15379.923100384482, 15406.922965385158, 15411.922940385297, 13728.656783580416, 13795.172289662627, 13808.654783630414, 13829.0, 13833.723325533509, 672.9057931889515, 689.9310068993086, 690.506288004077, 830.236182711905, 833.8332333533288, 833.6457005772553, 841.7306461932184, 845.18439705684, 848.2747251100313, 854.6666799948025, 852.3735054734765, 906.2342320738998, 908.8364094462994, 910.7267819654111, 910.877031600732, 709.0427922304899, 727.4435057181261, 739.5710487916995, 898.4070513461116, 898.5776684958059, 541.9729013549306, 544.3930018029907, 655.4821690864212, 675.2403546010738, 677.3598948993204, 14547.563573092719, 14564.85435145656, 14585.19781412022, 14586.34361453737, 14603.561893143222, 11707.180497365187, 13195.934020329933, 13427.12723672958, 13545.0, 13662.11196272239, 11989.460474278678, 12229.327386993711, 12275.263484190888, 12310.384480775925, 12625.242485450903, 4364.214441400547, 4386.0569977455, 4415.624671902892, 4448.132614140244, 4461.152381047591, 105027.0, 105204.42193367105, 106129.93870061355, 113438.08900065457, 114542.0, 9660.227181825438, 9700.320977531504, 9706.174975127053, 9849.409035457895, 9910.603575856885, 20531.38405847827, 20730.792692073188, 20735.377938661863, 20763.169473220903, 20776.68834967477, 7628.847423051508, 7647.808804779925, 7663.425243106678, 7718.652660630285, 7784.844303113906, 4081.428599996003, 4122.505299364096, 4176.18564379943, 4193.412922190896, 4345.261305578059, 3330.7501937354796, 3418.0087774545104, 3439.914002149966, 3446.603640581365, 3448.517207590939, 541.2719891745596, 624.4224092714221, 630.8044506203091, 645.1902861908369, 648.7502311610064, 565.3583183087144, 590.7991282963727, 607.2257871214238, 618.6628287583278, 631.0156156396037, 8566.143385661384, 8620.91379086201, 8645.524496152771, 8949.328800340001, 9077.04691007448, 574.7068994812593, 624.5503237668871, 625.4496043481707, 629.4775336470718, 638.5242993969522, 3757.385386283759, 4199.895002624959, 4370.409994650681, 4389.604935555815, 4476.104779044139, 162537.18731406503, 168308.15845920937, 170433.0, 170702.0, 174443.0, 95335.0, 136601.31699341637, 143128.0, 146487.0, 147933.26033369763, 88436.11563884407, 89427.0, 98034.0, 106026.0, 107389.4630526858, 9290.72127836166, 9637.277204209853, 9674.854877176707, 9801.11789938909, 9931.801363972825, 49524.25713614371, 60666.696666516385, 61704.76590468255, 61778.69110654418, 62663.0, 81555.96110097296, 90430.0, 90512.54743726239, 91672.54163729139, 91851.0, 12815.735195942825, 12838.55065072718, 12998.207520469325, 13024.609261722164, 13176.077674563072, 14447.927760361132, 14530.491432799801, 14625.561233163022, 14719.411223550938, 14727.631809204428, 13195.340232988505, 13360.732785344433, 13474.93262533681, 13609.047366684634, 13648.317584120556, 13685.726285474035, 13752.518661846787, 13778.0, 13804.792928106288, 13805.96455265839, 10882.347059176474, 13347.933260333637, 13380.19718816874, 13402.731945360843, 13410.39653215588, 10924.0, 11037.889621103686, 11224.607138750105, 11725.0, 11745.0, 9555.665551705657, 11142.970532791016, 11310.434478275889, 11375.0, 11534.884651153381], "value": 7637.309525986566, "unit": "score"}], "name": "dromaeo_css", "value": 7141.585950542301, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 113.0, 113.0, 177.0, 128.0, 112.0, 111.0, 112.0, 142.0, 114.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 183.0, 184.0, 184.0, 180.0, 183.0, 184.0, 179.0, 183.0], "value": 182.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 88.0, 60.0, 60.0, 59.0, 58.0, 82.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 89.0, 69.0, 69.0, 70.0, 93.0, 66.0, 69.0, 91.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 87.0, 83.0, 85.0, 82.0, 86.0, 83.0, 85.0, 82.0], "value": 84.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 91.0, 92.0], "value": 91.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 86.0, 84.0, 86.0, 90.0, 86.0, 87.0, 88.0], "value": 86.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 54.0, 56.0, 56.0, 54.0, 53.0, 53.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 64.0, 69.0, 77.0, 69.0, 70.0, 70.0, 71.0, 71.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 89.0, 86.0, 87.0, 84.0, 85.0, 88.0, 92.0, 90.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 145.0, 141.0, 146.0, 147.0, 145.0, 146.0, 204.0, 147.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 175.0, 171.0, 170.0, 170.0, 171.0, 236.0, 203.0, 170.0, 170.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 70.0, 69.0, 79.0, 89.0, 85.0, 88.0, 72.0, 68.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1453.3000000000002, "alertThreshold": 2.0}]} 09:32:58 INFO - Return code: 0 09:32:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:32:58 INFO - # TBPL SUCCESS # 09:32:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:32:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:32:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:32:58 INFO - 2016-10-11 09:32:58.359 screenresolution[1823:10156] starting screenresolution argv=screenresolution get 09:32:58 INFO - 2016-10-11 09:32:58.361 screenresolution[1823:10156] Display 0: 1600x1200x32@60 09:32:58 INFO - 2016-10-11 09:32:58.368 screenresolution[1824:10159] starting screenresolution argv=screenresolution list 09:32:58 INFO - Available Modes on Display 0 09:32:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:32:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:32:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:32:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:32:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:32:58 INFO - Intel Iris: 09:32:58 INFO - Chipset Model: Intel Iris 09:32:58 INFO - Type: GPU 09:32:58 INFO - Bus: Built-In 09:32:58 INFO - VRAM (Dynamic, Max): 1536 MB 09:32:58 INFO - Vendor: Intel (0x8086) 09:32:58 INFO - Device ID: 0x0a2e 09:32:58 INFO - Revision ID: 0x0009 09:32:58 INFO - Displays: 09:32:58 INFO - Display: 09:32:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:32:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:32:58 INFO - Display Serial Number: 1600x1200 60 09:32:58 INFO - Main Display: Yes 09:32:58 INFO - Mirror: Off 09:32:58 INFO - Online: Yes 09:32:58 INFO - Rotation: Supported 09:32:58 INFO - Return code: 0 09:32:58 INFO - Running post-action listener: _resource_record_post_action 09:32:58 INFO - [mozharness: 2016-10-11 16:32:58.603873Z] Finished run-tests step (success) 09:32:58 INFO - Running post-run listener: _resource_record_post_run 09:32:58 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 32087040; Write bytes: 708639232; Read time: 193; Write time: 2018 09:32:58 INFO - TinderboxPrint: CPU usage
53.9% 09:32:58 INFO - TinderboxPrint: I/O read bytes / time
32,087,040 / 193 09:32:58 INFO - TinderboxPrint: I/O write bytes / time
708,639,232 / 2,018 09:32:58 INFO - TinderboxPrint: CPU idle
2,236.0 (46.1%) 09:32:58 INFO - TinderboxPrint: CPU system
971.8 (20.1%) 09:32:58 INFO - TinderboxPrint: CPU user
1,637.8 (33.8%) 09:32:58 INFO - TinderboxPrint: Swap in / out
435,216,384 / 0 09:32:58 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384823808; Write bytes: 379627008; Read time: 28188; Write time: 768 09:32:58 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31161344; Write bytes: 298267648; Read time: 181; Write time: 1178 09:32:59 INFO - Running post-run listener: _upload_blobber_files 09:32:59 INFO - Blob upload gear active. 09:32:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:32:59 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 09:32:59 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'] 09:32:59 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 09:32:59 INFO - (blobuploader) - INFO - Open directory for files ... 09:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:33:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:00 INFO - (blobuploader) - INFO - Done attempting. 09:33:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:33:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:01 INFO - (blobuploader) - INFO - Done attempting. 09:33:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:33:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:33:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:33:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:33:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:33:03 INFO - (blobuploader) - INFO - Done attempting. 09:33:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:33:04 INFO - Return code: 0 09:33:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:33:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:33:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e12877a81d9dcf0aa687d567193abefa631edd94c4c71104df4115cef8e066cd466032551f1ccc3fe6510a6dbec68fdbe1f776db81fe07e6a509af6b84a14336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b8762e243ccd7ec2216b194761428e7bd2af31e39b8d2bbcef2e4cd98fc44f42b1d1960cd509f267d25433e9bc23ba70a851053f50fa19fd94223a82ab27c5fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67402bbd0b2bbe165453098b7e6105f3e08ec2221b8cdb2e0af9a8d07f72a34f460c3c96c9ca4cc17f7954d92d10b9534983b79fa08761d4d65e390e3c5352a0"} 09:33:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:33:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:33:04 INFO - Contents: 09:33:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e12877a81d9dcf0aa687d567193abefa631edd94c4c71104df4115cef8e066cd466032551f1ccc3fe6510a6dbec68fdbe1f776db81fe07e6a509af6b84a14336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b8762e243ccd7ec2216b194761428e7bd2af31e39b8d2bbcef2e4cd98fc44f42b1d1960cd509f267d25433e9bc23ba70a851053f50fa19fd94223a82ab27c5fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67402bbd0b2bbe165453098b7e6105f3e08ec2221b8cdb2e0af9a8d07f72a34f460c3c96c9ca4cc17f7954d92d10b9534983b79fa08761d4d65e390e3c5352a0"} 09:33:04 INFO - Running post-run listener: copy_logs_to_upload_dir 09:33:04 INFO - Copying logs to upload dir... 09:33:04 INFO - mkdir: /builds/slave/test/build/upload/logs 09:33:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.178912 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-11 09:33:04.074084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 09:33:04.078402) ========= 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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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/e12877a81d9dcf0aa687d567193abefa631edd94c4c71104df4115cef8e066cd466032551f1ccc3fe6510a6dbec68fdbe1f776db81fe07e6a509af6b84a14336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b8762e243ccd7ec2216b194761428e7bd2af31e39b8d2bbcef2e4cd98fc44f42b1d1960cd509f267d25433e9bc23ba70a851053f50fa19fd94223a82ab27c5fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67402bbd0b2bbe165453098b7e6105f3e08ec2221b8cdb2e0af9a8d07f72a34f460c3c96c9ca4cc17f7954d92d10b9534983b79fa08761d4d65e390e3c5352a0"} build_url:https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011120 build_url: 'https://queue.taskcluster.net/v1/task/crcBx3mbQEmXiUWHHFSFYg/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/e12877a81d9dcf0aa687d567193abefa631edd94c4c71104df4115cef8e066cd466032551f1ccc3fe6510a6dbec68fdbe1f776db81fe07e6a509af6b84a14336", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b8762e243ccd7ec2216b194761428e7bd2af31e39b8d2bbcef2e4cd98fc44f42b1d1960cd509f267d25433e9bc23ba70a851053f50fa19fd94223a82ab27c5fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/67402bbd0b2bbe165453098b7e6105f3e08ec2221b8cdb2e0af9a8d07f72a34f460c3c96c9ca4cc17f7954d92d10b9534983b79fa08761d4d65e390e3c5352a0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 09:33:04.110894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:33:04.114207) ========= 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.DZRMZ0YEsp/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.CqcNqL0xUF/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.005026 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 09:33:04.162452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 09:33:04.162718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 09:33:04.166030) ========= ========= Total master_lag: 0.20 =========