builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0014 starttime: 1476185756.93 results: success (0) buildid: 20161011021350 builduid: da8e3bde833044498a8a6bc90b0298c0 revision: a4c3d4d2588ceb1500aab82e2410396cca01755e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:56.932010) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:56.932515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:56.932830) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:56.958056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:56.958548) ========= 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.g79tPufk83/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.hJB7IafYZo/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-11 04:35:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 23.1M=0.001s 2016-10-11 04:35:57 (23.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123486 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:57.107414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:57.108056) ========= 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.g79tPufk83/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.hJB7IafYZo/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.037395 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:57.166308) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 04:35:57.166704) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev a4c3d4d2588ceb1500aab82e2410396cca01755e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev a4c3d4d2588ceb1500aab82e2410396cca01755e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.g79tPufk83/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.hJB7IafYZo/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-11 04:35:57,240 truncating revision to first 12 chars 2016-10-11 04:35:57,240 Setting DEBUG logging. 2016-10-11 04:35:57,240 attempt 1/10 2016-10-11 04:35:57,240 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/a4c3d4d2588c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 04:35:58,170 unpacking tar archive at: autoland-a4c3d4d2588c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.178137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 04:35:58.366850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:58.367164) ========= script_repo_revision: a4c3d4d2588ceb1500aab82e2410396cca01755e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:58.367534) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:58.367808) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 04:35:58.385797) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-11 04:35:58.386074) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.g79tPufk83/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.hJB7IafYZo/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:35:58 INFO - MultiFileLogger online at 20161011 04:35:58 in /builds/slave/test 04:35:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 04:35:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:58 INFO - {'append_to_log': False, 04:35:58 INFO - 'base_work_dir': '/builds/slave/test', 04:35:58 INFO - 'blob_upload_branch': 'Autoland', 04:35:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:58 INFO - 'branch': 'Autoland', 04:35:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:58 INFO - 'config_files': ('talos/mac_config.py',), 04:35:58 INFO - 'default_actions': ('clobber', 04:35:58 INFO - 'read-buildbot-config', 04:35:58 INFO - 'download-and-extract', 04:35:58 INFO - 'populate-webroot', 04:35:58 INFO - 'create-virtualenv', 04:35:58 INFO - 'install', 04:35:58 INFO - 'run-tests'), 04:35:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:58 INFO - 'download_minidump_stackwalk': True, 04:35:58 INFO - 'download_symbols': 'ondemand', 04:35:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:58 INFO - 'installer_path': 'installer.exe', 04:35:58 INFO - 'log_level': 'info', 04:35:58 INFO - 'log_name': 'talos', 04:35:58 INFO - 'log_to_console': True, 04:35:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:35:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:35:58 INFO - 'opt_config_files': (), 04:35:58 INFO - 'pip_index': False, 04:35:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:58 INFO - 'cmd': ('bash', 04:35:58 INFO - '-c', 04:35:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:58 INFO - 'enabled': True, 04:35:58 INFO - 'halt_on_failure': False, 04:35:58 INFO - 'name': 'check_screen_resolution'},), 04:35:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:58 INFO - 'cmd': ('bash', 04:35:58 INFO - '-c', 04:35:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:58 INFO - 'enabled': True, 04:35:58 INFO - 'halt_on_failure': False, 04:35:58 INFO - 'name': 'check_screen_resolution'},), 04:35:58 INFO - 'run_cmd_checks_enabled': True, 04:35:58 INFO - 'sps_profile': False, 04:35:58 INFO - 'sps_profile_interval': 0, 04:35:58 INFO - 'suite': 'dromaeojs', 04:35:58 INFO - 'system_bits': '32', 04:35:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:58 INFO - 'title': 't-yosemite-r7-0014', 04:35:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:58 INFO - 'use_talos_json': True, 04:35:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:58 INFO - 'work_dir': 'build'} 04:35:58 INFO - [mozharness: 2016-10-11 11:35:58.592498Z] Running clobber step. 04:35:58 INFO - Running pre-action listener: _resource_record_pre_action 04:35:58 INFO - Running main action method: clobber 04:35:58 INFO - rmtree: /builds/slave/test/build 04:35:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:01 INFO - Running post-action listener: _resource_record_post_action 04:36:01 INFO - [mozharness: 2016-10-11 11:36:01.024172Z] Finished clobber step (success) 04:36:01 INFO - [mozharness: 2016-10-11 11:36:01.024298Z] Running read-buildbot-config step. 04:36:01 INFO - Running pre-action listener: _resource_record_pre_action 04:36:01 INFO - Running main action method: read_buildbot_config 04:36:01 INFO - Using buildbot properties: 04:36:01 INFO - { 04:36:01 INFO - "project": "", 04:36:01 INFO - "product": "firefox", 04:36:01 INFO - "script_repo_revision": "production", 04:36:01 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 04:36:01 INFO - "repository": "", 04:36:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 04:36:01 INFO - "buildid": "20161011021350", 04:36:01 INFO - "pgo_build": "False", 04:36:01 INFO - "basedir": "/builds/slave/test", 04:36:01 INFO - "buildnumber": 276, 04:36:01 INFO - "slavename": "t-yosemite-r7-0014", 04:36:01 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 04:36:01 INFO - "platform": "yosemite_r7", 04:36:01 INFO - "scheduler": "tests-autoland-macosx64-talos", 04:36:01 INFO - "branch": "autoland", 04:36:01 INFO - "repo_path": "integration/autoland", 04:36:01 INFO - "revision": "a4c3d4d2588ceb1500aab82e2410396cca01755e", 04:36:01 INFO - "stage_platform": "macosx64", 04:36:01 INFO - "builduid": "da8e3bde833044498a8a6bc90b0298c0", 04:36:01 INFO - "slavebuilddir": "test" 04:36:01 INFO - } 04:36:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:36:01 INFO - Running post-action listener: _resource_record_post_action 04:36:01 INFO - [mozharness: 2016-10-11 11:36:01.027592Z] Finished read-buildbot-config step (success) 04:36:01 INFO - [mozharness: 2016-10-11 11:36:01.027700Z] Running download-and-extract step. 04:36:01 INFO - Running pre-action listener: _resource_record_pre_action 04:36:01 INFO - Running main action method: download_and_extract 04:36:01 INFO - mkdir: /builds/slave/test/build/tests 04:36: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')]} 04:36:01 INFO - trying https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:36:01 INFO - Downloading https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:36:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 04:36:02 INFO - Downloaded 1199 bytes. 04:36:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:36:02 INFO - Using the following test package requirements: 04:36:02 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:36:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:36:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:36:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'jsshell-mac.zip'], 04:36:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:36:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:36:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:36:02 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:36:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:36:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:36:02 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:36:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:36:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:36:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:02 INFO - Fetch https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:36:02 INFO - Http code: 200 04:36:02 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 04:36:02 INFO - x-amz-cf-id: UnAIDg65eVJ5TdySl0KHMpNpdP7kjvkz9JEkr_DW1K6s9hcGR1cXSg== 04:36:02 INFO - x-amz-version-id: 7UpkW70NVytWUuOXJjucmWx7M7TbW5NJ 04:36:03 INFO - Expected file size: 16508486 04:36:03 INFO - Obtained file size: 16508486 04:36:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:36:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:36:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:09 INFO - Fetch https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:36:10 INFO - Http code: 200 04:36:10 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 04:36:10 INFO - x-amz-cf-id: dMFNgiuN1aWK7Rso6aaeCMMU2txOJTw3nZiP0GQAGByMT8_dJwI8ug== 04:36:10 INFO - x-amz-version-id: 7UpkW70NVytWUuOXJjucmWx7M7TbW5NJ 04:36:10 INFO - Expected file size: 16508486 04:36:10 INFO - Obtained file size: 16508486 04:36:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:36:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:36:17 INFO - Fetch https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:36:17 INFO - Http code: 200 04:36:17 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 04:36:17 INFO - x-amz-cf-id: wRLUqJrcl6nhGAvGIm-Ba9TWrTLems3diBF8xHEiC6p_935zWZIpyQ== 04:36:17 INFO - x-amz-version-id: Gi6gEfk3XzZFMuXaQ9dciowRXqTAWgfM 04:36:17 INFO - Expected file size: 14409006 04:36:17 INFO - Obtained file size: 14409006 04:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:18 INFO - trying https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:36:18 INFO - Downloading https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:36:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 04:36:21 INFO - Downloaded 111744304 bytes. 04:36:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:36:21 INFO - mkdir: /builds/slave/test/properties 04:36:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:21 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:21 INFO - Contents: 04:36:21 INFO - build_url:https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:36:21 INFO - Running post-action listener: _resource_record_post_action 04:36:21 INFO - Running post-action listener: set_extra_try_arguments 04:36:21 INFO - [mozharness: 2016-10-11 11:36:21.862608Z] Finished download-and-extract step (success) 04:36:21 INFO - [mozharness: 2016-10-11 11:36:21.862750Z] Running populate-webroot step. 04:36:21 INFO - Running pre-action listener: _resource_record_pre_action 04:36:21 INFO - Running main action method: populate_webroot 04:36:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:21 INFO - '--tppagecycles', 04:36:21 INFO - '7'], 04:36:21 INFO - 'tests': ['tsvgm']}}, 04:36:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['damp', 'tps']}, 04:36:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'tests': ['damp', 'tps']}, 04:36:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['dromaeo_dom']}, 04:36:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['basic_compositor_video']}, 04:36:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['a11yr', 04:36:21 INFO - 'ts_paint', 04:36:21 INFO - 'tpaint', 04:36:21 INFO - 'sessionrestore', 04:36:21 INFO - 'sessionrestore_no_auto_restore', 04:36:21 INFO - 'tabpaint']}, 04:36:21 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:21 INFO - 'ts_paint', 04:36:21 INFO - 'tpaint', 04:36:21 INFO - 'sessionrestore', 04:36:21 INFO - 'sessionrestore_no_auto_restore', 04:36:21 INFO - 'tabpaint']}, 04:36:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:21 INFO - 'ts_paint', 04:36:21 INFO - 'tpaint', 04:36:21 INFO - 'sessionrestore', 04:36:21 INFO - 'sessionrestore_no_auto_restore', 04:36:21 INFO - 'tabpaint']}, 04:36:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:21 INFO - 'ts_paint', 04:36:21 INFO - 'tpaint', 04:36:21 INFO - 'sessionrestore', 04:36:21 INFO - 'sessionrestore_no_auto_restore', 04:36:21 INFO - 'tabpaint']}, 04:36:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['a11yr', 04:36:21 INFO - 'ts_paint', 04:36:21 INFO - 'tpaint', 04:36:21 INFO - 'sessionrestore', 04:36:21 INFO - 'sessionrestore_no_auto_restore', 04:36:21 INFO - 'tabpaint']}, 04:36:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['a11yr', 04:36:21 INFO - 'ts_paint', 04:36:21 INFO - 'tpaint', 04:36:21 INFO - 'sessionrestore', 04:36:21 INFO - 'sessionrestore_no_auto_restore', 04:36:21 INFO - 'tabpaint']}, 04:36:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['tsvgx', 04:36:21 INFO - 'tsvgr_opacity', 04:36:21 INFO - 'tart', 04:36:21 INFO - 'tscrollx', 04:36:21 INFO - 'cart']}, 04:36:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:21 INFO - 'tsvgr_opacity', 04:36:21 INFO - 'tart', 04:36:21 INFO - 'tscrollx', 04:36:21 INFO - 'cart']}, 04:36:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'talos_options': ['--disable-e10s'], 04:36:21 INFO - 'tests': ['tp5o']}, 04:36:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'tests': ['tp5o']}, 04:36:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'talos_options': ['--disable-e10s', 04:36:21 INFO - '--xperf_path', 04:36:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:21 INFO - 'tests': ['tp5n']}, 04:36:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:36:21 INFO - 'talos_options': ['--xperf_path', 04:36:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:21 INFO - 'tests': ['tp5n']}}, 04:36:21 INFO - 'talos.zip': {'path': '', 04:36:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:21 INFO - Running post-action listener: _resource_record_post_action 04:36:21 INFO - [mozharness: 2016-10-11 11:36:21.881533Z] Finished populate-webroot step (success) 04:36:21 INFO - [mozharness: 2016-10-11 11:36:21.881666Z] Running create-virtualenv step. 04:36:21 INFO - Running pre-action listener: _resource_record_pre_action 04:36:21 INFO - Running main action method: create_virtualenv 04:36:21 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:36:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:22 INFO - Using real prefix '/tools/python27' 04:36:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:22 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:25 INFO - Installing pip.................done. 04:36:25 INFO - Return code: 0 04:36:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:25 INFO - Reading from file tmpfile_stdout 04:36:25 INFO - Output received: 04:36:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:36:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:25 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:36:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:25 INFO - 'HOME': '/Users/cltbld', 04:36:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:25 INFO - 'LOGNAME': 'cltbld', 04:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:25 INFO - 'MOZ_NO_REMOTE': '1', 04:36:25 INFO - 'NO_EM_RESTART': '1', 04:36:25 INFO - 'PAGER': '/bin/cat', 04:36:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:25 INFO - 'PWD': '/builds/slave/test', 04:36:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:25 INFO - 'SHELL': '/bin/bash', 04:36:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:25 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:25 INFO - 'USER': 'cltbld', 04:36:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:25 INFO - 'XPC_FLAGS': '0x0', 04:36:25 INFO - 'XPC_SERVICE_NAME': '0', 04:36:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:36:26 INFO - Cleaning up... 04:36:26 INFO - Return code: 0 04:36:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:26 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:36:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:26 INFO - 'HOME': '/Users/cltbld', 04:36:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:26 INFO - 'LOGNAME': 'cltbld', 04:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:26 INFO - 'MOZ_NO_REMOTE': '1', 04:36:26 INFO - 'NO_EM_RESTART': '1', 04:36:26 INFO - 'PAGER': '/bin/cat', 04:36:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:26 INFO - 'PWD': '/builds/slave/test', 04:36:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:26 INFO - 'SHELL': '/bin/bash', 04:36:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:26 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:26 INFO - 'USER': 'cltbld', 04:36:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:26 INFO - 'XPC_FLAGS': '0x0', 04:36:26 INFO - 'XPC_SERVICE_NAME': '0', 04:36:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:26 INFO - Downloading/unpacking psutil>=3.1.1 04:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:29 INFO - Installing collected packages: psutil 04:36:29 INFO - Running setup.py install for psutil 04:36:29 INFO - building 'psutil._psutil_osx' extension 04:36:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:36:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:36:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:36:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:36:30 INFO - building 'psutil._psutil_posix' extension 04:36:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:36:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:36:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:36:30 INFO - ^ 04:36:30 INFO - 1 warning generated. 04:36:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:36:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:30 INFO - Successfully installed psutil 04:36:30 INFO - Cleaning up... 04:36:31 INFO - Return code: 0 04:36:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:36:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:31 INFO - 'HOME': '/Users/cltbld', 04:36:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:31 INFO - 'LOGNAME': 'cltbld', 04:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:31 INFO - 'MOZ_NO_REMOTE': '1', 04:36:31 INFO - 'NO_EM_RESTART': '1', 04:36:31 INFO - 'PAGER': '/bin/cat', 04:36:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:31 INFO - 'PWD': '/builds/slave/test', 04:36:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:31 INFO - 'SHELL': '/bin/bash', 04:36:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:31 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:31 INFO - 'USER': 'cltbld', 04:36:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:31 INFO - 'XPC_FLAGS': '0x0', 04:36:31 INFO - 'XPC_SERVICE_NAME': '0', 04:36:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:33 INFO - Installing collected packages: mozsystemmonitor 04:36:33 INFO - Running setup.py install for mozsystemmonitor 04:36:34 INFO - Successfully installed mozsystemmonitor 04:36:34 INFO - Cleaning up... 04:36:34 INFO - Return code: 0 04:36:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:34 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:34 INFO - 'HOME': '/Users/cltbld', 04:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:34 INFO - 'LOGNAME': 'cltbld', 04:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:34 INFO - 'MOZ_NO_REMOTE': '1', 04:36:34 INFO - 'NO_EM_RESTART': '1', 04:36:34 INFO - 'PAGER': '/bin/cat', 04:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:34 INFO - 'PWD': '/builds/slave/test', 04:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:34 INFO - 'SHELL': '/bin/bash', 04:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:34 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:34 INFO - 'USER': 'cltbld', 04:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:34 INFO - 'XPC_FLAGS': '0x0', 04:36:34 INFO - 'XPC_SERVICE_NAME': '0', 04:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:37 INFO - warning: no files found matching '*.txt' 04:36:37 INFO - no previously-included directories found matching 'build' 04:36:37 INFO - no previously-included directories found matching 'dist' 04:36:37 INFO - no previously-included directories found matching '.git*' 04:36:37 INFO - Installing collected packages: jsonschema, functools32 04:36:37 INFO - Running setup.py install for functools32 04:36:37 INFO - warning: no files found matching '*.txt' 04:36:37 INFO - no previously-included directories found matching 'build' 04:36:37 INFO - no previously-included directories found matching 'dist' 04:36:37 INFO - no previously-included directories found matching '.git*' 04:36:37 INFO - Successfully installed jsonschema functools32 04:36:37 INFO - Cleaning up... 04:36:37 INFO - Return code: 0 04:36:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:37 INFO - 'HOME': '/Users/cltbld', 04:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PAGER': '/bin/cat', 04:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:37 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - 'XPC_FLAGS': '0x0', 04:36:37 INFO - 'XPC_SERVICE_NAME': '0', 04:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:37 INFO - Cleaning up... 04:36:37 INFO - Return code: 0 04:36:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:37 INFO - 'HOME': '/Users/cltbld', 04:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PAGER': '/bin/cat', 04:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:37 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - 'XPC_FLAGS': '0x0', 04:36:37 INFO - 'XPC_SERVICE_NAME': '0', 04:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:38 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:41 INFO - Downloading docopt-0.6.1.tar.gz 04:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:41 INFO - Running setup.py install for blobuploader 04:36:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:42 INFO - Running setup.py install for requests 04:36:42 INFO - Running setup.py install for docopt 04:36:42 INFO - Successfully installed blobuploader requests docopt 04:36:42 INFO - Cleaning up... 04:36:42 INFO - Return code: 0 04:36:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:42 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:36:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:42 INFO - 'HOME': '/Users/cltbld', 04:36:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:42 INFO - 'LOGNAME': 'cltbld', 04:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:42 INFO - 'MOZ_NO_REMOTE': '1', 04:36:42 INFO - 'NO_EM_RESTART': '1', 04:36:42 INFO - 'PAGER': '/bin/cat', 04:36:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:42 INFO - 'PWD': '/builds/slave/test', 04:36:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:42 INFO - 'SHELL': '/bin/bash', 04:36:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:42 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:42 INFO - 'USER': 'cltbld', 04:36:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:42 INFO - 'XPC_FLAGS': '0x0', 04:36:42 INFO - 'XPC_SERVICE_NAME': '0', 04:36:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-40q4Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-2QzT3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-kNL3ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KrQMC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-3eaydT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-a37dYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-sOZ4Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jAdKuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:43 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Z6Mqj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ez1ApR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-aXo9De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ndEqXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-qdS8XJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-zfhTsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-uOzhGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-b_q7t6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:44 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PDqWl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:44 INFO - Running setup.py install for manifestparser 04:36:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:45 INFO - Running setup.py install for mozcrash 04:36:45 INFO - Running setup.py install for mozdebug 04:36:45 INFO - Running setup.py install for mozdevice 04:36:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:45 INFO - Running setup.py install for mozfile 04:36:45 INFO - Running setup.py install for mozhttpd 04:36:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:45 INFO - Running setup.py install for mozinfo 04:36:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:45 INFO - Running setup.py install for mozInstall 04:36:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Running setup.py install for mozleak 04:36:46 INFO - Running setup.py install for mozlog 04:36:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Running setup.py install for moznetwork 04:36:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Running setup.py install for mozprocess 04:36:46 INFO - Running setup.py install for mozprofile 04:36:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:46 INFO - Running setup.py install for mozrunner 04:36:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:47 INFO - Running setup.py install for mozscreenshot 04:36:47 INFO - Running setup.py install for moztest 04:36:47 INFO - Running setup.py install for mozversion 04:36:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:47 INFO - Cleaning up... 04:36:47 INFO - Return code: 0 04:36:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:47 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:36:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:47 INFO - 'HOME': '/Users/cltbld', 04:36:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:47 INFO - 'LOGNAME': 'cltbld', 04:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:47 INFO - 'MOZ_NO_REMOTE': '1', 04:36:47 INFO - 'NO_EM_RESTART': '1', 04:36:47 INFO - 'PAGER': '/bin/cat', 04:36:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:47 INFO - 'PWD': '/builds/slave/test', 04:36:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:47 INFO - 'SHELL': '/bin/bash', 04:36:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:47 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:47 INFO - 'USER': 'cltbld', 04:36:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:47 INFO - 'XPC_FLAGS': '0x0', 04:36:47 INFO - 'XPC_SERVICE_NAME': '0', 04:36:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bhpwnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:47 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-BWFd1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DHSMku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-cJlTQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Kgn89O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-X6EGKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-HMlsOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-SgPPLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-c0s7rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-7paMlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-q5_gff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:48 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-XlRp58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:49 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ZglLAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:49 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-JnrVsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:49 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-w4yaVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:49 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-qmCCVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:36:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:49 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-UAfap5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:52 INFO - Downloading blessings-1.6.tar.gz 04:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:52 INFO - Installing collected packages: blessings 04:36:52 INFO - Running setup.py install for blessings 04:36:52 INFO - Successfully installed blessings 04:36:52 INFO - Cleaning up... 04:36:52 INFO - Return code: 0 04:36:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:52 INFO - Reading from file tmpfile_stdout 04:36:52 INFO - Current package versions: 04:36:52 INFO - blessings == 1.6 04:36:52 INFO - blobuploader == 1.2.4 04:36:52 INFO - docopt == 0.6.1 04:36:52 INFO - functools32 == 3.2.3-2 04:36:52 INFO - jsonschema == 2.5.1 04:36:52 INFO - manifestparser == 1.1 04:36:52 INFO - mozInstall == 1.12 04:36:52 INFO - mozcrash == 0.17 04:36:52 INFO - mozdebug == 0.1 04:36:52 INFO - mozdevice == 0.48 04:36:52 INFO - mozfile == 1.2 04:36:52 INFO - mozhttpd == 0.7 04:36:52 INFO - mozinfo == 0.9 04:36:52 INFO - mozleak == 0.1 04:36:52 INFO - mozlog == 3.4 04:36:52 INFO - moznetwork == 0.27 04:36:52 INFO - mozprocess == 0.23 04:36:52 INFO - mozprofile == 0.28 04:36:52 INFO - mozrunner == 6.12 04:36:52 INFO - mozscreenshot == 0.1 04:36:52 INFO - mozsystemmonitor == 0.3 04:36:52 INFO - moztest == 0.7 04:36:52 INFO - mozversion == 1.4 04:36:52 INFO - psutil == 3.1.1 04:36:52 INFO - requests == 1.2.3 04:36:52 INFO - wsgiref == 0.1.2 04:36:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:52 INFO - 'HOME': '/Users/cltbld', 04:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:52 INFO - 'LOGNAME': 'cltbld', 04:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:52 INFO - 'MOZ_NO_REMOTE': '1', 04:36:52 INFO - 'NO_EM_RESTART': '1', 04:36:52 INFO - 'PAGER': '/bin/cat', 04:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:52 INFO - 'PWD': '/builds/slave/test', 04:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:52 INFO - 'SHELL': '/bin/bash', 04:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:52 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:52 INFO - 'USER': 'cltbld', 04:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:52 INFO - 'XPC_FLAGS': '0x0', 04:36:52 INFO - 'XPC_SERVICE_NAME': '0', 04:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:36:52 INFO - Cleaning up... 04:36:52 INFO - Return code: 0 04:36:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:52 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 0x1008df490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100855570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab6ac5b910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, '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.g79tPufk83/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.hJB7IafYZo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:36:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:36:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:36:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:36:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:52 INFO - 'HOME': '/Users/cltbld', 04:36:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:52 INFO - 'LOGNAME': 'cltbld', 04:36:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:52 INFO - 'MOZ_NO_REMOTE': '1', 04:36:52 INFO - 'NO_EM_RESTART': '1', 04:36:52 INFO - 'PAGER': '/bin/cat', 04:36:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:52 INFO - 'PWD': '/builds/slave/test', 04:36:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:52 INFO - 'SHELL': '/bin/bash', 04:36:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:36:52 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:36:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:52 INFO - 'USER': 'cltbld', 04:36:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:52 INFO - 'XPC_FLAGS': '0x0', 04:36:52 INFO - 'XPC_SERVICE_NAME': '0', 04:36:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:53 INFO - Cleaning up... 04:36:53 INFO - Return code: 0 04:36:53 INFO - Running post-action listener: _resource_record_post_action 04:36:53 INFO - Running post-action listener: _start_resource_monitoring 04:36:53 INFO - Starting resource monitoring. 04:36:53 INFO - [mozharness: 2016-10-11 11:36:53.281435Z] Finished create-virtualenv step (success) 04:36:53 INFO - [mozharness: 2016-10-11 11:36:53.282400Z] Running install step. 04:36:53 INFO - Running pre-action listener: _resource_record_pre_action 04:36:53 INFO - Running main action method: install 04:36:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:53 INFO - Reading from file tmpfile_stdout 04:36:53 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:53 INFO - Reading from file tmpfile_stdout 04:36:53 INFO - Output received: 04:36:53 INFO - Usage: mozinstall [options] installer 04:36:53 INFO - Options: 04:36:53 INFO - -h, --help show this help message and exit 04:36:53 INFO - -d DEST, --destination=DEST 04:36:53 INFO - Directory to install application into. [default: 04:36:53 INFO - "/builds/slave/test"] 04:36:53 INFO - --app=APP Application being installed. [default: firefox] 04:36:53 INFO - mkdir: /builds/slave/test/build/application 04:36:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:37:27 INFO - Reading from file tmpfile_stdout 04:37:27 INFO - Output received: 04:37:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:37:27 INFO - Running post-action listener: _resource_record_post_action 04:37:27 INFO - [mozharness: 2016-10-11 11:37:27.542362Z] Finished install step (success) 04:37:27 INFO - [mozharness: 2016-10-11 11:37:27.542522Z] Running run-tests step. 04:37:27 INFO - Running pre-action listener: _resource_record_pre_action 04:37:27 INFO - Running main action method: run_tests 04:37:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:27 INFO - 2016-10-11 04:37:27.557 screenresolution[1645:7457] starting screenresolution argv=screenresolution get 04:37:27 INFO - 2016-10-11 04:37:27.560 screenresolution[1645:7457] Display 0: 1600x1200x32@60 04:37:27 INFO - 2016-10-11 04:37:27.565 screenresolution[1646:7462] starting screenresolution argv=screenresolution list 04:37:27 INFO - Available Modes on Display 0 04:37:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:27 INFO - Intel Iris: 04:37:27 INFO - Chipset Model: Intel Iris 04:37:27 INFO - Type: GPU 04:37:27 INFO - Bus: Built-In 04:37:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:27 INFO - Vendor: Intel (0x8086) 04:37:27 INFO - Device ID: 0x0a2e 04:37:27 INFO - Revision ID: 0x0009 04:37:27 INFO - Displays: 04:37:27 INFO - Display: 04:37:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:27 INFO - Display Serial Number: 1600x1200 60 04:37:27 INFO - Main Display: Yes 04:37:27 INFO - Mirror: Off 04:37:27 INFO - Online: Yes 04:37:27 INFO - Rotation: Supported 04:37:27 INFO - Return code: 0 04:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:27 INFO - Python 2.7.3 04:37:27 INFO - Return code: 0 04:37:27 INFO - grabbing minidump binary from tooltool 04:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37: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 0x1006f3d30>, '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 0x100519db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1006ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37: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 04:37: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 04:37: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 04:37:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:27 INFO - Return code: 0 04:37:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:37:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:37:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.g79tPufk83/Render', 04:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:27 INFO - 'HOME': '/Users/cltbld', 04:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:27 INFO - 'LOGNAME': 'cltbld', 04:37:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:27 INFO - 'MOZ_NO_REMOTE': '1', 04:37:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:27 INFO - 'NO_EM_RESTART': '1', 04:37:27 INFO - 'PAGER': '/bin/cat', 04:37:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:27 INFO - 'PWD': '/builds/slave/test', 04:37:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:27 INFO - 'SHELL': '/bin/bash', 04:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hJB7IafYZo/Listeners', 04:37:27 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 04:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:27 INFO - 'USER': 'cltbld', 04:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:27 INFO - 'XPC_FLAGS': '0x0', 04:37:27 INFO - 'XPC_SERVICE_NAME': '0', 04:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:28 INFO - mozversion application_buildid: 20161011021350 04:37:28 INFO - mozversion application_changeset: a4c3d4d2588ceb1500aab82e2410396cca01755e 04:37:28 INFO - mozversion application_display_name: Nightly 04:37:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:28 INFO - mozversion application_name: Firefox 04:37:28 INFO - mozversion application_remotingname: firefox 04:37:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:37:28 INFO - mozversion application_vendor: Mozilla 04:37:28 INFO - mozversion application_version: 52.0a1 04:37:28 INFO - mozversion platform_buildid: 20161011021350 04:37:28 INFO - mozversion platform_changeset: a4c3d4d2588ceb1500aab82e2410396cca01755e 04:37:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:37:28 INFO - mozversion platform_version: 52.0a1 04:37:28 INFO - using testdate: 1476185848 04:37:28 INFO - actual date: 1476185848 04:37:28 INFO - starting webserver on 'localhost:49273' 04:37:28 INFO - SUITE-START | Running 2 tests 04:37:28 INFO - TEST-START | dromaeo_css 04:37:28 INFO - operating with platform_type : mac_ 04:37:28 INFO - Initialising browser for dromaeo_css test... 04:37:28 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpKDXID_/profile http://localhost:49273/getInfo.html) 04:37:30 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 04:37:30 INFO - PROCESS | 1656 | colorDepth:24 04:37:30 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 04:37:30 INFO - PROCESS | 1656 | __metrics 04:37:30 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:37:30 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:31 INFO - TEST-INFO | 1656: exit 0 04:37:31 INFO - Browser initialized. 04:37:31 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:31 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpKDXID_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:43 INFO - PROCESS | 1658 | RSS: Main: 235257856 04:37:43 INFO - PROCESS | 1658 | 04:38:34 INFO - PROCESS | 1658 | 1476185914314 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:40:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 04:40:48 INFO - PROCESS | 1658 | RSS: Main: 434663424 04:40:48 INFO - PROCESS | 1658 | 04:43:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 04:43:52 INFO - PROCESS | 1658 | RSS: Main: 369754112 04:43:52 INFO - PROCESS | 1658 | 04:46:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 04:46:55 INFO - PROCESS | 1658 | RSS: Main: 331431936 04:46:55 INFO - PROCESS | 1658 | 04:49:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 04:49:58 INFO - PROCESS | 1658 | RSS: Main: 335511552 04:49:58 INFO - PROCESS | 1658 | 04:53:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 04:53:02 INFO - PROCESS | 1658 | RSS: Main: 333139968 04:53:02 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 04:56:05 INFO - PROCESS | 1658 | RSS: Main: 429506560 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | __start_tp_report 04:56:05 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 04:56:05 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 04:56:05 INFO - PROCESS | 1658 | |i|pagename|runs| 04:56:05 INFO - PROCESS | 1658 | |0;dojo.html;2919.3577412969153;3171.7938334008286;3352.296017836254;3353.312570922961;3409.09658940381;5629.268195134637;5670.63140895842;5747.971260143693;5785.56608254381;5810.7094645267725;5697.259356283677;5735.369109397963;5771.451712087355;5817.127430885369;5923.05231163014;5155.9484405155845;5222.503862133091;5241.842744717665;5252.658577192489;5254.106801843695;5331.120365139747;5341.252224688546;5344.839654810343;5371.328583927009;5420.864478388033;4491.977540112295;5312.415634280226;5330.067238233332;5350.491703288181;5430.647007944491;4576.672764898176;5062.873428164288;5169.586433085344;5188.5849132069725;5219.9299143675835;5160.974195129038;5175.146100893348;5179.533841954205;5202.4277329493725;5287.68273903567;5784.68184249866;5809.390014048507;5823.184754134425;5826.300843898717;5837.970810145965;6101.420365065356;6129.297663865974;6157.784477543264;6206.968965155191;6283.497320214372;6174.5060395168275;6295.905561416583;6303.180586523768;6304.936950630481;6311.652859092748;5863.618864773776;5867.295924489089;5878.647281163058;5894.056950887923;5942.168096466498;5038.622103342264;6195.938040619626;6208.286047104641;6217.440430361289;6261.78083767066;6138.877222455615;6172.135900973867;6183.598066125687;6189.102580125947;6201.317855035943;6228.159198508234;6274.9686251569365;6293.842653933597;6299.5275354348605;6303.46420554258;6033.4871535919065;6096.798833414392;6190.442860142609;6239.724144824004;6257.342978987141;6164.969175154185;6172.845678857974;6234.407731265614;6245.437910588069;6288.591241569284;4936.802527898915;4950.70295782247;4950.950490495121;4963.528464795839;4987.675801072919;4451.710638808532;4461.776911154429;4469.664775141878;4491.663125265618;4532.161550113239;5635.971820140873;5680.488756011979;5684.175794509773;5770.105633626795;5793.565482588822;5307.681539107666;6175.722092505848;6219.813405597839;6245.875082498415;6305.054241863757;4608.792604332813;5856.1508581255475;5860.355360910296;5888.322842873039;5892;5423.538999185034;5439.456054394529;5450.700211488406;5453.15476101205;5465.59008074396;6220.409061139185;6232.158658581034;6278.4035516625845;6295.685215739103;6312.895243332398;6278.4035516625845;6286.937130628635;6291.716872740829;6307.653079080511;6310.337414571588;6279.246490421178;6312.715927783169;6317.273513545817;6319.6840157991;6327.145835312358;6075.969620151871;6130.386961303834;6144.477719393902;6270.372962703693;6272.686365681789;6175.166352542529;6260.874782504234;6288.056791481315;6302.401271879165;6323.652199129092;5942.71375298121;6183.258009038944;6194;6194.5973511721595;6209.720562574605;6106.755729770937;6147.600405973598;6153.661548614869;6182.752689892354;6240.719167637558;5857.941420585739;5934.495567876606;5953.880922381441;6022.638641681513;6042.546808989431;6069.150318955438;6101.307919489844;6110.0424004731585;6126.264848218242;6142.969285153546;5994.520438364833;6046.486048685911;6077.665728384981;6099.84750381244;6112.419320164755 04:56:05 INFO - PROCESS | 1658 | |1;ext.html;487.71956125228;520.3495630461922;534.4094775273323;539.5225225675276;555.0065382964497;30411;31756.36487270256;31786.36427271456;31814.522782158285;39504.40743388851;39590.8020459898;41787;41995.580044199545;42021.789891050576;42080.36879446811;8828.07305232951;9495.52522373882;9628.711138665834;9816.656417025406;9832.213422926148;8768.430052046597;8993.235574976103;9674.22606191503;9796.167325777318;9796.971318011612;11833.230839995416;12152.939235303811;12177.391130443486;12295.938520307385;12340.382980850967;11985.820212696817;12042.63872083839;12044.39778011096;12049.698757531045;12058.397080145958;8653.783655408602;8906.51014194219;11854.466549005316;11957.342346170957;11962.641120766391;31866.840665796524;32207.51688724671;32212.35575288481;38416.80791596052;39137;3303.9008829734908;3412.658734126592;3462.9653703462895;3544.1848374873666;3773.7735735855663;30201.942931997495;30798.110814885884;31038.534421983688;31060.534091988637;31116;3128.1710346758127;3274.214188594744;3302.4716045432615;3335.8665653373837;3346.765726399153;470787;472203;472383.99999999657;473539;477892;55228.17157742637;55531.444685552626;55571.72214138904;55596.722016389656;55632;58507;58546;58599.121013184835;58645.413545864845;58648;13572.728545429036;15563.53309400697;15868.682626347409;15897.205139743199;15900;12282.447289871978;12361.62915112548;12366.814497782361;12379.75240495185;12379.814302785466;11858.347790871412;13269.611469935504;13568.728625427437;13590.252536110609;15015.324310406058;5390.811321603725;5857.326407463111;6165.753369865245;6959.512834101665;7042.859142817115;864.6714248585623;918.3066784577601;935.4714586258879;980.6224603527551;1029.912457441126;27727;27770.444591108066;29452.852735736185;29542;29602.555961660593;1028.840529717895;1036.326387847905;1084.2356138922041;1111.6887271563976;1138.5673444091192;13372;14988.302105620874;15111.622209444631;15523.1462269574;15527.223638818014;615071;616813;616964;617335;619722;48762.02475950532;55892.44107558872;56344.71827640918;56346;56438.43561564414;1211.5638370186725;1245.371087600774;1274.1654216488214;1345.603047101088;1346.596021193638;29857.402851943272;30560.235994100327;30585;30859.537106942964;31365.372692545567;46527.53472465232;47102.76448617735;47237;47264.2910356338;47286.76356618195;518954;523758.76241238625;523840;523865;619917;24275.514489710462;25040.61951636506;25140.497190055732;25148.74851251464;25173.24480265595;44303.778481108675;44345.77827110844;44792.55207447884;44878.77560612176;45744.54255457403;37045;37415.81292093522;37437.06407339838;37959.81020094992;38322;36608.45087323745;37019.25961480809;37706.43440348342;37719.622803771614;37980;36013;36257.093572660895;36403;36498.45252321164;36769.89690309295;29456.11631651054;31604.36791264116;32720;32879;32951.58589317385;19399.2240310386;24481.38796530101;24539.503273200025;24661.63007554924;24904.252872413857 04:56:05 INFO - PROCESS | 1658 | |2;jquery.html;288.93932274222414;311.5218140154862;362.5088005752205;364.6881915961851;398.0625626649241;15402.537923862274;15421.691566168683;16106.91946540267;21323.68014479784;21349;18044;21980.560388792215;22165.66751498729;22181;22259.554808903813;5428.565714742831;6003.459688628033;6213.2233470816145;6307.180066591337;6318.304986451487;4274.487061552618;4352.36890650857;4498.910021799562;6959.8956015659805;7067.151941766995;6671.332866713314;6978.79063628092;6997.230304666483;7002.124734408199;7003.3346832050875;6174.660393678346;6575.506836987245;6906.585604863674;6955.652217389161;6991.89512157318;5678.801241956512;5877.412258774131;5981.491573216238;6025.879482410327;6031;26137;26850.657467126763;26871.32821679454;26910.865445672647;27148.728512715013;2337.2871274261342;2393.833580609551;2423.8182136339847;2444.1445494077107;2504.799616030713;14802.40790368384;15557.611059723484;15714.842851571566;15965.92017039919;16550.6689866202;1510.765831296151;1599.872010239178;1791.5073354827396;1905.7617797775279;1938.621968716101;107000;116025;116072.17834649656;116458.83541164649;117789;9279;10932.453377331101;11209.383483908301;11317.83023254652;11517.424128793527;14082.929585352213;14127.64680882986;14147.858521414653;14161.504347347793;14170.645733856736;8506.234438900528;8675.828763117024;8693.608787604573;8762.86855697165;8836.248918841842;8448.957755211184;8641.870371944426;8667.479951202948;8692.087330830298;8893.24407425376;6684.398404143553;6808.353206445379;6824.727010919607;6829.623578392056;6894.793156205322;1851.231738828398;1851.6944704123669;1860.6371757507427;1862.5157459060472;1902.7050807124917;814.3973459639942;896.7354630384052;931.2270815223349;1038.133158812385;1061.570064124031;20608.880709186917;21767.40135192637;22329.330120096423;22537.549249015257;22704.31887043391;937.8452555328431;957.30595318395;968.404431274775;971.621067783565;1031.242037102729;8987.247486740023;10271.691849244535;10773.569057237779;11882.584109556125;12009.579664711693;549016;590101;598387;622077;624116;81123;89087;106123.10167856913;109236;112364.43817780858;970.9514524273758;996.4718699089639;1021.4688362051692;1035.8239099353127;1037.6886933919793;19677.896614078767;20257.69613455829;20988.58022839565;21009.57980840344;21292.574148516633;37569;54049;55148.72425637846;55161.277421161874;55417.783288668004;73411.63294183495;74662.04055513373;75038;75862.86205706808;76251.61874190594;6326.272478665012;7542.170361260147;7958.960205198937;8167.346612270885;8201.589920503831;12183.451744671334;12513;13299.867001329863;13887.930560347133;13901.86098139046;9842;10085.394876307446;11176.776464470502;11542.19204655666;11834.940825295818;9727.221822254343;10761.784764304513;11463.942680286546;11718.062554995751;11913.761724765629;10596.364218146937;11659.708507287385;11805.703790116682;11994.880051199376;12021.098417618889;6880;7873.803154921173;7895.881561776693;7975.960120199362;8320.420669592446;9347.672831450867;11324.773504530029;11480.138989575982;11486.65540033767;11566.363849988331 04:56:05 INFO - PROCESS | 1658 | |3;mootools.html;1513.2433783108443;1535.2860919672353;1749.5101371615945;1916.9616607667838;1934.361660651985;8551.273141782947;9025.954870225656;9036.548172591369;9051.502167380791;9053.909460905397;7738.883916741239;8102.756917292476;8119.3910456715685;8499;8794.648214071429;2335.2060299498166;2369.7037870266217;2378.048780487801;2380.2859142257253;2385.224801939368;2330.93007209784;2348.6477028445697;2377.6076947303673;2380.27401642499;2382.8570285782907;2349.259983105325;2371.3004663624274;2375.4417711837705;2379.3456799380137;2386.844855084414;2341.6253399456004;2345.0887526665797;2356.705411823522;2357.0571771291447;2358.044991778324;2343.0510643189536;2350.4358953851124;2351.9176828811082;2354.6350315701093;2355.470019245673;8843.380963332569;8866.468011919242;8958.23854972328;8960.417572857743;8968.686095986674;4630.976845115787;5197.324347834795;5368.32895888014;5380.139177731583;5380.946190538123;3416.931661366759;3511.5953618552526;3631.691306238973;3633.4368172933237;3639.7998110103936;1007.8437842134408;1074.8172810622134;1077.9299345542515;1081.0918828184285;1100.2078503477483;11619.244749091282;11691.649250522498;11706.473208705544;11714.88285117155;11717.238379505305;4444.711093778894;4612.677112602153;4657.790399432034;4801.879953001133;4803.78382972767;9954.800903981879;9965.302428829913;9977;9978.251631127694;9987.550560224807;5220.738963051832;5232.869178270574;5234.476552344811;5235;5240.292560504359;4372.912541749147;4404.229259879572;4770.212914869007;4802.447718512416;4854.101991131652;3869.6517313441927;3883.5533913600298;3953.8616148434667;3998.9400158997637;4008.2785098682516;1254.3101294288288;1264.879836415539;1266.6263452281598;1274.337344580813;1285.4022879361141;783.2989474420476;889.2441424788877;913;921.6819947475175;939.9624015039459;5601.831945041656;5715.142728590745;5955.196048533393;5971.4327138921735;6073.691997041096;950.933434659581;953.1183655118987;953.7710949372239;955.9091886270793;995.9701208963743;3966.1076257842333;4043.4945631796027;4091;4249.617534421855;4254.7659878706345;10761.408122553335;10774.407407592658;10902.236843421044;10906.236563440483;10912.399818010086;10706.518206680717;10718.946405267923;10861.511231994578;10869.021788038955;10873.83689244662;6940.7917762467205;7999.9600001999615;8147.67409303633;8158;8289.129641387688;5947.881042379215;5962.940370596412;6066.090086487062;6069.36271691466;6157.107219453064;10036.197104231498;10152.086312231935;10187.592496300362;10199.643012494527;10208.489575521045;9911.959244279247;9946.055124763136;10212;10301.072903438726;10407.375557466576;6968.547044442095;7230.963845180951;7243.45674074436;7443.516171448839;7684.923150768421;8198.262156405952;8502.44734092282;8514.701985430727;8613.22480976715;8614.44006139599;7429.257074292527;7554.433417493819;7615.4669173157345;7653.272939070779;7718.961405193163;7506.24937506245;7535.886961695469;7645;7698.615069246403;7729.9227007729205;6906.482013848881;7056.435485161277;7072.823179420556;7073.434125270069;7078.079849619517;5022.372203474566;5163.535281824504;5209.140491818959;5277.577793776565;5454.918176227439;5310.442403547572;5403.8108666196495;5431.646942948696;5484.670919744828;5512.641678290898 04:56:05 INFO - PROCESS | 1658 | |4;prototype.html;297.0864591381502;302.401245533843;303.19350527596595;305.15319987035974;313.72078849823646;4297.806598703058;4676.368690226818;5086.211637196231;5161.587073034158;5227.581793456524;4537.009289781239;4926.482719314474;5076.822311219108;5164;5191.482131166381;3757.43638454232;3866.2074274773745;3927.882163535084;3932.3315036443732;4023.7384570002855;3529.505869178317;3964.306246406867;3978.5424676162324;3983.2830090583684;4026.5570787213383;3932.960670393288;3974.9602503975025;3983.940240896389;4007.2786898358286;4030.758154510724;3323.4047657124715;3567.8751243706347;3722.7952462614544;3952.6837852971835;3987.73006134968;2911.8107323023937;3457.757956943015;3466.838609065966;3494.353544594258;3508.6842184203542;3763.379042457991;4815.66290359675;5026.698398096126;5038.874028149289;5053.538326246497;3664.701768408427;4539.341795439643;4546.818127274905;4560.065186636732;4576.748278844662;5102.902875881703;5358.892822143574;5385.67685938841;5386.78452861885;5481.616286859921;3181.5545823584716;3707.1658876752786;3734.9915522808687;3735.7945313008045;3769.2838360711376;4801.8079276828885;5117.616178786643;5139.177731563007;5462.672239665632;5716.770894257713;3453.87911423104;3590.2998915211283;3775.962240377616;3778.508793856836;3801.790901500444;3829.9042523937123;3834.1564855731694;3834.884953451401;3837.827297771607;3843.26977874203;3816.923661526754;3889.6775096467336;4482.955170448254;4492.281235002384;4502.5047244803045;4226.4716910386205;4988.401391833003;5451.7733509960735;5529.695866727288;5534.4742249486235;1203.48851738011;1232.9150347693972;1282.8845403913692;1308.8036794480904;1311.996322813049;672.8250654829682;690.7221639966023;751.4476859508258;790.2611058660171;804.4650307545534;4164.875053748332;4242.957570424256;4935.407751069823;4972.701637901738;4976.925346119811;5551.611387202857;5553.416891226444;5585.245991791056;5600.663960162403;5613.259889434288;4862;4880.901212478669;4979.377577802775;5058.962912602908;5081.542661160439;2391.656176946602;2903.5209190483756;2917.9416411671646;2924.2543151496657;2934.1784300395925;4806.8798280043275;5081.5426611605135;5707.74315155819;5711.857203569944;5761.839310258653;5268.315119034501;5670.971645141831;5676.9911946668335;5713.914291285634;5719.914201286901;5714.114312281603;5735.741891614887;5743.942560574341;5758.395368486333;5798.275215598134;4398.890027749204;5504.091824849015;5540.63985840919;5553.8333849984565;5564.91652625219;4707.904982282851;5084.872878178076;5249.028929648028;5471.2613797138465;5511.448855114457;4684.578387945101;5694.800681976111;5696.379665353984;5735.48009777401;5739.167820666064;3145.465270903906;3562.9133114400356;3731.645493678096;3738.925221495609;3748.7001039917286;4546.4544254689645;5328.7602057906715;5576.302962129734;5577.629507459233;5612.971935140298;5384.973075134756;5404.135338345845;5408.891177308721;5412.621116521806;5418;4396.296592545177;4775.450823155382;5350.545203657733;5369.436209197978;5380.031594312904;4954.355933728592;5259.4477579853565;5305.575553955597;5316.494932981361;5323.653962492425;4735.881602959954;5086.872828179177;5290.677330667333;5296.311479507639;5404.43253458397;5183.5745170077025;5277.575054735276;5315.681059136464;5330.840074797762;5425.864353391039 04:56:05 INFO - PROCESS | 1658 | |5;yui.html;692.7332976803931;721.8303698630821;728.6283995162469;733.1056111543915;773.1533970302517;15316.46392376267;15779.13214773187;15883.126428046467;15885.444009459643;15953.282102305395;14147.929260353709;14239.78640320396;14257.2158531281;14276.785848212285;14725.337359818806;683.3474032299142;702.192478649552;707.6673963237271;850.587465079436;884.6859364925456;853.63293783673;876.1457578860592;881.1012766977678;888.4269646078276;889.9332550058739;926.5321012888481;929.2658799548349;930.7347405989294;930.962761489543;936.18551859882;720.3912693773752;924.6717415317567;926.578406824893;927.285989787863;928.767808047988;555.4889501658483;666.5733930284622;684.5345165287603;686.9072675188836;693.3517161454057;15240.618984525365;15287.159206243652;15292.235388230543;15300.923495382453;15337.079775213522;13709.794353084711;13859.045338919586;14157.504487342894;14276.286185690778;14419.339767994325;10151.898481015169;12326.568570100093;12544.435500402504;12689.365531723377;12720.300383478905;4503.909921801578;4524.16302983949;4532.592066714012;4713.363695901044;4716.221823399135;105367.47316263446;107897.46051269773;116455.2531712025;117544.41227793891;118809;11028.779424411467;11073.557057717762;11198.944005279922;11409.543618255342;11441.771164576661;22333.77666223317;22340;22343;22359.32922012342;22362.888185558968;7752.806179845549;7952.522848628985;7956.641951112214;8006.559639219899;8014.879776803353;3720.9441858372147;4026.037364015461;4214.220369231641;4240.936385954213;4401.581849724271;3522.876699315512;3591.7665351752053;3627.4196128619296;3633.94549081764;3642.5993140754495;574.8419184724235;676.2696288008939;677.4106527321163;678.1895634716565;682.0349205873732;572.4904834697123;607.4714997951722;615.5321955313993;664.6142792278155;686.4725984684038;9541.2367010639;9598.856017159747;9687.2734544908;9702.854457183148;9811.656592019244;595.8986972214734;634.5875181132301;671.9832004199836;684.2746688510196;696.380221602774;4213.494380674278;4403.889902752393;4524.434445694288;5144.922826157611;5205.375354957429;155775;157708;161337;162404;166489;95199.52400237955;114856;114986.27520587198;132575.33712331377;142510;112319.43840280746;112425.38469998848;113783;115687.42156289333;117949.4102529499;9235.722928312161;9716.3198576099;9885.456299903575;9897.35667181631;9900.900990989998;56789.58026049382;60011.69994150001;63455.048174278345;64490;65445.345546543926;60015.39984600098;62840.37159628528;63442;65275;85986.2422012475;11289.604863829727;13396.531121410704;13452.93273533626;13579.499195774042;13732.918145936985;12704.36478176106;14843.40626374933;14976.251187440366;15369.923150384177;15429.480905918415;10155.54300056514;12982.35088245565;13568.728625427239;13938.93030534841;13967.860321397062;13554.390052447861;13660.180389176681;13711.794323085362;13769.105008174436;14024.649383765487;13350.265735384648;13448.798268026183;13488.662783430493;13619.38712757948;13698.52055178064;10459.84310235332;11149.888501115209;11396;11474.827877582009;11521.884781152416;9264.814703706023;10204.489775511343;11292.887071129184;11488.368139752394;11553.768924621629 04:56:05 INFO - PROCESS | 1658 | __end_tp_report 04:56:05 INFO - PROCESS | 1658 | __start_cc_report 04:56:05 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2318 04:56:05 INFO - PROCESS | 1658 | __end_cc_report 04:56:05 INFO - PROCESS | 1658 | __startTimestamp1476186965958__endTimestamp 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | ------- Summary: start ------- 04:56:05 INFO - PROCESS | 1658 | Number of tests: 6 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5751.59 Median:6022.64 stddev:665.20 (11.0%) stddev-sans-first:629.04 04:56:05 INFO - PROCESS | 1658 | Values: 2919.4 3171.8 3352.3 3353.3 3409.1 5629.3 5670.6 5748.0 5785.6 5810.7 5697.3 5735.4 5771.5 5817.1 5923.1 5155.9 5222.5 5241.8 5252.7 5254.1 5331.1 5341.3 5344.8 5371.3 5420.9 4492.0 5312.4 5330.1 5350.5 5430.6 4576.7 5062.9 5169.6 5188.6 5219.9 5161.0 5175.1 5179.5 5202.4 5287.7 5784.7 5809.4 5823.2 5826.3 5838.0 6101.4 6129.3 6157.8 6207.0 6283.5 6174.5 6295.9 6303.2 6304.9 6311.7 5863.6 5867.3 5878.6 5894.1 5942.2 5038.6 6195.9 6208.3 6217.4 6261.8 6138.9 6172.1 6183.6 6189.1 6201.3 6228.2 6275.0 6293.8 6299.5 6303.5 6033.5 6096.8 6190.4 6239.7 6257.3 6165.0 6172.8 6234.4 6245.4 6288.6 4936.8 4950.7 4951.0 4963.5 4987.7 4451.7 4461.8 4469.7 4491.7 4532.2 5636.0 5680.5 5684.2 5770.1 5793.6 5307.7 6175.7 6219.8 6245.9 6305.1 4608.8 5856.2 5860.4 5888.3 5892.0 5423.5 5439.5 5450.7 5453.2 5465.6 6220.4 6232.2 6278.4 6295.7 6312.9 6278.4 6286.9 6291.7 6307.7 6310.3 6279.2 6312.7 6317.3 6319.7 6327.1 6076.0 6130.4 6144.5 6270.4 6272.7 6175.2 6260.9 6288.1 6302.4 6323.7 5942.7 6183.3 6194.0 6194.6 6209.7 6106.8 6147.6 6153.7 6182.8 6240.7 5857.9 5934.5 5953.9 6022.6 6042.5 6069.2 6101.3 6110.0 6126.3 6143.0 5994.5 6046.5 6077.7 6099.8 6112.4 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:66990.60 Median:36135.05 stddev:146380.68 (405.1%) stddev-sans-first:146706.16 04:56:05 INFO - PROCESS | 1658 | Values: 487.7 520.3 534.4 539.5 555.0 30411.0 31756.4 31786.4 31814.5 39504.4 39590.8 41787.0 41995.6 42021.8 42080.4 8828.1 9495.5 9628.7 9816.7 9832.2 8768.4 8993.2 9674.2 9796.2 9797.0 11833.2 12152.9 12177.4 12295.9 12340.4 11985.8 12042.6 12044.4 12049.7 12058.4 8653.8 8906.5 11854.5 11957.3 11962.6 31866.8 32207.5 32212.4 38416.8 39137.0 3303.9 3412.7 3463.0 3544.2 3773.8 30201.9 30798.1 31038.5 31060.5 31116.0 3128.2 3274.2 3302.5 3335.9 3346.8 470787.0 472203.0 472384.0 473539.0 477892.0 55228.2 55531.4 55571.7 55596.7 55632.0 58507.0 58546.0 58599.1 58645.4 58648.0 13572.7 15563.5 15868.7 15897.2 15900.0 12282.4 12361.6 12366.8 12379.8 12379.8 11858.3 13269.6 13568.7 13590.3 15015.3 5390.8 5857.3 6165.8 6959.5 7042.9 864.7 918.3 935.5 980.6 1029.9 27727.0 27770.4 29452.9 29542.0 29602.6 1028.8 1036.3 1084.2 1111.7 1138.6 13372.0 14988.3 15111.6 15523.1 15527.2 615071.0 616813.0 616964.0 617335.0 619722.0 48762.0 55892.4 56344.7 56346.0 56438.4 1211.6 1245.4 1274.2 1345.6 1346.6 29857.4 30560.2 30585.0 30859.5 31365.4 46527.5 47102.8 47237.0 47264.3 47286.8 518954.0 523758.8 523840.0 523865.0 619917.0 24275.5 25040.6 25140.5 25148.7 25173.2 44303.8 44345.8 44792.6 44878.8 45744.5 37045.0 37415.8 37437.1 37959.8 38322.0 36608.5 37019.3 37706.4 37719.6 37980.0 36013.0 36257.1 36403.0 36498.5 36769.9 29456.1 31604.4 32720.0 32879.0 32951.6 19399.2 24481.4 24539.5 24661.6 24904.3 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:34318.48 Median:26860.99 stddev:98919.49 (368.3%) stddev-sans-first:99163.99 04:56:05 INFO - PROCESS | 1658 | Values: 288.9 311.5 362.5 364.7 398.1 15402.5 15421.7 16106.9 21323.7 21349.0 18044.0 21980.6 22165.7 22181.0 22259.6 5428.6 6003.5 6213.2 6307.2 6318.3 4274.5 4352.4 4498.9 6959.9 7067.2 6671.3 6978.8 6997.2 7002.1 7003.3 6174.7 6575.5 6906.6 6955.7 6991.9 5678.8 5877.4 5981.5 6025.9 6031.0 26137.0 26850.7 26871.3 26910.9 27148.7 2337.3 2393.8 2423.8 2444.1 2504.8 14802.4 15557.6 15714.8 15965.9 16550.7 1510.8 1599.9 1791.5 1905.8 1938.6 107000.0 116025.0 116072.2 116458.8 117789.0 9279.0 10932.5 11209.4 11317.8 11517.4 14082.9 14127.6 14147.9 14161.5 14170.6 8506.2 8675.8 8693.6 8762.9 8836.2 8449.0 8641.9 8667.5 8692.1 8893.2 6684.4 6808.4 6824.7 6829.6 6894.8 1851.2 1851.7 1860.6 1862.5 1902.7 814.4 896.7 931.2 1038.1 1061.6 20608.9 21767.4 22329.3 22537.5 22704.3 937.8 957.3 968.4 971.6 1031.2 8987.2 10271.7 10773.6 11882.6 12009.6 549016.0 590101.0 598387.0 622077.0 624116.0 81123.0 89087.0 106123.1 109236.0 112364.4 971.0 996.5 1021.5 1035.8 1037.7 19677.9 20257.7 20988.6 21009.6 21292.6 37569.0 54049.0 55148.7 55161.3 55417.8 73411.6 74662.0 75038.0 75862.9 76251.6 6326.3 7542.2 7959.0 8167.3 8201.6 12183.5 12513.0 13299.9 13887.9 13901.9 9842.0 10085.4 11176.8 11542.2 11834.9 9727.2 10761.8 11463.9 11718.1 11913.8 10596.4 11659.7 11805.7 11994.9 12021.1 6880.0 7873.8 7895.9 7976.0 8320.4 9347.7 11324.8 11480.1 11486.7 11566.4 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5759.92 Median:5180.43 stddev:3216.11 (62.1%) stddev-sans-first:3209.30 04:56:05 INFO - PROCESS | 1658 | Values: 1513.2 1535.3 1749.5 1917.0 1934.4 8551.3 9026.0 9036.5 9051.5 9053.9 7738.9 8102.8 8119.4 8499.0 8794.6 2335.2 2369.7 2378.0 2380.3 2385.2 2330.9 2348.6 2377.6 2380.3 2382.9 2349.3 2371.3 2375.4 2379.3 2386.8 2341.6 2345.1 2356.7 2357.1 2358.0 2343.1 2350.4 2351.9 2354.6 2355.5 8843.4 8866.5 8958.2 8960.4 8968.7 4631.0 5197.3 5368.3 5380.1 5380.9 3416.9 3511.6 3631.7 3633.4 3639.8 1007.8 1074.8 1077.9 1081.1 1100.2 11619.2 11691.6 11706.5 11714.9 11717.2 4444.7 4612.7 4657.8 4801.9 4803.8 9954.8 9965.3 9977.0 9978.3 9987.6 5220.7 5232.9 5234.5 5235.0 5240.3 4372.9 4404.2 4770.2 4802.4 4854.1 3869.7 3883.6 3953.9 3998.9 4008.3 1254.3 1264.9 1266.6 1274.3 1285.4 783.3 889.2 913.0 921.7 940.0 5601.8 5715.1 5955.2 5971.4 6073.7 950.9 953.1 953.8 955.9 996.0 3966.1 4043.5 4091.0 4249.6 4254.8 10761.4 10774.4 10902.2 10906.2 10912.4 10706.5 10718.9 10861.5 10869.0 10873.8 6940.8 8000.0 8147.7 8158.0 8289.1 5947.9 5962.9 6066.1 6069.4 6157.1 10036.2 10152.1 10187.6 10199.6 10208.5 9912.0 9946.1 10212.0 10301.1 10407.4 6968.5 7231.0 7243.5 7443.5 7684.9 8198.3 8502.4 8514.7 8613.2 8614.4 7429.3 7554.4 7615.5 7653.3 7719.0 7506.2 7535.9 7645.0 7698.6 7729.9 6906.5 7056.4 7072.8 7073.4 7078.1 5022.4 5163.5 5209.1 5277.6 5454.9 5310.4 5403.8 5431.6 5484.7 5512.6 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4366.17 Median:4944.88 stddev:1351.61 (27.3%) stddev-sans-first:1320.44 04:56:05 INFO - PROCESS | 1658 | Values: 297.1 302.4 303.2 305.2 313.7 4297.8 4676.4 5086.2 5161.6 5227.6 4537.0 4926.5 5076.8 5164.0 5191.5 3757.4 3866.2 3927.9 3932.3 4023.7 3529.5 3964.3 3978.5 3983.3 4026.6 3933.0 3975.0 3983.9 4007.3 4030.8 3323.4 3567.9 3722.8 3952.7 3987.7 2911.8 3457.8 3466.8 3494.4 3508.7 3763.4 4815.7 5026.7 5038.9 5053.5 3664.7 4539.3 4546.8 4560.1 4576.7 5102.9 5358.9 5385.7 5386.8 5481.6 3181.6 3707.2 3735.0 3735.8 3769.3 4801.8 5117.6 5139.2 5462.7 5716.8 3453.9 3590.3 3776.0 3778.5 3801.8 3829.9 3834.2 3834.9 3837.8 3843.3 3816.9 3889.7 4483.0 4492.3 4502.5 4226.5 4988.4 5451.8 5529.7 5534.5 1203.5 1232.9 1282.9 1308.8 1312.0 672.8 690.7 751.4 790.3 804.5 4164.9 4243.0 4935.4 4972.7 4976.9 5551.6 5553.4 5585.2 5600.7 5613.3 4862.0 4880.9 4979.4 5059.0 5081.5 2391.7 2903.5 2917.9 2924.3 2934.2 4806.9 5081.5 5707.7 5711.9 5761.8 5268.3 5671.0 5677.0 5713.9 5719.9 5714.1 5735.7 5743.9 5758.4 5798.3 4398.9 5504.1 5540.6 5553.8 5564.9 4707.9 5084.9 5249.0 5471.3 5511.4 4684.6 5694.8 5696.4 5735.5 5739.2 3145.5 3562.9 3731.6 3738.9 3748.7 4546.5 5328.8 5576.3 5577.6 5613.0 5385.0 5404.1 5408.9 5412.6 5418.0 4396.3 4775.5 5350.5 5369.4 5380.0 4954.4 5259.4 5305.6 5316.5 5323.7 4735.9 5086.9 5290.7 5296.3 5404.4 5183.6 5277.6 5315.7 5330.8 5425.9 04:56:05 INFO - PROCESS | 1658 | 04:56:05 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24559.66 Median:3630.68 stddev:39699.38 (1093.4%) stddev-sans-first:39770.30 04:56:05 INFO - PROCESS | 1658 | Values: 692.7 721.8 728.6 733.1 773.2 15316.5 15779.1 15883.1 15885.4 15953.3 14147.9 14239.8 14257.2 14276.8 14725.3 683.3 702.2 707.7 850.6 884.7 853.6 876.1 881.1 888.4 889.9 926.5 929.3 930.7 931.0 936.2 720.4 924.7 926.6 927.3 928.8 555.5 666.6 684.5 686.9 693.4 15240.6 15287.2 15292.2 15300.9 15337.1 13709.8 13859.0 14157.5 14276.3 14419.3 10151.9 12326.6 12544.4 12689.4 12720.3 4503.9 4524.2 4532.6 4713.4 4716.2 105367.5 107897.5 116455.3 117544.4 118809.0 11028.8 11073.6 11198.9 11409.5 11441.8 22333.8 22340.0 22343.0 22359.3 22362.9 7752.8 7952.5 7956.6 8006.6 8014.9 3720.9 4026.0 4214.2 4240.9 4401.6 3522.9 3591.8 3627.4 3633.9 3642.6 574.8 676.3 677.4 678.2 682.0 572.5 607.5 615.5 664.6 686.5 9541.2 9598.9 9687.3 9702.9 9811.7 595.9 634.6 672.0 684.3 696.4 4213.5 4403.9 4524.4 5144.9 5205.4 155775.0 157708.0 161337.0 162404.0 166489.0 95199.5 114856.0 114986.3 132575.3 142510.0 112319.4 112425.4 113783.0 115687.4 117949.4 9235.7 9716.3 9885.5 9897.4 9900.9 56789.6 60011.7 63455.0 64490.0 65445.3 60015.4 62840.4 63442.0 65275.0 85986.2 11289.6 13396.5 13452.9 13579.5 13732.9 12704.4 14843.4 14976.3 15369.9 15429.5 10155.5 12982.4 13568.7 13938.9 13967.9 13554.4 13660.2 13711.8 13769.1 14024.6 13350.3 13448.8 13488.7 13619.4 13698.5 10459.8 11149.9 11396.0 11474.8 11521.9 9264.8 10204.5 11292.9 11488.4 11553.8 04:56:05 INFO - PROCESS | 1658 | -------- Summary: end -------- 04:56:05 INFO - PROCESS | 1658 | 04:56:06 INFO - TEST-INFO | 1658: exit 0 04:56:06 INFO - TEST-OK | dromaeo_css | took 1118475ms 04:56:06 INFO - TEST-START | kraken 04:56:06 INFO - operating with platform_type : mac_ 04:56:06 INFO - Initialising browser for kraken test... 04:56:06 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpCjEkab/profile http://localhost:49273/getInfo.html) 04:56:09 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 04:56:09 INFO - PROCESS | 1667 | colorDepth:24 04:56:09 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 04:56:09 INFO - PROCESS | 1667 | __metrics 04:56:09 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:09 INFO - PROCESS | 1667 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:09 INFO - TEST-INFO | 1667: exit 0 04:56:09 INFO - Browser initialized. 04:56:09 INFO - Running cycle 1/1 for kraken test... 04:56:09 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpCjEkab/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:21 INFO - PROCESS | 1668 | RSS: Main: 234946560 04:56:21 INFO - PROCESS | 1668 | 04:56:24 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:25 INFO - PROCESS | 1668 | RSS: Main: 293453824 04:56:25 INFO - PROCESS | 1668 | 04:56:28 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 04:56:28 INFO - PROCESS | 1668 | RSS: Main: 293543936 04:56:28 INFO - PROCESS | 1668 | 04:56:32 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 04:56:32 INFO - PROCESS | 1668 | RSS: Main: 382566400 04:56:32 INFO - PROCESS | 1668 | 04:56:34 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 04:56:35 INFO - PROCESS | 1668 | RSS: Main: 285085696 04:56:35 INFO - PROCESS | 1668 | 04:56:37 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:38 INFO - PROCESS | 1668 | RSS: Main: 289357824 04:56:38 INFO - PROCESS | 1668 | 04:56:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:41 INFO - PROCESS | 1668 | RSS: Main: 327188480 04:56:41 INFO - PROCESS | 1668 | 04:56:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:45 INFO - PROCESS | 1668 | RSS: Main: 328949760 04:56:45 INFO - PROCESS | 1668 | 04:56:48 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 04:56:48 INFO - PROCESS | 1668 | RSS: Main: 327254016 04:56:48 INFO - PROCESS | 1668 | 04:56:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:50 INFO - PROCESS | 1668 | RSS: Main: 301891584 04:56:50 INFO - PROCESS | 1668 | 04:56:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:53 INFO - PROCESS | 1668 | RSS: Main: 307376128 04:56:53 INFO - PROCESS | 1668 | 04:56:55 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:56 INFO - PROCESS | 1668 | RSS: Main: 310988800 04:56:56 INFO - PROCESS | 1668 | 04:56:59 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:59 INFO - PROCESS | 1668 | RSS: Main: 320385024 04:56:59 INFO - PROCESS | 1668 | 04:57:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:03 INFO - PROCESS | 1668 | RSS: Main: 320262144 04:57:03 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 04:57:05 INFO - PROCESS | 1668 | RSS: Main: 364621824 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | __start_tp_report 04:57:05 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 04:57:05 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 04:57:05 INFO - PROCESS | 1668 | |i|pagename|runs| 04:57:05 INFO - PROCESS | 1668 | |0;ai-astar;112;114;113;112;114;113;113;113;113;113 04:57:05 INFO - PROCESS | 1668 | |1;audio-beat-detection;150;112;112;150;113;115;107;111;144;112 04:57:05 INFO - PROCESS | 1668 | |2;audio-dft;182;182;184;184;184;184;182;179;187;185 04:57:05 INFO - PROCESS | 1668 | |3;audio-fft;79;58;59;87;77;85;81;60;83;58 04:57:05 INFO - PROCESS | 1668 | |4;audio-oscillator;89;72;91;71;68;69;91;67;68;90 04:57:05 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;87;85;87;84;86;83;87;84;88;122 04:57:05 INFO - PROCESS | 1668 | |6;imaging-darkroom;144;162;96;96;96;108;160;96;95;96 04:57:05 INFO - PROCESS | 1668 | |7;imaging-desaturate;83;86;84;87;84;83;86;102;133;131 04:57:05 INFO - PROCESS | 1668 | |8;json-parse-financial;56;54;55;52;53;55;52;53;55;54 04:57:05 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;65;82;75;72;71;67;68;70;68;69 04:57:05 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;86;91;89;86;86;88;85;85;84;84 04:57:05 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;146;146;148;153;150;178;159;148;172;145 04:57:05 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;173;171;176;174;173;172;172;175;171;171 04:57:05 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;69;70;68;67;69;72;69;69;67;69 04:57:05 INFO - PROCESS | 1668 | __end_tp_report 04:57:05 INFO - PROCESS | 1668 | __start_cc_report 04:57:05 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1955 04:57:05 INFO - PROCESS | 1668 | __end_cc_report 04:57:05 INFO - PROCESS | 1668 | __startTimestamp1476187025344__endTimestamp 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | ------- Summary: start ------- 04:57:05 INFO - PROCESS | 1668 | Number of tests: 14 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 04:57:05 INFO - PROCESS | 1668 | Values: 112.0 114.0 113.0 112.0 114.0 113.0 113.0 113.0 113.0 113.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:114.00 stddev:17.72 (15.5%) stddev-sans-first:15.77 04:57:05 INFO - PROCESS | 1668 | Values: 150.0 112.0 112.0 150.0 113.0 115.0 107.0 111.0 144.0 112.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.16 (1.2%) stddev-sans-first:2.24 04:57:05 INFO - PROCESS | 1668 | Values: 182.0 182.0 184.0 184.0 184.0 184.0 182.0 179.0 187.0 185.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:72.70 Median:80.00 stddev:12.34 (15.4%) stddev-sans-first:12.87 04:57:05 INFO - PROCESS | 1668 | Values: 79.0 58.0 59.0 87.0 77.0 85.0 81.0 60.0 83.0 58.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:80.50 stddev:11.00 (13.7%) stddev-sans-first:10.86 04:57:05 INFO - PROCESS | 1668 | Values: 89.0 72.0 91.0 71.0 68.0 69.0 91.0 67.0 68.0 90.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:86.50 stddev:11.61 (13.4%) stddev-sans-first:12.28 04:57:05 INFO - PROCESS | 1668 | Values: 87.0 85.0 87.0 84.0 86.0 83.0 87.0 84.0 88.0 122.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:114.90 Median:96.00 stddev:28.54 (29.7%) stddev-sans-first:28.26 04:57:05 INFO - PROCESS | 1668 | Values: 144.0 162.0 96.0 96.0 96.0 108.0 160.0 96.0 95.0 96.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:84.00 stddev:19.82 (23.6%) stddev-sans-first:20.47 04:57:05 INFO - PROCESS | 1668 | Values: 83.0 86.0 84.0 87.0 84.0 83.0 86.0 102.0 133.0 131.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.50 stddev:1.37 (2.5%) stddev-sans-first:1.22 04:57:05 INFO - PROCESS | 1668 | Values: 56.0 54.0 55.0 52.0 53.0 55.0 52.0 53.0 55.0 54.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:70.50 stddev:4.85 (6.9%) stddev-sans-first:4.69 04:57:05 INFO - PROCESS | 1668 | Values: 65.0 82.0 75.0 72.0 71.0 67.0 68.0 70.0 68.0 69.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:86.00 stddev:2.27 (2.6%) stddev-sans-first:2.40 04:57:05 INFO - PROCESS | 1668 | Values: 86.0 91.0 89.0 86.0 86.0 88.0 85.0 85.0 84.0 84.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:154.50 Median:151.50 stddev:11.65 (7.7%) stddev-sans-first:11.94 04:57:05 INFO - PROCESS | 1668 | Values: 146.0 146.0 148.0 153.0 150.0 178.0 159.0 148.0 172.0 145.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.00 stddev:1.75 (1.0%) stddev-sans-first:1.86 04:57:05 INFO - PROCESS | 1668 | Values: 173.0 171.0 176.0 174.0 173.0 172.0 172.0 175.0 171.0 171.0 04:57:05 INFO - PROCESS | 1668 | 04:57:05 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.54 04:57:05 INFO - PROCESS | 1668 | Values: 69.0 70.0 68.0 67.0 69.0 72.0 69.0 69.0 67.0 69.0 04:57:05 INFO - PROCESS | 1668 | -------- Summary: end -------- 04:57:05 INFO - PROCESS | 1668 | 04:57:06 INFO - TEST-INFO | 1668: exit 0 04:57:06 INFO - TEST-OK | kraken | took 59589ms 04:57:06 INFO - SUITE-END | took 1178s 04:57:06 INFO - Completed test suite (00:19:38) 04:57:06 INFO - javascript benchmark 04:57:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2919.3577412969153, 3171.7938334008286, 3352.296017836254, 3353.312570922961, 3409.09658940381, 5629.268195134637, 5670.63140895842, 5747.971260143693, 5785.56608254381, 5810.7094645267725, 5697.259356283677, 5735.369109397963, 5771.451712087355, 5817.127430885369, 5923.05231163014, 5155.9484405155845, 5222.503862133091, 5241.842744717665, 5252.658577192489, 5254.106801843695, 5331.120365139747, 5341.252224688546, 5344.839654810343, 5371.328583927009, 5420.864478388033, 4491.977540112295, 5312.415634280226, 5330.067238233332, 5350.491703288181, 5430.647007944491, 4576.672764898176, 5062.873428164288, 5169.586433085344, 5188.5849132069725, 5219.9299143675835, 5160.974195129038, 5175.146100893348, 5179.533841954205, 5202.4277329493725, 5287.68273903567, 5784.68184249866, 5809.390014048507, 5823.184754134425, 5826.300843898717, 5837.970810145965, 6101.420365065356, 6129.297663865974, 6157.784477543264, 6206.968965155191, 6283.497320214372, 6174.5060395168275, 6295.905561416583, 6303.180586523768, 6304.936950630481, 6311.652859092748, 5863.618864773776, 5867.295924489089, 5878.647281163058, 5894.056950887923, 5942.168096466498, 5038.622103342264, 6195.938040619626, 6208.286047104641, 6217.440430361289, 6261.78083767066, 6138.877222455615, 6172.135900973867, 6183.598066125687, 6189.102580125947, 6201.317855035943, 6228.159198508234, 6274.9686251569365, 6293.842653933597, 6299.5275354348605, 6303.46420554258, 6033.4871535919065, 6096.798833414392, 6190.442860142609, 6239.724144824004, 6257.342978987141, 6164.969175154185, 6172.845678857974, 6234.407731265614, 6245.437910588069, 6288.591241569284, 4936.802527898915, 4950.70295782247, 4950.950490495121, 4963.528464795839, 4987.675801072919, 4451.710638808532, 4461.776911154429, 4469.664775141878, 4491.663125265618, 4532.161550113239, 5635.971820140873, 5680.488756011979, 5684.175794509773, 5770.105633626795, 5793.565482588822, 5307.681539107666, 6175.722092505848, 6219.813405597839, 6245.875082498415, 6305.054241863757, 4608.792604332813, 5856.1508581255475, 5860.355360910296, 5888.322842873039, 5892.0, 5423.538999185034, 5439.456054394529, 5450.700211488406, 5453.15476101205, 5465.59008074396, 6220.409061139185, 6232.158658581034, 6278.4035516625845, 6295.685215739103, 6312.895243332398, 6278.4035516625845, 6286.937130628635, 6291.716872740829, 6307.653079080511, 6310.337414571588, 6279.246490421178, 6312.715927783169, 6317.273513545817, 6319.6840157991, 6327.145835312358, 6075.969620151871, 6130.386961303834, 6144.477719393902, 6270.372962703693, 6272.686365681789, 6175.166352542529, 6260.874782504234, 6288.056791481315, 6302.401271879165, 6323.652199129092, 5942.71375298121, 6183.258009038944, 6194.0, 6194.5973511721595, 6209.720562574605, 6106.755729770937, 6147.600405973598, 6153.661548614869, 6182.752689892354, 6240.719167637558, 5857.941420585739, 5934.495567876606, 5953.880922381441, 6022.638641681513, 6042.546808989431, 6069.150318955438, 6101.307919489844, 6110.0424004731585, 6126.264848218242, 6142.969285153546, 5994.520438364833, 6046.486048685911, 6077.665728384981, 6099.84750381244, 6112.419320164755], "value": 5707.83745178937, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.71956125228, 520.3495630461922, 534.4094775273323, 539.5225225675276, 555.0065382964497, 30411.0, 31756.36487270256, 31786.36427271456, 31814.522782158285, 39504.40743388851, 39590.8020459898, 41787.0, 41995.580044199545, 42021.789891050576, 42080.36879446811, 8828.07305232951, 9495.52522373882, 9628.711138665834, 9816.656417025406, 9832.213422926148, 8768.430052046597, 8993.235574976103, 9674.22606191503, 9796.167325777318, 9796.971318011612, 11833.230839995416, 12152.939235303811, 12177.391130443486, 12295.938520307385, 12340.382980850967, 11985.820212696817, 12042.63872083839, 12044.39778011096, 12049.698757531045, 12058.397080145958, 8653.783655408602, 8906.51014194219, 11854.466549005316, 11957.342346170957, 11962.641120766391, 31866.840665796524, 32207.51688724671, 32212.35575288481, 38416.80791596052, 39137.0, 3303.9008829734908, 3412.658734126592, 3462.9653703462895, 3544.1848374873666, 3773.7735735855663, 30201.942931997495, 30798.110814885884, 31038.534421983688, 31060.534091988637, 31116.0, 3128.1710346758127, 3274.214188594744, 3302.4716045432615, 3335.8665653373837, 3346.765726399153, 470787.0, 472203.0, 472383.99999999657, 473539.0, 477892.0, 55228.17157742637, 55531.444685552626, 55571.72214138904, 55596.722016389656, 55632.0, 58507.0, 58546.0, 58599.121013184835, 58645.413545864845, 58648.0, 13572.728545429036, 15563.53309400697, 15868.682626347409, 15897.205139743199, 15900.0, 12282.447289871978, 12361.62915112548, 12366.814497782361, 12379.75240495185, 12379.814302785466, 11858.347790871412, 13269.611469935504, 13568.728625427437, 13590.252536110609, 15015.324310406058, 5390.811321603725, 5857.326407463111, 6165.753369865245, 6959.512834101665, 7042.859142817115, 864.6714248585623, 918.3066784577601, 935.4714586258879, 980.6224603527551, 1029.912457441126, 27727.0, 27770.444591108066, 29452.852735736185, 29542.0, 29602.555961660593, 1028.840529717895, 1036.326387847905, 1084.2356138922041, 1111.6887271563976, 1138.5673444091192, 13372.0, 14988.302105620874, 15111.622209444631, 15523.1462269574, 15527.223638818014, 615071.0, 616813.0, 616964.0, 617335.0, 619722.0, 48762.02475950532, 55892.44107558872, 56344.71827640918, 56346.0, 56438.43561564414, 1211.5638370186725, 1245.371087600774, 1274.1654216488214, 1345.603047101088, 1346.596021193638, 29857.402851943272, 30560.235994100327, 30585.0, 30859.537106942964, 31365.372692545567, 46527.53472465232, 47102.76448617735, 47237.0, 47264.2910356338, 47286.76356618195, 518954.0, 523758.76241238625, 523840.0, 523865.0, 619917.0, 24275.514489710462, 25040.61951636506, 25140.497190055732, 25148.74851251464, 25173.24480265595, 44303.778481108675, 44345.77827110844, 44792.55207447884, 44878.77560612176, 45744.54255457403, 37045.0, 37415.81292093522, 37437.06407339838, 37959.81020094992, 38322.0, 36608.45087323745, 37019.25961480809, 37706.43440348342, 37719.622803771614, 37980.0, 36013.0, 36257.093572660895, 36403.0, 36498.45252321164, 36769.89690309295, 29456.11631651054, 31604.36791264116, 32720.0, 32879.0, 32951.58589317385, 19399.2240310386, 24481.38796530101, 24539.503273200025, 24661.63007554924, 24904.252872413857], "value": 19321.97096364159, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.93932274222414, 311.5218140154862, 362.5088005752205, 364.6881915961851, 398.0625626649241, 15402.537923862274, 15421.691566168683, 16106.91946540267, 21323.68014479784, 21349.0, 18044.0, 21980.560388792215, 22165.66751498729, 22181.0, 22259.554808903813, 5428.565714742831, 6003.459688628033, 6213.2233470816145, 6307.180066591337, 6318.304986451487, 4274.487061552618, 4352.36890650857, 4498.910021799562, 6959.8956015659805, 7067.151941766995, 6671.332866713314, 6978.79063628092, 6997.230304666483, 7002.124734408199, 7003.3346832050875, 6174.660393678346, 6575.506836987245, 6906.585604863674, 6955.652217389161, 6991.89512157318, 5678.801241956512, 5877.412258774131, 5981.491573216238, 6025.879482410327, 6031.0, 26137.0, 26850.657467126763, 26871.32821679454, 26910.865445672647, 27148.728512715013, 2337.2871274261342, 2393.833580609551, 2423.8182136339847, 2444.1445494077107, 2504.799616030713, 14802.40790368384, 15557.611059723484, 15714.842851571566, 15965.92017039919, 16550.6689866202, 1510.765831296151, 1599.872010239178, 1791.5073354827396, 1905.7617797775279, 1938.621968716101, 107000.0, 116025.0, 116072.17834649656, 116458.83541164649, 117789.0, 9279.0, 10932.453377331101, 11209.383483908301, 11317.83023254652, 11517.424128793527, 14082.929585352213, 14127.64680882986, 14147.858521414653, 14161.504347347793, 14170.645733856736, 8506.234438900528, 8675.828763117024, 8693.608787604573, 8762.86855697165, 8836.248918841842, 8448.957755211184, 8641.870371944426, 8667.479951202948, 8692.087330830298, 8893.24407425376, 6684.398404143553, 6808.353206445379, 6824.727010919607, 6829.623578392056, 6894.793156205322, 1851.231738828398, 1851.6944704123669, 1860.6371757507427, 1862.5157459060472, 1902.7050807124917, 814.3973459639942, 896.7354630384052, 931.2270815223349, 1038.133158812385, 1061.570064124031, 20608.880709186917, 21767.40135192637, 22329.330120096423, 22537.549249015257, 22704.31887043391, 937.8452555328431, 957.30595318395, 968.404431274775, 971.621067783565, 1031.242037102729, 8987.247486740023, 10271.691849244535, 10773.569057237779, 11882.584109556125, 12009.579664711693, 549016.0, 590101.0, 598387.0, 622077.0, 624116.0, 81123.0, 89087.0, 106123.10167856913, 109236.0, 112364.43817780858, 970.9514524273758, 996.4718699089639, 1021.4688362051692, 1035.8239099353127, 1037.6886933919793, 19677.896614078767, 20257.69613455829, 20988.58022839565, 21009.57980840344, 21292.574148516633, 37569.0, 54049.0, 55148.72425637846, 55161.277421161874, 55417.783288668004, 73411.63294183495, 74662.04055513373, 75038.0, 75862.86205706808, 76251.61874190594, 6326.272478665012, 7542.170361260147, 7958.960205198937, 8167.346612270885, 8201.589920503831, 12183.451744671334, 12513.0, 13299.867001329863, 13887.930560347133, 13901.86098139046, 9842.0, 10085.394876307446, 11176.776464470502, 11542.19204655666, 11834.940825295818, 9727.221822254343, 10761.784764304513, 11463.942680286546, 11718.062554995751, 11913.761724765629, 10596.364218146937, 11659.708507287385, 11805.703790116682, 11994.880051199376, 12021.098417618889, 6880.0, 7873.803154921173, 7895.881561776693, 7975.960120199362, 8320.420669592446, 9347.672831450867, 11324.773504530029, 11480.138989575982, 11486.65540033767, 11566.363849988331], "value": 9787.528165599018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.2433783108443, 1535.2860919672353, 1749.5101371615945, 1916.9616607667838, 1934.361660651985, 8551.273141782947, 9025.954870225656, 9036.548172591369, 9051.502167380791, 9053.909460905397, 7738.883916741239, 8102.756917292476, 8119.3910456715685, 8499.0, 8794.648214071429, 2335.2060299498166, 2369.7037870266217, 2378.048780487801, 2380.2859142257253, 2385.224801939368, 2330.93007209784, 2348.6477028445697, 2377.6076947303673, 2380.27401642499, 2382.8570285782907, 2349.259983105325, 2371.3004663624274, 2375.4417711837705, 2379.3456799380137, 2386.844855084414, 2341.6253399456004, 2345.0887526665797, 2356.705411823522, 2357.0571771291447, 2358.044991778324, 2343.0510643189536, 2350.4358953851124, 2351.9176828811082, 2354.6350315701093, 2355.470019245673, 8843.380963332569, 8866.468011919242, 8958.23854972328, 8960.417572857743, 8968.686095986674, 4630.976845115787, 5197.324347834795, 5368.32895888014, 5380.139177731583, 5380.946190538123, 3416.931661366759, 3511.5953618552526, 3631.691306238973, 3633.4368172933237, 3639.7998110103936, 1007.8437842134408, 1074.8172810622134, 1077.9299345542515, 1081.0918828184285, 1100.2078503477483, 11619.244749091282, 11691.649250522498, 11706.473208705544, 11714.88285117155, 11717.238379505305, 4444.711093778894, 4612.677112602153, 4657.790399432034, 4801.879953001133, 4803.78382972767, 9954.800903981879, 9965.302428829913, 9977.0, 9978.251631127694, 9987.550560224807, 5220.738963051832, 5232.869178270574, 5234.476552344811, 5235.0, 5240.292560504359, 4372.912541749147, 4404.229259879572, 4770.212914869007, 4802.447718512416, 4854.101991131652, 3869.6517313441927, 3883.5533913600298, 3953.8616148434667, 3998.9400158997637, 4008.2785098682516, 1254.3101294288288, 1264.879836415539, 1266.6263452281598, 1274.337344580813, 1285.4022879361141, 783.2989474420476, 889.2441424788877, 913.0, 921.6819947475175, 939.9624015039459, 5601.831945041656, 5715.142728590745, 5955.196048533393, 5971.4327138921735, 6073.691997041096, 950.933434659581, 953.1183655118987, 953.7710949372239, 955.9091886270793, 995.9701208963743, 3966.1076257842333, 4043.4945631796027, 4091.0, 4249.617534421855, 4254.7659878706345, 10761.408122553335, 10774.407407592658, 10902.236843421044, 10906.236563440483, 10912.399818010086, 10706.518206680717, 10718.946405267923, 10861.511231994578, 10869.021788038955, 10873.83689244662, 6940.7917762467205, 7999.9600001999615, 8147.67409303633, 8158.0, 8289.129641387688, 5947.881042379215, 5962.940370596412, 6066.090086487062, 6069.36271691466, 6157.107219453064, 10036.197104231498, 10152.086312231935, 10187.592496300362, 10199.643012494527, 10208.489575521045, 9911.959244279247, 9946.055124763136, 10212.0, 10301.072903438726, 10407.375557466576, 6968.547044442095, 7230.963845180951, 7243.45674074436, 7443.516171448839, 7684.923150768421, 8198.262156405952, 8502.44734092282, 8514.701985430727, 8613.22480976715, 8614.44006139599, 7429.257074292527, 7554.433417493819, 7615.4669173157345, 7653.272939070779, 7718.961405193163, 7506.24937506245, 7535.886961695469, 7645.0, 7698.615069246403, 7729.9227007729205, 6906.482013848881, 7056.435485161277, 7072.823179420556, 7073.434125270069, 7078.079849619517, 5022.372203474566, 5163.535281824504, 5209.140491818959, 5277.577793776565, 5454.918176227439, 5310.442403547572, 5403.8108666196495, 5431.646942948696, 5484.670919744828, 5512.641678290898], "value": 4633.611433420605, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.0864591381502, 302.401245533843, 303.19350527596595, 305.15319987035974, 313.72078849823646, 4297.806598703058, 4676.368690226818, 5086.211637196231, 5161.587073034158, 5227.581793456524, 4537.009289781239, 4926.482719314474, 5076.822311219108, 5164.0, 5191.482131166381, 3757.43638454232, 3866.2074274773745, 3927.882163535084, 3932.3315036443732, 4023.7384570002855, 3529.505869178317, 3964.306246406867, 3978.5424676162324, 3983.2830090583684, 4026.5570787213383, 3932.960670393288, 3974.9602503975025, 3983.940240896389, 4007.2786898358286, 4030.758154510724, 3323.4047657124715, 3567.8751243706347, 3722.7952462614544, 3952.6837852971835, 3987.73006134968, 2911.8107323023937, 3457.757956943015, 3466.838609065966, 3494.353544594258, 3508.6842184203542, 3763.379042457991, 4815.66290359675, 5026.698398096126, 5038.874028149289, 5053.538326246497, 3664.701768408427, 4539.341795439643, 4546.818127274905, 4560.065186636732, 4576.748278844662, 5102.902875881703, 5358.892822143574, 5385.67685938841, 5386.78452861885, 5481.616286859921, 3181.5545823584716, 3707.1658876752786, 3734.9915522808687, 3735.7945313008045, 3769.2838360711376, 4801.8079276828885, 5117.616178786643, 5139.177731563007, 5462.672239665632, 5716.770894257713, 3453.87911423104, 3590.2998915211283, 3775.962240377616, 3778.508793856836, 3801.790901500444, 3829.9042523937123, 3834.1564855731694, 3834.884953451401, 3837.827297771607, 3843.26977874203, 3816.923661526754, 3889.6775096467336, 4482.955170448254, 4492.281235002384, 4502.5047244803045, 4226.4716910386205, 4988.401391833003, 5451.7733509960735, 5529.695866727288, 5534.4742249486235, 1203.48851738011, 1232.9150347693972, 1282.8845403913692, 1308.8036794480904, 1311.996322813049, 672.8250654829682, 690.7221639966023, 751.4476859508258, 790.2611058660171, 804.4650307545534, 4164.875053748332, 4242.957570424256, 4935.407751069823, 4972.701637901738, 4976.925346119811, 5551.611387202857, 5553.416891226444, 5585.245991791056, 5600.663960162403, 5613.259889434288, 4862.0, 4880.901212478669, 4979.377577802775, 5058.962912602908, 5081.542661160439, 2391.656176946602, 2903.5209190483756, 2917.9416411671646, 2924.2543151496657, 2934.1784300395925, 4806.8798280043275, 5081.5426611605135, 5707.74315155819, 5711.857203569944, 5761.839310258653, 5268.315119034501, 5670.971645141831, 5676.9911946668335, 5713.914291285634, 5719.914201286901, 5714.114312281603, 5735.741891614887, 5743.942560574341, 5758.395368486333, 5798.275215598134, 4398.890027749204, 5504.091824849015, 5540.63985840919, 5553.8333849984565, 5564.91652625219, 4707.904982282851, 5084.872878178076, 5249.028929648028, 5471.2613797138465, 5511.448855114457, 4684.578387945101, 5694.800681976111, 5696.379665353984, 5735.48009777401, 5739.167820666064, 3145.465270903906, 3562.9133114400356, 3731.645493678096, 3738.925221495609, 3748.7001039917286, 4546.4544254689645, 5328.7602057906715, 5576.302962129734, 5577.629507459233, 5612.971935140298, 5384.973075134756, 5404.135338345845, 5408.891177308721, 5412.621116521806, 5418.0, 4396.296592545177, 4775.450823155382, 5350.545203657733, 5369.436209197978, 5380.031594312904, 4954.355933728592, 5259.4477579853565, 5305.575553955597, 5316.494932981361, 5323.653962492425, 4735.881602959954, 5086.872828179177, 5290.677330667333, 5296.311479507639, 5404.43253458397, 5183.5745170077025, 5277.575054735276, 5315.681059136464, 5330.840074797762, 5425.864353391039], "value": 3929.5759219982624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.7332976803931, 721.8303698630821, 728.6283995162469, 733.1056111543915, 773.1533970302517, 15316.46392376267, 15779.13214773187, 15883.126428046467, 15885.444009459643, 15953.282102305395, 14147.929260353709, 14239.78640320396, 14257.2158531281, 14276.785848212285, 14725.337359818806, 683.3474032299142, 702.192478649552, 707.6673963237271, 850.587465079436, 884.6859364925456, 853.63293783673, 876.1457578860592, 881.1012766977678, 888.4269646078276, 889.9332550058739, 926.5321012888481, 929.2658799548349, 930.7347405989294, 930.962761489543, 936.18551859882, 720.3912693773752, 924.6717415317567, 926.578406824893, 927.285989787863, 928.767808047988, 555.4889501658483, 666.5733930284622, 684.5345165287603, 686.9072675188836, 693.3517161454057, 15240.618984525365, 15287.159206243652, 15292.235388230543, 15300.923495382453, 15337.079775213522, 13709.794353084711, 13859.045338919586, 14157.504487342894, 14276.286185690778, 14419.339767994325, 10151.898481015169, 12326.568570100093, 12544.435500402504, 12689.365531723377, 12720.300383478905, 4503.909921801578, 4524.16302983949, 4532.592066714012, 4713.363695901044, 4716.221823399135, 105367.47316263446, 107897.46051269773, 116455.2531712025, 117544.41227793891, 118809.0, 11028.779424411467, 11073.557057717762, 11198.944005279922, 11409.543618255342, 11441.771164576661, 22333.77666223317, 22340.0, 22343.0, 22359.32922012342, 22362.888185558968, 7752.806179845549, 7952.522848628985, 7956.641951112214, 8006.559639219899, 8014.879776803353, 3720.9441858372147, 4026.037364015461, 4214.220369231641, 4240.936385954213, 4401.581849724271, 3522.876699315512, 3591.7665351752053, 3627.4196128619296, 3633.94549081764, 3642.5993140754495, 574.8419184724235, 676.2696288008939, 677.4106527321163, 678.1895634716565, 682.0349205873732, 572.4904834697123, 607.4714997951722, 615.5321955313993, 664.6142792278155, 686.4725984684038, 9541.2367010639, 9598.856017159747, 9687.2734544908, 9702.854457183148, 9811.656592019244, 595.8986972214734, 634.5875181132301, 671.9832004199836, 684.2746688510196, 696.380221602774, 4213.494380674278, 4403.889902752393, 4524.434445694288, 5144.922826157611, 5205.375354957429, 155775.0, 157708.0, 161337.0, 162404.0, 166489.0, 95199.52400237955, 114856.0, 114986.27520587198, 132575.33712331377, 142510.0, 112319.43840280746, 112425.38469998848, 113783.0, 115687.42156289333, 117949.4102529499, 9235.722928312161, 9716.3198576099, 9885.456299903575, 9897.35667181631, 9900.900990989998, 56789.58026049382, 60011.69994150001, 63455.048174278345, 64490.0, 65445.345546543926, 60015.39984600098, 62840.37159628528, 63442.0, 65275.0, 85986.2422012475, 11289.604863829727, 13396.531121410704, 13452.93273533626, 13579.499195774042, 13732.918145936985, 12704.36478176106, 14843.40626374933, 14976.251187440366, 15369.923150384177, 15429.480905918415, 10155.54300056514, 12982.35088245565, 13568.728625427239, 13938.93030534841, 13967.860321397062, 13554.390052447861, 13660.180389176681, 13711.794323085362, 13769.105008174436, 14024.649383765487, 13350.265735384648, 13448.798268026183, 13488.662783430493, 13619.38712757948, 13698.52055178064, 10459.84310235332, 11149.888501115209, 11396.0, 11474.827877582009, 11521.884781152416, 9264.814703706023, 10204.489775511343, 11292.887071129184, 11488.368139752394, 11553.768924621629], "value": 7830.32295411026, "unit": "score"}], "name": "dromaeo_css", "value": 7320.621452926502, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 113.0, 112.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 112.0, 112.0, 150.0, 113.0, 115.0, 107.0, 111.0, 144.0, 112.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 184.0, 184.0, 184.0, 184.0, 182.0, 179.0, 187.0, 185.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 58.0, 59.0, 87.0, 77.0, 85.0, 81.0, 60.0, 83.0, 58.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 72.0, 91.0, 71.0, 68.0, 69.0, 91.0, 67.0, 68.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 86.0, 83.0, 87.0, 84.0, 88.0, 122.0], "value": 89.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 162.0, 96.0, 96.0, 96.0, 108.0, 160.0, 96.0, 95.0, 96.0], "value": 114.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 87.0, 84.0, 83.0, 86.0, 102.0, 133.0, 131.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 55.0, 52.0, 53.0, 55.0, 52.0, 53.0, 55.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 82.0, 75.0, 72.0, 71.0, 67.0, 68.0, 70.0, 68.0, 69.0], "value": 70.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 91.0, 89.0, 86.0, 86.0, 88.0, 85.0, 85.0, 84.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 148.0, 153.0, 150.0, 178.0, 159.0, 148.0, 172.0, 145.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 176.0, 174.0, 173.0, 172.0, 172.0, 175.0, 171.0, 171.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 67.0, 69.0, 72.0, 69.0, 69.0, 67.0, 69.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1476.5, "alertThreshold": 2.0}]} 04:57:06 INFO - Return code: 0 04:57:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:06 INFO - # TBPL SUCCESS # 04:57:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:06 INFO - 2016-10-11 04:57:06.686 screenresolution[1672:9730] starting screenresolution argv=screenresolution get 04:57:06 INFO - 2016-10-11 04:57:06.689 screenresolution[1672:9730] Display 0: 1600x1200x32@60 04:57:06 INFO - 2016-10-11 04:57:06.695 screenresolution[1673:9733] starting screenresolution argv=screenresolution list 04:57:06 INFO - Available Modes on Display 0 04:57:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:06 INFO - Intel Iris: 04:57:06 INFO - Chipset Model: Intel Iris 04:57:06 INFO - Type: GPU 04:57:06 INFO - Bus: Built-In 04:57:06 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:06 INFO - Vendor: Intel (0x8086) 04:57:06 INFO - Device ID: 0x0a2e 04:57:06 INFO - Revision ID: 0x0009 04:57:06 INFO - Displays: 04:57:06 INFO - Display: 04:57:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:06 INFO - Display Serial Number: 1600x1200 60 04:57:06 INFO - Main Display: Yes 04:57:06 INFO - Mirror: Off 04:57:06 INFO - Online: Yes 04:57:06 INFO - Rotation: Supported 04:57:06 INFO - Return code: 0 04:57:06 INFO - Running post-action listener: _resource_record_post_action 04:57:06 INFO - [mozharness: 2016-10-11 11:57:06.928007Z] Finished run-tests step (success) 04:57:06 INFO - Running post-run listener: _resource_record_post_run 04:57:06 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 38499328; Write bytes: 705018880; Read time: 377; Write time: 2060 04:57:06 INFO - TinderboxPrint: CPU usage
53.8% 04:57:06 INFO - TinderboxPrint: I/O read bytes / time
38,499,328 / 377 04:57:06 INFO - TinderboxPrint: I/O write bytes / time
705,018,880 / 2,060 04:57:06 INFO - TinderboxPrint: CPU idle
2,240.9 (46.2%) 04:57:06 INFO - TinderboxPrint: CPU system
979.6 (20.2%) 04:57:06 INFO - TinderboxPrint: CPU user
1,633.2 (33.6%) 04:57:06 INFO - TinderboxPrint: Swap in / out
446,066,688 / 0 04:57:06 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 404206080; Write bytes: 397919744; Read time: 29816; Write time: 763 04:57:07 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34501632; Write bytes: 293955072; Read time: 345; Write time: 1254 04:57:07 INFO - Running post-run listener: _upload_blobber_files 04:57:07 INFO - Blob upload gear active. 04:57:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:07 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:08 INFO - (blobuploader) - INFO - Done attempting. 04:57:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:10 INFO - (blobuploader) - INFO - Done attempting. 04:57:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:13 INFO - (blobuploader) - INFO - Done attempting. 04:57:13 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:13 INFO - Return code: 0 04:57:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c29b6432f6238207ea15a36a63e28c3e2f55c4337e55398a008143293e9ecb46740f305ec4b775c6871d97dd9738d762178e7555afe34a0270ac03ea5f2c4860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e3f610acab676bc45c94f4b670667c3fed7d2ad7c5e2008187c0a57f90d5d334e2c4d711e84508371e4aea12bf580b920dc46734593b762fd29eea2de217346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e20a68b99e2da61a31a8136f21ed67d6686a1fc6d58da1ccf4ed0fc8a4dab9761f47dcd8cd74efb94a3d744d291c40a6d9caf53257c4d174951bef9ae591a327"} 04:57:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:13 INFO - Contents: 04:57:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c29b6432f6238207ea15a36a63e28c3e2f55c4337e55398a008143293e9ecb46740f305ec4b775c6871d97dd9738d762178e7555afe34a0270ac03ea5f2c4860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e3f610acab676bc45c94f4b670667c3fed7d2ad7c5e2008187c0a57f90d5d334e2c4d711e84508371e4aea12bf580b920dc46734593b762fd29eea2de217346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e20a68b99e2da61a31a8136f21ed67d6686a1fc6d58da1ccf4ed0fc8a4dab9761f47dcd8cd74efb94a3d744d291c40a6d9caf53257c4d174951bef9ae591a327"} 04:57:13 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:13 INFO - Copying logs to upload dir... 04:57:13 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.539320 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-11 04:57:13.966041) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 04:57:13.969554) ========= 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.g79tPufk83/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.hJB7IafYZo/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c29b6432f6238207ea15a36a63e28c3e2f55c4337e55398a008143293e9ecb46740f305ec4b775c6871d97dd9738d762178e7555afe34a0270ac03ea5f2c4860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e3f610acab676bc45c94f4b670667c3fed7d2ad7c5e2008187c0a57f90d5d334e2c4d711e84508371e4aea12bf580b920dc46734593b762fd29eea2de217346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e20a68b99e2da61a31a8136f21ed67d6686a1fc6d58da1ccf4ed0fc8a4dab9761f47dcd8cd74efb94a3d744d291c40a6d9caf53257c4d174951bef9ae591a327"} build_url:https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011167 build_url: 'https://queue.taskcluster.net/v1/task/cvoU90aiSdeTUZ62pfWu5Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c29b6432f6238207ea15a36a63e28c3e2f55c4337e55398a008143293e9ecb46740f305ec4b775c6871d97dd9738d762178e7555afe34a0270ac03ea5f2c4860", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/1e3f610acab676bc45c94f4b670667c3fed7d2ad7c5e2008187c0a57f90d5d334e2c4d711e84508371e4aea12bf580b920dc46734593b762fd29eea2de217346", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e20a68b99e2da61a31a8136f21ed67d6686a1fc6d58da1ccf4ed0fc8a4dab9761f47dcd8cd74efb94a3d744d291c40a6d9caf53257c4d174951bef9ae591a327"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 04:57:14.008193) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:57:14.008696) ========= 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.g79tPufk83/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.hJB7IafYZo/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005102 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 04:57:14.057694) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 04:57:14.058014) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 04:57:14.058325) ========= ========= Total master_lag: 0.18 =========