builder: graphics_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0203 starttime: 1479985320.55 results: success (0) buildid: 20161124005437 builduid: bd1f4b48aae9460882ea45523133f0c7 revision: 957b5d8ef568b79e31e8324455a4825766c4e497 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:00.553719) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:00.554783) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:00.555169) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:00.606667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:00.606939) ========= 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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-11-24 03:02:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.3M=0.001s 2016-11-24 03:02:01 (21.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.610523 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:01.245038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:01.245363) ========= 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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.024124 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:01.294162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 03:02:01.294511) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 957b5d8ef568b79e31e8324455a4825766c4e497 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 957b5d8ef568b79e31e8324455a4825766c4e497 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BZx7j1qbxl/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.HeNMNOjfWB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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-11-24 03:02:01,394 truncating revision to first 12 chars 2016-11-24 03:02:01,394 Setting DEBUG logging. 2016-11-24 03:02:01,394 attempt 1/10 2016-11-24 03:02:01,394 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/957b5d8ef568?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-24 03:02:03,120 unpacking tar archive at: graphics-957b5d8ef568/testing/mozharness/ program finished with exit code 0 elapsedTime=2.010409 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-24 03:02:03.328450) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:03.328931) ========= script_repo_revision: 957b5d8ef568b79e31e8324455a4825766c4e497 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:03.329443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:03.329826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-24 03:02:03.350037) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-24 03:02:03.350489) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BZx7j1qbxl/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.HeNMNOjfWB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:03 INFO - MultiFileLogger online at 20161124 03:02:03 in /builds/slave/test 03:02:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 03:02:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:02:03 INFO - {'append_to_log': False, 03:02:03 INFO - 'base_work_dir': '/builds/slave/test', 03:02:03 INFO - 'blob_upload_branch': 'Graphics', 03:02:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:02:03 INFO - 'branch': 'Graphics', 03:02:03 INFO - 'buildbot_json_path': 'buildprops.json', 03:02:03 INFO - 'config_files': ('talos/mac_config.py',), 03:02:03 INFO - 'default_actions': ('clobber', 03:02:03 INFO - 'read-buildbot-config', 03:02:03 INFO - 'download-and-extract', 03:02:03 INFO - 'populate-webroot', 03:02:03 INFO - 'create-virtualenv', 03:02:03 INFO - 'install', 03:02:03 INFO - 'run-tests'), 03:02:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:02:03 INFO - 'download_minidump_stackwalk': True, 03:02:03 INFO - 'download_symbols': 'ondemand', 03:02:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:02:03 INFO - 'tooltool.py': '/tools/tooltool.py', 03:02:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:02:03 INFO - '/tools/misc-python/virtualenv.py')}, 03:02:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:02:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:02:03 INFO - 'installer_path': 'installer.exe', 03:02:03 INFO - 'log_level': 'info', 03:02:03 INFO - 'log_name': 'talos', 03:02:03 INFO - 'log_to_console': True, 03:02:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:02:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:02:03 INFO - 'opt_config_files': (), 03:02:03 INFO - 'pip_index': False, 03:02:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:03 INFO - 'cmd': ('bash', 03:02:03 INFO - '-c', 03:02:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:03 INFO - 'enabled': True, 03:02:03 INFO - 'halt_on_failure': False, 03:02:03 INFO - 'name': 'check_screen_resolution'},), 03:02:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:02:03 INFO - 'cmd': ('bash', 03:02:03 INFO - '-c', 03:02:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:02:03 INFO - 'enabled': True, 03:02:03 INFO - 'halt_on_failure': False, 03:02:03 INFO - 'name': 'check_screen_resolution'},), 03:02:03 INFO - 'run_cmd_checks_enabled': True, 03:02:03 INFO - 'sps_profile': False, 03:02:03 INFO - 'sps_profile_interval': 0, 03:02:03 INFO - 'suite': 'dromaeojs', 03:02:03 INFO - 'system_bits': '32', 03:02:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:02:03 INFO - 'title': 't-yosemite-r7-0203', 03:02:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:02:03 INFO - 'use_talos_json': True, 03:02:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:02:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:02:03 INFO - 'work_dir': 'build'} 03:02:03 INFO - [mozharness: 2016-11-24 11:02:03.552465Z] Running clobber step. 03:02:03 INFO - Running pre-action listener: _resource_record_pre_action 03:02:03 INFO - Running main action method: clobber 03:02:03 INFO - rmtree: /builds/slave/test/build 03:02:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:02:06 INFO - Running post-action listener: _resource_record_post_action 03:02:06 INFO - [mozharness: 2016-11-24 11:02:06.043815Z] Finished clobber step (success) 03:02:06 INFO - [mozharness: 2016-11-24 11:02:06.043967Z] Running read-buildbot-config step. 03:02:06 INFO - Running pre-action listener: _resource_record_pre_action 03:02:06 INFO - Running main action method: read_buildbot_config 03:02:06 INFO - Using buildbot properties: 03:02:06 INFO - { 03:02:06 INFO - "project": "", 03:02:06 INFO - "product": "firefox", 03:02:06 INFO - "script_repo_revision": "default", 03:02:06 INFO - "builddir": "graphics_yosemite_r7_test-dromaeojs", 03:02:06 INFO - "repository": "", 03:02:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 graphics talos dromaeojs", 03:02:06 INFO - "buildid": "20161124005437", 03:02:06 INFO - "pgo_build": "False", 03:02:06 INFO - "basedir": "/builds/slave/test", 03:02:06 INFO - "buildnumber": 1, 03:02:06 INFO - "slavename": "t-yosemite-r7-0203", 03:02:06 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:02:06 INFO - "platform": "yosemite_r7", 03:02:06 INFO - "scheduler": "tests-graphics-macosx64-talos", 03:02:06 INFO - "branch": "graphics", 03:02:06 INFO - "repo_path": "projects/graphics", 03:02:06 INFO - "revision": "957b5d8ef568b79e31e8324455a4825766c4e497", 03:02:06 INFO - "stage_platform": "macosx64", 03:02:06 INFO - "builduid": "bd1f4b48aae9460882ea45523133f0c7", 03:02:06 INFO - "slavebuilddir": "test" 03:02:06 INFO - } 03:02:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 03:02:06 INFO - Running post-action listener: _resource_record_post_action 03:02:06 INFO - [mozharness: 2016-11-24 11:02:06.047368Z] Finished read-buildbot-config step (success) 03:02:06 INFO - [mozharness: 2016-11-24 11:02:06.047500Z] Running download-and-extract step. 03:02:06 INFO - Running pre-action listener: _resource_record_pre_action 03:02:06 INFO - Running main action method: download_and_extract 03:02:06 INFO - mkdir: /builds/slave/test/build/tests 03:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:06 INFO - trying https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 03:02:06 INFO - Downloading https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:02:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 03:02:06 INFO - Downloaded 1199 bytes. 03:02:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 03:02:06 INFO - Using the following test package requirements: 03:02:06 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:02:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 03:02:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 03:02:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'jsshell-mac.zip'], 03:02:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 03:02:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 03:02:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 03:02:06 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 03:02:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 03:02:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 03:02:06 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 03:02:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:02:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:02:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:02:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:02:07 INFO - Http code: 200 03:02:07 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 03:02:07 INFO - x-amz-cf-id: oYsEi98RSXoAEK5TOtufRs51S2SQhxM2qcQpNq0XJ7z5dwTlAkc4_g== 03:02:07 INFO - x-amz-version-id: F14a79LamnZlH5r6lcKvlRLle2E2bzcZ 03:02:07 INFO - Expected file size: 16267102 03:02:07 INFO - Obtained file size: 16267102 03:02:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:02:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 03:02:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:02:14 INFO - Fetch https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 03:02:15 INFO - Http code: 200 03:02:15 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 03:02:15 INFO - x-amz-cf-id: XblkfNU1nxLJftIRHKbmLS2x5-5tOjrOWds76EzKNuQ_1itC7AcakA== 03:02:15 INFO - x-amz-version-id: F14a79LamnZlH5r6lcKvlRLle2E2bzcZ 03:02:15 INFO - Expected file size: 16267102 03:02:15 INFO - Obtained file size: 16267102 03:02:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 03:02:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:02:21 INFO - Fetch https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 03:02:22 INFO - Http code: 200 03:02:22 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 03:02:22 INFO - x-amz-cf-id: vLX9w7AcWOjquLS3hA38NDeTsP88MVaHNy_LV2iZBeif0zj19zGmfQ== 03:02:22 INFO - x-amz-version-id: z80uFu.UvpU0yz5Q2YtO4udH7QcF4Nn. 03:02:22 INFO - Expected file size: 14409506 03:02:22 INFO - Obtained file size: 14409506 03:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:23 INFO - trying https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:02:23 INFO - Downloading https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 03:02:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 03:02:26 INFO - Downloaded 107548480 bytes. 03:02:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:02:26 INFO - mkdir: /builds/slave/test/properties 03:02:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:02:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:02:26 INFO - Contents: 03:02:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 03:02:26 INFO - Running post-action listener: _resource_record_post_action 03:02:26 INFO - Running post-action listener: set_extra_try_arguments 03:02:26 INFO - [mozharness: 2016-11-24 11:02:26.950655Z] Finished download-and-extract step (success) 03:02:26 INFO - [mozharness: 2016-11-24 11:02:26.950811Z] Running populate-webroot step. 03:02:26 INFO - Running pre-action listener: _resource_record_pre_action 03:02:26 INFO - Running main action method: populate_webroot 03:02:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:02:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:02:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:02:26 INFO - '--tppagecycles', 03:02:26 INFO - '7'], 03:02:26 INFO - 'tests': ['tsvgm']}}, 03:02:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:02:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:02:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:02:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:02:26 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:02:26 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['damp', 'tps']}, 03:02:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'tests': ['damp', 'tps']}, 03:02:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['dromaeo_dom']}, 03:02:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:02:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['basic_compositor_video']}, 03:02:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:02:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['a11yr', 03:02:26 INFO - 'ts_paint', 03:02:26 INFO - 'tpaint', 03:02:26 INFO - 'sessionrestore', 03:02:26 INFO - 'sessionrestore_no_auto_restore', 03:02:26 INFO - 'tabpaint']}, 03:02:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:02:26 INFO - 'ts_paint', 03:02:26 INFO - 'tpaint', 03:02:26 INFO - 'sessionrestore', 03:02:26 INFO - 'sessionrestore_no_auto_restore', 03:02:26 INFO - 'tabpaint']}, 03:02:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:02:26 INFO - 'ts_paint', 03:02:26 INFO - 'tpaint', 03:02:26 INFO - 'sessionrestore', 03:02:26 INFO - 'sessionrestore_no_auto_restore', 03:02:26 INFO - 'tabpaint']}, 03:02:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:02:26 INFO - 'ts_paint', 03:02:26 INFO - 'tpaint', 03:02:26 INFO - 'sessionrestore', 03:02:26 INFO - 'sessionrestore_no_auto_restore', 03:02:26 INFO - 'tabpaint']}, 03:02:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['a11yr', 03:02:26 INFO - 'ts_paint', 03:02:26 INFO - 'tpaint', 03:02:26 INFO - 'sessionrestore', 03:02:26 INFO - 'sessionrestore_no_auto_restore', 03:02:26 INFO - 'tabpaint']}, 03:02:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['a11yr', 03:02:26 INFO - 'ts_paint', 03:02:26 INFO - 'tpaint', 03:02:26 INFO - 'sessionrestore', 03:02:26 INFO - 'sessionrestore_no_auto_restore', 03:02:26 INFO - 'tabpaint']}, 03:02:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['tsvgx', 03:02:26 INFO - 'tsvgr_opacity', 03:02:26 INFO - 'tart', 03:02:26 INFO - 'tscrollx', 03:02:26 INFO - 'cart']}, 03:02:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:02:26 INFO - 'tsvgr_opacity', 03:02:26 INFO - 'tart', 03:02:26 INFO - 'tscrollx', 03:02:26 INFO - 'cart']}, 03:02:26 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'talos_options': ['--disable-e10s'], 03:02:26 INFO - 'tests': ['tp5o']}, 03:02:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:02:26 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'talos_options': ['--disable-e10s', 03:02:26 INFO - '--xperf_path', 03:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:26 INFO - 'tests': ['tp5n']}, 03:02:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:02:26 INFO - 'talos_options': ['--xperf_path', 03:02:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:02:26 INFO - 'tests': ['tp5n']}}, 03:02:26 INFO - 'talos.zip': {'path': '', 03:02:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:02:26 INFO - Running post-action listener: _resource_record_post_action 03:02:26 INFO - [mozharness: 2016-11-24 11:02:26.969270Z] Finished populate-webroot step (success) 03:02:26 INFO - [mozharness: 2016-11-24 11:02:26.969400Z] Running create-virtualenv step. 03:02:26 INFO - Running pre-action listener: _resource_record_pre_action 03:02:26 INFO - Running main action method: create_virtualenv 03:02:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:02:26 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 03:02:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:02:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:02:27 INFO - Using real prefix '/tools/python27' 03:02:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:02:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:02:30 INFO - Installing pip.................done. 03:02:30 INFO - Return code: 0 03:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:02:31 INFO - Reading from file tmpfile_stdout 03:02:31 INFO - Output received: 03:02:31 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) 03:02:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02: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', 'pip>=1.5'] in /builds/slave/test/build 03:02: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 pip>=1.5 03:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:31 INFO - 'HOME': '/Users/cltbld', 03:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:31 INFO - 'LOGNAME': 'cltbld', 03:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:31 INFO - 'MOZ_NO_REMOTE': '1', 03:02:31 INFO - 'NO_EM_RESTART': '1', 03:02:31 INFO - 'PAGER': '/bin/cat', 03:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:31 INFO - 'PWD': '/builds/slave/test', 03:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:31 INFO - 'SHELL': '/bin/bash', 03:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:31 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:31 INFO - 'USER': 'cltbld', 03:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:31 INFO - 'XPC_FLAGS': '0x0', 03:02:31 INFO - 'XPC_SERVICE_NAME': '0', 03:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:31 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 03:02:31 INFO - Cleaning up... 03:02:31 INFO - Return code: 0 03:02:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', '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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:02: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 psutil>=3.1.1 03:02:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:31 INFO - 'HOME': '/Users/cltbld', 03:02:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:31 INFO - 'LOGNAME': 'cltbld', 03:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:31 INFO - 'MOZ_NO_REMOTE': '1', 03:02:31 INFO - 'NO_EM_RESTART': '1', 03:02:31 INFO - 'PAGER': '/bin/cat', 03:02:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:31 INFO - 'PWD': '/builds/slave/test', 03:02:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:31 INFO - 'SHELL': '/bin/bash', 03:02:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:31 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:31 INFO - 'USER': 'cltbld', 03:02:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:31 INFO - 'XPC_FLAGS': '0x0', 03:02:31 INFO - 'XPC_SERVICE_NAME': '0', 03:02:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:31 INFO - Downloading/unpacking psutil>=3.1.1 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:02:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:35 INFO - Installing collected packages: psutil 03:02:35 INFO - Running setup.py install for psutil 03:02:35 INFO - building 'psutil._psutil_osx' extension 03:02:35 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 03:02:36 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 03:02:36 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 03:02:36 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 03:02:36 INFO - building 'psutil._psutil_posix' extension 03:02:36 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 03:02:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:02:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:02:36 INFO - ^ 03:02:36 INFO - 1 warning generated. 03:02:36 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 03:02:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:02:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:02:36 INFO - Successfully installed psutil 03:02:36 INFO - Cleaning up... 03:02:36 INFO - Return code: 0 03:02:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:02:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:36 INFO - 'HOME': '/Users/cltbld', 03:02:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:36 INFO - 'LOGNAME': 'cltbld', 03:02:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:36 INFO - 'MOZ_NO_REMOTE': '1', 03:02:36 INFO - 'NO_EM_RESTART': '1', 03:02:36 INFO - 'PAGER': '/bin/cat', 03:02:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:36 INFO - 'PWD': '/builds/slave/test', 03:02:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:36 INFO - 'SHELL': '/bin/bash', 03:02:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:36 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:36 INFO - 'USER': 'cltbld', 03:02:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:36 INFO - 'XPC_FLAGS': '0x0', 03:02:36 INFO - 'XPC_SERVICE_NAME': '0', 03:02:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:02:37 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 03:02:37 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 03:02:37 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 03:02:37 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 03:02:37 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 03:02:37 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 03:02:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:02:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:02:39 INFO - Installing collected packages: mozsystemmonitor 03:02:39 INFO - Running setup.py install for mozsystemmonitor 03:02:39 INFO - Successfully installed mozsystemmonitor 03:02:39 INFO - Cleaning up... 03:02:40 INFO - Return code: 0 03:02:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:40 INFO - 'HOME': '/Users/cltbld', 03:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:40 INFO - 'LOGNAME': 'cltbld', 03:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:40 INFO - 'MOZ_NO_REMOTE': '1', 03:02:40 INFO - 'NO_EM_RESTART': '1', 03:02:40 INFO - 'PAGER': '/bin/cat', 03:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:40 INFO - 'PWD': '/builds/slave/test', 03:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:40 INFO - 'SHELL': '/bin/bash', 03:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:40 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:40 INFO - 'USER': 'cltbld', 03:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:40 INFO - 'XPC_FLAGS': '0x0', 03:02:40 INFO - 'XPC_SERVICE_NAME': '0', 03:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:40 INFO - Downloading/unpacking jsonschema==2.5.1 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:43 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:43 INFO - warning: no files found matching '*.txt' 03:02:43 INFO - no previously-included directories found matching 'build' 03:02:43 INFO - no previously-included directories found matching 'dist' 03:02:43 INFO - no previously-included directories found matching '.git*' 03:02:43 INFO - Installing collected packages: jsonschema, functools32 03:02:43 INFO - Running setup.py install for functools32 03:02:43 INFO - warning: no files found matching '*.txt' 03:02:43 INFO - no previously-included directories found matching 'build' 03:02:43 INFO - no previously-included directories found matching 'dist' 03:02:43 INFO - no previously-included directories found matching '.git*' 03:02:43 INFO - Successfully installed jsonschema functools32 03:02:43 INFO - Cleaning up... 03:02:43 INFO - Return code: 0 03:02:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:02:43 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')]} 03:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:43 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')]} 03:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:43 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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:43 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 03:02:43 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 03:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:43 INFO - 'HOME': '/Users/cltbld', 03:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:43 INFO - 'LOGNAME': 'cltbld', 03:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:43 INFO - 'MOZ_NO_REMOTE': '1', 03:02:43 INFO - 'NO_EM_RESTART': '1', 03:02:43 INFO - 'PAGER': '/bin/cat', 03:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:43 INFO - 'PWD': '/builds/slave/test', 03:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:43 INFO - 'SHELL': '/bin/bash', 03:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:43 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:43 INFO - 'USER': 'cltbld', 03:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:43 INFO - 'XPC_FLAGS': '0x0', 03:02:43 INFO - 'XPC_SERVICE_NAME': '0', 03:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:02:43 INFO - Cleaning up... 03:02:43 INFO - Return code: 0 03:02:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:02:43 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')]} 03:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:43 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')]} 03:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:43 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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:43 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 03:02:43 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 03:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:43 INFO - 'HOME': '/Users/cltbld', 03:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:43 INFO - 'LOGNAME': 'cltbld', 03:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:43 INFO - 'MOZ_NO_REMOTE': '1', 03:02:43 INFO - 'NO_EM_RESTART': '1', 03:02:43 INFO - 'PAGER': '/bin/cat', 03:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:43 INFO - 'PWD': '/builds/slave/test', 03:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:43 INFO - 'SHELL': '/bin/bash', 03:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:43 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:43 INFO - 'USER': 'cltbld', 03:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:43 INFO - 'XPC_FLAGS': '0x0', 03:02:43 INFO - 'XPC_SERVICE_NAME': '0', 03:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:46 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:46 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 03:02:46 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 03:02:46 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 03:02:46 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 03:02:46 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 03:02:46 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 03:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02:47 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 03:02:47 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 03:02:47 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 03:02:47 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 03:02:47 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 03:02:47 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 03:02:47 INFO - Downloading docopt-0.6.1.tar.gz 03:02:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:48 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:48 INFO - Running setup.py install for blobuploader 03:02:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:48 INFO - Running setup.py install for requests 03:02:48 INFO - Running setup.py install for docopt 03:02:48 INFO - Successfully installed blobuploader requests docopt 03:02:48 INFO - Cleaning up... 03:02:48 INFO - Return code: 0 03:02:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:48 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')]} 03:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:48 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')]} 03:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:48 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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:48 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 03:02:48 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 03:02:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:48 INFO - 'HOME': '/Users/cltbld', 03:02:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:48 INFO - 'LOGNAME': 'cltbld', 03:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:48 INFO - 'MOZ_NO_REMOTE': '1', 03:02:48 INFO - 'NO_EM_RESTART': '1', 03:02:48 INFO - 'PAGER': '/bin/cat', 03:02:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:48 INFO - 'PWD': '/builds/slave/test', 03:02:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:48 INFO - 'SHELL': '/bin/bash', 03:02:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:48 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:48 INFO - 'USER': 'cltbld', 03:02:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:48 INFO - 'XPC_FLAGS': '0x0', 03:02:48 INFO - 'XPC_SERVICE_NAME': '0', 03:02:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-bL0V94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ANyPdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-TLi4R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-bzNJU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-zDl6wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HA9sGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-eiWIlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-twOJ4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:49 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-A6e6A8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-zmykFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-IRUFIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Q_94ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-MTEMYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-iIm44G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HXLHrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-mC1wZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:50 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-IgYRlW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:50 INFO - Running setup.py install for manifestparser 03:02:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:51 INFO - Running setup.py install for mozcrash 03:02:51 INFO - Running setup.py install for mozdebug 03:02:51 INFO - Running setup.py install for mozdevice 03:02:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:02:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:51 INFO - Running setup.py install for mozfile 03:02:51 INFO - Running setup.py install for mozhttpd 03:02:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:51 INFO - Running setup.py install for mozinfo 03:02:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:51 INFO - Running setup.py install for mozInstall 03:02:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Running setup.py install for mozleak 03:02:52 INFO - Running setup.py install for mozlog 03:02:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Running setup.py install for moznetwork 03:02:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Running setup.py install for mozprocess 03:02:52 INFO - Running setup.py install for mozprofile 03:02:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:52 INFO - Running setup.py install for mozrunner 03:02:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:53 INFO - Running setup.py install for mozscreenshot 03:02:53 INFO - Running setup.py install for moztest 03:02:53 INFO - Running setup.py install for mozversion 03:02:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:53 INFO - Cleaning up... 03:02:53 INFO - Return code: 0 03:02:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:53 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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:53 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 03:02:53 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 03:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:53 INFO - 'HOME': '/Users/cltbld', 03:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:53 INFO - 'LOGNAME': 'cltbld', 03:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:53 INFO - 'MOZ_NO_REMOTE': '1', 03:02:53 INFO - 'NO_EM_RESTART': '1', 03:02:53 INFO - 'PAGER': '/bin/cat', 03:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:53 INFO - 'PWD': '/builds/slave/test', 03:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:53 INFO - 'SHELL': '/bin/bash', 03:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:53 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:53 INFO - 'USER': 'cltbld', 03:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:53 INFO - 'XPC_FLAGS': '0x0', 03:02:53 INFO - 'XPC_SERVICE_NAME': '0', 03:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:53 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-eq5mPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:53 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)) 03:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:53 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-dI0d6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:53 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-BtWxKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-tKbtBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-o1D1mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-0FNwXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-jjL5FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ZwDu8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-2DpZqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-pbISZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-J3Qm08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:54 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)) 03:02:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:54 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-HSK8ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:55 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)) 03:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:55 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-ULUE8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:55 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)) 03:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:55 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-DXZ05A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:55 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-7dd_U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:55 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)) 03:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:55 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-Xmd4LV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:55 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)) 03:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:55 INFO - Running setup.py (path:/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/pip-7mxr7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:55 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)) 03:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:55 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)) 03:02:55 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:55 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:02:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02:55 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 03:02:55 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 03:02:55 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 03:02:55 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 03:02:55 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 03:02:55 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 03:02:58 INFO - Downloading blessings-1.6.tar.gz 03:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:58 INFO - Installing collected packages: blessings 03:02:58 INFO - Running setup.py install for blessings 03:02:58 INFO - Successfully installed blessings 03:02:58 INFO - Cleaning up... 03:02:58 INFO - Return code: 0 03:02:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:58 INFO - Reading from file tmpfile_stdout 03:02:58 INFO - Current package versions: 03:02:58 INFO - blessings == 1.6 03:02:58 INFO - blobuploader == 1.2.4 03:02:58 INFO - docopt == 0.6.1 03:02:58 INFO - functools32 == 3.2.3-2 03:02:58 INFO - jsonschema == 2.5.1 03:02:58 INFO - manifestparser == 1.1 03:02:58 INFO - mozInstall == 1.12 03:02:58 INFO - mozcrash == 1.0 03:02:58 INFO - mozdebug == 0.1 03:02:58 INFO - mozdevice == 0.49 03:02:58 INFO - mozfile == 1.2 03:02:58 INFO - mozhttpd == 0.7 03:02:58 INFO - mozinfo == 0.9 03:02:58 INFO - mozleak == 0.1 03:02:58 INFO - mozlog == 3.4 03:02:58 INFO - moznetwork == 0.27 03:02:58 INFO - mozprocess == 0.23 03:02:58 INFO - mozprofile == 0.28 03:02:58 INFO - mozrunner == 6.13 03:02:58 INFO - mozscreenshot == 0.1 03:02:58 INFO - mozsystemmonitor == 0.3 03:02:58 INFO - moztest == 0.7 03:02:58 INFO - mozversion == 1.4 03:02:58 INFO - psutil == 3.1.1 03:02:58 INFO - requests == 1.2.3 03:02:58 INFO - wsgiref == 0.1.2 03:02:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:58 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')]} 03:02:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:58 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')]} 03:02:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:58 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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:58 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 03:02:58 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 03:02:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:58 INFO - 'HOME': '/Users/cltbld', 03:02:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:58 INFO - 'LOGNAME': 'cltbld', 03:02:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:58 INFO - 'MOZ_NO_REMOTE': '1', 03:02:58 INFO - 'NO_EM_RESTART': '1', 03:02:58 INFO - 'PAGER': '/bin/cat', 03:02:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:58 INFO - 'PWD': '/builds/slave/test', 03:02:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:58 INFO - 'SHELL': '/bin/bash', 03:02:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:58 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:58 INFO - 'USER': 'cltbld', 03:02:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:58 INFO - 'XPC_FLAGS': '0x0', 03:02:58 INFO - 'XPC_SERVICE_NAME': '0', 03:02:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 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)) 03:02:59 INFO - Cleaning up... 03:02:59 INFO - Return code: 0 03:02:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:59 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 0x10892d3f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088a3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80e25c73a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, '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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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 03:02:59 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 03:02:59 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 03:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:02:59 INFO - 'HOME': '/Users/cltbld', 03:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:02:59 INFO - 'LOGNAME': 'cltbld', 03:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:59 INFO - 'MOZ_NO_REMOTE': '1', 03:02:59 INFO - 'NO_EM_RESTART': '1', 03:02:59 INFO - 'PAGER': '/bin/cat', 03:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:59 INFO - 'PWD': '/builds/slave/test', 03:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:02:59 INFO - 'SHELL': '/bin/bash', 03:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:02:59 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:02:59 INFO - 'USER': 'cltbld', 03:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:59 INFO - 'XPC_FLAGS': '0x0', 03:02:59 INFO - 'XPC_SERVICE_NAME': '0', 03:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:02:59 INFO - Cleaning up... 03:02:59 INFO - Return code: 0 03:02:59 INFO - Running post-action listener: _resource_record_post_action 03:02:59 INFO - Running post-action listener: _start_resource_monitoring 03:02:59 INFO - Starting resource monitoring. 03:02:59 INFO - [mozharness: 2016-11-24 11:02:59.330728Z] Finished create-virtualenv step (success) 03:02:59 INFO - [mozharness: 2016-11-24 11:02:59.331764Z] Running install step. 03:02:59 INFO - Running pre-action listener: _resource_record_pre_action 03:02:59 INFO - Running main action method: install 03:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:59 INFO - Reading from file tmpfile_stdout 03:02:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:59 INFO - Reading from file tmpfile_stdout 03:02:59 INFO - Output received: 03:02:59 INFO - Usage: mozinstall [options] installer 03:02:59 INFO - Options: 03:02:59 INFO - -h, --help show this help message and exit 03:02:59 INFO - -d DEST, --destination=DEST 03:02:59 INFO - Directory to install application into. [default: 03:02:59 INFO - "/builds/slave/test"] 03:02:59 INFO - --app=APP Application being installed. [default: firefox] 03:02:59 INFO - mkdir: /builds/slave/test/build/application 03:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:03:32 INFO - Reading from file tmpfile_stdout 03:03:32 INFO - Output received: 03:03:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:03:32 INFO - Running post-action listener: _resource_record_post_action 03:03:32 INFO - [mozharness: 2016-11-24 11:03:32.878964Z] Finished install step (success) 03:03:32 INFO - [mozharness: 2016-11-24 11:03:32.879094Z] Running run-tests step. 03:03:32 INFO - Running pre-action listener: _resource_record_pre_action 03:03:32 INFO - Running main action method: run_tests 03:03:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:03:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:03:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:03:32 INFO - 2016-11-24 03:03:32.893 screenresolution[1633:8957] starting screenresolution argv=screenresolution get 03:03:32 INFO - 2016-11-24 03:03:32.896 screenresolution[1633:8957] Display 0: 1600x1200x32@60 03:03:32 INFO - 2016-11-24 03:03:32.903 screenresolution[1634:8959] starting screenresolution argv=screenresolution list 03:03:32 INFO - Available Modes on Display 0 03:03:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:03:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:03:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:03:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:03:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:03:33 INFO - Intel Iris: 03:03:33 INFO - Chipset Model: Intel Iris 03:03:33 INFO - Type: GPU 03:03:33 INFO - Bus: Built-In 03:03:33 INFO - VRAM (Dynamic, Max): 1536 MB 03:03:33 INFO - Vendor: Intel (0x8086) 03:03:33 INFO - Device ID: 0x0a2e 03:03:33 INFO - Revision ID: 0x0009 03:03:33 INFO - Displays: 03:03:33 INFO - Display: 03:03:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:03:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:03:33 INFO - Display Serial Number: 1600x1200 60 03:03:33 INFO - Main Display: Yes 03:03:33 INFO - Mirror: Off 03:03:33 INFO - Online: Yes 03:03:33 INFO - Rotation: Supported 03:03:33 INFO - Return code: 0 03:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:03:33 INFO - Python 2.7.3 03:03:33 INFO - Return code: 0 03:03:33 INFO - grabbing minidump binary from tooltool 03:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:03:33 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 0x108743d30>, '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 0x1085aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10873bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:03:33 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 03:03:33 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 03:03:33 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 03:03:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:03:33 INFO - Return code: 0 03:03:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:03:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:03:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:03:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:03:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:03:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 03:03:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0203 --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 03:03:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BZx7j1qbxl/Render', 03:03:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:03:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:03:33 INFO - 'HOME': '/Users/cltbld', 03:03:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:03:33 INFO - 'LOGNAME': 'cltbld', 03:03:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:03:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:03:33 INFO - 'MOZ_NO_REMOTE': '1', 03:03:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:03:33 INFO - 'NO_EM_RESTART': '1', 03:03:33 INFO - 'PAGER': '/bin/cat', 03:03:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:03:33 INFO - 'PWD': '/builds/slave/test', 03:03:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:03:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:03:33 INFO - 'SHELL': '/bin/bash', 03:03:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HeNMNOjfWB/Listeners', 03:03:33 INFO - 'TMPDIR': '/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/', 03:03:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:03:33 INFO - 'USER': 'cltbld', 03:03:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:03:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:03:33 INFO - 'XPC_FLAGS': '0x0', 03:03:33 INFO - 'XPC_SERVICE_NAME': '0', 03:03:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:03:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0203', '--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 03:03:33 INFO - mozversion application_buildid: 20161124005437 03:03:33 INFO - mozversion application_changeset: 957b5d8ef568b79e31e8324455a4825766c4e497 03:03:33 INFO - mozversion application_display_name: Nightly 03:03:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:03:33 INFO - mozversion application_name: Firefox 03:03:33 INFO - mozversion application_remotingname: firefox 03:03:33 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 03:03:33 INFO - mozversion application_vendor: Mozilla 03:03:33 INFO - mozversion application_version: 53.0a1 03:03:33 INFO - mozversion platform_buildid: 20161124005437 03:03:33 INFO - mozversion platform_changeset: 957b5d8ef568b79e31e8324455a4825766c4e497 03:03:33 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 03:03:33 INFO - mozversion platform_version: 53.0a1 03:03:33 INFO - using testdate: 1479985413 03:03:33 INFO - actual date: 1479985413 03:03:33 INFO - starting webserver on 'localhost:49236' 03:03:33 INFO - SUITE-START | Running 2 tests 03:03:33 INFO - TEST-START | dromaeo_css 03:03:33 INFO - operating with platform_type : mac_ 03:03:33 INFO - Initialising browser for dromaeo_css test... 03:03:33 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpqHtihU/profile http://localhost:49236/getInfo.html) 03:03:36 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 03:03:36 INFO - PROCESS | 1644 | colorDepth:24 03:03:36 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 03:03:36 INFO - PROCESS | 1644 | __metrics 03:03:36 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:03:36 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:03:37 INFO - TEST-INFO | 1644: exit 0 03:03:37 INFO - Browser initialized. 03:03:37 INFO - Running cycle 1/1 for dromaeo_css test... 03:03:37 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpqHtihU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:03:49 INFO - PROCESS | 1648 | RSS: Main: 259301376 03:03:49 INFO - PROCESS | 1648 | 03:04:41 INFO - PROCESS | 1648 | 1479985481283 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] 03:06:53 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 03:06:55 INFO - PROCESS | 1648 | RSS: Main: 444166144 03:06:55 INFO - PROCESS | 1648 | 03:09:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 03:09:59 INFO - PROCESS | 1648 | RSS: Main: 381493248 03:09:59 INFO - PROCESS | 1648 | 03:13:01 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 03:13:02 INFO - PROCESS | 1648 | RSS: Main: 367923200 03:13:02 INFO - PROCESS | 1648 | 03:16:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 03:16:05 INFO - PROCESS | 1648 | RSS: Main: 353558528 03:16:05 INFO - PROCESS | 1648 | 03:19:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 03:19:09 INFO - PROCESS | 1648 | RSS: Main: 344666112 03:19:09 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 03:22:13 INFO - PROCESS | 1648 | RSS: Main: 413343744 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | __start_tp_report 03:22:13 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 03:22:13 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 03:22:13 INFO - PROCESS | 1648 | |i|pagename|runs| 03:22:13 INFO - PROCESS | 1648 | |0;dojo.html;3345.2305969626987;3360.42872711639;3384.2047118927035;3405.6764607362293;3439.896803095908;5618.971905140468;5664.603477756558;5721.456461636149;5773.220615216945;5782.826515204545;5697.373288938214;5699.658020518772;5796.159556864252;5819.738111784969;5846.4445877641665;5138;5154.639175257734;5182;5244.134717771563;5264;4242.215190189825;4576.519465456129;5316.362036555619;5348.277982472375;5364.088105022156;5161.793528258865;5306.204069389584;5323;5324.201369794523;5406.702631355274;5148.897022059537;5259;5263.0526505229045;5265.710385928773;5280.815171469018;4343.2399330117105;5151.484851514856;5223.843284701465;5230.555402790767;5241.86895327616;5737.483626473638;5741.856453588652;5751.194832723422;5753.108268218391;5753.395893431171;6139.952147135068;6196.783112591038;6202.875942481171;6226.564140510166;6227.532935029891;4937.185364414867;6285.622862628211;6296.244450665904;6304.054391841215;6308.621482711006;5740.425957404268;5830.0380437227805;5830.679312637803;5834.795782147605;5839.153322768175;6165.969170154121;6244.344343843922;6270.749170033238;6274.6548939808745;6281.403266689657;6095.377886651315;6101.768966869689;6114.297368146176;6138.754449821957;6141.600795948339;5257.7896884124975;6192.5974811638;6227.221597300338;6255.218097737783;6270.874582508324;6246.781362652377;6248.187735594434;6251.156093927352;6259.436650701458;6267.592606480655;6277.2153480814895;6279.183706118175;6280.152179455807;6285.968570157212;6286.371362863769;4865.051314993613;4918.1884988977135;4925.261210818406;4929.112759703216;5009.198528235464;4384.495782984934;4414.580614841585;4418.116376724668;4441.022974945507;4463.642908567307;5738.454846789548;5758.165066065397;5854.648721076749;5866.6480011199465;5870.7945221917025;6139.171211886338;6151.9692401538605;6242.563020588515;6248.343923888017;6281;5735.8566035849435;5785.334686511021;5787.8553036174435;5826.621269617462;5828.125781132864;5428.701421421781;5435.565154787608;5435.565154787608;5436.565074794007;5470;6281.937180628227;6282.528810339151;6314.1160237565855;6332.746690132435;6334.461570766352;6161.969190154021;6212.658303793335;6219.689015549295;6235.189425374672;6278.246610406781;6222.471089957405;6263.812085637438;6291.6539590321145;6327.683615819098;6360.904586431115;5005.324281221989;5923.607952131159;6216.191895053614;6228.937710622836;6250.093736408105;6161.168242287234;6200.100985357189;6291.716872740829;6302.054691796084;6312.179416675803;6099.634021958696;6112.510999119971;6122.459144589048;6136.631802091889;6139;6160.952638051453;6163.7842675506145;6182.258129024546;6183.258009038944;6187.948048831619;5946;6053.727582258721;6055.161261342324;6076.422739839708;6100.8779824404155;5689.6586204827845;6175.62946223228;6180.783672571618;6187.504999599932;6191.659458729813;5497.39528651856;5601.215829783915;5984;6061.454469097626;6064.363241859718 03:22:13 INFO - PROCESS | 1648 | |1;ext.html;486.90261947610475;488.7580647579446;509.98470045898614;512.2623422271926;526.3394439977827;30084.84957575212;37464.8760537184;38769.80615096928;38884.80557597208;41768.37347439791;40471.79764101183;40942;41024;41198.58801411985;41221.17557648845;8430.662773489054;9181.678641247541;9355.625774968994;9355.766105847375;9372.718818435458;8403.70587029451;10985.121190304797;11264.21150519464;11304.943475282653;11446.71383215422;11221.66335009951;11286.604968826092;11291.887081129165;11302;11303.491342889549;11135.610253641084;11223.046041086518;11269.985701286842;11310.37792921389;11329.716757081056;11078.556857725682;11137.777244455065;11142.944285278521;11164.609238676607;11175.21773475857;37988.240235195415;38298.042548936224;38299.425508617394;38349.80825095884;38359.808200959094;3439.1574064354145;3517.683408493248;3749.287635349302;3853.2678791029616;3871.264459752666;28876.27809304784;29728.405431891457;29825.850870745726;30078.097657070324;30531;3166.746660267196;3174.2857856982223;3198.0885447647543;3227.177069847174;3268.3299923515624;395167;492573;500530;500722.99999999633;501898;55718.72140639271;56110;56143.71928140333;56160;56193.7190314054;58380;58499.4150058494;58503.12245316324;58530.82938341209;58533.70733146307;15133;15629.218539073001;15655.452059178102;15681.764773528406;15694;11034.117270618332;11303.604373846876;11995.1003674723;12228.388580570936;12326.630201093982;14358.138511689333;14752.188629625474;14765.261736913111;14927.850721492647;14933.088047830568;6082.300535438481;6092.0833789799935;6132.754689812357;6135.202423684892;6135.417135372132;817.5789468423767;927.1582599333022;974.449436068619;993.4833886379187;1001.6944831826363;24938.37654058663;28713.277203367863;28787.85606071956;29328.26679333034;30131;1019.3883669798211;1021.7752094539189;1099.8130317845985;1100.6863044032411;1108.3349990005931;14319.427222911176;14876;14894.106353618818;15208.46770363032;15268.770968435483;615663;619015;620417;621106;621631;54769;54870.17694734582;54954.45045549573;55003.44996550064;55119.448805512235;1189.6133756529164;1235.6293112066344;1306.151001848806;1343.9596812095458;1345.9259740714158;28423.85788071129;29644.110676679735;29787;30393.936212232467;30514.542281866234;46618.76690616661;47216.7639161802;47291.52708472871;47302.81742956454;47407;386622;452266;452849;454008;455857;35812.462813058344;37003.629963701096;37201.25597487981;37227.813860930524;37250;44013;44629.10741785081;46158.538414615425;47532.2870156941;47734.76132619315;36535.45196822103;36900.446493302086;37093.81453092717;37987.24025519529;38479.61520384761;36197.27605447929;37044.44433333556;37638.36531442773;38240;40507.3923891136;36612;36679.89960301195;36931.81534092312;37340;37587.248255035294;32221;32861.35693215377;33749.66250337465;33854.830725846216;33902.66097338995;24648.014079436623;24769.62845557354;24774.38064048341;24907.750922490544;25077.87461062683 03:22:13 INFO - PROCESS | 1648 | |2;jquery.html;319.8464736926275;321.8738487192911;350.40955989158255;370.885025642051;398.2850782844793;14729.937808706776;15364.231788410576;16662.833371666296;20000.799992000077;20017;19034.61930761384;19492.22031118757;19520.510282635;19546.902265488654;19579.90210048948;5496.065668836288;5696.77212911483;5704.828855134353;5715.399883012286;5723.313202415695;4005.759654420744;4184.958150418503;4254;5712.857178570527;6347.365263473662;6090.5736598438125;6291.087792270118;6353.332900045498;6363.172787537636;6404;6281.937180628203;6309.716062777209;6342.334054924213;6353.078803573502;6363.268224154189;5234.319538460014;5370.946290537084;5448.264484294648;5480.671159730429;5485.890282194374;24718.011279548977;24786.628200577004;24800.75996200201;25016;25105.62341564878;2062.360668192865;2382.2257766226044;2435.208557218893;2453.58289090855;2789.693133755285;9676.95161524195;9679.516024198761;9747;10108.94945525275;10166;1552.5497605694447;1800.189914538463;1811.6467288878673;1855.2393518657286;1902.5338791995912;117794;127939;129095.35452322772;130113;130224;10992.461055452242;11084.279521831055;11215.60745373908;11233.775324493465;11450.885491145149;14225.78661320081;14249.216293103771;14261.643458913402;14266.643333916734;14267.215303158426;6688.665566721742;8082.191780821989;8198.081151309287;8198.754037378889;8419.158084191531;6578.967105164444;8104.39217058723;8265.214804593554;8280.544570048705;8334.416590838584;4314.331278651814;4409.192231185199;4410.117976404732;4460.375547423363;4461.174682683714;1615.7737916691672;1864.5525073982146;1874.8031456696851;1881.4355693292232;1881.5484283771796;858.7466697324304;921.8617207418806;936.241644268145;937.4047479850344;1025.6153942271649;19355.4193374199;19911.800881990996;19989.401377820792;20062.05687047488;20287.594248114954;914.4421902639517;918.673870775865;921.083521895718;980.3725615606018;1004.8593196952432;8906.465612063297;10041.447720375449;10534.315269507457;10542.789144217226;10570.947145264225;559066;566306;568123;578937;580392;129874;130714.69285307026;130957.69042309455;134943;135334;963.9903600964041;968.6997030920437;1005.1657124586576;1007.0634310091685;1008.4000019988096;17366.52669466137;17446.73829892578;17582;17649.205785739417;17850.5537361567;52377.47622523726;53625;53641;53890;55507.444925550226;76347.61826190834;76355;78538;79052;79802.2019779818;7488;7549.433792465477;7743.806404839924;7840.098388685375;8019.03771547418;10635.14918806478;11017.944910275397;11882.16824822254;11956;12050.09624278165;9949.214220018406;9954.402735835873;10165.390076595133;10212.897871021194;10381.169506439617;9697.369670971364;9953;9995.200383969119;10116.645917392856;10186.592536298465;10096.242781791248;10233.385996840214;10387.896121038693;10449.425281609585;10604.416757078434;6576.506761992774;7456.7762967111075;7653.387728981779;7669.578173200527;7897.24976127267;8500.829983400421;10015.949920250643;10104.989501049837;10218.386896786216;10444.791104178026 03:22:13 INFO - PROCESS | 1648 | |3;mootools.html;1250.8248845161672;1460.963475913102;1477.342582550765;1615.8949668271562;1797.8022417534062;6925.099737034185;7898.486598371109;8090.190980901914;8413.074561798212;8460.830783384345;8288;8298.25315721585;8370.372222083337;8388.62251198696;8398.244158025776;2009.7085922541223;2260.660900864867;2306.9192578259763;2311.4683622766775;2312.36409987254;2110.757262914769;2228.2089858100385;2321.698179236697;2332.4052366646483;2337.158622895765;2214.900329485169;2226.9109235630635;2256.8194544436487;2263.6830843681814;2266.3427605994243;2287.313805858244;2313.618252988255;2314.953700925989;2318.7913087822008;2320.8607483550873;2300.3903965449167;2344.941376465585;2347.4131467133216;2351.2005917987794;2361.2207971369407;8067.475614085066;8250.298724608416;8271.421000529965;8275.793105172359;8278.337732981347;5042.621803364726;5201;5203.063448579254;5211.895762084775;5212.478752124795;3246.8863589774246;3454.3436747017986;3495.7378196635354;3530.3468858261303;3541.5218945442293;998.3211416236956;1037.6835065305079;1056.3820165203288;1072.7961687279392;1080.3409919948824;10463.790724185474;10655.733606659818;10848.186386021001;10857.34855908648;10860.239783215178;4494.617957473586;4574.656900732459;4620.052889157714;4646.070785842778;4647.907041859212;9457.38526995743;9478.052194780605;9495.43027418357;9498.19265362452;9509;5201.271821944931;5210;5215.478452154754;5221.425643179247;5227.111391063529;4314.654827613784;4470.195364834296;4674.742889141062;4719.174144524694;4758.095961767253;3563.7861728295866;3712.1090938174643;3832.869303555458;3854.2484215577692;3855.9228815424094;1198.7902117129468;1245.4333278358324;1250.1561446023898;1250.8373911391461;1259.3199672177104;799.8720204767326;867.8481265778463;889.7019498468086;925.1118925831278;932.2961164320894;5485.670859748428;5533.837894042296;5588.1338392548405;5676.772929082873;5877.206577112121;897.3314880414002;905.6920646980059;915.1260546178517;930.4789317981952;978.8091322192247;3675.4486826976167;3678.8043885737243;3782.829772660237;3804.3912973924594;3937.0944682723134;9593.520323983912;10158.492075396349;10178.847317290247;10209.744756381002;10223.539940702687;9502.239820814319;9982.001799820106;9982.700518984442;10110.595576177018;10119.392836429837;7613.124490683532;7732.188120247518;7769.844603107907;7852.882206766903;7878.833320836701;4631.339395330753;4833.32333473307;5421.159720243369;5544.833654990357;5652.7738890443925;9048.41185322952;9146;9221.354505184572;9236.07639236098;9498.14516693501;9464.95267523658;9473.289503287144;9478;9499.43003419797;9578.557467845654;7111.040009598638;7146.964265178641;7194.136703595602;7239.746608868664;7257.854842903007;6565.901511477236;7161.765365690752;7869.016372953381;7936;7982.321502672105;6078.513718902565;6133.7546498141355;7030.9296907030275;7033.980072889504;7245.311695388929;7009.4579192579595;7030.156381234285;7036.5074444790425;7094.574325540484;7170.282971702788;6422;6615.636140012153;6721;6729;6733.663316834237;4730.148573256847;4798.184308667465;4814.325994360723;4878.146324393288;5003.974980125222;4384.254676705032;4515.006698526319;4804.135255654016;4913.48408417111;4992.80028798844 03:22:13 INFO - PROCESS | 1648 | |4;prototype.html;298.8296670897588;299.3489161074662;307.4036369443279;310.0512431958208;312.87954137656993;5108.310378098956;5139.946311006244;5223.973880130598;5300.973495132524;5320.547753440957;4342.001339691873;4985.277134815449;5062.367204099488;5129.435762066169;5137.768800403981;3988.7207895447405;4004.799760011988;4024.356103023517;4029.3150164471963;4038.1116154445976;3772.4718539404507;3809.6190380961957;3811.5997820228895;4001.339778936472;4003.65968892643;3455.8272086395705;3608.0438683748825;3873.690104791624;4010.1177740896956;4059.3302105152616;3587.910302242439;3967.26605577969;3967.3652215645357;3973.3443981742976;3975.978256525033;3190.011096560074;3477.1828620274214;3484.4250698634696;3494.4408894576745;3496;4695.436547614308;4886.731229782361;5032.671902164136;5055.494450554952;5151.948480515184;4452.443444569429;4544.363789069533;4550.931736023962;4559.52125026874;4574.839880604196;5408.513233808976;5438.592105592096;5458.235846981426;5494.780208791643;5498.230247765316;3276.3774882772195;3639.344917914774;3834.8082595870096;3839.596842331543;3877.592852750477;4660.930086048712;4821.059893320804;5689.459501347365;5736.684482353469;5804;3390.881319153818;3504.474328850693;3920.7843568604;3986.8836725716847;4011.29802284599;4000.2999475092324;4000.879973600797;4014.895903626526;4018.095928416083;4029.778362190049;3681.5214022177483;3989.6608788253325;4364.890877728082;4540.320081569775;4585.518520555361;5176.378834539804;5201.245819356172;5507;5538;5544.750486228129;1235;1256.327864592457;1279.6736832107938;1294.7216348485122;1307.6730817295677;891.4873947480224;903.4579252448478;904.7331037344;910.988802429303;920.0265430651216;4120.381942708617;4175.415441838145;4959.752012399365;4971.1797553403285;4989.90020199594;4897.41231052276;5070.340855688737;5198.518422249641;5467.835964920979;5542.944570554324;4393.384926110347;4630.842289427643;4871.561559459595;4940.307532394853;4972.2790195422185;2248.8313376496826;2544.8854801533976;2808.4413150701557;2814.5356016257088;2837.4892519346304;5144;5291.788328466895;5336.504589493888;5598.412166722517;5603.159526071122;4713.34013238147;4934.361700001987;5530.253415788898;5555.666660000413;5560;4768.1616298879735;4783.641226907996;5103.7846156920905;5599.944000560024;5609.579281553818;4315.546867578984;4709.905801884011;4743.742908129279;5179.326687530597;5317.2555842181355;4555.476120246081;5256.395514515727;5286.471352864683;5305.628605997543;5315.335583052119;5394.842063174761;5577.183522321202;5583.637063590853;5608.915866262091;5612.887742245214;3100.366008515264;3734.5891951885815;3741.7754934702916;3760.473533705338;3761.962380376161;4463.598276155161;5027.874303142305;5177.948220517897;5393.438116894444;5407.378151512469;5109.156989096758;5270.393904700855;5291.76187071575;5293.894122117459;5316.129290183258;4359.585839345384;4601.470830854495;4702.636146508583;5076.771545280398;5202.531772140525;4281.97859010703;4285.657147428261;4620.283856002325;5208.609354298367;5321.760520776497;4917.508249175054;4928.211486162197;5044.2685810558;5188.481151884781;5507.339119305709;5343.919841202307;5351.197320401815;5394.352677678704;5394.541463975449;5436.994156081138 03:22:13 INFO - PROCESS | 1648 | |5;yui.html;635.6376865186844;691.2810676896027;750.6209364271045;751.5302935665209;784.690047431265;14042.789358159624;14840.480583179591;14853.851461485381;14886.181260030708;14919.32863021164;13172.538961136363;13347.666308342295;13526;13552.593422197326;13560.660983475418;656.917885264342;680.1430197950593;806.7902345390212;815.7185770909042;840.5419046619577;823.3454403749004;843.3674743942044;844.1558441558442;846.8306338732248;848.6393282854793;843.2747836860295;858.527809704663;897.5287973813768;899.6491368366343;901.7384958362068;673.9561928474634;710.2684235237714;840.5881118252044;841.1084250694283;894.9821003579924;644.4618743349309;646.240667216024;657.4149007383432;661.7617657643244;661.9007148927651;14319.642008949755;14335.42658293667;14338.068025578305;14353;14382.352794124185;13228.669283267898;13247.867521324759;13325.800112998313;13346.998975076907;13380.86619133806;11994.70013249667;12166.51333946641;12278.263304201777;12295.754084918251;12514.136819502095;4171.186618609372;4190.664746820277;4450.154470650566;4495;4504;79657.99999999942;94644;97972;98580;98691;10521.526531305957;10567.577296908192;10611.734706632396;10616.787664246825;11058.502367393487;20386.592268154553;20421.89789051075;20443.38669839907;20504.897475512826;20525.89737051335;7507.962460187664;7549.886751698729;7592.240775922474;7670.27132422419;7823.100343460461;3972.324704800191;3982.303096958021;4198.6641068714425;4222.261104306734;4394.209042372339;3182.840857957139;3291.1113999220074;3294.1270563300745;3297.5383446317533;3298.868045278162;524.4281880151073;625.8623102917351;632.3139393757732;632.5319263744796;633.9144215530845;543.3398420918523;606.4905479397239;610.6916007416227;622.4802290087737;635.3741564558906;8254.257116859391;8291.875621865676;8645.567721613894;8650.394472386872;8754.47473151613;525.5506541906691;549.0611055095751;575.576950941058;627.1126356205917;630.5271046714964;3967.543732470745;4098.754074755524;4322.502912165141;4651;4961.603071754251;107518;108290.45854770833;112220.43889780498;116059;116059.6788064234;98436.50781746046;99010;100078;101846;102292.48853755684;82917;87337.56331218303;87446.56276718703;88666;89945.55027224822;7078.823029424306;8914.910850891409;9187.356885017985;9488.430694158373;9507.429554226492;49135.52593422203;54471.45528544664;54859.72570137124;55340.16989745077;57795.55511112256;54957.175642366194;61227.69386153041;61695.6915215421;71934;76540;12380.566680166152;12603.369831508571;12605.180663256859;12641.87358126407;13069.542566010525;13963.650908727363;14204.218767967861;14386.712265754835;14605.269736512919;14669.633259168606;12963.481460741465;12979.00600678011;13194.472221111047;13212.471501139848;13385.464581416634;12963.481460741465;13036;13322.527879562558;13326.33368331599;13708.93145534266;12570.994320454525;12854.421551030413;12858.42137103814;13137.34313284351;13590.252536110609;9987.800243995225;10091.69724908254;10985.231033827875;11128.293641687727;11648.472644490072;10631.627893023708;10833.729156770829;11211.943940280247;11224.551017959517;11338.319700817978 03:22:13 INFO - PROCESS | 1648 | __end_tp_report 03:22:13 INFO - PROCESS | 1648 | __start_cc_report 03:22:13 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1853 03:22:13 INFO - PROCESS | 1648 | __end_cc_report 03:22:13 INFO - PROCESS | 1648 | __startTimestamp1479986533292__endTimestamp 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | ------- Summary: start ------- 03:22:13 INFO - PROCESS | 1648 | Number of tests: 6 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5734.70 Median:5946.00 stddev:660.14 (11.1%) stddev-sans-first:635.00 03:22:13 INFO - PROCESS | 1648 | Values: 3345.2 3360.4 3384.2 3405.7 3439.9 5619.0 5664.6 5721.5 5773.2 5782.8 5697.4 5699.7 5796.2 5819.7 5846.4 5138.0 5154.6 5182.0 5244.1 5264.0 4242.2 4576.5 5316.4 5348.3 5364.1 5161.8 5306.2 5323.0 5324.2 5406.7 5148.9 5259.0 5263.1 5265.7 5280.8 4343.2 5151.5 5223.8 5230.6 5241.9 5737.5 5741.9 5751.2 5753.1 5753.4 6140.0 6196.8 6202.9 6226.6 6227.5 4937.2 6285.6 6296.2 6304.1 6308.6 5740.4 5830.0 5830.7 5834.8 5839.2 6166.0 6244.3 6270.7 6274.7 6281.4 6095.4 6101.8 6114.3 6138.8 6141.6 5257.8 6192.6 6227.2 6255.2 6270.9 6246.8 6248.2 6251.2 6259.4 6267.6 6277.2 6279.2 6280.2 6286.0 6286.4 4865.1 4918.2 4925.3 4929.1 5009.2 4384.5 4414.6 4418.1 4441.0 4463.6 5738.5 5758.2 5854.6 5866.6 5870.8 6139.2 6152.0 6242.6 6248.3 6281.0 5735.9 5785.3 5787.9 5826.6 5828.1 5428.7 5435.6 5435.6 5436.6 5470.0 6281.9 6282.5 6314.1 6332.7 6334.5 6162.0 6212.7 6219.7 6235.2 6278.2 6222.5 6263.8 6291.7 6327.7 6360.9 5005.3 5923.6 6216.2 6228.9 6250.1 6161.2 6200.1 6291.7 6302.1 6312.2 6099.6 6112.5 6122.5 6136.6 6139.0 6161.0 6163.8 6182.3 6183.3 6187.9 5946.0 6053.7 6055.2 6076.4 6100.9 5689.7 6175.6 6180.8 6187.5 6191.7 5497.4 5601.2 5984.0 6061.5 6064.4 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:65000.53 Median:37024.04 stddev:138486.20 (374.0%) stddev-sans-first:138789.99 03:22:13 INFO - PROCESS | 1648 | Values: 486.9 488.8 510.0 512.3 526.3 30084.8 37464.9 38769.8 38884.8 41768.4 40471.8 40942.0 41024.0 41198.6 41221.2 8430.7 9181.7 9355.6 9355.8 9372.7 8403.7 10985.1 11264.2 11304.9 11446.7 11221.7 11286.6 11291.9 11302.0 11303.5 11135.6 11223.0 11270.0 11310.4 11329.7 11078.6 11137.8 11142.9 11164.6 11175.2 37988.2 38298.0 38299.4 38349.8 38359.8 3439.2 3517.7 3749.3 3853.3 3871.3 28876.3 29728.4 29825.9 30078.1 30531.0 3166.7 3174.3 3198.1 3227.2 3268.3 395167.0 492573.0 500530.0 500723.0 501898.0 55718.7 56110.0 56143.7 56160.0 56193.7 58380.0 58499.4 58503.1 58530.8 58533.7 15133.0 15629.2 15655.5 15681.8 15694.0 11034.1 11303.6 11995.1 12228.4 12326.6 14358.1 14752.2 14765.3 14927.9 14933.1 6082.3 6092.1 6132.8 6135.2 6135.4 817.6 927.2 974.4 993.5 1001.7 24938.4 28713.3 28787.9 29328.3 30131.0 1019.4 1021.8 1099.8 1100.7 1108.3 14319.4 14876.0 14894.1 15208.5 15268.8 615663.0 619015.0 620417.0 621106.0 621631.0 54769.0 54870.2 54954.5 55003.4 55119.4 1189.6 1235.6 1306.2 1344.0 1345.9 28423.9 29644.1 29787.0 30393.9 30514.5 46618.8 47216.8 47291.5 47302.8 47407.0 386622.0 452266.0 452849.0 454008.0 455857.0 35812.5 37003.6 37201.3 37227.8 37250.0 44013.0 44629.1 46158.5 47532.3 47734.8 36535.5 36900.4 37093.8 37987.2 38479.6 36197.3 37044.4 37638.4 38240.0 40507.4 36612.0 36679.9 36931.8 37340.0 37587.2 32221.0 32861.4 33749.7 33854.8 33902.7 24648.0 24769.6 24774.4 24907.8 25077.9 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34209.27 Median:320.86 stddev:95961.79 (29907.7%) stddev-sans-first:96197.25 03:22:13 INFO - PROCESS | 1648 | Values: 319.8 321.9 350.4 370.9 398.3 14729.9 15364.2 16662.8 20000.8 20017.0 19034.6 19492.2 19520.5 19546.9 19579.9 5496.1 5696.8 5704.8 5715.4 5723.3 4005.8 4185.0 4254.0 5712.9 6347.4 6090.6 6291.1 6353.3 6363.2 6404.0 6281.9 6309.7 6342.3 6353.1 6363.3 5234.3 5370.9 5448.3 5480.7 5485.9 24718.0 24786.6 24800.8 25016.0 25105.6 2062.4 2382.2 2435.2 2453.6 2789.7 9677.0 9679.5 9747.0 10108.9 10166.0 1552.5 1800.2 1811.6 1855.2 1902.5 117794.0 127939.0 129095.4 130113.0 130224.0 10992.5 11084.3 11215.6 11233.8 11450.9 14225.8 14249.2 14261.6 14266.6 14267.2 6688.7 8082.2 8198.1 8198.8 8419.2 6579.0 8104.4 8265.2 8280.5 8334.4 4314.3 4409.2 4410.1 4460.4 4461.2 1615.8 1864.6 1874.8 1881.4 1881.5 858.7 921.9 936.2 937.4 1025.6 19355.4 19911.8 19989.4 20062.1 20287.6 914.4 918.7 921.1 980.4 1004.9 8906.5 10041.4 10534.3 10542.8 10570.9 559066.0 566306.0 568123.0 578937.0 580392.0 129874.0 130714.7 130957.7 134943.0 135334.0 964.0 968.7 1005.2 1007.1 1008.4 17366.5 17446.7 17582.0 17649.2 17850.6 52377.5 53625.0 53641.0 53890.0 55507.4 76347.6 76355.0 78538.0 79052.0 79802.2 7488.0 7549.4 7743.8 7840.1 8019.0 10635.1 11017.9 11882.2 11956.0 12050.1 9949.2 9954.4 10165.4 10212.9 10381.2 9697.4 9953.0 9995.2 10116.6 10186.6 10096.2 10233.4 10387.9 10449.4 10604.4 6576.5 7456.8 7653.4 7669.6 7897.2 8500.8 10015.9 10105.0 10218.4 10444.8 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5399.60 Median:5206.53 stddev:2965.15 (57.0%) stddev-sans-first:2957.08 03:22:13 INFO - PROCESS | 1648 | Values: 1250.8 1461.0 1477.3 1615.9 1797.8 6925.1 7898.5 8090.2 8413.1 8460.8 8288.0 8298.3 8370.4 8388.6 8398.2 2009.7 2260.7 2306.9 2311.5 2312.4 2110.8 2228.2 2321.7 2332.4 2337.2 2214.9 2226.9 2256.8 2263.7 2266.3 2287.3 2313.6 2315.0 2318.8 2320.9 2300.4 2344.9 2347.4 2351.2 2361.2 8067.5 8250.3 8271.4 8275.8 8278.3 5042.6 5201.0 5203.1 5211.9 5212.5 3246.9 3454.3 3495.7 3530.3 3541.5 998.3 1037.7 1056.4 1072.8 1080.3 10463.8 10655.7 10848.2 10857.3 10860.2 4494.6 4574.7 4620.1 4646.1 4647.9 9457.4 9478.1 9495.4 9498.2 9509.0 5201.3 5210.0 5215.5 5221.4 5227.1 4314.7 4470.2 4674.7 4719.2 4758.1 3563.8 3712.1 3832.9 3854.2 3855.9 1198.8 1245.4 1250.2 1250.8 1259.3 799.9 867.8 889.7 925.1 932.3 5485.7 5533.8 5588.1 5676.8 5877.2 897.3 905.7 915.1 930.5 978.8 3675.4 3678.8 3782.8 3804.4 3937.1 9593.5 10158.5 10178.8 10209.7 10223.5 9502.2 9982.0 9982.7 10110.6 10119.4 7613.1 7732.2 7769.8 7852.9 7878.8 4631.3 4833.3 5421.2 5544.8 5652.8 9048.4 9146.0 9221.4 9236.1 9498.1 9465.0 9473.3 9478.0 9499.4 9578.6 7111.0 7147.0 7194.1 7239.7 7257.9 6565.9 7161.8 7869.0 7936.0 7982.3 6078.5 6133.8 7030.9 7034.0 7245.3 7009.5 7030.2 7036.5 7094.6 7170.3 6422.0 6615.6 6721.0 6729.0 6733.7 4730.1 4798.2 4814.3 4878.1 5004.0 4384.3 4515.0 4804.1 4913.5 4992.8 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4325.83 Median:4802.35 stddev:1294.06 (26.9%) stddev-sans-first:1261.90 03:22:13 INFO - PROCESS | 1648 | Values: 298.8 299.3 307.4 310.1 312.9 5108.3 5139.9 5224.0 5301.0 5320.5 4342.0 4985.3 5062.4 5129.4 5137.8 3988.7 4004.8 4024.4 4029.3 4038.1 3772.5 3809.6 3811.6 4001.3 4003.7 3455.8 3608.0 3873.7 4010.1 4059.3 3587.9 3967.3 3967.4 3973.3 3976.0 3190.0 3477.2 3484.4 3494.4 3496.0 4695.4 4886.7 5032.7 5055.5 5151.9 4452.4 4544.4 4550.9 4559.5 4574.8 5408.5 5438.6 5458.2 5494.8 5498.2 3276.4 3639.3 3834.8 3839.6 3877.6 4660.9 4821.1 5689.5 5736.7 5804.0 3390.9 3504.5 3920.8 3986.9 4011.3 4000.3 4000.9 4014.9 4018.1 4029.8 3681.5 3989.7 4364.9 4540.3 4585.5 5176.4 5201.2 5507.0 5538.0 5544.8 1235.0 1256.3 1279.7 1294.7 1307.7 891.5 903.5 904.7 911.0 920.0 4120.4 4175.4 4959.8 4971.2 4989.9 4897.4 5070.3 5198.5 5467.8 5542.9 4393.4 4630.8 4871.6 4940.3 4972.3 2248.8 2544.9 2808.4 2814.5 2837.5 5144.0 5291.8 5336.5 5598.4 5603.2 4713.3 4934.4 5530.3 5555.7 5560.0 4768.2 4783.6 5103.8 5599.9 5609.6 4315.5 4709.9 4743.7 5179.3 5317.3 4555.5 5256.4 5286.5 5305.6 5315.3 5394.8 5577.2 5583.6 5608.9 5612.9 3100.4 3734.6 3741.8 3760.5 3762.0 4463.6 5027.9 5177.9 5393.4 5407.4 5109.2 5270.4 5291.8 5293.9 5316.1 4359.6 4601.5 4702.6 5076.8 5202.5 4282.0 4285.7 4620.3 5208.6 5321.8 4917.5 4928.2 5044.3 5188.5 5507.3 5343.9 5351.2 5394.4 5394.5 5437.0 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20782.79 Median:4358.36 stddev:30691.81 (704.2%) stddev-sans-first:30740.62 03:22:13 INFO - PROCESS | 1648 | Values: 635.6 691.3 750.6 751.5 784.7 14042.8 14840.5 14853.9 14886.2 14919.3 13172.5 13347.7 13526.0 13552.6 13560.7 656.9 680.1 806.8 815.7 840.5 823.3 843.4 844.2 846.8 848.6 843.3 858.5 897.5 899.6 901.7 674.0 710.3 840.6 841.1 895.0 644.5 646.2 657.4 661.8 661.9 14319.6 14335.4 14338.1 14353.0 14382.4 13228.7 13247.9 13325.8 13347.0 13380.9 11994.7 12166.5 12278.3 12295.8 12514.1 4171.2 4190.7 4450.2 4495.0 4504.0 79658.0 94644.0 97972.0 98580.0 98691.0 10521.5 10567.6 10611.7 10616.8 11058.5 20386.6 20421.9 20443.4 20504.9 20525.9 7508.0 7549.9 7592.2 7670.3 7823.1 3972.3 3982.3 4198.7 4222.3 4394.2 3182.8 3291.1 3294.1 3297.5 3298.9 524.4 625.9 632.3 632.5 633.9 543.3 606.5 610.7 622.5 635.4 8254.3 8291.9 8645.6 8650.4 8754.5 525.6 549.1 575.6 627.1 630.5 3967.5 4098.8 4322.5 4651.0 4961.6 107518.0 108290.5 112220.4 116059.0 116059.7 98436.5 99010.0 100078.0 101846.0 102292.5 82917.0 87337.6 87446.6 88666.0 89945.6 7078.8 8914.9 9187.4 9488.4 9507.4 49135.5 54471.5 54859.7 55340.2 57795.6 54957.2 61227.7 61695.7 71934.0 76540.0 12380.6 12603.4 12605.2 12641.9 13069.5 13963.7 14204.2 14386.7 14605.3 14669.6 12963.5 12979.0 13194.5 13212.5 13385.5 12963.5 13036.0 13322.5 13326.3 13708.9 12571.0 12854.4 12858.4 13137.3 13590.3 9987.8 10091.7 10985.2 11128.3 11648.5 10631.6 10833.7 11211.9 11224.6 11338.3 03:22:13 INFO - PROCESS | 1648 | -------- Summary: end -------- 03:22:13 INFO - PROCESS | 1648 | 03:22:13 INFO - TEST-INFO | 1648: exit 0 03:22:13 INFO - TEST-OK | dromaeo_css | took 1120481ms 03:22:13 INFO - TEST-START | kraken 03:22:13 INFO - operating with platform_type : mac_ 03:22:13 INFO - Initialising browser for kraken test... 03:22:13 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpss5eTZ/profile http://localhost:49236/getInfo.html) 03:22:16 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 03:22:16 INFO - PROCESS | 1653 | colorDepth:24 03:22:16 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 03:22:16 INFO - PROCESS | 1653 | __metrics 03:22:16 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:22:16 INFO - PROCESS | 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:22:17 INFO - TEST-INFO | 1653: exit 0 03:22:17 INFO - Browser initialized. 03:22:17 INFO - Running cycle 1/1 for kraken test... 03:22:17 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/T/tmpss5eTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:22:29 INFO - PROCESS | 1654 | RSS: Main: 265625600 03:22:29 INFO - PROCESS | 1654 | 03:22:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 03:22:33 INFO - PROCESS | 1654 | RSS: Main: 313376768 03:22:33 INFO - PROCESS | 1654 | 03:22:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 03:22:36 INFO - PROCESS | 1654 | RSS: Main: 314433536 03:22:36 INFO - PROCESS | 1654 | 03:22:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 03:22:40 INFO - PROCESS | 1654 | RSS: Main: 402948096 03:22:40 INFO - PROCESS | 1654 | 03:22:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 03:22:43 INFO - PROCESS | 1654 | RSS: Main: 304529408 03:22:43 INFO - PROCESS | 1654 | 03:22:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:22:45 INFO - PROCESS | 1654 | RSS: Main: 308129792 03:22:45 INFO - PROCESS | 1654 | 03:22:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 03:22:49 INFO - PROCESS | 1654 | RSS: Main: 349667328 03:22:49 INFO - PROCESS | 1654 | 03:22:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 03:22:52 INFO - PROCESS | 1654 | RSS: Main: 351465472 03:22:52 INFO - PROCESS | 1654 | 03:22:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 03:22:56 INFO - PROCESS | 1654 | RSS: Main: 347750400 03:22:56 INFO - PROCESS | 1654 | 03:22:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:22:58 INFO - PROCESS | 1654 | RSS: Main: 326664192 03:22:58 INFO - PROCESS | 1654 | 03:23:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:23:01 INFO - PROCESS | 1654 | RSS: Main: 328876032 03:23:01 INFO - PROCESS | 1654 | 03:23:03 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:23:04 INFO - PROCESS | 1654 | RSS: Main: 330240000 03:23:04 INFO - PROCESS | 1654 | 03:23:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:23:08 INFO - PROCESS | 1654 | RSS: Main: 348004352 03:23:08 INFO - PROCESS | 1654 | 03:23:11 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:23:11 INFO - PROCESS | 1654 | RSS: Main: 341680128 03:23:11 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 03:23:13 INFO - PROCESS | 1654 | RSS: Main: 385335296 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | __start_tp_report 03:23:13 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 03:23:13 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 03:23:13 INFO - PROCESS | 1654 | |i|pagename|runs| 03:23:13 INFO - PROCESS | 1654 | |0;ai-astar;115;116;117;116;116;116;116;115;117;114 03:23:13 INFO - PROCESS | 1654 | |1;audio-beat-detection;139;111;112;147;116;108;112;113;128;112 03:23:13 INFO - PROCESS | 1654 | |2;audio-dft;184;187;185;184;184;183;181;182;184;183 03:23:13 INFO - PROCESS | 1654 | |3;audio-fft;79;59;59;85;59;60;62;59;106;80 03:23:13 INFO - PROCESS | 1654 | |4;audio-oscillator;89;70;89;70;68;69;82;69;69;83 03:23:13 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;88;86;89;86;88;85;89;86;89;85 03:23:13 INFO - PROCESS | 1654 | |6;imaging-darkroom;95;96;97;98;97;98;96;97;96;97 03:23:13 INFO - PROCESS | 1654 | |7;imaging-desaturate;86;86;87;85;87;85;86;85;87;85 03:23:13 INFO - PROCESS | 1654 | |8;json-parse-financial;57;55;54;52;54;54;54;53;72;78 03:23:13 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;66;73;77;76;74;75;99;101;88;71 03:23:13 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;89;90;105;107;106;83;91;86;88;88 03:23:13 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;140;152;154;143;136;156;170;162;219;177 03:23:13 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;177;175;181;175;176;173;218;188;173;227 03:23:13 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;66;68;67;67;67;68;68;66;66;67 03:23:13 INFO - PROCESS | 1654 | __end_tp_report 03:23:13 INFO - PROCESS | 1654 | __start_cc_report 03:23:13 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2012 03:23:13 INFO - PROCESS | 1654 | __end_cc_report 03:23:13 INFO - PROCESS | 1654 | __startTimestamp1479986593732__endTimestamp 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | ------- Summary: start ------- 03:23:13 INFO - PROCESS | 1654 | Number of tests: 14 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 03:23:13 INFO - PROCESS | 1654 | Values: 115.0 116.0 117.0 116.0 116.0 116.0 116.0 115.0 117.0 114.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:114.50 stddev:13.48 (11.8%) stddev-sans-first:12.38 03:23:13 INFO - PROCESS | 1654 | Values: 139.0 111.0 112.0 147.0 116.0 108.0 112.0 113.0 128.0 112.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.00 stddev:1.64 (0.9%) stddev-sans-first:1.73 03:23:13 INFO - PROCESS | 1654 | Values: 184.0 187.0 185.0 184.0 184.0 183.0 181.0 182.0 184.0 183.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:70.80 Median:61.00 stddev:16.14 (26.5%) stddev-sans-first:16.84 03:23:13 INFO - PROCESS | 1654 | Values: 79.0 59.0 59.0 85.0 59.0 60.0 62.0 59.0 106.0 80.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:76.00 stddev:8.85 (11.7%) stddev-sans-first:8.00 03:23:13 INFO - PROCESS | 1654 | Values: 89.0 70.0 89.0 70.0 68.0 69.0 82.0 69.0 69.0 83.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:1.66 (1.9%) stddev-sans-first:1.73 03:23:13 INFO - PROCESS | 1654 | Values: 88.0 86.0 89.0 86.0 88.0 85.0 89.0 86.0 89.0 85.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:96.70 Median:97.00 stddev:0.95 (1.0%) stddev-sans-first:0.78 03:23:13 INFO - PROCESS | 1654 | Values: 95.0 96.0 97.0 98.0 97.0 98.0 96.0 97.0 96.0 97.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:0.88 (1.0%) stddev-sans-first:0.93 03:23:13 INFO - PROCESS | 1654 | Values: 86.0 86.0 87.0 85.0 87.0 85.0 86.0 85.0 87.0 85.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:54.50 stddev:9.01 (16.5%) stddev-sans-first:9.54 03:23:13 INFO - PROCESS | 1654 | Values: 57.0 55.0 54.0 52.0 54.0 54.0 54.0 53.0 72.0 78.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:80.00 Median:75.50 stddev:11.92 (15.8%) stddev-sans-first:11.51 03:23:13 INFO - PROCESS | 1654 | Values: 66.0 73.0 77.0 76.0 74.0 75.0 99.0 101.0 88.0 71.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:88.00 stddev:9.04 (10.3%) stddev-sans-first:9.46 03:23:13 INFO - PROCESS | 1654 | Values: 89.0 90.0 105.0 107.0 106.0 83.0 91.0 86.0 88.0 88.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:160.90 Median:159.00 stddev:24.15 (15.2%) stddev-sans-first:24.40 03:23:13 INFO - PROCESS | 1654 | Values: 140.0 152.0 154.0 143.0 136.0 156.0 170.0 162.0 219.0 177.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.30 Median:179.00 stddev:19.70 (11.0%) stddev-sans-first:20.61 03:23:13 INFO - PROCESS | 1654 | Values: 177.0 175.0 181.0 175.0 176.0 173.0 218.0 188.0 173.0 227.0 03:23:13 INFO - PROCESS | 1654 | 03:23:13 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 03:23:13 INFO - PROCESS | 1654 | Values: 66.0 68.0 67.0 67.0 67.0 68.0 68.0 66.0 66.0 67.0 03:23:13 INFO - PROCESS | 1654 | -------- Summary: end -------- 03:23:13 INFO - PROCESS | 1654 | 03:23:14 INFO - TEST-INFO | 1654: exit 0 03:23:14 INFO - TEST-OK | kraken | took 60839ms 03:23:14 INFO - SUITE-END | took 1181s 03:23:14 INFO - Completed test suite (00:19:41) 03:23:14 INFO - javascript benchmark 03:23:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3345.2305969626987, 3360.42872711639, 3384.2047118927035, 3405.6764607362293, 3439.896803095908, 5618.971905140468, 5664.603477756558, 5721.456461636149, 5773.220615216945, 5782.826515204545, 5697.373288938214, 5699.658020518772, 5796.159556864252, 5819.738111784969, 5846.4445877641665, 5138.0, 5154.639175257734, 5182.0, 5244.134717771563, 5264.0, 4242.215190189825, 4576.519465456129, 5316.362036555619, 5348.277982472375, 5364.088105022156, 5161.793528258865, 5306.204069389584, 5323.0, 5324.201369794523, 5406.702631355274, 5148.897022059537, 5259.0, 5263.0526505229045, 5265.710385928773, 5280.815171469018, 4343.2399330117105, 5151.484851514856, 5223.843284701465, 5230.555402790767, 5241.86895327616, 5737.483626473638, 5741.856453588652, 5751.194832723422, 5753.108268218391, 5753.395893431171, 6139.952147135068, 6196.783112591038, 6202.875942481171, 6226.564140510166, 6227.532935029891, 4937.185364414867, 6285.622862628211, 6296.244450665904, 6304.054391841215, 6308.621482711006, 5740.425957404268, 5830.0380437227805, 5830.679312637803, 5834.795782147605, 5839.153322768175, 6165.969170154121, 6244.344343843922, 6270.749170033238, 6274.6548939808745, 6281.403266689657, 6095.377886651315, 6101.768966869689, 6114.297368146176, 6138.754449821957, 6141.600795948339, 5257.7896884124975, 6192.5974811638, 6227.221597300338, 6255.218097737783, 6270.874582508324, 6246.781362652377, 6248.187735594434, 6251.156093927352, 6259.436650701458, 6267.592606480655, 6277.2153480814895, 6279.183706118175, 6280.152179455807, 6285.968570157212, 6286.371362863769, 4865.051314993613, 4918.1884988977135, 4925.261210818406, 4929.112759703216, 5009.198528235464, 4384.495782984934, 4414.580614841585, 4418.116376724668, 4441.022974945507, 4463.642908567307, 5738.454846789548, 5758.165066065397, 5854.648721076749, 5866.6480011199465, 5870.7945221917025, 6139.171211886338, 6151.9692401538605, 6242.563020588515, 6248.343923888017, 6281.0, 5735.8566035849435, 5785.334686511021, 5787.8553036174435, 5826.621269617462, 5828.125781132864, 5428.701421421781, 5435.565154787608, 5435.565154787608, 5436.565074794007, 5470.0, 6281.937180628227, 6282.528810339151, 6314.1160237565855, 6332.746690132435, 6334.461570766352, 6161.969190154021, 6212.658303793335, 6219.689015549295, 6235.189425374672, 6278.246610406781, 6222.471089957405, 6263.812085637438, 6291.6539590321145, 6327.683615819098, 6360.904586431115, 5005.324281221989, 5923.607952131159, 6216.191895053614, 6228.937710622836, 6250.093736408105, 6161.168242287234, 6200.100985357189, 6291.716872740829, 6302.054691796084, 6312.179416675803, 6099.634021958696, 6112.510999119971, 6122.459144589048, 6136.631802091889, 6139.0, 6160.952638051453, 6163.7842675506145, 6182.258129024546, 6183.258009038944, 6187.948048831619, 5946.0, 6053.727582258721, 6055.161261342324, 6076.422739839708, 6100.8779824404155, 5689.6586204827845, 6175.62946223228, 6180.783672571618, 6187.504999599932, 6191.659458729813, 5497.39528651856, 5601.215829783915, 5984.0, 6061.454469097626, 6064.363241859718], "value": 5693.414098965535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.90261947610475, 488.7580647579446, 509.98470045898614, 512.2623422271926, 526.3394439977827, 30084.84957575212, 37464.8760537184, 38769.80615096928, 38884.80557597208, 41768.37347439791, 40471.79764101183, 40942.0, 41024.0, 41198.58801411985, 41221.17557648845, 8430.662773489054, 9181.678641247541, 9355.625774968994, 9355.766105847375, 9372.718818435458, 8403.70587029451, 10985.121190304797, 11264.21150519464, 11304.943475282653, 11446.71383215422, 11221.66335009951, 11286.604968826092, 11291.887081129165, 11302.0, 11303.491342889549, 11135.610253641084, 11223.046041086518, 11269.985701286842, 11310.37792921389, 11329.716757081056, 11078.556857725682, 11137.777244455065, 11142.944285278521, 11164.609238676607, 11175.21773475857, 37988.240235195415, 38298.042548936224, 38299.425508617394, 38349.80825095884, 38359.808200959094, 3439.1574064354145, 3517.683408493248, 3749.287635349302, 3853.2678791029616, 3871.264459752666, 28876.27809304784, 29728.405431891457, 29825.850870745726, 30078.097657070324, 30531.0, 3166.746660267196, 3174.2857856982223, 3198.0885447647543, 3227.177069847174, 3268.3299923515624, 395167.0, 492573.0, 500530.0, 500722.99999999633, 501898.0, 55718.72140639271, 56110.0, 56143.71928140333, 56160.0, 56193.7190314054, 58380.0, 58499.4150058494, 58503.12245316324, 58530.82938341209, 58533.70733146307, 15133.0, 15629.218539073001, 15655.452059178102, 15681.764773528406, 15694.0, 11034.117270618332, 11303.604373846876, 11995.1003674723, 12228.388580570936, 12326.630201093982, 14358.138511689333, 14752.188629625474, 14765.261736913111, 14927.850721492647, 14933.088047830568, 6082.300535438481, 6092.0833789799935, 6132.754689812357, 6135.202423684892, 6135.417135372132, 817.5789468423767, 927.1582599333022, 974.449436068619, 993.4833886379187, 1001.6944831826363, 24938.37654058663, 28713.277203367863, 28787.85606071956, 29328.26679333034, 30131.0, 1019.3883669798211, 1021.7752094539189, 1099.8130317845985, 1100.6863044032411, 1108.3349990005931, 14319.427222911176, 14876.0, 14894.106353618818, 15208.46770363032, 15268.770968435483, 615663.0, 619015.0, 620417.0, 621106.0, 621631.0, 54769.0, 54870.17694734582, 54954.45045549573, 55003.44996550064, 55119.448805512235, 1189.6133756529164, 1235.6293112066344, 1306.151001848806, 1343.9596812095458, 1345.9259740714158, 28423.85788071129, 29644.110676679735, 29787.0, 30393.936212232467, 30514.542281866234, 46618.76690616661, 47216.7639161802, 47291.52708472871, 47302.81742956454, 47407.0, 386622.0, 452266.0, 452849.0, 454008.0, 455857.0, 35812.462813058344, 37003.629963701096, 37201.25597487981, 37227.813860930524, 37250.0, 44013.0, 44629.10741785081, 46158.538414615425, 47532.2870156941, 47734.76132619315, 36535.45196822103, 36900.446493302086, 37093.81453092717, 37987.24025519529, 38479.61520384761, 36197.27605447929, 37044.44433333556, 37638.36531442773, 38240.0, 40507.3923891136, 36612.0, 36679.89960301195, 36931.81534092312, 37340.0, 37587.248255035294, 32221.0, 32861.35693215377, 33749.66250337465, 33854.830725846216, 33902.66097338995, 24648.014079436623, 24769.62845557354, 24774.38064048341, 24907.750922490544, 25077.87461062683], "value": 19578.29577139068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.8464736926275, 321.8738487192911, 350.40955989158255, 370.885025642051, 398.2850782844793, 14729.937808706776, 15364.231788410576, 16662.833371666296, 20000.799992000077, 20017.0, 19034.61930761384, 19492.22031118757, 19520.510282635, 19546.902265488654, 19579.90210048948, 5496.065668836288, 5696.77212911483, 5704.828855134353, 5715.399883012286, 5723.313202415695, 4005.759654420744, 4184.958150418503, 4254.0, 5712.857178570527, 6347.365263473662, 6090.5736598438125, 6291.087792270118, 6353.332900045498, 6363.172787537636, 6404.0, 6281.937180628203, 6309.716062777209, 6342.334054924213, 6353.078803573502, 6363.268224154189, 5234.319538460014, 5370.946290537084, 5448.264484294648, 5480.671159730429, 5485.890282194374, 24718.011279548977, 24786.628200577004, 24800.75996200201, 25016.0, 25105.62341564878, 2062.360668192865, 2382.2257766226044, 2435.208557218893, 2453.58289090855, 2789.693133755285, 9676.95161524195, 9679.516024198761, 9747.0, 10108.94945525275, 10166.0, 1552.5497605694447, 1800.189914538463, 1811.6467288878673, 1855.2393518657286, 1902.5338791995912, 117794.0, 127939.0, 129095.35452322772, 130113.0, 130224.0, 10992.461055452242, 11084.279521831055, 11215.60745373908, 11233.775324493465, 11450.885491145149, 14225.78661320081, 14249.216293103771, 14261.643458913402, 14266.643333916734, 14267.215303158426, 6688.665566721742, 8082.191780821989, 8198.081151309287, 8198.754037378889, 8419.158084191531, 6578.967105164444, 8104.39217058723, 8265.214804593554, 8280.544570048705, 8334.416590838584, 4314.331278651814, 4409.192231185199, 4410.117976404732, 4460.375547423363, 4461.174682683714, 1615.7737916691672, 1864.5525073982146, 1874.8031456696851, 1881.4355693292232, 1881.5484283771796, 858.7466697324304, 921.8617207418806, 936.241644268145, 937.4047479850344, 1025.6153942271649, 19355.4193374199, 19911.800881990996, 19989.401377820792, 20062.05687047488, 20287.594248114954, 914.4421902639517, 918.673870775865, 921.083521895718, 980.3725615606018, 1004.8593196952432, 8906.465612063297, 10041.447720375449, 10534.315269507457, 10542.789144217226, 10570.947145264225, 559066.0, 566306.0, 568123.0, 578937.0, 580392.0, 129874.0, 130714.69285307026, 130957.69042309455, 134943.0, 135334.0, 963.9903600964041, 968.6997030920437, 1005.1657124586576, 1007.0634310091685, 1008.4000019988096, 17366.52669466137, 17446.73829892578, 17582.0, 17649.205785739417, 17850.5537361567, 52377.47622523726, 53625.0, 53641.0, 53890.0, 55507.444925550226, 76347.61826190834, 76355.0, 78538.0, 79052.0, 79802.2019779818, 7488.0, 7549.433792465477, 7743.806404839924, 7840.098388685375, 8019.03771547418, 10635.14918806478, 11017.944910275397, 11882.16824822254, 11956.0, 12050.09624278165, 9949.214220018406, 9954.402735835873, 10165.390076595133, 10212.897871021194, 10381.169506439617, 9697.369670971364, 9953.0, 9995.200383969119, 10116.645917392856, 10186.592536298465, 10096.242781791248, 10233.385996840214, 10387.896121038693, 10449.425281609585, 10604.416757078434, 6576.506761992774, 7456.7762967111075, 7653.387728981779, 7669.578173200527, 7897.24976127267, 8500.829983400421, 10015.949920250643, 10104.989501049837, 10218.386896786216, 10444.791104178026], "value": 9214.309719190782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1250.8248845161672, 1460.963475913102, 1477.342582550765, 1615.8949668271562, 1797.8022417534062, 6925.099737034185, 7898.486598371109, 8090.190980901914, 8413.074561798212, 8460.830783384345, 8288.0, 8298.25315721585, 8370.372222083337, 8388.62251198696, 8398.244158025776, 2009.7085922541223, 2260.660900864867, 2306.9192578259763, 2311.4683622766775, 2312.36409987254, 2110.757262914769, 2228.2089858100385, 2321.698179236697, 2332.4052366646483, 2337.158622895765, 2214.900329485169, 2226.9109235630635, 2256.8194544436487, 2263.6830843681814, 2266.3427605994243, 2287.313805858244, 2313.618252988255, 2314.953700925989, 2318.7913087822008, 2320.8607483550873, 2300.3903965449167, 2344.941376465585, 2347.4131467133216, 2351.2005917987794, 2361.2207971369407, 8067.475614085066, 8250.298724608416, 8271.421000529965, 8275.793105172359, 8278.337732981347, 5042.621803364726, 5201.0, 5203.063448579254, 5211.895762084775, 5212.478752124795, 3246.8863589774246, 3454.3436747017986, 3495.7378196635354, 3530.3468858261303, 3541.5218945442293, 998.3211416236956, 1037.6835065305079, 1056.3820165203288, 1072.7961687279392, 1080.3409919948824, 10463.790724185474, 10655.733606659818, 10848.186386021001, 10857.34855908648, 10860.239783215178, 4494.617957473586, 4574.656900732459, 4620.052889157714, 4646.070785842778, 4647.907041859212, 9457.38526995743, 9478.052194780605, 9495.43027418357, 9498.19265362452, 9509.0, 5201.271821944931, 5210.0, 5215.478452154754, 5221.425643179247, 5227.111391063529, 4314.654827613784, 4470.195364834296, 4674.742889141062, 4719.174144524694, 4758.095961767253, 3563.7861728295866, 3712.1090938174643, 3832.869303555458, 3854.2484215577692, 3855.9228815424094, 1198.7902117129468, 1245.4333278358324, 1250.1561446023898, 1250.8373911391461, 1259.3199672177104, 799.8720204767326, 867.8481265778463, 889.7019498468086, 925.1118925831278, 932.2961164320894, 5485.670859748428, 5533.837894042296, 5588.1338392548405, 5676.772929082873, 5877.206577112121, 897.3314880414002, 905.6920646980059, 915.1260546178517, 930.4789317981952, 978.8091322192247, 3675.4486826976167, 3678.8043885737243, 3782.829772660237, 3804.3912973924594, 3937.0944682723134, 9593.520323983912, 10158.492075396349, 10178.847317290247, 10209.744756381002, 10223.539940702687, 9502.239820814319, 9982.001799820106, 9982.700518984442, 10110.595576177018, 10119.392836429837, 7613.124490683532, 7732.188120247518, 7769.844603107907, 7852.882206766903, 7878.833320836701, 4631.339395330753, 4833.32333473307, 5421.159720243369, 5544.833654990357, 5652.7738890443925, 9048.41185322952, 9146.0, 9221.354505184572, 9236.07639236098, 9498.14516693501, 9464.95267523658, 9473.289503287144, 9478.0, 9499.43003419797, 9578.557467845654, 7111.040009598638, 7146.964265178641, 7194.136703595602, 7239.746608868664, 7257.854842903007, 6565.901511477236, 7161.765365690752, 7869.016372953381, 7936.0, 7982.321502672105, 6078.513718902565, 6133.7546498141355, 7030.9296907030275, 7033.980072889504, 7245.311695388929, 7009.4579192579595, 7030.156381234285, 7036.5074444790425, 7094.574325540484, 7170.282971702788, 6422.0, 6615.636140012153, 6721.0, 6729.0, 6733.663316834237, 4730.148573256847, 4798.184308667465, 4814.325994360723, 4878.146324393288, 5003.974980125222, 4384.254676705032, 4515.006698526319, 4804.135255654016, 4913.48408417111, 4992.80028798844], "value": 4377.292257910384, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8296670897588, 299.3489161074662, 307.4036369443279, 310.0512431958208, 312.87954137656993, 5108.310378098956, 5139.946311006244, 5223.973880130598, 5300.973495132524, 5320.547753440957, 4342.001339691873, 4985.277134815449, 5062.367204099488, 5129.435762066169, 5137.768800403981, 3988.7207895447405, 4004.799760011988, 4024.356103023517, 4029.3150164471963, 4038.1116154445976, 3772.4718539404507, 3809.6190380961957, 3811.5997820228895, 4001.339778936472, 4003.65968892643, 3455.8272086395705, 3608.0438683748825, 3873.690104791624, 4010.1177740896956, 4059.3302105152616, 3587.910302242439, 3967.26605577969, 3967.3652215645357, 3973.3443981742976, 3975.978256525033, 3190.011096560074, 3477.1828620274214, 3484.4250698634696, 3494.4408894576745, 3496.0, 4695.436547614308, 4886.731229782361, 5032.671902164136, 5055.494450554952, 5151.948480515184, 4452.443444569429, 4544.363789069533, 4550.931736023962, 4559.52125026874, 4574.839880604196, 5408.513233808976, 5438.592105592096, 5458.235846981426, 5494.780208791643, 5498.230247765316, 3276.3774882772195, 3639.344917914774, 3834.8082595870096, 3839.596842331543, 3877.592852750477, 4660.930086048712, 4821.059893320804, 5689.459501347365, 5736.684482353469, 5804.0, 3390.881319153818, 3504.474328850693, 3920.7843568604, 3986.8836725716847, 4011.29802284599, 4000.2999475092324, 4000.879973600797, 4014.895903626526, 4018.095928416083, 4029.778362190049, 3681.5214022177483, 3989.6608788253325, 4364.890877728082, 4540.320081569775, 4585.518520555361, 5176.378834539804, 5201.245819356172, 5507.0, 5538.0, 5544.750486228129, 1235.0, 1256.327864592457, 1279.6736832107938, 1294.7216348485122, 1307.6730817295677, 891.4873947480224, 903.4579252448478, 904.7331037344, 910.988802429303, 920.0265430651216, 4120.381942708617, 4175.415441838145, 4959.752012399365, 4971.1797553403285, 4989.90020199594, 4897.41231052276, 5070.340855688737, 5198.518422249641, 5467.835964920979, 5542.944570554324, 4393.384926110347, 4630.842289427643, 4871.561559459595, 4940.307532394853, 4972.2790195422185, 2248.8313376496826, 2544.8854801533976, 2808.4413150701557, 2814.5356016257088, 2837.4892519346304, 5144.0, 5291.788328466895, 5336.504589493888, 5598.412166722517, 5603.159526071122, 4713.34013238147, 4934.361700001987, 5530.253415788898, 5555.666660000413, 5560.0, 4768.1616298879735, 4783.641226907996, 5103.7846156920905, 5599.944000560024, 5609.579281553818, 4315.546867578984, 4709.905801884011, 4743.742908129279, 5179.326687530597, 5317.2555842181355, 4555.476120246081, 5256.395514515727, 5286.471352864683, 5305.628605997543, 5315.335583052119, 5394.842063174761, 5577.183522321202, 5583.637063590853, 5608.915866262091, 5612.887742245214, 3100.366008515264, 3734.5891951885815, 3741.7754934702916, 3760.473533705338, 3761.962380376161, 4463.598276155161, 5027.874303142305, 5177.948220517897, 5393.438116894444, 5407.378151512469, 5109.156989096758, 5270.393904700855, 5291.76187071575, 5293.894122117459, 5316.129290183258, 4359.585839345384, 4601.470830854495, 4702.636146508583, 5076.771545280398, 5202.531772140525, 4281.97859010703, 4285.657147428261, 4620.283856002325, 5208.609354298367, 5321.760520776497, 4917.508249175054, 4928.211486162197, 5044.2685810558, 5188.481151884781, 5507.339119305709, 5343.919841202307, 5351.197320401815, 5394.352677678704, 5394.541463975449, 5436.994156081138], "value": 3920.138786354745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.6376865186844, 691.2810676896027, 750.6209364271045, 751.5302935665209, 784.690047431265, 14042.789358159624, 14840.480583179591, 14853.851461485381, 14886.181260030708, 14919.32863021164, 13172.538961136363, 13347.666308342295, 13526.0, 13552.593422197326, 13560.660983475418, 656.917885264342, 680.1430197950593, 806.7902345390212, 815.7185770909042, 840.5419046619577, 823.3454403749004, 843.3674743942044, 844.1558441558442, 846.8306338732248, 848.6393282854793, 843.2747836860295, 858.527809704663, 897.5287973813768, 899.6491368366343, 901.7384958362068, 673.9561928474634, 710.2684235237714, 840.5881118252044, 841.1084250694283, 894.9821003579924, 644.4618743349309, 646.240667216024, 657.4149007383432, 661.7617657643244, 661.9007148927651, 14319.642008949755, 14335.42658293667, 14338.068025578305, 14353.0, 14382.352794124185, 13228.669283267898, 13247.867521324759, 13325.800112998313, 13346.998975076907, 13380.86619133806, 11994.70013249667, 12166.51333946641, 12278.263304201777, 12295.754084918251, 12514.136819502095, 4171.186618609372, 4190.664746820277, 4450.154470650566, 4495.0, 4504.0, 79657.99999999942, 94644.0, 97972.0, 98580.0, 98691.0, 10521.526531305957, 10567.577296908192, 10611.734706632396, 10616.787664246825, 11058.502367393487, 20386.592268154553, 20421.89789051075, 20443.38669839907, 20504.897475512826, 20525.89737051335, 7507.962460187664, 7549.886751698729, 7592.240775922474, 7670.27132422419, 7823.100343460461, 3972.324704800191, 3982.303096958021, 4198.6641068714425, 4222.261104306734, 4394.209042372339, 3182.840857957139, 3291.1113999220074, 3294.1270563300745, 3297.5383446317533, 3298.868045278162, 524.4281880151073, 625.8623102917351, 632.3139393757732, 632.5319263744796, 633.9144215530845, 543.3398420918523, 606.4905479397239, 610.6916007416227, 622.4802290087737, 635.3741564558906, 8254.257116859391, 8291.875621865676, 8645.567721613894, 8650.394472386872, 8754.47473151613, 525.5506541906691, 549.0611055095751, 575.576950941058, 627.1126356205917, 630.5271046714964, 3967.543732470745, 4098.754074755524, 4322.502912165141, 4651.0, 4961.603071754251, 107518.0, 108290.45854770833, 112220.43889780498, 116059.0, 116059.6788064234, 98436.50781746046, 99010.0, 100078.0, 101846.0, 102292.48853755684, 82917.0, 87337.56331218303, 87446.56276718703, 88666.0, 89945.55027224822, 7078.823029424306, 8914.910850891409, 9187.356885017985, 9488.430694158373, 9507.429554226492, 49135.52593422203, 54471.45528544664, 54859.72570137124, 55340.16989745077, 57795.55511112256, 54957.175642366194, 61227.69386153041, 61695.6915215421, 71934.0, 76540.0, 12380.566680166152, 12603.369831508571, 12605.180663256859, 12641.87358126407, 13069.542566010525, 13963.650908727363, 14204.218767967861, 14386.712265754835, 14605.269736512919, 14669.633259168606, 12963.481460741465, 12979.00600678011, 13194.472221111047, 13212.471501139848, 13385.464581416634, 12963.481460741465, 13036.0, 13322.527879562558, 13326.33368331599, 13708.93145534266, 12570.994320454525, 12854.421551030413, 12858.42137103814, 13137.34313284351, 13590.252536110609, 9987.800243995225, 10091.69724908254, 10985.231033827875, 11128.293641687727, 11648.472644490072, 10631.627893023708, 10833.729156770829, 11211.943940280247, 11224.551017959517, 11338.319700817978], "value": 7283.147655792636, "unit": "score"}], "name": "dromaeo_css", "value": 7102.547551567468, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 117.0, 116.0, 116.0, 116.0, 116.0, 115.0, 117.0, 114.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 111.0, 112.0, 147.0, 116.0, 108.0, 112.0, 113.0, 128.0, 112.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 187.0, 185.0, 184.0, 184.0, 183.0, 181.0, 182.0, 184.0, 183.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 85.0, 59.0, 60.0, 62.0, 59.0, 106.0, 80.0], "value": 70.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 89.0, 70.0, 68.0, 69.0, 82.0, 69.0, 69.0, 83.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 85.0, 89.0, 86.0, 89.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 98.0, 97.0, 98.0, 96.0, 97.0, 96.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 85.0, 87.0, 85.0, 86.0, 85.0, 87.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 54.0, 52.0, 54.0, 54.0, 54.0, 53.0, 72.0, 78.0], "value": 58.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 77.0, 76.0, 74.0, 75.0, 99.0, 101.0, 88.0, 71.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 105.0, 107.0, 106.0, 83.0, 91.0, 86.0, 88.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 152.0, 154.0, 143.0, 136.0, 156.0, 170.0, 162.0, 219.0, 177.0], "value": 160.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 175.0, 181.0, 175.0, 176.0, 173.0, 218.0, 188.0, 173.0, 227.0], "value": 186.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 66.0, 66.0, 67.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1481.4, "alertThreshold": 2.0}]} 03:23:14 INFO - Return code: 0 03:23:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:23:15 INFO - # TBPL SUCCESS # 03:23:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:23:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:23:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:23:15 INFO - 2016-11-24 03:23:15.072 screenresolution[1658:11103] starting screenresolution argv=screenresolution get 03:23:15 INFO - 2016-11-24 03:23:15.075 screenresolution[1658:11103] Display 0: 1600x1200x32@60 03:23:15 INFO - 2016-11-24 03:23:15.081 screenresolution[1659:11106] starting screenresolution argv=screenresolution list 03:23:15 INFO - Available Modes on Display 0 03:23:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:23:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:23:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:23:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:23:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:23:15 INFO - Intel Iris: 03:23:15 INFO - Chipset Model: Intel Iris 03:23:15 INFO - Type: GPU 03:23:15 INFO - Bus: Built-In 03:23:15 INFO - VRAM (Dynamic, Max): 1536 MB 03:23:15 INFO - Vendor: Intel (0x8086) 03:23:15 INFO - Device ID: 0x0a2e 03:23:15 INFO - Revision ID: 0x0009 03:23:15 INFO - Displays: 03:23:15 INFO - Display: 03:23:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:23:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:23:15 INFO - Display Serial Number: 1600x1200 60 03:23:15 INFO - Main Display: Yes 03:23:15 INFO - Mirror: Off 03:23:15 INFO - Online: Yes 03:23:15 INFO - Rotation: Supported 03:23:15 INFO - Return code: 0 03:23:15 INFO - Running post-action listener: _resource_record_post_action 03:23:15 INFO - [mozharness: 2016-11-24 11:23:15.329942Z] Finished run-tests step (success) 03:23:15 INFO - Running post-run listener: _resource_record_post_run 03:23:15 INFO - Total resource usage - Wall time: 1215s; CPU: 54.0%; Read bytes: 32373760; Write bytes: 699211264; Read time: 200; Write time: 2030 03:23:15 INFO - TinderboxPrint: CPU usage
53.8% 03:23:15 INFO - TinderboxPrint: I/O read bytes / time
32,373,760 / 200 03:23:15 INFO - TinderboxPrint: I/O write bytes / time
699,211,264 / 2,030 03:23:15 INFO - TinderboxPrint: CPU idle
2,246.5 (46.2%) 03:23:15 INFO - TinderboxPrint: CPU system
973.7 (20.0%) 03:23:15 INFO - TinderboxPrint: CPU user
1,641.5 (33.8%) 03:23:15 INFO - TinderboxPrint: Swap in / out
426,500,096 / 0 03:23:15 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 372357632; Write bytes: 368031232; Read time: 28602; Write time: 771 03:23:15 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 30305280; Write bytes: 311785472; Read time: 181; Write time: 1207 03:23:15 INFO - Running post-run listener: _upload_blobber_files 03:23:15 INFO - Blob upload gear active. 03:23:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:23:15 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 03:23:15 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:23:15 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:23:16 INFO - (blobuploader) - INFO - Open directory for files ... 03:23:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:23:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:17 INFO - (blobuploader) - INFO - Done attempting. 03:23:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:23:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:23:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:18 INFO - (blobuploader) - INFO - Done attempting. 03:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:23:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:23:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:23:20 INFO - (blobuploader) - INFO - Done attempting. 03:23:20 INFO - (blobuploader) - INFO - Iteration through files over. 03:23:20 INFO - Return code: 0 03:23:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:23:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:23:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e165163e0161e200bfc5589bc47d33530b54c06f0b83721c9471efc828881ea13dc8f1339e576e9964c9848cf83ffb5c97f23aeeacf62d3ce63b9ae60dcf6082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6e62229418d62ec5c8d3ec15ae3a4094d00543a6d4ab3dc9bfa4eb7e2161b7724d043c38d312a1bc60079ad1d69777ad5e4a96f57d78cdea4e884df0e71a80b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00ae8f55cb6a8757c33d0a69dc7461ed0df43f6036d469ac0d11222dfa2b55b44632d4f74af79af0163529036840dc22c247b41054d8699467ee42e0dc98bbd3"} 03:23:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:23:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:23:20 INFO - Contents: 03:23:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e165163e0161e200bfc5589bc47d33530b54c06f0b83721c9471efc828881ea13dc8f1339e576e9964c9848cf83ffb5c97f23aeeacf62d3ce63b9ae60dcf6082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6e62229418d62ec5c8d3ec15ae3a4094d00543a6d4ab3dc9bfa4eb7e2161b7724d043c38d312a1bc60079ad1d69777ad5e4a96f57d78cdea4e884df0e71a80b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00ae8f55cb6a8757c33d0a69dc7461ed0df43f6036d469ac0d11222dfa2b55b44632d4f74af79af0163529036840dc22c247b41054d8699467ee42e0dc98bbd3"} 03:23:20 INFO - Running post-run listener: copy_logs_to_upload_dir 03:23:20 INFO - Copying logs to upload dir... 03:23:20 INFO - mkdir: /builds/slave/test/build/upload/logs 03:23:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.657591 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-11-24 03:23:21.060958) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 03:23:21.064676) ========= 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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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/Graphics/sha512/e165163e0161e200bfc5589bc47d33530b54c06f0b83721c9471efc828881ea13dc8f1339e576e9964c9848cf83ffb5c97f23aeeacf62d3ce63b9ae60dcf6082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6e62229418d62ec5c8d3ec15ae3a4094d00543a6d4ab3dc9bfa4eb7e2161b7724d043c38d312a1bc60079ad1d69777ad5e4a96f57d78cdea4e884df0e71a80b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00ae8f55cb6a8757c33d0a69dc7461ed0df43f6036d469ac0d11222dfa2b55b44632d4f74af79af0163529036840dc22c247b41054d8699467ee42e0dc98bbd3"} build_url:https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/NwF_JTVgQkqstkjrY3wtng/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/e165163e0161e200bfc5589bc47d33530b54c06f0b83721c9471efc828881ea13dc8f1339e576e9964c9848cf83ffb5c97f23aeeacf62d3ce63b9ae60dcf6082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d6e62229418d62ec5c8d3ec15ae3a4094d00543a6d4ab3dc9bfa4eb7e2161b7724d043c38d312a1bc60079ad1d69777ad5e4a96f57d78cdea4e884df0e71a80b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/00ae8f55cb6a8757c33d0a69dc7461ed0df43f6036d469ac0d11222dfa2b55b44632d4f74af79af0163529036840dc22c247b41054d8699467ee42e0dc98bbd3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-24 03:23:21.105890) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 03:23:21.106439) ========= 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.BZx7j1qbxl/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.HeNMNOjfWB/Listeners TMPDIR=/var/folders/cl/xc50dtmn0c7ds5688s724z3w00000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-24 03:23:21.156174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 03:23:21.156536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-24 03:23:21.156909) ========= ========= Total master_lag: 0.20 =========