builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0146 starttime: 1483807560.34 results: success (0) buildid: 20170107073256 builduid: 6aeb6334eea3492897794b1e9920a0ed revision: 9a9493b6820804ccb4d2089f337179341b151133 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.341705) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.342363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.342643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.367419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.367785) ========= 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.563C8xUq5D/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.pucGQIyrMT/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-07 08:46:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 166M=0s 2017-01-07 08:46:00 (166 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154659 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.546694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.547080) ========= 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.563C8xUq5D/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.pucGQIyrMT/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.020120 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.596835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:00.597229) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a9493b6820804ccb4d2089f337179341b151133 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 9a9493b6820804ccb4d2089f337179341b151133 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.563C8xUq5D/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.pucGQIyrMT/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-07 08:46:00,671 truncating revision to first 12 chars 2017-01-07 08:46:00,671 Setting DEBUG logging. 2017-01-07 08:46:00,671 attempt 1/10 2017-01-07 08:46:00,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/9a9493b68208?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 08:46:00,962 unpacking tar archive at: mozilla-aurora-9a9493b68208/testing/mozharness/ program finished with exit code 0 elapsedTime=0.547144 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:01.215742) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:01.216051) ========= script_repo_revision: 9a9493b6820804ccb4d2089f337179341b151133 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:01.216460) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:01.216749) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 08:46:01.238316) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-07 08:46:01.238727) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.563C8xUq5D/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.pucGQIyrMT/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:01 INFO - MultiFileLogger online at 20170107 08:46:01 in /builds/slave/test 08:46:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:46:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:46:01 INFO - {'append_to_log': False, 08:46:01 INFO - 'base_work_dir': '/builds/slave/test', 08:46:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:46:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:46:01 INFO - 'branch': 'Mozilla-Aurora', 08:46:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:46:01 INFO - 'config_files': ('talos/mac_config.py',), 08:46:01 INFO - 'default_actions': ('clobber', 08:46:01 INFO - 'read-buildbot-config', 08:46:01 INFO - 'download-and-extract', 08:46:01 INFO - 'populate-webroot', 08:46:01 INFO - 'create-virtualenv', 08:46:01 INFO - 'install', 08:46:01 INFO - 'run-tests'), 08:46:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:46:01 INFO - 'download_minidump_stackwalk': True, 08:46:01 INFO - 'download_symbols': 'ondemand', 08:46:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:46:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:46:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:46:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:46:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:46:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:46:01 INFO - 'installer_path': 'installer.exe', 08:46:01 INFO - 'log_level': 'info', 08:46:01 INFO - 'log_name': 'talos', 08:46:01 INFO - 'log_to_console': True, 08:46:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:46:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:46:01 INFO - 'opt_config_files': (), 08:46:01 INFO - 'pip_index': False, 08:46:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:46:01 INFO - 'cmd': ('bash', 08:46:01 INFO - '-c', 08:46:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:46:01 INFO - 'enabled': True, 08:46:01 INFO - 'halt_on_failure': False, 08:46:01 INFO - 'name': 'check_screen_resolution'},), 08:46:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:46:01 INFO - 'cmd': ('bash', 08:46:01 INFO - '-c', 08:46:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:46:01 INFO - 'enabled': True, 08:46:01 INFO - 'halt_on_failure': False, 08:46:01 INFO - 'name': 'check_screen_resolution'},), 08:46:01 INFO - 'run_cmd_checks_enabled': True, 08:46:01 INFO - 'sps_profile': False, 08:46:01 INFO - 'sps_profile_interval': 0, 08:46:01 INFO - 'suite': 'dromaeojs', 08:46:01 INFO - 'system_bits': '32', 08:46:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:46:01 INFO - 'title': 't-yosemite-r7-0146', 08:46:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:46:01 INFO - 'use_talos_json': True, 08:46:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:46:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:46:01 INFO - 'work_dir': 'build'} 08:46:01 INFO - [mozharness: 2017-01-07 16:46:01.442973Z] Running clobber step. 08:46:01 INFO - Running pre-action listener: _resource_record_pre_action 08:46:01 INFO - Running main action method: clobber 08:46:01 INFO - rmtree: /builds/slave/test/build 08:46:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:46:01 INFO - Running post-action listener: _resource_record_post_action 08:46:01 INFO - [mozharness: 2017-01-07 16:46:01.803131Z] Finished clobber step (success) 08:46:01 INFO - [mozharness: 2017-01-07 16:46:01.803298Z] Running read-buildbot-config step. 08:46:01 INFO - Running pre-action listener: _resource_record_pre_action 08:46:01 INFO - Running main action method: read_buildbot_config 08:46:01 INFO - Using buildbot properties: 08:46:01 INFO - { 08:46:01 INFO - "project": "", 08:46:01 INFO - "product": "firefox", 08:46:01 INFO - "script_repo_revision": "production", 08:46:01 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:46:01 INFO - "repository": "", 08:46:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:46:01 INFO - "buildid": "20170107073256", 08:46:01 INFO - "pgo_build": "False", 08:46:01 INFO - "basedir": "/builds/slave/test", 08:46:01 INFO - "buildnumber": 37, 08:46:01 INFO - "slavename": "t-yosemite-r7-0146", 08:46:01 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:46:01 INFO - "platform": "yosemite_r7", 08:46:01 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:46:01 INFO - "branch": "mozilla-aurora", 08:46:01 INFO - "repo_path": "releases/mozilla-aurora", 08:46:01 INFO - "revision": "9a9493b6820804ccb4d2089f337179341b151133", 08:46:01 INFO - "stage_platform": "macosx64", 08:46:01 INFO - "builduid": "6aeb6334eea3492897794b1e9920a0ed", 08:46:01 INFO - "slavebuilddir": "test" 08:46:01 INFO - } 08:46:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:46:01 INFO - Running post-action listener: _resource_record_post_action 08:46:01 INFO - [mozharness: 2017-01-07 16:46:01.806620Z] Finished read-buildbot-config step (success) 08:46:01 INFO - [mozharness: 2017-01-07 16:46:01.806735Z] Running download-and-extract step. 08:46:01 INFO - Running pre-action listener: _resource_record_pre_action 08:46:01 INFO - Running main action method: download_and_extract 08:46:01 INFO - mkdir: /builds/slave/test/build/tests 08:46:01 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')]} 08:46:01 INFO - trying https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:46:01 INFO - Downloading https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:46:03 INFO - Downloaded 1199 bytes. 08:46:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:46:03 INFO - Using the following test package requirements: 08:46:03 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:46:03 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:46:03 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:46:03 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'jsshell-mac.zip'], 08:46:03 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:46:03 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:46:03 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:46:03 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:46:03 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:46:03 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:46:03 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:46:03 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:46:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:46:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:46:03 INFO - Fetch https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:46:03 INFO - Http code: 200 08:46:03 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 08:46:03 INFO - x-amz-cf-id: kkOM-7ZWBKfi8hGXZq-shb9_OYGXA53sQmwrahxs_eHL_wqjJptCnA== 08:46:03 INFO - x-amz-version-id: VnMEy6ZDYITk9FLc49_Tc9XimLbauxiv 08:46:03 INFO - Expected file size: 16269706 08:46:03 INFO - Obtained file size: 16269706 08:46:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:46:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:46:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:46:10 INFO - Fetch https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:46:11 INFO - Http code: 200 08:46:11 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 08:46:11 INFO - x-amz-cf-id: _3o-LHF-Jk3YIRMO4XpvskHcc3aHMbp4GbaKJ1lM6wvd1kQmfyrzjQ== 08:46:11 INFO - x-amz-version-id: VnMEy6ZDYITk9FLc49_Tc9XimLbauxiv 08:46:11 INFO - Expected file size: 16269706 08:46:11 INFO - Obtained file size: 16269706 08:46:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:46:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:46:17 INFO - Fetch https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:46:19 INFO - Http code: 200 08:46:19 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:46:19 INFO - x-amz-cf-id: cvLr4mLsSvEQHExwAhVqcRxLJvUwNdDWUsXrSbXck4ZAAeWbMIGoxg== 08:46:19 INFO - x-amz-version-id: JtpzMdzF4s9wrHZNAk8X7Vuls2NCcAR. 08:46:20 INFO - Expected file size: 14409038 08:46:20 INFO - Obtained file size: 14409038 08:46: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')]} 08:46:20 INFO - trying https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:46:20 INFO - Downloading https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:46:23 INFO - Downloaded 109860853 bytes. 08:46:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:46:23 INFO - mkdir: /builds/slave/test/properties 08:46:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:46:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:46:23 INFO - Contents: 08:46:23 INFO - build_url:https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:46:24 INFO - Running post-action listener: _resource_record_post_action 08:46:24 INFO - Running post-action listener: set_extra_try_arguments 08:46:24 INFO - [mozharness: 2017-01-07 16:46:24.173671Z] Finished download-and-extract step (success) 08:46:24 INFO - [mozharness: 2017-01-07 16:46:24.173822Z] Running populate-webroot step. 08:46:24 INFO - Running pre-action listener: _resource_record_pre_action 08:46:24 INFO - Running main action method: populate_webroot 08:46:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:46:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:46:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:46:24 INFO - '--tppagecycles', 08:46:24 INFO - '7'], 08:46:24 INFO - 'tests': ['tsvgm']}}, 08:46:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:46:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:46:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:46:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:46:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:46:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['damp', 'tps']}, 08:46:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'tests': ['damp', 'tps']}, 08:46:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['dromaeo_dom']}, 08:46:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:46:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['basic_compositor_video']}, 08:46:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:46:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['a11yr', 08:46:24 INFO - 'ts_paint', 08:46:24 INFO - 'tpaint', 08:46:24 INFO - 'sessionrestore', 08:46:24 INFO - 'sessionrestore_no_auto_restore', 08:46:24 INFO - 'tabpaint']}, 08:46:24 INFO - 'other-e10s': {'tests': ['a11yr', 08:46:24 INFO - 'ts_paint', 08:46:24 INFO - 'tpaint', 08:46:24 INFO - 'sessionrestore', 08:46:24 INFO - 'sessionrestore_no_auto_restore', 08:46:24 INFO - 'tabpaint']}, 08:46:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:46:24 INFO - 'ts_paint', 08:46:24 INFO - 'tpaint', 08:46:24 INFO - 'sessionrestore', 08:46:24 INFO - 'sessionrestore_no_auto_restore', 08:46:24 INFO - 'tabpaint']}, 08:46:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:46:24 INFO - 'ts_paint', 08:46:24 INFO - 'tpaint', 08:46:24 INFO - 'sessionrestore', 08:46:24 INFO - 'sessionrestore_no_auto_restore', 08:46:24 INFO - 'tabpaint']}, 08:46:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['a11yr', 08:46:24 INFO - 'ts_paint', 08:46:24 INFO - 'tpaint', 08:46:24 INFO - 'sessionrestore', 08:46:24 INFO - 'sessionrestore_no_auto_restore', 08:46:24 INFO - 'tabpaint']}, 08:46:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['a11yr', 08:46:24 INFO - 'ts_paint', 08:46:24 INFO - 'tpaint', 08:46:24 INFO - 'sessionrestore', 08:46:24 INFO - 'sessionrestore_no_auto_restore', 08:46:24 INFO - 'tabpaint']}, 08:46:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['tsvgx', 08:46:24 INFO - 'tsvgr_opacity', 08:46:24 INFO - 'tart', 08:46:24 INFO - 'tscrollx', 08:46:24 INFO - 'cart']}, 08:46:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:46:24 INFO - 'tsvgr_opacity', 08:46:24 INFO - 'tart', 08:46:24 INFO - 'tscrollx', 08:46:24 INFO - 'cart']}, 08:46:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'talos_options': ['--disable-e10s'], 08:46:24 INFO - 'tests': ['tp5o']}, 08:46:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'tests': ['tp5o']}, 08:46:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'talos_options': ['--disable-e10s', 08:46:24 INFO - '--xperf_path', 08:46:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:24 INFO - 'tests': ['tp5n']}, 08:46:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:46:24 INFO - 'talos_options': ['--xperf_path', 08:46:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:46:24 INFO - 'tests': ['tp5n']}}, 08:46:24 INFO - 'talos.zip': {'path': '', 08:46:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:46:24 INFO - Running post-action listener: _resource_record_post_action 08:46:24 INFO - [mozharness: 2017-01-07 16:46:24.193166Z] Finished populate-webroot step (success) 08:46:24 INFO - [mozharness: 2017-01-07 16:46:24.193303Z] Running create-virtualenv step. 08:46:24 INFO - Running pre-action listener: _resource_record_pre_action 08:46:24 INFO - Running main action method: create_virtualenv 08:46:24 INFO - Creating virtualenv /builds/slave/test/build/venv 08:46:24 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 08:46:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:46:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:46:24 INFO - Using real prefix '/tools/python27' 08:46:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:46:25 INFO - Installing distribute.............................................................................................................................................................................................done. 08:46:27 INFO - Installing pip.................done. 08:46:27 INFO - Return code: 0 08:46:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:46:28 INFO - Reading from file tmpfile_stdout 08:46:28 INFO - Output received: 08:46:28 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) 08:46:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:28 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:28 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 08:46:28 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 08:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:28 INFO - 'HOME': '/Users/cltbld', 08:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:28 INFO - 'LOGNAME': 'cltbld', 08:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:28 INFO - 'MOZ_NO_REMOTE': '1', 08:46:28 INFO - 'NO_EM_RESTART': '1', 08:46:28 INFO - 'PAGER': '/bin/cat', 08:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:28 INFO - 'PWD': '/builds/slave/test', 08:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:28 INFO - 'SHELL': '/bin/bash', 08:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:28 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:28 INFO - 'USER': 'cltbld', 08:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:28 INFO - 'XPC_FLAGS': '0x0', 08:46:28 INFO - 'XPC_SERVICE_NAME': '0', 08:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:28 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 08:46:28 INFO - Cleaning up... 08:46:28 INFO - Return code: 0 08:46:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:28 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:28 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 08:46:28 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 08:46:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:28 INFO - 'HOME': '/Users/cltbld', 08:46:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:28 INFO - 'LOGNAME': 'cltbld', 08:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:28 INFO - 'MOZ_NO_REMOTE': '1', 08:46:28 INFO - 'NO_EM_RESTART': '1', 08:46:28 INFO - 'PAGER': '/bin/cat', 08:46:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:28 INFO - 'PWD': '/builds/slave/test', 08:46:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:28 INFO - 'SHELL': '/bin/bash', 08:46:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:28 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:28 INFO - 'USER': 'cltbld', 08:46:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:28 INFO - 'XPC_FLAGS': '0x0', 08:46:28 INFO - 'XPC_SERVICE_NAME': '0', 08:46:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:28 INFO - Downloading/unpacking psutil>=3.1.1 08:46:28 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 08:46:28 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 08:46:28 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 08:46:28 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 08:46:28 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 08:46:28 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 08:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:32 INFO - Installing collected packages: psutil 08:46:32 INFO - Running setup.py install for psutil 08:46:32 INFO - building 'psutil._psutil_osx' extension 08:46:32 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 08:46:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:46:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:46:33 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 08:46:33 INFO - building 'psutil._psutil_posix' extension 08:46:33 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 08:46:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:46:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:46:33 INFO - ^ 08:46:33 INFO - 1 warning generated. 08:46:33 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 08:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:46:33 INFO - Successfully installed psutil 08:46:33 INFO - Cleaning up... 08:46:33 INFO - Return code: 0 08:46:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:33 INFO - 'HOME': '/Users/cltbld', 08:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:33 INFO - 'LOGNAME': 'cltbld', 08:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:33 INFO - 'MOZ_NO_REMOTE': '1', 08:46:33 INFO - 'NO_EM_RESTART': '1', 08:46:33 INFO - 'PAGER': '/bin/cat', 08:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:33 INFO - 'PWD': '/builds/slave/test', 08:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:33 INFO - 'SHELL': '/bin/bash', 08:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:33 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:33 INFO - 'USER': 'cltbld', 08:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:33 INFO - 'XPC_FLAGS': '0x0', 08:46:33 INFO - 'XPC_SERVICE_NAME': '0', 08:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46: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 08:46:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:46:36 INFO - Installing collected packages: mozsystemmonitor 08:46:36 INFO - Running setup.py install for mozsystemmonitor 08:46:36 INFO - Successfully installed mozsystemmonitor 08:46:36 INFO - Cleaning up... 08:46:36 INFO - Return code: 0 08:46:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:46:36 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')]} 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:36 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')]} 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:36 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:36 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 08:46:36 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 08:46:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:36 INFO - 'HOME': '/Users/cltbld', 08:46:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:36 INFO - 'LOGNAME': 'cltbld', 08:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:36 INFO - 'MOZ_NO_REMOTE': '1', 08:46:36 INFO - 'NO_EM_RESTART': '1', 08:46:36 INFO - 'PAGER': '/bin/cat', 08:46:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:36 INFO - 'PWD': '/builds/slave/test', 08:46:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:36 INFO - 'SHELL': '/bin/bash', 08:46:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:36 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:36 INFO - 'USER': 'cltbld', 08:46:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:36 INFO - 'XPC_FLAGS': '0x0', 08:46:36 INFO - 'XPC_SERVICE_NAME': '0', 08:46:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:46:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:46:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:46:39 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 08:46:39 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 08:46:39 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 08:46:39 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 08:46:39 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 08:46:39 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 08:46:40 INFO - Downloading functools32-3.2.3-2.tar.gz 08:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:46:40 INFO - warning: no files found matching '*.txt' 08:46:40 INFO - no previously-included directories found matching 'build' 08:46:40 INFO - no previously-included directories found matching 'dist' 08:46:40 INFO - no previously-included directories found matching '.git*' 08:46:40 INFO - Installing collected packages: jsonschema, functools32 08:46:40 INFO - Running setup.py install for functools32 08:46:40 INFO - warning: no files found matching '*.txt' 08:46:40 INFO - no previously-included directories found matching 'build' 08:46:40 INFO - no previously-included directories found matching 'dist' 08:46:40 INFO - no previously-included directories found matching '.git*' 08:46:40 INFO - Successfully installed jsonschema functools32 08:46:40 INFO - Cleaning up... 08:46:40 INFO - Return code: 0 08:46:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:40 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:40 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 08:46:40 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 08:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:40 INFO - 'HOME': '/Users/cltbld', 08:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:40 INFO - 'LOGNAME': 'cltbld', 08:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:40 INFO - 'MOZ_NO_REMOTE': '1', 08:46:40 INFO - 'NO_EM_RESTART': '1', 08:46:40 INFO - 'PAGER': '/bin/cat', 08:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:40 INFO - 'PWD': '/builds/slave/test', 08:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:40 INFO - 'SHELL': '/bin/bash', 08:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:40 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:40 INFO - 'USER': 'cltbld', 08:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:40 INFO - 'XPC_FLAGS': '0x0', 08:46:40 INFO - 'XPC_SERVICE_NAME': '0', 08:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:46:40 INFO - Cleaning up... 08:46:40 INFO - Return code: 0 08:46:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:40 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:40 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 08:46:40 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 08:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:40 INFO - 'HOME': '/Users/cltbld', 08:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:40 INFO - 'LOGNAME': 'cltbld', 08:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:40 INFO - 'MOZ_NO_REMOTE': '1', 08:46:40 INFO - 'NO_EM_RESTART': '1', 08:46:40 INFO - 'PAGER': '/bin/cat', 08:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:40 INFO - 'PWD': '/builds/slave/test', 08:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:40 INFO - 'SHELL': '/bin/bash', 08:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:40 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:40 INFO - 'USER': 'cltbld', 08:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:40 INFO - 'XPC_FLAGS': '0x0', 08:46:40 INFO - 'XPC_SERVICE_NAME': '0', 08:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:40 INFO - Downloading/unpacking blobuploader==1.2.4 08:46:40 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 08:46:40 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 08:46:40 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 08:46:40 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 08:46:40 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 08:46:40 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 08:46:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:46:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:46:43 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 08:46:43 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 08:46:43 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 08:46:43 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 08:46:43 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 08:46:43 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 08:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:46:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:46:44 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 08:46:44 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 08:46:44 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 08:46:44 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 08:46:44 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 08:46:44 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 08:46:44 INFO - Downloading docopt-0.6.1.tar.gz 08:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:46:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:46:44 INFO - Running setup.py install for blobuploader 08:46:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:46:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:46:45 INFO - Running setup.py install for requests 08:46:45 INFO - Running setup.py install for docopt 08:46:45 INFO - Successfully installed blobuploader requests docopt 08:46:45 INFO - Cleaning up... 08:46:45 INFO - Return code: 0 08:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46: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')]} 08:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46: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')]} 08:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:45 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:45 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 08:46:45 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 08:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:45 INFO - 'HOME': '/Users/cltbld', 08:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:45 INFO - 'LOGNAME': 'cltbld', 08:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:45 INFO - 'MOZ_NO_REMOTE': '1', 08:46:45 INFO - 'NO_EM_RESTART': '1', 08:46:45 INFO - 'PAGER': '/bin/cat', 08:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:45 INFO - 'PWD': '/builds/slave/test', 08:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:45 INFO - 'SHELL': '/bin/bash', 08:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:45 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:45 INFO - 'USER': 'cltbld', 08:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:45 INFO - 'XPC_FLAGS': '0x0', 08:46:45 INFO - 'XPC_SERVICE_NAME': '0', 08:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ceqEJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-rw0vK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3JDiLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-A6xxC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-i_52x0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-vJEwBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-txA0x3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-HjugI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:46 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-pBRDlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-FkpXVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3zY9fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ILlrxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-ZGvJEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-YYDHHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-j_hPEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-yQH5No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:47 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-NQAtW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:46:47 INFO - Running setup.py install for manifestparser 08:46:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:46:47 INFO - Running setup.py install for mozcrash 08:46:48 INFO - Running setup.py install for mozdebug 08:46:48 INFO - Running setup.py install for mozdevice 08:46:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Running setup.py install for mozfile 08:46:48 INFO - Running setup.py install for mozhttpd 08:46:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Running setup.py install for mozinfo 08:46:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Running setup.py install for mozInstall 08:46:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:46:48 INFO - Running setup.py install for mozleak 08:46:49 INFO - Running setup.py install for mozlog 08:46:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:46:49 INFO - Running setup.py install for moznetwork 08:46:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:46:49 INFO - Running setup.py install for mozprocess 08:46:49 INFO - Running setup.py install for mozprofile 08:46:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:46:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:46:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:46:49 INFO - Running setup.py install for mozrunner 08:46:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:46:49 INFO - Running setup.py install for mozscreenshot 08:46:50 INFO - Running setup.py install for moztest 08:46:50 INFO - Running setup.py install for mozversion 08:46:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:46:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:46:50 INFO - Cleaning up... 08:46:50 INFO - Return code: 0 08:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:50 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')]} 08:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:50 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')]} 08:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:50 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:50 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 08:46:50 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 08:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:50 INFO - 'HOME': '/Users/cltbld', 08:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:50 INFO - 'LOGNAME': 'cltbld', 08:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:50 INFO - 'MOZ_NO_REMOTE': '1', 08:46:50 INFO - 'NO_EM_RESTART': '1', 08:46:50 INFO - 'PAGER': '/bin/cat', 08:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:50 INFO - 'PWD': '/builds/slave/test', 08:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:50 INFO - 'SHELL': '/bin/bash', 08:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:50 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:50 INFO - 'USER': 'cltbld', 08:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:50 INFO - 'XPC_FLAGS': '0x0', 08:46:50 INFO - 'XPC_SERVICE_NAME': '0', 08:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:46:50 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-kFZtgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:46:50 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)) 08:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:46:50 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-viPk1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:46:50 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qEJeHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-utjODo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-Z6iF1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-LgcxLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-KwWC1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-0XaTfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-3BlKH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-QV_nuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-WkFQvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-057Hic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:46:51 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)) 08:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:46:51 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wjeaV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:46:52 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)) 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:46:52 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-qrZDPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:52 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wOW50X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:46:52 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)) 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:46:52 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-wzSt7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:46:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:46:52 INFO - Running setup.py (path:/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/pip-5W0lPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:46:52 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)) 08:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:46:52 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)) 08:46:52 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)) 08:46:52 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)) 08:46:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:46:52 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 08:46:52 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 08:46:52 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 08:46:52 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 08:46:52 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 08:46:52 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 08:46:55 INFO - Downloading blessings-1.6.tar.gz 08:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:46:55 INFO - Installing collected packages: blessings 08:46:55 INFO - Running setup.py install for blessings 08:46:55 INFO - Successfully installed blessings 08:46:55 INFO - Cleaning up... 08:46:55 INFO - Return code: 0 08:46:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:55 INFO - Reading from file tmpfile_stdout 08:46:55 INFO - Current package versions: 08:46:55 INFO - blessings == 1.6 08:46:55 INFO - blobuploader == 1.2.4 08:46:55 INFO - docopt == 0.6.1 08:46:55 INFO - functools32 == 3.2.3-2 08:46:55 INFO - jsonschema == 2.5.1 08:46:55 INFO - manifestparser == 1.1 08:46:55 INFO - mozInstall == 1.12 08:46:55 INFO - mozcrash == 1.0 08:46:55 INFO - mozdebug == 0.1 08:46:55 INFO - mozdevice == 0.48 08:46:55 INFO - mozfile == 1.2 08:46:55 INFO - mozhttpd == 0.7 08:46:55 INFO - mozinfo == 0.9 08:46:55 INFO - mozleak == 0.1 08:46:55 INFO - mozlog == 3.4 08:46:55 INFO - moznetwork == 0.27 08:46:55 INFO - mozprocess == 0.23 08:46:55 INFO - mozprofile == 0.28 08:46:55 INFO - mozrunner == 6.13 08:46:55 INFO - mozscreenshot == 0.1 08:46:55 INFO - mozsystemmonitor == 0.3 08:46:55 INFO - moztest == 0.8 08:46:55 INFO - mozversion == 1.4 08:46:55 INFO - psutil == 3.1.1 08:46:55 INFO - requests == 1.2.3 08:46:55 INFO - wsgiref == 0.1.2 08:46:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:46:55 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')]} 08:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:55 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')]} 08:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:55 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:55 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 08:46:55 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 08:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:55 INFO - 'HOME': '/Users/cltbld', 08:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:55 INFO - 'LOGNAME': 'cltbld', 08:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:55 INFO - 'MOZ_NO_REMOTE': '1', 08:46:55 INFO - 'NO_EM_RESTART': '1', 08:46:55 INFO - 'PAGER': '/bin/cat', 08:46:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:55 INFO - 'PWD': '/builds/slave/test', 08:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:55 INFO - 'SHELL': '/bin/bash', 08:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:55 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:55 INFO - 'USER': 'cltbld', 08:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:55 INFO - 'XPC_FLAGS': '0x0', 08:46:55 INFO - 'XPC_SERVICE_NAME': '0', 08:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 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)) 08:46:56 INFO - Cleaning up... 08:46:56 INFO - Return code: 0 08:46:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:46:56 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')]} 08:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 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')]} 08:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:46:56 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 0x10478d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104703570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad93c72eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, '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.563C8xUq5D/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.pucGQIyrMT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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 08:46:56 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 08:46:56 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 08:46:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:46:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:46:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:46:56 INFO - 'HOME': '/Users/cltbld', 08:46:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:46:56 INFO - 'LOGNAME': 'cltbld', 08:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:46:56 INFO - 'MOZ_NO_REMOTE': '1', 08:46:56 INFO - 'NO_EM_RESTART': '1', 08:46:56 INFO - 'PAGER': '/bin/cat', 08:46:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:46:56 INFO - 'PWD': '/builds/slave/test', 08:46:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:46:56 INFO - 'SHELL': '/bin/bash', 08:46:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:46:56 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:46:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:46:56 INFO - 'USER': 'cltbld', 08:46:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:46:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:46:56 INFO - 'XPC_FLAGS': '0x0', 08:46:56 INFO - 'XPC_SERVICE_NAME': '0', 08:46:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:46:56 INFO - Cleaning up... 08:46:56 INFO - Return code: 0 08:46:56 INFO - Running post-action listener: _resource_record_post_action 08:46:56 INFO - Running post-action listener: _start_resource_monitoring 08:46:56 INFO - Starting resource monitoring. 08:46:56 INFO - [mozharness: 2017-01-07 16:46:56.362611Z] Finished create-virtualenv step (success) 08:46:56 INFO - [mozharness: 2017-01-07 16:46:56.363588Z] Running install step. 08:46:56 INFO - Running pre-action listener: _resource_record_pre_action 08:46:56 INFO - Running main action method: install 08:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:46:56 INFO - Reading from file tmpfile_stdout 08:46:56 INFO - Detecting whether we're running mozinstall >=1.0... 08:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:46:56 INFO - Reading from file tmpfile_stdout 08:46:56 INFO - Output received: 08:46:56 INFO - Usage: mozinstall [options] installer 08:46:56 INFO - Options: 08:46:56 INFO - -h, --help show this help message and exit 08:46:56 INFO - -d DEST, --destination=DEST 08:46:56 INFO - Directory to install application into. [default: 08:46:56 INFO - "/builds/slave/test"] 08:46:56 INFO - --app=APP Application being installed. [default: firefox] 08:46:56 INFO - mkdir: /builds/slave/test/build/application 08:46:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:47:27 INFO - Reading from file tmpfile_stdout 08:47:27 INFO - Output received: 08:47:27 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:47:27 INFO - Running post-action listener: _resource_record_post_action 08:47:27 INFO - [mozharness: 2017-01-07 16:47:27.489497Z] Finished install step (success) 08:47:27 INFO - [mozharness: 2017-01-07 16:47:27.489663Z] Running run-tests step. 08:47:27 INFO - Running pre-action listener: _resource_record_pre_action 08:47:27 INFO - Running main action method: run_tests 08:47:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:47:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:47:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:47:27 INFO - 2017-01-07 08:47:27.504 screenresolution[1985:21484] starting screenresolution argv=screenresolution get 08:47:27 INFO - 2017-01-07 08:47:27.506 screenresolution[1985:21484] Display 0: 1600x1200x32@60 08:47:27 INFO - 2017-01-07 08:47:27.512 screenresolution[1986:21487] starting screenresolution argv=screenresolution list 08:47:27 INFO - Available Modes on Display 0 08:47:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:47:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:47:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:47:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:47:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:47:27 INFO - Intel Iris: 08:47:27 INFO - Chipset Model: Intel Iris 08:47:27 INFO - Type: GPU 08:47:27 INFO - Bus: Built-In 08:47:27 INFO - VRAM (Dynamic, Max): 1536 MB 08:47:27 INFO - Vendor: Intel (0x8086) 08:47:27 INFO - Device ID: 0x0a2e 08:47:27 INFO - Revision ID: 0x0009 08:47:27 INFO - Displays: 08:47:27 INFO - Display: 08:47:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:47:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:47:27 INFO - Display Serial Number: 1600x1200 60 08:47:27 INFO - Main Display: Yes 08:47:27 INFO - Mirror: Off 08:47:27 INFO - Online: Yes 08:47:27 INFO - Rotation: Supported 08:47:27 INFO - Return code: 0 08:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:47:27 INFO - Python 2.7.3 08:47:27 INFO - Return code: 0 08:47:27 INFO - grabbing minidump binary from tooltool 08:47: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')]} 08:47:27 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 0x1045a1d30>, '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 0x104407db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104599b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:47:27 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 08:47:27 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 08:47:27 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 08:47:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:47:27 INFO - Return code: 0 08:47:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:47:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:47:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:47:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:47:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 08:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0146 --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 08:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.563C8xUq5D/Render', 08:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:47:27 INFO - 'HOME': '/Users/cltbld', 08:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:47:27 INFO - 'LOGNAME': 'cltbld', 08:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:47:27 INFO - 'MOZ_NO_REMOTE': '1', 08:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:47:27 INFO - 'NO_EM_RESTART': '1', 08:47:27 INFO - 'PAGER': '/bin/cat', 08:47:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:47:27 INFO - 'PWD': '/builds/slave/test', 08:47:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:47:27 INFO - 'SHELL': '/bin/bash', 08:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pucGQIyrMT/Listeners', 08:47:27 INFO - 'TMPDIR': '/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/', 08:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:47:27 INFO - 'USER': 'cltbld', 08:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:47:27 INFO - 'XPC_FLAGS': '0x0', 08:47:27 INFO - 'XPC_SERVICE_NAME': '0', 08:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:47:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0146', '--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 08:47:28 INFO - mozversion application_buildid: 20170107073256 08:47:28 INFO - mozversion application_changeset: 9a9493b6820804ccb4d2089f337179341b151133 08:47:28 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:47:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:47:28 INFO - mozversion application_name: Firefox 08:47:28 INFO - mozversion application_remotingname: firefox-dev 08:47:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:47:28 INFO - mozversion application_vendor: Mozilla 08:47:28 INFO - mozversion application_version: 52.0a2 08:47:28 INFO - mozversion platform_buildid: 20170107073256 08:47:28 INFO - mozversion platform_changeset: 9a9493b6820804ccb4d2089f337179341b151133 08:47:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:47:28 INFO - mozversion platform_version: 52.0a2 08:47:28 INFO - using testdate: 1483807648 08:47:28 INFO - actual date: 1483807648 08:47:28 INFO - starting webserver on 'localhost:49299' 08:47:28 INFO - SUITE-START | Running 2 tests 08:47:28 INFO - TEST-START | dromaeo_css 08:47:28 INFO - operating with platform_type : mac_ 08:47:28 INFO - Initialising browser for dromaeo_css test... 08:47:28 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpRq3poW/profile http://localhost:49299/getInfo.html) 08:47:30 INFO - PROCESS | 1996 | __metrics Screen width/height:1600/1200 08:47:30 INFO - PROCESS | 1996 | colorDepth:24 08:47:30 INFO - PROCESS | 1996 | Browser inner width/height: 1024/689 08:47:30 INFO - PROCESS | 1996 | __metrics 08:47:30 INFO - PROCESS | 1996 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:47:30 INFO - PROCESS | 1996 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:47:31 INFO - TEST-INFO | 1996: exit 0 08:47:31 INFO - Browser initialized. 08:47:31 INFO - Running cycle 1/1 for dromaeo_css test... 08:47:31 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpRq3poW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:47:43 INFO - PROCESS | 1999 | RSS: Main: 222724096 08:47:43 INFO - PROCESS | 1999 | 08:50:47 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49299/tests/dromaeo/cssquery-ext.html) 08:50:50 INFO - PROCESS | 1999 | RSS: Main: 347357184 08:50:50 INFO - PROCESS | 1999 | 08:53:53 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-ext.html (next: http://localhost:49299/tests/dromaeo/cssquery-jquery.html) 08:53:53 INFO - PROCESS | 1999 | RSS: Main: 345419776 08:53:53 INFO - PROCESS | 1999 | 08:56:56 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49299/tests/dromaeo/cssquery-mootools.html) 08:56:56 INFO - PROCESS | 1999 | RSS: Main: 329859072 08:56:56 INFO - PROCESS | 1999 | 08:59:58 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49299/tests/dromaeo/cssquery-prototype.html) 08:59:59 INFO - PROCESS | 1999 | RSS: Main: 319873024 08:59:59 INFO - PROCESS | 1999 | 09:03:03 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49299/tests/dromaeo/cssquery-yui.html) 09:03:03 INFO - PROCESS | 1999 | RSS: Main: 314904576 09:03:03 INFO - PROCESS | 1999 | 09:06:06 INFO - PROCESS | 1999 | Cycle 1(1): loaded http://localhost:49299/tests/dromaeo/cssquery-yui.html (next: http://localhost:49299/tests/dromaeo/cssquery-dojo.html) 09:06:07 INFO - PROCESS | 1999 | RSS: Main: 378413056 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | __start_tp_report 09:06:07 INFO - PROCESS | 1999 | _x_x_mozilla_page_load 09:06:07 INFO - PROCESS | 1999 | _x_x_mozilla_page_load_details 09:06:07 INFO - PROCESS | 1999 | |i|pagename|runs| 09:06:07 INFO - PROCESS | 1999 | |0;dojo.html;2806.579013148028;3291.2594666200107;3307.503874418837;3332.26690128172;3356.9328613427733;5524.58565607579;5619.831405057845;5653.632513886594;5666.631668941516;5674.347450043247;5595.21666966625;5630.0991841305295;5666.914996275059;5673.886522269552;5710.257666503348;5010.699358038521;5148.099082660538;5154.32993710817;5207;5215.16557350822;5120.231965205212;5139.12634852076;5160.148575485059;5258.973705131488;5263.710495922723;4281.764502952336;5123.052235336456;5214.556762675177;5237.476252374751;5246.370435547739;5174.197999310113;5212.166053431471;5221.895562088737;5246.527812496894;5272.604554658377;4297.8495752648505;5151.381834179922;5226.451222621608;5241.633085684004;5269.789208431658;5540.833774986757;5563.388027316992;5594.356648985378;5599.804006859781;5638.746256418471;6114.358196333954;6168.907466388007;6201.813945581594;6204.162438070848;6220.253569571635;6299.275583307933;6318.399752023551;6325.96837015812;6331.715072821734;6339.36606339367;5606.85982850432;5682.403347648437;5697.373288938214;5770;5777;5601.243832082698;6282.560220784592;6331.873362532723;6331.96834015827;6356.110144579762;6079.148919151322;6098.634081955097;6104.298005729309;6114.633122012693;6128.509719222451;6072.240969878765;6182.721777520022;6204.751809927552;6272.278687950853;6299.338569450142;5086.364204474441;6022.789202377896;6067.544934129958;6100;6145.016797312498;6175.722092505848;6203.410675985774;6217.098520714471;6231.22109736283;6233.96883015582;4876.804927802848;4908.165611845995;4910;4922.827701030446;4948.356713627278;4364.672649551297;4377.1683380157665;4383.956160438419;4400.889977750582;4435.401220835211;5676.063449530864;5697.800576979868;5697.914531282034;5701.372848986608;5706.657600543981;5309.522143007148;6088.178095956989;6166.506679465632;6174.9073763893575;6181.876362472725;5639.661620302795;5681.943180568224;5684.8010319638615;5687.544996400278;5697.202391665171;5322.787088516493;5337.306150200449;5348.277982472317;5351.652142610717;5351.892962140735;6209.720562574695;6256.311805701369;6264.2796078451565;6266.530010249158;6271.31015588294;6112.685862051923;6182.1345011699295;6196.907046394217;6251.843703907439;6264.373562643699;6139.785107521216;6252.562320637512;6261.217347831521;6269.373062693877;6288.748450061947;6012.338642749207;6072.332043475126;6155.84610384744;6165;6200.162977998093;6142.498775697809;6159.19930409044;6194.938050619436;6218.689065546795;6241.563090583615;6122.173506576733;6126.945200426759;6130.459285710702;6134.263888333428;6135.263289243823;5784;6095.51235901118;6119.479844213113;6128.846778830565;6140.631562106288;5802.738876750472;5864.384239654775;5877;5908.556858235564;5957.4042595740075;5986.431289027535;6127.708789264132;6136.7948077883175;6138.848241798433;6141.723622437091;4834.395700537433;5888.646681199141;5898.911516327173;5906.557008224315;5968.8806223876145 09:06:07 INFO - PROCESS | 1999 | |1;ext.html;480.80767692922836;483.9903201935961;505.3758608118974;519.4883040205397;520.8229202071295;29588.556171657416;38637;39872;39876.80061599695;41514.58485415145;39761.801190994076;40152.59847401525;40181;40199.59800401995;40280.59719402805;9202.999999999984;9392.342536022481;9401.670941517048;9411.200047995928;9424.481653509054;7380.852382952337;8360.581970901461;9248;9564.426134431922;10463.633772817953;11269.492872820743;11299.152563557725;11300.095992320594;11307.943460282728;11324.830127548094;8319.916800831974;11201.831972520418;11276.548938042468;11285.661430157108;11287.209895307331;8393.95803020981;10679.038886500175;11048.392338421383;11050.613228536962;11221.158413118967;38823.8058809707;39302.410463843065;39353.01617459558;39373.803130984445;39377;3310.1890036941104;3317.618473875487;3333.3666603345287;3579.2483578448555;3847.3459511882766;28091.438171236667;28337.858310708314;29214.707852921623;29583.964561240253;30365.544516832266;2886.898958536441;3120.0639808057717;3183.3474137801695;3201.5357773123;3204.1829333519804;457564;459663;460198;461106;470533;32435;32954.67045329564;33385.998420047436;59147.704261478415;59707;34068.82965585206;34128.14679632979;34176.316473670886;34187.316253675286;34224.657753422645;14041;14204;14207;14211.64470888236;14224.786628200585;10934.507947142398;11119.499622516845;12015.579454719043;12051.758964820654;12168.695782605506;7331.670074846645;7646.847063058708;7839.686412543434;7844.529328240324;7896.881546776803;2764.585312203186;2795.4688609164195;3170.508571171472;3236.3527294541186;3245.902622921316;864.489950928955;1026.6252817721627;1039.3555995282823;1083.9620613278655;1093.5953697132113;23970.161044363365;26257.737422625913;27671.75477103495;28754.281142971595;29532.409351812843;881.4662487272228;1003.4430890855646;1019.8113349030305;1041.0890470838017;1107.2028139739375;14894.106353618818;15091.622709432133;15118.622034449007;15300.846991530165;15505.224738763016;629091;631117;633167;633374;634268;54182;54752;54800.725996369765;54804;54975;1193.1170933509313;1202.9759404811855;1247.6319485751726;1249.194269696059;1298.8636193199577;26353.868230658725;27663.72336276692;30618.92833750808;30652.92714755062;31264.374712505167;52340.21489677734;52952;52983;53074.73462632662;53155.6711082226;552006;557442;559875;560110.1994490002;561582;25846.22461326163;25928.351791204615;26307.4738505225;26541.60187597226;26832;29261.7073829259;45005.54994450013;46149.07701846011;46345.536544634124;48343.61594688338;27819.860900695367;34670.95987120391;36609.63390366062;37717.86846394613;37868.62131378651;35989;36841.631583684895;36849;37646.43530346992;37939.430908536946;36743.26513469662;37445.81277093597;37609.059773505884;39603.811885643474;40220.597794022855;36660.63339366679;39407.97672421097;39797.60202398055;39867;40792.79603601963;29377.97177098791;30229.546556801226;30256.469212198088;30940.845295773375;31263.53104703477 09:06:07 INFO - PROCESS | 1999 | |2;jquery.html;311.3352991363439;364.20239675111486;371.3964807188318;386.17166178547035;401.0715194325137;19023.61952760946;19452.319168829094;20462.89768551157;20974.475638109056;21110.05004774785;19501.804981950176;19549.21803127873;20115.295964641206;20123.798762012375;20147.899260503713;5417.431169727181;5579.079451890433;5581.190727344532;5607.915881261774;5788.450097240755;4734.621230301567;4796.856094317176;4802.111609352281;4802.919343147799;4805.495422980589;4764.618830493552;4765.142274390609;4769.833055843046;4771.117343291485;4779.80880764769;5135.58915286778;5370.677759334433;5429.6742195468205;5454.018276710231;5463.071277882769;5269.841904742864;5300.893982120336;5323.627346085776;5324.201369794523;5527.806526771584;13034.478620855154;13257.66855828612;13276.668083297898;13282.867171328357;14640.70718585633;2136.2309568555306;2216.312942987663;2274.9658755118685;2294.816414686821;2337.0418128567208;9894.505274736306;10215.978402159799;10449.529771160316;12446.937765311206;14242.572722818331;1845.391020963079;1845.5847434327304;1887.7734671839467;1919.8560107991816;1923.913423895928;93332;118257;119607.4019629905;121861.78138218682;123688.38155809163;9302.813943721088;9752.171065459515;9994.700158995242;10136.239782016379;10320.638777642747;12591.118621696576;12688.555900543437;12698.30159341245;12702.9364853177;12703.618891433272;7782.727604533814;8007.839843203104;8019.117897031322;8107.635156417975;8110.229528194812;8248;8255.917440825515;8273.214044665747;8404.24361807428;8404.243618074403;3495.3883070463075;3685.281370132852;3957.5448823385104;3990.68074554035;4059.2490389278078;1466.65533599604;1795.2674646715107;1832.9633407331778;1878.8027257138076;1933.7969513201192;812.524673066251;912.3932584831012;920.8066306075665;979.3193730357476;987.2792861211356;20298.69551956722;20917.790822091887;20950.58098838015;21126.78873211279;21244.681329780065;896.8475359188953;901.3420203251663;924.1451657217182;932.911373419524;941.4774799986074;10321.483925803679;11149.554017839358;11160.995510404102;11182.552697891993;11196.272242304387;570868;576166;588439;619437;620713.5857282829;73971.63014184895;86789.56605216934;95763;108975;119070;939.957701903416;956.1872408452898;964.262339310428;984.3011461862015;994.3089552760762;17589.20848561792;18057.097145142427;18330.633387332444;18421.894686318865;18596.81403186005;51936.74031629818;52166.69583260297;52616.736916315174;52789;53859.73070134624;74800;74989.62505187657;76018.23981760112;76723;76925.61537192279;5259.39516955555;5496.120620700669;6726.529142959946;6955.408790252885;7999.800004999922;9191.816163676554;13032.739345213233;13465;13498.52755153565;13592.592222233348;11077.556897724;11338.886611133783;11454.599089031844;11490.310581365145;11566.479508421973;9637.18083962871;10382.532786024496;10661.573537058432;10964.835527466936;11159.381889626122;11419.257748246337;11511.884881151082;11608.129390295593;11977.820332695192;12009.939950300193;7414.962925185339;7497.325240728361;7499.88750168737;7640.274173953466;7812.453128280966;8368.163183681583;9926.454045027593;9973.252006099716;11139.33164010162;11616.709582260512 09:06:07 INFO - PROCESS | 1999 | |3;mootools.html;1420.460225114456;1449.260876952754;1580.5495433801368;1752.0801579170925;1795.9615836026107;7988.92011079889;8414.579271036439;8415.410921235509;8421.115782842806;8426.662933482668;7287.19840817511;7525.4732168748205;7895.447318687694;8139.593020348989;8229.629666665;2266.9886650566764;2304.573653874039;2305.7348404933396;2309.688192094071;2309.884505774713;2293.4495721027;2318.547883162784;2346.718393792747;2349.0368948731025;2350.4711439925964;2255.9210427635035;2260.050778672953;2287.165184707578;2290.7938285554296;2294.2199652118275;2231.966520502194;2277.6241920083166;2295.9196428124937;2300.321405185466;2300.7009088818513;2294.8852557372234;2316.108298305148;2317.5364927014666;2318.2349824557855;2322.9767702323097;8235.670573177065;8247;8334.541600211985;8340.416170868042;8353.457025293337;5031.371078615173;5193.37679478465;5194.428612852583;5197.922031169535;5201.479852014806;3263.6573159818354;3470.0804286864;3470.3400758102816;3589.0847833802213;3598.442241452579;935.9017303183135;1013.9797204055877;1052.026875140492;1080.027974822658;1100.8293714474269;10727.678169654922;10805.783884322269;10892.40091794951;10902.073323767489;10913.945430272877;4415.62467190286;4546.431696037996;4636.86089417318;4642.187617166982;4654.883627909262;9310;9343.859842102374;9346.813063738688;9347.485888276211;9357.251419886392;5068.974655126701;5150.793968241228;5151.974240128776;5154.329937108152;5160.225966105039;4279.315309550457;4377.468239700044;4433.357163211316;4636.397268355092;4798.256270278112;3718.386466233041;3741.120836603396;3817.8091095445116;3838.9808050960123;3848.8460461581785;1248.375812093953;1253.9310337931502;1256.7926292161874;1265.2218885385605;1266.5567051532075;708.5359089796192;769.6151924037981;806.9031716194095;842.4566154830222;844.7423535821633;4983.8504844854715;5108.386993560796;5117.590592752571;5176.559992400613;5196.32447781786;444.9911001779946;874.8364674982258;926.3120271638758;931.3434029009532;992.161623428202;3365.730741540671;3369.157710572357;3398.5242066110764;3409.863605455754;3498.1254686328416;9619.711408657751;9972.601095956226;10040.09639132467;10187.490625468698;10194.337368071052;9806.509674516246;10130.544125514369;10135.493225338703;10150.492475376202;10155.593776249016;7698.730544430918;7813.570253635991;7941.086775020831;7944.44388892772;7971.800704982305;5026.246063090565;5057.418396884405;5058.215976523645;5149.407818100966;5256.290400795843;9121.042290559395;9240.353175277665;9252.95373523128;9456.669016584387;9477;9338.719838404859;9359.391639543408;9542.141207291377;9671.854922176313;9677.080677335642;5924.940750592439;6601.768938087144;6686.264510903894;6688.799336019927;6748.763793267212;7705.267999540035;7766.029246344207;7793.454458187873;7806.531608103532;7810.062792464941;6878.140232470942;6986.441084713312;7051.894221586577;7156.355927966508;7229.240929702516;6814.795556133324;6972.965135174291;7035.929640703527;7065.328793764585;7123.180834204133;6432.581882177644;6454.419102280817;6520.054592084216;6526.575772574767;6531.11829902957;4531.048479819143;4571.1543364477675;4618.468876079294;4664.113818374498;4709.411323584552;4426.358178064227;4533.911861153366;4596.724196548218;4597.655175861757;4706.247000479907 09:06:07 INFO - PROCESS | 1999 | |4;prototype.html;262.41088755743357;309.4491804587834;310.30182090296825;314.1329929394868;316.43358388484614;4576.794044268012;5240.353621421182;5265.499777521139;5269.104252277118;5287.915977224669;4179.540250572434;4689.835855745049;5117.692938423697;5173.3533308336455;5214.243934629477;3398.7111095556907;3475.480276799313;3619.348517266891;3863.8840834775;3938.921221575567;3599.8560057597665;4001.879943601682;4002;4016.5782592827773;4043.777592232426;3930.9189972757576;3969.4045893115976;3977.3238549446664;3981.462502562146;3983.58172391899;3317;3593.94609080864;3723.478712980185;3828.846846126152;3982.2632812929555;3454.4972936772333;3476.6349533298894;3481.268933523963;3491.4239150540384;3496.17839807645;4598.895745371894;5023.748812559394;5048.848534543969;5086.160783470723;5120.641555091145;3811.2568049230413;4043.5241136985082;4361.149575832714;4475.686701930867;4580.862574122782;5413.404525502192;5414.07960646691;5417.864553386157;5420.7018613976215;5430.8099216527235;3589.964100358989;3670.247599242149;3819.8854034379015;3838.4626152338415;3841.4621952926614;4734.810607575727;4749.857504274877;5429.4570542945785;5622.8313150605545;5652.98246315663;3863.5750067492554;3864.9757814179266;3874.728768986144;3880.835749275206;3900.2979463696806;3564.8395822187545;3750.9437358439645;3923.588023257574;3927.0378757204667;3961.6632586229916;4545.863624091283;4556.954430455719;4558.020025694492;4558.544145585415;4561.813928378646;4806.110869489155;5264.419236299716;5265.552428043583;5373.167159090347;5410.026195284808;1122.5790328626765;1162.5001249462812;1257.4090177616506;1262.072376803049;1270.5743575902177;701.2741812224425;743.3495691270139;837.380338549469;883.6642076011075;887.4719541872576;4142.46148000758;4353.564643535621;4615.399998000238;4662.836800711959;4991.326170966873;5550.72246387679;5591.944080559224;5597.468240517144;5608.775648973995;5610.4670056344585;4315.791578358065;4755.881102972453;5111.463296353903;5127.4872512748425;5140.665856719302;2307.1852340144997;2370.9644355334685;2727.372704278027;2759.7102304258165;2767.301880666334;5247.580193584504;5410.945890541044;5432.185172224119;5470.960517501741;5480.616356854982;4439.045605194834;4715.976420117878;4754.334906698664;5387.299651045418;5405.648632838853;4572.833927348504;4943.060818444484;5076.111680455905;5285.735713214247;5469.56243500519;5061.039292014213;5275;5281.207818827053;5328.096187577702;5343.46185561855;4868.878278042936;4977.427595826382;5155.664881782672;5176.576441478624;5241.842744717512;4956.727379994135;5707.971460142673;5764.250647415809;5794.01501744696;5794.7682092717505;3259.967400326061;3371;3796.37359835624;3861.555921069113;3864.922701545897;4790.8323208687525;5194.610404219623;5520.227168196536;5617.354004289559;5717.942820571908;5014.398272207359;5450.890982180414;5451.809186678447;5454.863628409322;5487.64330318528;4670.159371313196;5349;5448.427915068861;5462.426445223195;5516.779328826802;5130.51260130287;5352.652077614943;5356.009138309425;5379.4082650907585;5380.73096345189;4807.278908163804;5203.947960520498;5348.572114230775;5358.142697168434;5453.672779633234;4510.188166130128;4642.907141857211;5427.99582077317;5450.073487507213;5498.862528436821 09:06:07 INFO - PROCESS | 1999 | |5;yui.html;665.6405541007856;666.4235436347559;696.2132789947359;713.101492119929;723.2405973727584;13824.032317737763;14431.989760716753;14438.133711977262;14443.638909027266;14445.422183112676;12765.170263932861;12867.09930304879;12879.93560032201;12884.67788305293;12905.935470322635;634.961902285862;805.8307755371379;816.5468165168329;821.1993306526149;821.4865708931918;652.5138771615129;660.465023331101;661.6129564204946;662.1127688896877;663.9402453779159;838.4885220015785;858.6908712863365;868.0581568997645;876.3996662286322;877.9824403511926;821.1296026212234;858.5406807358033;865.9350548708841;866.3588944181323;870.0559892516627;497.57954528423426;643.2120652201063;644.1143427786793;646.066434002866;647.1586936981905;10514;11526.308421494738;13540.864591354059;13573;13935.233562154077;12700.555480558136;13095.214287142802;13135.934320328433;13179.60461186166;13202.86797132026;10885.455727213686;11038.779224415466;11138.443077846076;11178.888211117948;11208.327500350006;3579.552555930509;3650.908727281813;3660.68884144848;3667.339878821811;3777.5089238399105;76845.61577192078;81749.59125204336;81766;82605.58697206536;82853.58573207156;9793.608255669693;10039.749006274755;10126.139278161292;10200.38797672142;10315.1747860171;19176.616467670567;19724.149644571684;19832.70250946237;19944.3019494317;20312.289069882485;6417.1657684500715;7410.5183163094225;7486.363659088929;7516.887246691194;7577.507462014952;4179.231595783116;4243.554426785205;4247.32042873145;4332.4367832181615;4387.407699960529;3361.7310615150727;3450.7929524228625;3468.9826550867588;3469.2714529948994;3476.3742526344995;531.5455285730721;626.4111734969206;636.3413866647998;637.8501052252717;638.7030031035591;545.0543307361725;549.4121290219426;559.4685049203273;602.4969150759077;648.5654611410366;8115.797105072303;8614.741557753277;8853.51305678181;9122.996470388252;9362.485063321583;622.5237693164732;661.3221448015726;667.3226674924955;668.2215219269497;677.3937326093119;3432.9485057724155;4266.189424009428;4444.799984000663;4475.239209334421;4599.149157405891;93546.59680104804;102004;107680;109461;111238;64126.7936603168;92117.53941230386;94923.10153796885;95697.52151239199;98005.18314781896;86231;86527.26945461181;89583.55208224048;89921;90225;8492.575371231538;8657.39398242117;8672.219500245008;8676.08901065379;8909.599068042084;42369.576304237795;50412;52791.47208528019;53023;53744;76518;76731;79685.8047129305;80603;81008;10758.892411075789;10819.459027048459;11133.165012623924;11252.774944500901;11347.886521134684;10386.493958375842;11939.283642981449;11982.340971246316;12057.879421205676;12427.875721242672;11508.769824603629;11760.35318057515;11903.642890713292;12048.638540843789;12471.875281247072;9992.750181245527;10473.790524189626;11535.596254131066;11595.362255076052;13217.669558261121;12274.877251227374;12760.234385936874;13035.413406396925;13126.60620181396;13204.867951320748;9155.404898681565;10443.791124177322;10846.837297440703;11192.720181995515;11395.316281023164;10740.785184296426;10880.510377033212;11154.772974972584;11453.255538389978;11493.54025838957 09:06:07 INFO - PROCESS | 1999 | __end_tp_report 09:06:07 INFO - PROCESS | 1999 | __start_cc_report 09:06:07 INFO - PROCESS | 1999 | _x_x_mozilla_cycle_collect,2050 09:06:07 INFO - PROCESS | 1999 | __end_cc_report 09:06:07 INFO - PROCESS | 1999 | __startTimestamp1483808767204__endTimestamp 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | ------- Summary: start ------- 09:06:07 INFO - PROCESS | 1999 | Number of tests: 6 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | [#0] dojo.html Cycles:165 Average:5678.68 Median:5877.00 stddev:668.86 (11.4%) stddev-sans-first:631.83 09:06:07 INFO - PROCESS | 1999 | Values: 2806.6 3291.3 3307.5 3332.3 3356.9 5524.6 5619.8 5653.6 5666.6 5674.3 5595.2 5630.1 5666.9 5673.9 5710.3 5010.7 5148.1 5154.3 5207.0 5215.2 5120.2 5139.1 5160.1 5259.0 5263.7 4281.8 5123.1 5214.6 5237.5 5246.4 5174.2 5212.2 5221.9 5246.5 5272.6 4297.8 5151.4 5226.5 5241.6 5269.8 5540.8 5563.4 5594.4 5599.8 5638.7 6114.4 6168.9 6201.8 6204.2 6220.3 6299.3 6318.4 6326.0 6331.7 6339.4 5606.9 5682.4 5697.4 5770.0 5777.0 5601.2 6282.6 6331.9 6332.0 6356.1 6079.1 6098.6 6104.3 6114.6 6128.5 6072.2 6182.7 6204.8 6272.3 6299.3 5086.4 6022.8 6067.5 6100.0 6145.0 6175.7 6203.4 6217.1 6231.2 6234.0 4876.8 4908.2 4910.0 4922.8 4948.4 4364.7 4377.2 4384.0 4400.9 4435.4 5676.1 5697.8 5697.9 5701.4 5706.7 5309.5 6088.2 6166.5 6174.9 6181.9 5639.7 5681.9 5684.8 5687.5 5697.2 5322.8 5337.3 5348.3 5351.7 5351.9 6209.7 6256.3 6264.3 6266.5 6271.3 6112.7 6182.1 6196.9 6251.8 6264.4 6139.8 6252.6 6261.2 6269.4 6288.7 6012.3 6072.3 6155.8 6165.0 6200.2 6142.5 6159.2 6194.9 6218.7 6241.6 6122.2 6126.9 6130.5 6134.3 6135.3 5784.0 6095.5 6119.5 6128.8 6140.6 5802.7 5864.4 5877.0 5908.6 5957.4 5986.4 6127.7 6136.8 6138.8 6141.7 4834.4 5888.6 5898.9 5906.6 5968.9 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | [#1] ext.html Cycles:180 Average:66742.86 Median:34447.81 stddev:148608.24 (431.4%) stddev-sans-first:148941.85 09:06:07 INFO - PROCESS | 1999 | Values: 480.8 484.0 505.4 519.5 520.8 29588.6 38637.0 39872.0 39876.8 41514.6 39761.8 40152.6 40181.0 40199.6 40280.6 9203.0 9392.3 9401.7 9411.2 9424.5 7380.9 8360.6 9248.0 9564.4 10463.6 11269.5 11299.2 11300.1 11307.9 11324.8 8319.9 11201.8 11276.5 11285.7 11287.2 8394.0 10679.0 11048.4 11050.6 11221.2 38823.8 39302.4 39353.0 39373.8 39377.0 3310.2 3317.6 3333.4 3579.2 3847.3 28091.4 28337.9 29214.7 29584.0 30365.5 2886.9 3120.1 3183.3 3201.5 3204.2 457564.0 459663.0 460198.0 461106.0 470533.0 32435.0 32954.7 33386.0 59147.7 59707.0 34068.8 34128.1 34176.3 34187.3 34224.7 14041.0 14204.0 14207.0 14211.6 14224.8 10934.5 11119.5 12015.6 12051.8 12168.7 7331.7 7646.8 7839.7 7844.5 7896.9 2764.6 2795.5 3170.5 3236.4 3245.9 864.5 1026.6 1039.4 1084.0 1093.6 23970.2 26257.7 27671.8 28754.3 29532.4 881.5 1003.4 1019.8 1041.1 1107.2 14894.1 15091.6 15118.6 15300.8 15505.2 629091.0 631117.0 633167.0 633374.0 634268.0 54182.0 54752.0 54800.7 54804.0 54975.0 1193.1 1203.0 1247.6 1249.2 1298.9 26353.9 27663.7 30618.9 30652.9 31264.4 52340.2 52952.0 52983.0 53074.7 53155.7 552006.0 557442.0 559875.0 560110.2 561582.0 25846.2 25928.4 26307.5 26541.6 26832.0 29261.7 45005.5 46149.1 46345.5 48343.6 27819.9 34671.0 36609.6 37717.9 37868.6 35989.0 36841.6 36849.0 37646.4 37939.4 36743.3 37445.8 37609.1 39603.8 40220.6 36660.6 39408.0 39797.6 39867.0 40792.8 29378.0 30229.5 30256.5 30940.8 31263.5 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | [#2] jquery.html Cycles:180 Average:33313.39 Median:2230.16 stddev:98818.65 (4431.0%) stddev-sans-first:99064.79 09:06:07 INFO - PROCESS | 1999 | Values: 311.3 364.2 371.4 386.2 401.1 19023.6 19452.3 20462.9 20974.5 21110.1 19501.8 19549.2 20115.3 20123.8 20147.9 5417.4 5579.1 5581.2 5607.9 5788.5 4734.6 4796.9 4802.1 4802.9 4805.5 4764.6 4765.1 4769.8 4771.1 4779.8 5135.6 5370.7 5429.7 5454.0 5463.1 5269.8 5300.9 5323.6 5324.2 5527.8 13034.5 13257.7 13276.7 13282.9 14640.7 2136.2 2216.3 2275.0 2294.8 2337.0 9894.5 10216.0 10449.5 12446.9 14242.6 1845.4 1845.6 1887.8 1919.9 1923.9 93332.0 118257.0 119607.4 121861.8 123688.4 9302.8 9752.2 9994.7 10136.2 10320.6 12591.1 12688.6 12698.3 12702.9 12703.6 7782.7 8007.8 8019.1 8107.6 8110.2 8248.0 8255.9 8273.2 8404.2 8404.2 3495.4 3685.3 3957.5 3990.7 4059.2 1466.7 1795.3 1833.0 1878.8 1933.8 812.5 912.4 920.8 979.3 987.3 20298.7 20917.8 20950.6 21126.8 21244.7 896.8 901.3 924.1 932.9 941.5 10321.5 11149.6 11161.0 11182.6 11196.3 570868.0 576166.0 588439.0 619437.0 620713.6 73971.6 86789.6 95763.0 108975.0 119070.0 940.0 956.2 964.3 984.3 994.3 17589.2 18057.1 18330.6 18421.9 18596.8 51936.7 52166.7 52616.7 52789.0 53859.7 74800.0 74989.6 76018.2 76723.0 76925.6 5259.4 5496.1 6726.5 6955.4 7999.8 9191.8 13032.7 13465.0 13498.5 13592.6 11077.6 11338.9 11454.6 11490.3 11566.5 9637.2 10382.5 10661.6 10964.8 11159.4 11419.3 11511.9 11608.1 11977.8 12009.9 7415.0 7497.3 7499.9 7640.3 7812.5 8368.2 9926.5 9973.3 11139.3 11616.7 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | [#3] mootools.html Cycles:180 Average:5355.31 Median:5057.82 stddev:2977.83 (58.9%) stddev-sans-first:2971.50 09:06:07 INFO - PROCESS | 1999 | Values: 1420.5 1449.3 1580.5 1752.1 1796.0 7988.9 8414.6 8415.4 8421.1 8426.7 7287.2 7525.5 7895.4 8139.6 8229.6 2267.0 2304.6 2305.7 2309.7 2309.9 2293.4 2318.5 2346.7 2349.0 2350.5 2255.9 2260.1 2287.2 2290.8 2294.2 2232.0 2277.6 2295.9 2300.3 2300.7 2294.9 2316.1 2317.5 2318.2 2323.0 8235.7 8247.0 8334.5 8340.4 8353.5 5031.4 5193.4 5194.4 5197.9 5201.5 3263.7 3470.1 3470.3 3589.1 3598.4 935.9 1014.0 1052.0 1080.0 1100.8 10727.7 10805.8 10892.4 10902.1 10913.9 4415.6 4546.4 4636.9 4642.2 4654.9 9310.0 9343.9 9346.8 9347.5 9357.3 5069.0 5150.8 5152.0 5154.3 5160.2 4279.3 4377.5 4433.4 4636.4 4798.3 3718.4 3741.1 3817.8 3839.0 3848.8 1248.4 1253.9 1256.8 1265.2 1266.6 708.5 769.6 806.9 842.5 844.7 4983.9 5108.4 5117.6 5176.6 5196.3 445.0 874.8 926.3 931.3 992.2 3365.7 3369.2 3398.5 3409.9 3498.1 9619.7 9972.6 10040.1 10187.5 10194.3 9806.5 10130.5 10135.5 10150.5 10155.6 7698.7 7813.6 7941.1 7944.4 7971.8 5026.2 5057.4 5058.2 5149.4 5256.3 9121.0 9240.4 9253.0 9456.7 9477.0 9338.7 9359.4 9542.1 9671.9 9677.1 5924.9 6601.8 6686.3 6688.8 6748.8 7705.3 7766.0 7793.5 7806.5 7810.1 6878.1 6986.4 7051.9 7156.4 7229.2 6814.8 6973.0 7035.9 7065.3 7123.2 6432.6 6454.4 6520.1 6526.6 6531.1 4531.0 4571.2 4618.5 4664.1 4709.4 4426.4 4533.9 4596.7 4597.7 4706.2 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | [#4] prototype.html Cycles:180 Average:4346.91 Median:4806.69 stddev:1328.64 (27.6%) stddev-sans-first:1296.51 09:06:07 INFO - PROCESS | 1999 | Values: 262.4 309.4 310.3 314.1 316.4 4576.8 5240.4 5265.5 5269.1 5287.9 4179.5 4689.8 5117.7 5173.4 5214.2 3398.7 3475.5 3619.3 3863.9 3938.9 3599.9 4001.9 4002.0 4016.6 4043.8 3930.9 3969.4 3977.3 3981.5 3983.6 3317.0 3593.9 3723.5 3828.8 3982.3 3454.5 3476.6 3481.3 3491.4 3496.2 4598.9 5023.7 5048.8 5086.2 5120.6 3811.3 4043.5 4361.1 4475.7 4580.9 5413.4 5414.1 5417.9 5420.7 5430.8 3590.0 3670.2 3819.9 3838.5 3841.5 4734.8 4749.9 5429.5 5622.8 5653.0 3863.6 3865.0 3874.7 3880.8 3900.3 3564.8 3750.9 3923.6 3927.0 3961.7 4545.9 4557.0 4558.0 4558.5 4561.8 4806.1 5264.4 5265.6 5373.2 5410.0 1122.6 1162.5 1257.4 1262.1 1270.6 701.3 743.3 837.4 883.7 887.5 4142.5 4353.6 4615.4 4662.8 4991.3 5550.7 5591.9 5597.5 5608.8 5610.5 4315.8 4755.9 5111.5 5127.5 5140.7 2307.2 2371.0 2727.4 2759.7 2767.3 5247.6 5410.9 5432.2 5471.0 5480.6 4439.0 4716.0 4754.3 5387.3 5405.6 4572.8 4943.1 5076.1 5285.7 5469.6 5061.0 5275.0 5281.2 5328.1 5343.5 4868.9 4977.4 5155.7 5176.6 5241.8 4956.7 5708.0 5764.3 5794.0 5794.8 3260.0 3371.0 3796.4 3861.6 3864.9 4790.8 5194.6 5520.2 5617.4 5717.9 5014.4 5450.9 5451.8 5454.9 5487.6 4670.2 5349.0 5448.4 5462.4 5516.8 5130.5 5352.7 5356.0 5379.4 5380.7 4807.3 5203.9 5348.6 5358.1 5453.7 4510.2 4642.9 5428.0 5450.1 5498.9 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - PROCESS | 1999 | [#5] yui.html Cycles:180 Average:19836.93 Median:4537.19 stddev:29274.93 (645.2%) stddev-sans-first:29321.66 09:06:07 INFO - PROCESS | 1999 | Values: 665.6 666.4 696.2 713.1 723.2 13824.0 14432.0 14438.1 14443.6 14445.4 12765.2 12867.1 12879.9 12884.7 12905.9 635.0 805.8 816.5 821.2 821.5 652.5 660.5 661.6 662.1 663.9 838.5 858.7 868.1 876.4 878.0 821.1 858.5 865.9 866.4 870.1 497.6 643.2 644.1 646.1 647.2 10514.0 11526.3 13540.9 13573.0 13935.2 12700.6 13095.2 13135.9 13179.6 13202.9 10885.5 11038.8 11138.4 11178.9 11208.3 3579.6 3650.9 3660.7 3667.3 3777.5 76845.6 81749.6 81766.0 82605.6 82853.6 9793.6 10039.7 10126.1 10200.4 10315.2 19176.6 19724.1 19832.7 19944.3 20312.3 6417.2 7410.5 7486.4 7516.9 7577.5 4179.2 4243.6 4247.3 4332.4 4387.4 3361.7 3450.8 3469.0 3469.3 3476.4 531.5 626.4 636.3 637.9 638.7 545.1 549.4 559.5 602.5 648.6 8115.8 8614.7 8853.5 9123.0 9362.5 622.5 661.3 667.3 668.2 677.4 3432.9 4266.2 4444.8 4475.2 4599.1 93546.6 102004.0 107680.0 109461.0 111238.0 64126.8 92117.5 94923.1 95697.5 98005.2 86231.0 86527.3 89583.6 89921.0 90225.0 8492.6 8657.4 8672.2 8676.1 8909.6 42369.6 50412.0 52791.5 53023.0 53744.0 76518.0 76731.0 79685.8 80603.0 81008.0 10758.9 10819.5 11133.2 11252.8 11347.9 10386.5 11939.3 11982.3 12057.9 12427.9 11508.8 11760.4 11903.6 12048.6 12471.9 9992.8 10473.8 11535.6 11595.4 13217.7 12274.9 12760.2 13035.4 13126.6 13204.9 9155.4 10443.8 10846.8 11192.7 11395.3 10740.8 10880.5 11154.8 11453.3 11493.5 09:06:07 INFO - PROCESS | 1999 | -------- Summary: end -------- 09:06:07 INFO - PROCESS | 1999 | 09:06:07 INFO - TEST-INFO | 1999: exit 0 09:06:07 INFO - TEST-OK | dromaeo_css | took 1119764ms 09:06:07 INFO - TEST-START | kraken 09:06:07 INFO - operating with platform_type : mac_ 09:06:07 INFO - Initialising browser for kraken test... 09:06:07 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpNrhj_v/profile http://localhost:49299/getInfo.html) 09:06:10 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 09:06:10 INFO - PROCESS | 2004 | colorDepth:24 09:06:10 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 09:06:10 INFO - PROCESS | 2004 | __metrics 09:06:10 INFO - PROCESS | 2004 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:06:10 INFO - PROCESS | 2004 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:11 INFO - TEST-INFO | 2004: exit 0 09:06:11 INFO - Browser initialized. 09:06:11 INFO - Running cycle 1/1 for kraken test... 09:06:11 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/tmpNrhj_v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:23 INFO - PROCESS | 2005 | RSS: Main: 222932992 09:06:23 INFO - PROCESS | 2005 | 09:06:26 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-beat-detection) 09:06:27 INFO - PROCESS | 2005 | RSS: Main: 273121280 09:06:27 INFO - PROCESS | 2005 | 09:06:29 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-dft) 09:06:30 INFO - PROCESS | 2005 | RSS: Main: 285622272 09:06:30 INFO - PROCESS | 2005 | 09:06:33 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-fft) 09:06:34 INFO - PROCESS | 2005 | RSS: Main: 380616704 09:06:34 INFO - PROCESS | 2005 | 09:06:36 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49299/tests/kraken/driver.html?testName=audio-oscillator) 09:06:37 INFO - PROCESS | 2005 | RSS: Main: 283262976 09:06:37 INFO - PROCESS | 2005 | 09:06:39 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:06:39 INFO - PROCESS | 2005 | RSS: Main: 284508160 09:06:39 INFO - PROCESS | 2005 | 09:06:42 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-darkroom) 09:06:43 INFO - PROCESS | 2005 | RSS: Main: 325480448 09:06:43 INFO - PROCESS | 2005 | 09:06:45 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49299/tests/kraken/driver.html?testName=imaging-desaturate) 09:06:46 INFO - PROCESS | 2005 | RSS: Main: 327045120 09:06:46 INFO - PROCESS | 2005 | 09:06:49 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49299/tests/kraken/driver.html?testName=json-parse-financial) 09:06:49 INFO - PROCESS | 2005 | RSS: Main: 324616192 09:06:49 INFO - PROCESS | 2005 | 09:06:51 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49299/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:06:52 INFO - PROCESS | 2005 | RSS: Main: 298926080 09:06:52 INFO - PROCESS | 2005 | 09:06:54 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:06:54 INFO - PROCESS | 2005 | RSS: Main: 301453312 09:06:54 INFO - PROCESS | 2005 | 09:06:56 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:06:57 INFO - PROCESS | 2005 | RSS: Main: 304128000 09:06:57 INFO - PROCESS | 2005 | 09:07:00 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:07:01 INFO - PROCESS | 2005 | RSS: Main: 322486272 09:07:01 INFO - PROCESS | 2005 | 09:07:04 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:07:04 INFO - PROCESS | 2005 | RSS: Main: 315645952 09:07:04 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49299/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49299/tests/kraken/driver.html?testName=ai-astar) 09:07:06 INFO - PROCESS | 2005 | RSS: Main: 359907328 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | __start_tp_report 09:07:06 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 09:07:06 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 09:07:06 INFO - PROCESS | 2005 | |i|pagename|runs| 09:07:06 INFO - PROCESS | 2005 | |0;ai-astar;118;116;115;116;119;161;171;112;115;114 09:07:06 INFO - PROCESS | 2005 | |1;audio-beat-detection;146;112;110;144;110;113;109;113;138;109 09:07:06 INFO - PROCESS | 2005 | |2;audio-dft;185;184;184;183;184;184;185;183;185;187 09:07:06 INFO - PROCESS | 2005 | |3;audio-fft;81;59;58;90;61;59;59;57;84;73 09:07:06 INFO - PROCESS | 2005 | |4;audio-oscillator;82;70;96;71;67;69;89;67;70;92 09:07:06 INFO - PROCESS | 2005 | |5;imaging-gaussian-blur;87;86;87;85;87;117;87;84;88;84 09:07:06 INFO - PROCESS | 2005 | |6;imaging-darkroom;92;93;93;93;93;92;93;93;91;119 09:07:06 INFO - PROCESS | 2005 | |7;imaging-desaturate;82;84;78;79;81;81;86;83;82;81 09:07:06 INFO - PROCESS | 2005 | |8;json-parse-financial;58;57;56;55;55;59;59;60;59;59 09:07:06 INFO - PROCESS | 2005 | |9;json-stringify-tinderbox;64;69;78;77;73;69;69;71;72;70 09:07:06 INFO - PROCESS | 2005 | |10;stanford-crypto-aes;83;82;83;81;82;82;82;90;83;82 09:07:06 INFO - PROCESS | 2005 | |11;stanford-crypto-ccm;139;141;140;139;139;150;157;158;184;162 09:07:06 INFO - PROCESS | 2005 | |12;stanford-crypto-pbkdf2;166;166;165;163;165;164;166;163;163;170 09:07:06 INFO - PROCESS | 2005 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;69;67;67;65;64 09:07:06 INFO - PROCESS | 2005 | __end_tp_report 09:07:06 INFO - PROCESS | 2005 | __start_cc_report 09:07:06 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,2208 09:07:06 INFO - PROCESS | 2005 | __end_cc_report 09:07:06 INFO - PROCESS | 2005 | __startTimestamp1483808826610__endTimestamp 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | ------- Summary: start ------- 09:07:06 INFO - PROCESS | 2005 | Number of tests: 14 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#0] ai-astar Cycles:10 Average:125.70 Median:117.00 stddev:21.46 (18.3%) stddev-sans-first:22.58 09:07:06 INFO - PROCESS | 2005 | Values: 118.0 116.0 115.0 116.0 119.0 161.0 171.0 112.0 115.0 114.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#1] audio-beat-detection Cycles:10 Average:120.40 Median:113.00 stddev:15.56 (13.8%) stddev-sans-first:13.46 09:07:06 INFO - PROCESS | 2005 | Values: 146.0 112.0 110.0 144.0 110.0 113.0 109.0 113.0 138.0 109.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#2] audio-dft Cycles:10 Average:184.40 Median:184.50 stddev:1.17 (0.6%) stddev-sans-first:1.22 09:07:06 INFO - PROCESS | 2005 | Values: 185.0 184.0 184.0 183.0 184.0 184.0 185.0 183.0 185.0 187.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#3] audio-fft Cycles:10 Average:68.10 Median:67.00 stddev:12.68 (18.9%) stddev-sans-first:12.56 09:07:06 INFO - PROCESS | 2005 | Values: 81.0 59.0 58.0 90.0 61.0 59.0 59.0 57.0 84.0 73.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:76.50 stddev:11.31 (14.8%) stddev-sans-first:11.87 09:07:06 INFO - PROCESS | 2005 | Values: 82.0 70.0 96.0 71.0 67.0 69.0 89.0 67.0 70.0 92.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#5] imaging-gaussian-blur Cycles:10 Average:89.20 Median:87.00 stddev:9.86 (11.3%) stddev-sans-first:10.43 09:07:06 INFO - PROCESS | 2005 | Values: 87.0 86.0 87.0 85.0 87.0 117.0 87.0 84.0 88.0 84.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#6] imaging-darkroom Cycles:10 Average:95.20 Median:93.00 stddev:8.39 (9.0%) stddev-sans-first:8.82 09:07:06 INFO - PROCESS | 2005 | Values: 92.0 93.0 93.0 93.0 93.0 92.0 93.0 93.0 91.0 119.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#7] imaging-desaturate Cycles:10 Average:81.70 Median:82.00 stddev:2.31 (2.8%) stddev-sans-first:2.45 09:07:06 INFO - PROCESS | 2005 | Values: 82.0 84.0 78.0 79.0 81.0 81.0 86.0 83.0 82.0 81.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:59.00 stddev:1.83 (3.1%) stddev-sans-first:1.94 09:07:06 INFO - PROCESS | 2005 | Values: 58.0 57.0 56.0 55.0 55.0 59.0 59.0 60.0 59.0 59.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:4.10 (5.7%) stddev-sans-first:3.43 09:07:06 INFO - PROCESS | 2005 | Values: 64.0 69.0 78.0 77.0 73.0 69.0 69.0 71.0 72.0 70.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.50 stddev:2.54 (3.1%) stddev-sans-first:2.69 09:07:06 INFO - PROCESS | 2005 | Values: 83.0 82.0 83.0 81.0 82.0 82.0 82.0 90.0 83.0 82.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:153.50 stddev:14.72 (9.6%) stddev-sans-first:14.96 09:07:06 INFO - PROCESS | 2005 | Values: 139.0 141.0 140.0 139.0 139.0 150.0 157.0 158.0 184.0 162.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.50 stddev:2.13 (1.3%) stddev-sans-first:2.24 09:07:06 INFO - PROCESS | 2005 | Values: 166.0 166.0 165.0 163.0 165.0 164.0 166.0 163.0 163.0 170.0 09:07:06 INFO - PROCESS | 2005 | 09:07:06 INFO - PROCESS | 2005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:1.49 (2.2%) stddev-sans-first:1.58 09:07:06 INFO - PROCESS | 2005 | Values: 67.0 68.0 68.0 68.0 67.0 69.0 67.0 67.0 65.0 64.0 09:07:06 INFO - PROCESS | 2005 | -------- Summary: end -------- 09:07:06 INFO - PROCESS | 2005 | 09:07:07 INFO - TEST-INFO | 2005: exit 0 09:07:07 INFO - TEST-OK | kraken | took 59891ms 09:07:07 INFO - SUITE-END | took 1179s 09:07:07 INFO - Completed test suite (00:19:39) 09:07:07 INFO - javascript benchmark 09:07:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2806.579013148028, 3291.2594666200107, 3307.503874418837, 3332.26690128172, 3356.9328613427733, 5524.58565607579, 5619.831405057845, 5653.632513886594, 5666.631668941516, 5674.347450043247, 5595.21666966625, 5630.0991841305295, 5666.914996275059, 5673.886522269552, 5710.257666503348, 5010.699358038521, 5148.099082660538, 5154.32993710817, 5207.0, 5215.16557350822, 5120.231965205212, 5139.12634852076, 5160.148575485059, 5258.973705131488, 5263.710495922723, 4281.764502952336, 5123.052235336456, 5214.556762675177, 5237.476252374751, 5246.370435547739, 5174.197999310113, 5212.166053431471, 5221.895562088737, 5246.527812496894, 5272.604554658377, 4297.8495752648505, 5151.381834179922, 5226.451222621608, 5241.633085684004, 5269.789208431658, 5540.833774986757, 5563.388027316992, 5594.356648985378, 5599.804006859781, 5638.746256418471, 6114.358196333954, 6168.907466388007, 6201.813945581594, 6204.162438070848, 6220.253569571635, 6299.275583307933, 6318.399752023551, 6325.96837015812, 6331.715072821734, 6339.36606339367, 5606.85982850432, 5682.403347648437, 5697.373288938214, 5770.0, 5777.0, 5601.243832082698, 6282.560220784592, 6331.873362532723, 6331.96834015827, 6356.110144579762, 6079.148919151322, 6098.634081955097, 6104.298005729309, 6114.633122012693, 6128.509719222451, 6072.240969878765, 6182.721777520022, 6204.751809927552, 6272.278687950853, 6299.338569450142, 5086.364204474441, 6022.789202377896, 6067.544934129958, 6100.0, 6145.016797312498, 6175.722092505848, 6203.410675985774, 6217.098520714471, 6231.22109736283, 6233.96883015582, 4876.804927802848, 4908.165611845995, 4910.0, 4922.827701030446, 4948.356713627278, 4364.672649551297, 4377.1683380157665, 4383.956160438419, 4400.889977750582, 4435.401220835211, 5676.063449530864, 5697.800576979868, 5697.914531282034, 5701.372848986608, 5706.657600543981, 5309.522143007148, 6088.178095956989, 6166.506679465632, 6174.9073763893575, 6181.876362472725, 5639.661620302795, 5681.943180568224, 5684.8010319638615, 5687.544996400278, 5697.202391665171, 5322.787088516493, 5337.306150200449, 5348.277982472317, 5351.652142610717, 5351.892962140735, 6209.720562574695, 6256.311805701369, 6264.2796078451565, 6266.530010249158, 6271.31015588294, 6112.685862051923, 6182.1345011699295, 6196.907046394217, 6251.843703907439, 6264.373562643699, 6139.785107521216, 6252.562320637512, 6261.217347831521, 6269.373062693877, 6288.748450061947, 6012.338642749207, 6072.332043475126, 6155.84610384744, 6165.0, 6200.162977998093, 6142.498775697809, 6159.19930409044, 6194.938050619436, 6218.689065546795, 6241.563090583615, 6122.173506576733, 6126.945200426759, 6130.459285710702, 6134.263888333428, 6135.263289243823, 5784.0, 6095.51235901118, 6119.479844213113, 6128.846778830565, 6140.631562106288, 5802.738876750472, 5864.384239654775, 5877.0, 5908.556858235564, 5957.4042595740075, 5986.431289027535, 6127.708789264132, 6136.7948077883175, 6138.848241798433, 6141.723622437091, 4834.395700537433, 5888.646681199141, 5898.911516327173, 5906.557008224315, 5968.8806223876145], "value": 5634.4762857870155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.80767692922836, 483.9903201935961, 505.3758608118974, 519.4883040205397, 520.8229202071295, 29588.556171657416, 38637.0, 39872.0, 39876.80061599695, 41514.58485415145, 39761.801190994076, 40152.59847401525, 40181.0, 40199.59800401995, 40280.59719402805, 9202.999999999984, 9392.342536022481, 9401.670941517048, 9411.200047995928, 9424.481653509054, 7380.852382952337, 8360.581970901461, 9248.0, 9564.426134431922, 10463.633772817953, 11269.492872820743, 11299.152563557725, 11300.095992320594, 11307.943460282728, 11324.830127548094, 8319.916800831974, 11201.831972520418, 11276.548938042468, 11285.661430157108, 11287.209895307331, 8393.95803020981, 10679.038886500175, 11048.392338421383, 11050.613228536962, 11221.158413118967, 38823.8058809707, 39302.410463843065, 39353.01617459558, 39373.803130984445, 39377.0, 3310.1890036941104, 3317.618473875487, 3333.3666603345287, 3579.2483578448555, 3847.3459511882766, 28091.438171236667, 28337.858310708314, 29214.707852921623, 29583.964561240253, 30365.544516832266, 2886.898958536441, 3120.0639808057717, 3183.3474137801695, 3201.5357773123, 3204.1829333519804, 457564.0, 459663.0, 460198.0, 461106.0, 470533.0, 32435.0, 32954.67045329564, 33385.998420047436, 59147.704261478415, 59707.0, 34068.82965585206, 34128.14679632979, 34176.316473670886, 34187.316253675286, 34224.657753422645, 14041.0, 14204.0, 14207.0, 14211.64470888236, 14224.786628200585, 10934.507947142398, 11119.499622516845, 12015.579454719043, 12051.758964820654, 12168.695782605506, 7331.670074846645, 7646.847063058708, 7839.686412543434, 7844.529328240324, 7896.881546776803, 2764.585312203186, 2795.4688609164195, 3170.508571171472, 3236.3527294541186, 3245.902622921316, 864.489950928955, 1026.6252817721627, 1039.3555995282823, 1083.9620613278655, 1093.5953697132113, 23970.161044363365, 26257.737422625913, 27671.75477103495, 28754.281142971595, 29532.409351812843, 881.4662487272228, 1003.4430890855646, 1019.8113349030305, 1041.0890470838017, 1107.2028139739375, 14894.106353618818, 15091.622709432133, 15118.622034449007, 15300.846991530165, 15505.224738763016, 629091.0, 631117.0, 633167.0, 633374.0, 634268.0, 54182.0, 54752.0, 54800.725996369765, 54804.0, 54975.0, 1193.1170933509313, 1202.9759404811855, 1247.6319485751726, 1249.194269696059, 1298.8636193199577, 26353.868230658725, 27663.72336276692, 30618.92833750808, 30652.92714755062, 31264.374712505167, 52340.21489677734, 52952.0, 52983.0, 53074.73462632662, 53155.6711082226, 552006.0, 557442.0, 559875.0, 560110.1994490002, 561582.0, 25846.22461326163, 25928.351791204615, 26307.4738505225, 26541.60187597226, 26832.0, 29261.7073829259, 45005.54994450013, 46149.07701846011, 46345.536544634124, 48343.61594688338, 27819.860900695367, 34670.95987120391, 36609.63390366062, 37717.86846394613, 37868.62131378651, 35989.0, 36841.631583684895, 36849.0, 37646.43530346992, 37939.430908536946, 36743.26513469662, 37445.81277093597, 37609.059773505884, 39603.811885643474, 40220.597794022855, 36660.63339366679, 39407.97672421097, 39797.60202398055, 39867.0, 40792.79603601963, 29377.97177098791, 30229.546556801226, 30256.469212198088, 30940.845295773375, 31263.53104703477], "value": 18310.48932706707, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.3352991363439, 364.20239675111486, 371.3964807188318, 386.17166178547035, 401.0715194325137, 19023.61952760946, 19452.319168829094, 20462.89768551157, 20974.475638109056, 21110.05004774785, 19501.804981950176, 19549.21803127873, 20115.295964641206, 20123.798762012375, 20147.899260503713, 5417.431169727181, 5579.079451890433, 5581.190727344532, 5607.915881261774, 5788.450097240755, 4734.621230301567, 4796.856094317176, 4802.111609352281, 4802.919343147799, 4805.495422980589, 4764.618830493552, 4765.142274390609, 4769.833055843046, 4771.117343291485, 4779.80880764769, 5135.58915286778, 5370.677759334433, 5429.6742195468205, 5454.018276710231, 5463.071277882769, 5269.841904742864, 5300.893982120336, 5323.627346085776, 5324.201369794523, 5527.806526771584, 13034.478620855154, 13257.66855828612, 13276.668083297898, 13282.867171328357, 14640.70718585633, 2136.2309568555306, 2216.312942987663, 2274.9658755118685, 2294.816414686821, 2337.0418128567208, 9894.505274736306, 10215.978402159799, 10449.529771160316, 12446.937765311206, 14242.572722818331, 1845.391020963079, 1845.5847434327304, 1887.7734671839467, 1919.8560107991816, 1923.913423895928, 93332.0, 118257.0, 119607.4019629905, 121861.78138218682, 123688.38155809163, 9302.813943721088, 9752.171065459515, 9994.700158995242, 10136.239782016379, 10320.638777642747, 12591.118621696576, 12688.555900543437, 12698.30159341245, 12702.9364853177, 12703.618891433272, 7782.727604533814, 8007.839843203104, 8019.117897031322, 8107.635156417975, 8110.229528194812, 8248.0, 8255.917440825515, 8273.214044665747, 8404.24361807428, 8404.243618074403, 3495.3883070463075, 3685.281370132852, 3957.5448823385104, 3990.68074554035, 4059.2490389278078, 1466.65533599604, 1795.2674646715107, 1832.9633407331778, 1878.8027257138076, 1933.7969513201192, 812.524673066251, 912.3932584831012, 920.8066306075665, 979.3193730357476, 987.2792861211356, 20298.69551956722, 20917.790822091887, 20950.58098838015, 21126.78873211279, 21244.681329780065, 896.8475359188953, 901.3420203251663, 924.1451657217182, 932.911373419524, 941.4774799986074, 10321.483925803679, 11149.554017839358, 11160.995510404102, 11182.552697891993, 11196.272242304387, 570868.0, 576166.0, 588439.0, 619437.0, 620713.5857282829, 73971.63014184895, 86789.56605216934, 95763.0, 108975.0, 119070.0, 939.957701903416, 956.1872408452898, 964.262339310428, 984.3011461862015, 994.3089552760762, 17589.20848561792, 18057.097145142427, 18330.633387332444, 18421.894686318865, 18596.81403186005, 51936.74031629818, 52166.69583260297, 52616.736916315174, 52789.0, 53859.73070134624, 74800.0, 74989.62505187657, 76018.23981760112, 76723.0, 76925.61537192279, 5259.39516955555, 5496.120620700669, 6726.529142959946, 6955.408790252885, 7999.800004999922, 9191.816163676554, 13032.739345213233, 13465.0, 13498.52755153565, 13592.592222233348, 11077.556897724, 11338.886611133783, 11454.599089031844, 11490.310581365145, 11566.479508421973, 9637.18083962871, 10382.532786024496, 10661.573537058432, 10964.835527466936, 11159.381889626122, 11419.257748246337, 11511.884881151082, 11608.129390295593, 11977.820332695192, 12009.939950300193, 7414.962925185339, 7497.325240728361, 7499.88750168737, 7640.274173953466, 7812.453128280966, 8368.163183681583, 9926.454045027593, 9973.252006099716, 11139.33164010162, 11616.709582260512], "value": 8922.841470645815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.460225114456, 1449.260876952754, 1580.5495433801368, 1752.0801579170925, 1795.9615836026107, 7988.92011079889, 8414.579271036439, 8415.410921235509, 8421.115782842806, 8426.662933482668, 7287.19840817511, 7525.4732168748205, 7895.447318687694, 8139.593020348989, 8229.629666665, 2266.9886650566764, 2304.573653874039, 2305.7348404933396, 2309.688192094071, 2309.884505774713, 2293.4495721027, 2318.547883162784, 2346.718393792747, 2349.0368948731025, 2350.4711439925964, 2255.9210427635035, 2260.050778672953, 2287.165184707578, 2290.7938285554296, 2294.2199652118275, 2231.966520502194, 2277.6241920083166, 2295.9196428124937, 2300.321405185466, 2300.7009088818513, 2294.8852557372234, 2316.108298305148, 2317.5364927014666, 2318.2349824557855, 2322.9767702323097, 8235.670573177065, 8247.0, 8334.541600211985, 8340.416170868042, 8353.457025293337, 5031.371078615173, 5193.37679478465, 5194.428612852583, 5197.922031169535, 5201.479852014806, 3263.6573159818354, 3470.0804286864, 3470.3400758102816, 3589.0847833802213, 3598.442241452579, 935.9017303183135, 1013.9797204055877, 1052.026875140492, 1080.027974822658, 1100.8293714474269, 10727.678169654922, 10805.783884322269, 10892.40091794951, 10902.073323767489, 10913.945430272877, 4415.62467190286, 4546.431696037996, 4636.86089417318, 4642.187617166982, 4654.883627909262, 9310.0, 9343.859842102374, 9346.813063738688, 9347.485888276211, 9357.251419886392, 5068.974655126701, 5150.793968241228, 5151.974240128776, 5154.329937108152, 5160.225966105039, 4279.315309550457, 4377.468239700044, 4433.357163211316, 4636.397268355092, 4798.256270278112, 3718.386466233041, 3741.120836603396, 3817.8091095445116, 3838.9808050960123, 3848.8460461581785, 1248.375812093953, 1253.9310337931502, 1256.7926292161874, 1265.2218885385605, 1266.5567051532075, 708.5359089796192, 769.6151924037981, 806.9031716194095, 842.4566154830222, 844.7423535821633, 4983.8504844854715, 5108.386993560796, 5117.590592752571, 5176.559992400613, 5196.32447781786, 444.9911001779946, 874.8364674982258, 926.3120271638758, 931.3434029009532, 992.161623428202, 3365.730741540671, 3369.157710572357, 3398.5242066110764, 3409.863605455754, 3498.1254686328416, 9619.711408657751, 9972.601095956226, 10040.09639132467, 10187.490625468698, 10194.337368071052, 9806.509674516246, 10130.544125514369, 10135.493225338703, 10150.492475376202, 10155.593776249016, 7698.730544430918, 7813.570253635991, 7941.086775020831, 7944.44388892772, 7971.800704982305, 5026.246063090565, 5057.418396884405, 5058.215976523645, 5149.407818100966, 5256.290400795843, 9121.042290559395, 9240.353175277665, 9252.95373523128, 9456.669016584387, 9477.0, 9338.719838404859, 9359.391639543408, 9542.141207291377, 9671.854922176313, 9677.080677335642, 5924.940750592439, 6601.768938087144, 6686.264510903894, 6688.799336019927, 6748.763793267212, 7705.267999540035, 7766.029246344207, 7793.454458187873, 7806.531608103532, 7810.062792464941, 6878.140232470942, 6986.441084713312, 7051.894221586577, 7156.355927966508, 7229.240929702516, 6814.795556133324, 6972.965135174291, 7035.929640703527, 7065.328793764585, 7123.180834204133, 6432.581882177644, 6454.419102280817, 6520.054592084216, 6526.575772574767, 6531.11829902957, 4531.048479819143, 4571.1543364477675, 4618.468876079294, 4664.113818374498, 4709.411323584552, 4426.358178064227, 4533.911861153366, 4596.724196548218, 4597.655175861757, 4706.247000479907], "value": 4321.332910655926, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.41088755743357, 309.4491804587834, 310.30182090296825, 314.1329929394868, 316.43358388484614, 4576.794044268012, 5240.353621421182, 5265.499777521139, 5269.104252277118, 5287.915977224669, 4179.540250572434, 4689.835855745049, 5117.692938423697, 5173.3533308336455, 5214.243934629477, 3398.7111095556907, 3475.480276799313, 3619.348517266891, 3863.8840834775, 3938.921221575567, 3599.8560057597665, 4001.879943601682, 4002.0, 4016.5782592827773, 4043.777592232426, 3930.9189972757576, 3969.4045893115976, 3977.3238549446664, 3981.462502562146, 3983.58172391899, 3317.0, 3593.94609080864, 3723.478712980185, 3828.846846126152, 3982.2632812929555, 3454.4972936772333, 3476.6349533298894, 3481.268933523963, 3491.4239150540384, 3496.17839807645, 4598.895745371894, 5023.748812559394, 5048.848534543969, 5086.160783470723, 5120.641555091145, 3811.2568049230413, 4043.5241136985082, 4361.149575832714, 4475.686701930867, 4580.862574122782, 5413.404525502192, 5414.07960646691, 5417.864553386157, 5420.7018613976215, 5430.8099216527235, 3589.964100358989, 3670.247599242149, 3819.8854034379015, 3838.4626152338415, 3841.4621952926614, 4734.810607575727, 4749.857504274877, 5429.4570542945785, 5622.8313150605545, 5652.98246315663, 3863.5750067492554, 3864.9757814179266, 3874.728768986144, 3880.835749275206, 3900.2979463696806, 3564.8395822187545, 3750.9437358439645, 3923.588023257574, 3927.0378757204667, 3961.6632586229916, 4545.863624091283, 4556.954430455719, 4558.020025694492, 4558.544145585415, 4561.813928378646, 4806.110869489155, 5264.419236299716, 5265.552428043583, 5373.167159090347, 5410.026195284808, 1122.5790328626765, 1162.5001249462812, 1257.4090177616506, 1262.072376803049, 1270.5743575902177, 701.2741812224425, 743.3495691270139, 837.380338549469, 883.6642076011075, 887.4719541872576, 4142.46148000758, 4353.564643535621, 4615.399998000238, 4662.836800711959, 4991.326170966873, 5550.72246387679, 5591.944080559224, 5597.468240517144, 5608.775648973995, 5610.4670056344585, 4315.791578358065, 4755.881102972453, 5111.463296353903, 5127.4872512748425, 5140.665856719302, 2307.1852340144997, 2370.9644355334685, 2727.372704278027, 2759.7102304258165, 2767.301880666334, 5247.580193584504, 5410.945890541044, 5432.185172224119, 5470.960517501741, 5480.616356854982, 4439.045605194834, 4715.976420117878, 4754.334906698664, 5387.299651045418, 5405.648632838853, 4572.833927348504, 4943.060818444484, 5076.111680455905, 5285.735713214247, 5469.56243500519, 5061.039292014213, 5275.0, 5281.207818827053, 5328.096187577702, 5343.46185561855, 4868.878278042936, 4977.427595826382, 5155.664881782672, 5176.576441478624, 5241.842744717512, 4956.727379994135, 5707.971460142673, 5764.250647415809, 5794.01501744696, 5794.7682092717505, 3259.967400326061, 3371.0, 3796.37359835624, 3861.555921069113, 3864.922701545897, 4790.8323208687525, 5194.610404219623, 5520.227168196536, 5617.354004289559, 5717.942820571908, 5014.398272207359, 5450.890982180414, 5451.809186678447, 5454.863628409322, 5487.64330318528, 4670.159371313196, 5349.0, 5448.427915068861, 5462.426445223195, 5516.779328826802, 5130.51260130287, 5352.652077614943, 5356.009138309425, 5379.4082650907585, 5380.73096345189, 4807.278908163804, 5203.947960520498, 5348.572114230775, 5358.142697168434, 5453.672779633234, 4510.188166130128, 4642.907141857211, 5427.99582077317, 5450.073487507213, 5498.862528436821], "value": 3918.193707467767, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.6405541007856, 666.4235436347559, 696.2132789947359, 713.101492119929, 723.2405973727584, 13824.032317737763, 14431.989760716753, 14438.133711977262, 14443.638909027266, 14445.422183112676, 12765.170263932861, 12867.09930304879, 12879.93560032201, 12884.67788305293, 12905.935470322635, 634.961902285862, 805.8307755371379, 816.5468165168329, 821.1993306526149, 821.4865708931918, 652.5138771615129, 660.465023331101, 661.6129564204946, 662.1127688896877, 663.9402453779159, 838.4885220015785, 858.6908712863365, 868.0581568997645, 876.3996662286322, 877.9824403511926, 821.1296026212234, 858.5406807358033, 865.9350548708841, 866.3588944181323, 870.0559892516627, 497.57954528423426, 643.2120652201063, 644.1143427786793, 646.066434002866, 647.1586936981905, 10514.0, 11526.308421494738, 13540.864591354059, 13573.0, 13935.233562154077, 12700.555480558136, 13095.214287142802, 13135.934320328433, 13179.60461186166, 13202.86797132026, 10885.455727213686, 11038.779224415466, 11138.443077846076, 11178.888211117948, 11208.327500350006, 3579.552555930509, 3650.908727281813, 3660.68884144848, 3667.339878821811, 3777.5089238399105, 76845.61577192078, 81749.59125204336, 81766.0, 82605.58697206536, 82853.58573207156, 9793.608255669693, 10039.749006274755, 10126.139278161292, 10200.38797672142, 10315.1747860171, 19176.616467670567, 19724.149644571684, 19832.70250946237, 19944.3019494317, 20312.289069882485, 6417.1657684500715, 7410.5183163094225, 7486.363659088929, 7516.887246691194, 7577.507462014952, 4179.231595783116, 4243.554426785205, 4247.32042873145, 4332.4367832181615, 4387.407699960529, 3361.7310615150727, 3450.7929524228625, 3468.9826550867588, 3469.2714529948994, 3476.3742526344995, 531.5455285730721, 626.4111734969206, 636.3413866647998, 637.8501052252717, 638.7030031035591, 545.0543307361725, 549.4121290219426, 559.4685049203273, 602.4969150759077, 648.5654611410366, 8115.797105072303, 8614.741557753277, 8853.51305678181, 9122.996470388252, 9362.485063321583, 622.5237693164732, 661.3221448015726, 667.3226674924955, 668.2215219269497, 677.3937326093119, 3432.9485057724155, 4266.189424009428, 4444.799984000663, 4475.239209334421, 4599.149157405891, 93546.59680104804, 102004.0, 107680.0, 109461.0, 111238.0, 64126.7936603168, 92117.53941230386, 94923.10153796885, 95697.52151239199, 98005.18314781896, 86231.0, 86527.26945461181, 89583.55208224048, 89921.0, 90225.0, 8492.575371231538, 8657.39398242117, 8672.219500245008, 8676.08901065379, 8909.599068042084, 42369.576304237795, 50412.0, 52791.47208528019, 53023.0, 53744.0, 76518.0, 76731.0, 79685.8047129305, 80603.0, 81008.0, 10758.892411075789, 10819.459027048459, 11133.165012623924, 11252.774944500901, 11347.886521134684, 10386.493958375842, 11939.283642981449, 11982.340971246316, 12057.879421205676, 12427.875721242672, 11508.769824603629, 11760.35318057515, 11903.642890713292, 12048.638540843789, 12471.875281247072, 9992.750181245527, 10473.790524189626, 11535.596254131066, 11595.362255076052, 13217.669558261121, 12274.877251227374, 12760.234385936874, 13035.413406396925, 13126.60620181396, 13204.867951320748, 9155.404898681565, 10443.791124177322, 10846.837297440703, 11192.720181995515, 11395.316281023164, 10740.785184296426, 10880.510377033212, 11154.772974972584, 11453.255538389978, 11493.54025838957], "value": 6979.029929142721, "unit": "score"}], "name": "dromaeo_css", "value": 6909.291930004605, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 115.0, 116.0, 119.0, 161.0, 171.0, 112.0, 115.0, 114.0], "value": 125.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 112.0, 110.0, 144.0, 110.0, 113.0, 109.0, 113.0, 138.0, 109.0], "value": 120.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 183.0, 184.0, 184.0, 185.0, 183.0, 185.0, 187.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 90.0, 61.0, 59.0, 59.0, 57.0, 84.0, 73.0], "value": 68.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 96.0, 71.0, 67.0, 69.0, 89.0, 67.0, 70.0, 92.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 85.0, 87.0, 117.0, 87.0, 84.0, 88.0, 84.0], "value": 89.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 91.0, 119.0], "value": 95.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 78.0, 79.0, 81.0, 81.0, 86.0, 83.0, 82.0, 81.0], "value": 81.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 55.0, 55.0, 59.0, 59.0, 60.0, 59.0, 59.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 78.0, 77.0, 73.0, 69.0, 69.0, 71.0, 72.0, 70.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 81.0, 82.0, 82.0, 82.0, 90.0, 83.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 140.0, 139.0, 139.0, 150.0, 157.0, 158.0, 184.0, 162.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 163.0, 165.0, 164.0, 166.0, 163.0, 163.0, 170.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 69.0, 67.0, 67.0, 65.0, 64.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1436.9, "alertThreshold": 2.0}]} 09:07:07 INFO - Return code: 0 09:07:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:07:07 INFO - # TBPL SUCCESS # 09:07:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:07:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:07:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:07:07 INFO - 2017-01-07 09:07:07.914 screenresolution[2009:23605] starting screenresolution argv=screenresolution get 09:07:07 INFO - 2017-01-07 09:07:07.916 screenresolution[2009:23605] Display 0: 1600x1200x32@60 09:07:07 INFO - 2017-01-07 09:07:07.923 screenresolution[2010:23608] starting screenresolution argv=screenresolution list 09:07:07 INFO - Available Modes on Display 0 09:07:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:07:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:07:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:07:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:07:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:07:08 INFO - Intel Iris: 09:07:08 INFO - Chipset Model: Intel Iris 09:07:08 INFO - Type: GPU 09:07:08 INFO - Bus: Built-In 09:07:08 INFO - VRAM (Dynamic, Max): 1536 MB 09:07:08 INFO - Vendor: Intel (0x8086) 09:07:08 INFO - Device ID: 0x0a2e 09:07:08 INFO - Revision ID: 0x0009 09:07:08 INFO - Displays: 09:07:08 INFO - Display: 09:07:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:07:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:07:08 INFO - Display Serial Number: 1600x1200 60 09:07:08 INFO - Main Display: Yes 09:07:08 INFO - Mirror: Off 09:07:08 INFO - Online: Yes 09:07:08 INFO - Rotation: Supported 09:07:08 INFO - Return code: 0 09:07:08 INFO - Running post-action listener: _resource_record_post_action 09:07:08 INFO - [mozharness: 2017-01-07 17:07:08.172833Z] Finished run-tests step (success) 09:07:08 INFO - Running post-run listener: _resource_record_post_run 09:07:08 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 31415296; Write bytes: 660533248; Read time: 357; Write time: 2126 09:07:08 INFO - TinderboxPrint: CPU usage
53.5% 09:07:08 INFO - TinderboxPrint: I/O read bytes / time
31,415,296 / 357 09:07:08 INFO - TinderboxPrint: I/O write bytes / time
660,533,248 / 2,126 09:07:08 INFO - TinderboxPrint: CPU idle
2,253.8 (46.5%) 09:07:08 INFO - TinderboxPrint: CPU system
974.0 (20.1%) 09:07:08 INFO - TinderboxPrint: CPU user
1,617.9 (33.4%) 09:07:08 INFO - TinderboxPrint: Swap in / out
374,726,656 / 0 09:07:08 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 349889024; Write bytes: 351963136; Read time: 26963; Write time: 735 09:07:08 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 28982272; Write bytes: 305524736; Read time: 344; Write time: 1337 09:07:08 INFO - Running post-run listener: _upload_blobber_files 09:07:08 INFO - Blob upload gear active. 09:07:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:07:08 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:07:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:07:09 INFO - (blobuploader) - INFO - Open directory for files ... 09:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:07:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:10 INFO - (blobuploader) - INFO - Done attempting. 09:07:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:07:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:11 INFO - (blobuploader) - INFO - Done attempting. 09:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:07:13 INFO - (blobuploader) - INFO - Done attempting. 09:07:13 INFO - (blobuploader) - INFO - Iteration through files over. 09:07:13 INFO - Return code: 0 09:07:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:07:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:07:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a9ede59e26a252e7caf77f561f093636eda8497254ee613a24f23204763de686a6303ef705b82fad4072ce37f95833d0d2d5cc27c49edcf29eb7b76997a5fe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e0b11378b3ef9389b7b68d3d260acdd9cd6f22ad31ba48925a629fbf19a8b55d3d8fd0acc90a18d5e4a6764c9cbb8a617ca18d51af0bc5b16ab06e87bfa17f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87432ca83178d63877d2888a5c747b14b1a2515f4f5cf7d86e2df49528f4dc548e1064c43a9bfd7220842ffbea4ac2726b81a02798534eea803674c5db195dac"} 09:07:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:07:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:07:13 INFO - Contents: 09:07:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a9ede59e26a252e7caf77f561f093636eda8497254ee613a24f23204763de686a6303ef705b82fad4072ce37f95833d0d2d5cc27c49edcf29eb7b76997a5fe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e0b11378b3ef9389b7b68d3d260acdd9cd6f22ad31ba48925a629fbf19a8b55d3d8fd0acc90a18d5e4a6764c9cbb8a617ca18d51af0bc5b16ab06e87bfa17f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87432ca83178d63877d2888a5c747b14b1a2515f4f5cf7d86e2df49528f4dc548e1064c43a9bfd7220842ffbea4ac2726b81a02798534eea803674c5db195dac"} 09:07:13 INFO - Running post-run listener: copy_logs_to_upload_dir 09:07:13 INFO - Copying logs to upload dir... 09:07:13 INFO - mkdir: /builds/slave/test/build/upload/logs 09:07:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.364292 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2017-01-07 09:07:13.651916) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:07:13.655392) ========= 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.563C8xUq5D/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.pucGQIyrMT/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a9ede59e26a252e7caf77f561f093636eda8497254ee613a24f23204763de686a6303ef705b82fad4072ce37f95833d0d2d5cc27c49edcf29eb7b76997a5fe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e0b11378b3ef9389b7b68d3d260acdd9cd6f22ad31ba48925a629fbf19a8b55d3d8fd0acc90a18d5e4a6764c9cbb8a617ca18d51af0bc5b16ab06e87bfa17f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87432ca83178d63877d2888a5c747b14b1a2515f4f5cf7d86e2df49528f4dc548e1064c43a9bfd7220842ffbea4ac2726b81a02798534eea803674c5db195dac"} build_url:https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/NudW4T75SUCktpFslPDHvQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9a9ede59e26a252e7caf77f561f093636eda8497254ee613a24f23204763de686a6303ef705b82fad4072ce37f95833d0d2d5cc27c49edcf29eb7b76997a5fe7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8e0b11378b3ef9389b7b68d3d260acdd9cd6f22ad31ba48925a629fbf19a8b55d3d8fd0acc90a18d5e4a6764c9cbb8a617ca18d51af0bc5b16ab06e87bfa17f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/87432ca83178d63877d2888a5c747b14b1a2515f4f5cf7d86e2df49528f4dc548e1064c43a9bfd7220842ffbea4ac2726b81a02798534eea803674c5db195dac"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:07:13.694422) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:07:13.694758) ========= 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.563C8xUq5D/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.pucGQIyrMT/Listeners TMPDIR=/var/folders/wh/xl0_dj0x6qd32b8d3tzy392w00000w/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.005247 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:07:13.743562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:07:13.743882) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:07:13.744199) ========= ========= Total master_lag: 0.25 =========