builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0190 starttime: 1480351321.69 results: success (0) buildid: 20161128061357 builduid: f32ed2cbe46b4783a8150cbd1b9e37f4 revision: aed03debf4f236c5ccbd746f1a8fdb353a2b572b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.692750) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.693170) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.693463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.719860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.720136) ========= 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.2jqumpMJc1/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.4MMVl5lcr8/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-28 08:42:01-- 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% 8.02M=0.001s 2016-11-28 08:42:01 (8.02 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.891046) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.894376) ========= 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.2jqumpMJc1/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.4MMVl5lcr8/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.020320 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:01.942843) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 08:42:01.943168) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aed03debf4f236c5ccbd746f1a8fdb353a2b572b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev aed03debf4f236c5ccbd746f1a8fdb353a2b572b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2jqumpMJc1/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.4MMVl5lcr8/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-28 08:42:02,019 truncating revision to first 12 chars 2016-11-28 08:42:02,020 Setting DEBUG logging. 2016-11-28 08:42:02,020 attempt 1/10 2016-11-28 08:42:02,020 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/aed03debf4f2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 08:42:03,176 unpacking tar archive at: mozilla-aurora-aed03debf4f2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.414940 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-28 08:42:03.387524) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:03.387845) ========= script_repo_revision: aed03debf4f236c5ccbd746f1a8fdb353a2b572b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:03.388235) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:03.388537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 08:42:03.408302) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-28 08:42:03.408593) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2jqumpMJc1/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.4MMVl5lcr8/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:42:03 INFO - MultiFileLogger online at 20161128 08:42:03 in /builds/slave/test 08:42:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:42:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:03 INFO - {'append_to_log': False, 08:42:03 INFO - 'base_work_dir': '/builds/slave/test', 08:42:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:42:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:03 INFO - 'branch': 'Mozilla-Aurora', 08:42:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:03 INFO - 'config_files': ('talos/mac_config.py',), 08:42:03 INFO - 'default_actions': ('clobber', 08:42:03 INFO - 'read-buildbot-config', 08:42:03 INFO - 'download-and-extract', 08:42:03 INFO - 'populate-webroot', 08:42:03 INFO - 'create-virtualenv', 08:42:03 INFO - 'install', 08:42:03 INFO - 'run-tests'), 08:42:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:03 INFO - 'download_minidump_stackwalk': True, 08:42:03 INFO - 'download_symbols': 'ondemand', 08:42:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:03 INFO - 'installer_path': 'installer.exe', 08:42:03 INFO - 'log_level': 'info', 08:42:03 INFO - 'log_name': 'talos', 08:42:03 INFO - 'log_to_console': True, 08:42:03 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:42:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:42:03 INFO - 'opt_config_files': (), 08:42:03 INFO - 'pip_index': False, 08:42:03 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:03 INFO - 'cmd': ('bash', 08:42:03 INFO - '-c', 08:42:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:03 INFO - 'enabled': True, 08:42:03 INFO - 'halt_on_failure': False, 08:42:03 INFO - 'name': 'check_screen_resolution'},), 08:42:03 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:03 INFO - 'cmd': ('bash', 08:42:03 INFO - '-c', 08:42:03 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:03 INFO - 'enabled': True, 08:42:03 INFO - 'halt_on_failure': False, 08:42:03 INFO - 'name': 'check_screen_resolution'},), 08:42:03 INFO - 'run_cmd_checks_enabled': True, 08:42:03 INFO - 'sps_profile': False, 08:42:03 INFO - 'sps_profile_interval': 0, 08:42:03 INFO - 'suite': 'dromaeojs-e10s', 08:42:03 INFO - 'system_bits': '32', 08:42:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:03 INFO - 'title': 't-yosemite-r7-0190', 08:42:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:03 INFO - 'use_talos_json': True, 08:42:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:03 INFO - 'work_dir': 'build'} 08:42:03 INFO - [mozharness: 2016-11-28 16:42:03.613142Z] Running clobber step. 08:42:03 INFO - Running pre-action listener: _resource_record_pre_action 08:42:03 INFO - Running main action method: clobber 08:42:03 INFO - rmtree: /builds/slave/test/build 08:42:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:05 INFO - Running post-action listener: _resource_record_post_action 08:42:05 INFO - [mozharness: 2016-11-28 16:42:05.587610Z] Finished clobber step (success) 08:42:05 INFO - [mozharness: 2016-11-28 16:42:05.587740Z] Running read-buildbot-config step. 08:42:05 INFO - Running pre-action listener: _resource_record_pre_action 08:42:05 INFO - Running main action method: read_buildbot_config 08:42:05 INFO - Using buildbot properties: 08:42:05 INFO - { 08:42:05 INFO - "project": "", 08:42:05 INFO - "product": "firefox", 08:42:05 INFO - "script_repo_revision": "production", 08:42:05 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 08:42:05 INFO - "repository": "", 08:42:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 08:42:05 INFO - "buildid": "20161128061357", 08:42:05 INFO - "pgo_build": "False", 08:42:05 INFO - "basedir": "/builds/slave/test", 08:42:05 INFO - "buildnumber": 0, 08:42:05 INFO - "slavename": "t-yosemite-r7-0190", 08:42:05 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:42:05 INFO - "platform": "yosemite_r7", 08:42:05 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:42:05 INFO - "branch": "mozilla-aurora", 08:42:05 INFO - "repo_path": "releases/mozilla-aurora", 08:42:05 INFO - "revision": "aed03debf4f236c5ccbd746f1a8fdb353a2b572b", 08:42:05 INFO - "stage_platform": "macosx64", 08:42:05 INFO - "builduid": "f32ed2cbe46b4783a8150cbd1b9e37f4", 08:42:05 INFO - "slavebuilddir": "test" 08:42:05 INFO - } 08:42:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 08:42:05 INFO - Running post-action listener: _resource_record_post_action 08:42:05 INFO - [mozharness: 2016-11-28 16:42:05.591055Z] Finished read-buildbot-config step (success) 08:42:05 INFO - [mozharness: 2016-11-28 16:42:05.591168Z] Running download-and-extract step. 08:42:05 INFO - Running pre-action listener: _resource_record_pre_action 08:42:05 INFO - Running main action method: download_and_extract 08:42:05 INFO - mkdir: /builds/slave/test/build/tests 08:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:05 INFO - trying https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 08:42:05 INFO - Downloading https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:42:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 08:42:07 INFO - Downloaded 1199 bytes. 08:42:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 08:42:07 INFO - Using the following test package requirements: 08:42:07 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:42:07 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 08:42:07 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 08:42:07 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'jsshell-mac.zip'], 08:42:07 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 08:42:07 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 08:42:07 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 08:42:07 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 08:42:07 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 08:42:07 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 08:42:07 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 08:42:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:42:07 INFO - Http code: 200 08:42:07 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:42:07 INFO - x-amz-cf-id: 0d329sqEJCJTO7EG7EZetvL-WbrdLgJBGrMD44hm400kAZ-pckqbiw== 08:42:07 INFO - x-amz-version-id: uE973YNYNg.ANvYXegv9KTbJzdATzKPe 08:42:07 INFO - Expected file size: 16279469 08:42:07 INFO - Obtained file size: 16279469 08:42:14 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:42:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 08:42:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:42:14 INFO - Fetch https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 08:42:15 INFO - Http code: 200 08:42:15 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:42:15 INFO - x-amz-cf-id: dkaQAhoPkxNJvkE_-K6GT5Ffi8r5J07SEshbA2IHkquAVmx5emGZDw== 08:42:15 INFO - x-amz-version-id: uE973YNYNg.ANvYXegv9KTbJzdATzKPe 08:42:15 INFO - Expected file size: 16279469 08:42:15 INFO - Obtained file size: 16279469 08:42:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 08:42:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:42:21 INFO - Fetch https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 08:42:22 INFO - Http code: 200 08:42:22 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:42:22 INFO - x-amz-cf-id: 5BmEU_zVwmiK58Gcz8DcLBF96ZJScJzO8ay_u0e3FtFPEYBOs4lB6Q== 08:42:22 INFO - x-amz-version-id: 2O6ooB_GWzy_vzKpcMy8i7oBs0Gr5r5o 08:42:22 INFO - Expected file size: 14409038 08:42:22 INFO - Obtained file size: 14409038 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - trying https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:42:22 INFO - Downloading https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 08:42:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 08:42:25 INFO - Downloaded 109743881 bytes. 08:42:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:42:25 INFO - mkdir: /builds/slave/test/properties 08:42:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:25 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:25 INFO - Contents: 08:42:25 INFO - build_url:https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 08:42:26 INFO - Running post-action listener: _resource_record_post_action 08:42:26 INFO - Running post-action listener: set_extra_try_arguments 08:42:26 INFO - [mozharness: 2016-11-28 16:42:26.279574Z] Finished download-and-extract step (success) 08:42:26 INFO - [mozharness: 2016-11-28 16:42:26.279694Z] Running populate-webroot step. 08:42:26 INFO - Running pre-action listener: _resource_record_pre_action 08:42:26 INFO - Running main action method: populate_webroot 08:42:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:26 INFO - '--tppagecycles', 08:42:26 INFO - '7'], 08:42:26 INFO - 'tests': ['tsvgm']}}, 08:42:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['damp', 'tps']}, 08:42:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'tests': ['damp', 'tps']}, 08:42:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['dromaeo_dom']}, 08:42:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['basic_compositor_video']}, 08:42:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['a11yr', 08:42:26 INFO - 'ts_paint', 08:42:26 INFO - 'tpaint', 08:42:26 INFO - 'sessionrestore', 08:42:26 INFO - 'sessionrestore_no_auto_restore', 08:42:26 INFO - 'tabpaint']}, 08:42:26 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:26 INFO - 'ts_paint', 08:42:26 INFO - 'tpaint', 08:42:26 INFO - 'sessionrestore', 08:42:26 INFO - 'sessionrestore_no_auto_restore', 08:42:26 INFO - 'tabpaint']}, 08:42:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:26 INFO - 'ts_paint', 08:42:26 INFO - 'tpaint', 08:42:26 INFO - 'sessionrestore', 08:42:26 INFO - 'sessionrestore_no_auto_restore', 08:42:26 INFO - 'tabpaint']}, 08:42:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:26 INFO - 'ts_paint', 08:42:26 INFO - 'tpaint', 08:42:26 INFO - 'sessionrestore', 08:42:26 INFO - 'sessionrestore_no_auto_restore', 08:42:26 INFO - 'tabpaint']}, 08:42:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['a11yr', 08:42:26 INFO - 'ts_paint', 08:42:26 INFO - 'tpaint', 08:42:26 INFO - 'sessionrestore', 08:42:26 INFO - 'sessionrestore_no_auto_restore', 08:42:26 INFO - 'tabpaint']}, 08:42:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['a11yr', 08:42:26 INFO - 'ts_paint', 08:42:26 INFO - 'tpaint', 08:42:26 INFO - 'sessionrestore', 08:42:26 INFO - 'sessionrestore_no_auto_restore', 08:42:26 INFO - 'tabpaint']}, 08:42:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['tsvgx', 08:42:26 INFO - 'tsvgr_opacity', 08:42:26 INFO - 'tart', 08:42:26 INFO - 'tscrollx', 08:42:26 INFO - 'cart']}, 08:42:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:26 INFO - 'tsvgr_opacity', 08:42:26 INFO - 'tart', 08:42:26 INFO - 'tscrollx', 08:42:26 INFO - 'cart']}, 08:42:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'talos_options': ['--disable-e10s'], 08:42:26 INFO - 'tests': ['tp5o']}, 08:42:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'tests': ['tp5o']}, 08:42:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'talos_options': ['--disable-e10s', 08:42:26 INFO - '--xperf_path', 08:42:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:26 INFO - 'tests': ['tp5n']}, 08:42:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:26 INFO - 'talos_options': ['--xperf_path', 08:42:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:26 INFO - 'tests': ['tp5n']}}, 08:42:26 INFO - 'talos.zip': {'path': '', 08:42:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:26 INFO - Running post-action listener: _resource_record_post_action 08:42:26 INFO - [mozharness: 2016-11-28 16:42:26.298358Z] Finished populate-webroot step (success) 08:42:26 INFO - [mozharness: 2016-11-28 16:42:26.298452Z] Running create-virtualenv step. 08:42:26 INFO - Running pre-action listener: _resource_record_pre_action 08:42:26 INFO - Running main action method: create_virtualenv 08:42:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42: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 08:42:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:26 INFO - Using real prefix '/tools/python27' 08:42:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:30 INFO - Installing pip.................done. 08:42:30 INFO - Return code: 0 08:42:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:30 INFO - Reading from file tmpfile_stdout 08:42:30 INFO - Output received: 08:42:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:42:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:30 INFO - 'HOME': '/Users/cltbld', 08:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:30 INFO - 'LOGNAME': 'cltbld', 08:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:30 INFO - 'MOZ_NO_REMOTE': '1', 08:42:30 INFO - 'NO_EM_RESTART': '1', 08:42:30 INFO - 'PAGER': '/bin/cat', 08:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:30 INFO - 'PWD': '/builds/slave/test', 08:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:30 INFO - 'SHELL': '/bin/bash', 08:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:30 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:30 INFO - 'USER': 'cltbld', 08:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:30 INFO - 'XPC_FLAGS': '0x0', 08:42:30 INFO - 'XPC_SERVICE_NAME': '0', 08:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:42:30 INFO - Cleaning up... 08:42:30 INFO - Return code: 0 08:42:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:42:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:30 INFO - 'HOME': '/Users/cltbld', 08:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:30 INFO - 'LOGNAME': 'cltbld', 08:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:30 INFO - 'MOZ_NO_REMOTE': '1', 08:42:30 INFO - 'NO_EM_RESTART': '1', 08:42:30 INFO - 'PAGER': '/bin/cat', 08:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:30 INFO - 'PWD': '/builds/slave/test', 08:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:30 INFO - 'SHELL': '/bin/bash', 08:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:30 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:30 INFO - 'USER': 'cltbld', 08:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:30 INFO - 'XPC_FLAGS': '0x0', 08:42:30 INFO - 'XPC_SERVICE_NAME': '0', 08:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:30 INFO - Downloading/unpacking psutil>=3.1.1 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:34 INFO - Installing collected packages: psutil 08:42:34 INFO - Running setup.py install for psutil 08:42:34 INFO - building 'psutil._psutil_osx' extension 08:42:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:42:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:42:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:42:34 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:42:34 INFO - building 'psutil._psutil_posix' extension 08:42:34 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:42:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:35 INFO - ^ 08:42:35 INFO - 1 warning generated. 08:42:35 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:42:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:35 INFO - Successfully installed psutil 08:42:35 INFO - Cleaning up... 08:42:35 INFO - Return code: 0 08:42:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:35 INFO - 'HOME': '/Users/cltbld', 08:42:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:35 INFO - 'LOGNAME': 'cltbld', 08:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:35 INFO - 'MOZ_NO_REMOTE': '1', 08:42:35 INFO - 'NO_EM_RESTART': '1', 08:42:35 INFO - 'PAGER': '/bin/cat', 08:42:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:35 INFO - 'PWD': '/builds/slave/test', 08:42:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:35 INFO - 'SHELL': '/bin/bash', 08:42:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:35 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:35 INFO - 'USER': 'cltbld', 08:42:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:35 INFO - 'XPC_FLAGS': '0x0', 08:42:35 INFO - 'XPC_SERVICE_NAME': '0', 08:42:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:38 INFO - Installing collected packages: mozsystemmonitor 08:42:38 INFO - Running setup.py install for mozsystemmonitor 08:42:38 INFO - Successfully installed mozsystemmonitor 08:42:38 INFO - Cleaning up... 08:42:38 INFO - Return code: 0 08:42:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:38 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:38 INFO - 'HOME': '/Users/cltbld', 08:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:38 INFO - 'LOGNAME': 'cltbld', 08:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:38 INFO - 'MOZ_NO_REMOTE': '1', 08:42:38 INFO - 'NO_EM_RESTART': '1', 08:42:38 INFO - 'PAGER': '/bin/cat', 08:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:38 INFO - 'PWD': '/builds/slave/test', 08:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:38 INFO - 'SHELL': '/bin/bash', 08:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:38 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:38 INFO - 'USER': 'cltbld', 08:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:38 INFO - 'XPC_FLAGS': '0x0', 08:42:38 INFO - 'XPC_SERVICE_NAME': '0', 08:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:41 INFO - warning: no files found matching '*.txt' 08:42:41 INFO - no previously-included directories found matching 'build' 08:42:41 INFO - no previously-included directories found matching 'dist' 08:42:41 INFO - no previously-included directories found matching '.git*' 08:42:41 INFO - Installing collected packages: jsonschema, functools32 08:42:41 INFO - Running setup.py install for functools32 08:42:41 INFO - warning: no files found matching '*.txt' 08:42:41 INFO - no previously-included directories found matching 'build' 08:42:41 INFO - no previously-included directories found matching 'dist' 08:42:41 INFO - no previously-included directories found matching '.git*' 08:42:41 INFO - Successfully installed jsonschema functools32 08:42:41 INFO - Cleaning up... 08:42:42 INFO - Return code: 0 08:42:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:42 INFO - 'HOME': '/Users/cltbld', 08:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:42 INFO - 'LOGNAME': 'cltbld', 08:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:42 INFO - 'MOZ_NO_REMOTE': '1', 08:42:42 INFO - 'NO_EM_RESTART': '1', 08:42:42 INFO - 'PAGER': '/bin/cat', 08:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:42 INFO - 'PWD': '/builds/slave/test', 08:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:42 INFO - 'SHELL': '/bin/bash', 08:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:42 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:42 INFO - 'USER': 'cltbld', 08:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:42 INFO - 'XPC_FLAGS': '0x0', 08:42:42 INFO - 'XPC_SERVICE_NAME': '0', 08:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:42 INFO - Cleaning up... 08:42:42 INFO - Return code: 0 08:42:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:42 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:42 INFO - 'HOME': '/Users/cltbld', 08:42:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:42 INFO - 'LOGNAME': 'cltbld', 08:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:42 INFO - 'MOZ_NO_REMOTE': '1', 08:42:42 INFO - 'NO_EM_RESTART': '1', 08:42:42 INFO - 'PAGER': '/bin/cat', 08:42:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:42 INFO - 'PWD': '/builds/slave/test', 08:42:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:42 INFO - 'SHELL': '/bin/bash', 08:42:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:42 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:42 INFO - 'USER': 'cltbld', 08:42:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:42 INFO - 'XPC_FLAGS': '0x0', 08:42:42 INFO - 'XPC_SERVICE_NAME': '0', 08:42:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:45 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:46 INFO - Downloading docopt-0.6.1.tar.gz 08:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:46 INFO - Running setup.py install for blobuploader 08:42:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:46 INFO - Running setup.py install for requests 08:42:47 INFO - Running setup.py install for docopt 08:42:47 INFO - Successfully installed blobuploader requests docopt 08:42:47 INFO - Cleaning up... 08:42:47 INFO - Return code: 0 08:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:47 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:47 INFO - 'HOME': '/Users/cltbld', 08:42:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:47 INFO - 'LOGNAME': 'cltbld', 08:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:47 INFO - 'MOZ_NO_REMOTE': '1', 08:42:47 INFO - 'NO_EM_RESTART': '1', 08:42:47 INFO - 'PAGER': '/bin/cat', 08:42:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:47 INFO - 'PWD': '/builds/slave/test', 08:42:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:47 INFO - 'SHELL': '/bin/bash', 08:42:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:47 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:47 INFO - 'USER': 'cltbld', 08:42:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:47 INFO - 'XPC_FLAGS': '0x0', 08:42:47 INFO - 'XPC_SERVICE_NAME': '0', 08:42:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:47 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-FMyxZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:47 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-AAlame-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:47 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-WAgeOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:47 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-kdtkE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:47 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-E5xYKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-YgZHhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-AnbnX0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-7vNmzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-7kPcdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-yvYMbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-zSsDxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-1dWDoM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-NSX5H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-LC65ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:48 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-Z6a_Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-yj8KaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:49 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-V5WN0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:49 INFO - Running setup.py install for manifestparser 08:42:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozcrash 08:42:49 INFO - Running setup.py install for mozdebug 08:42:49 INFO - Running setup.py install for mozdevice 08:42:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:49 INFO - Running setup.py install for mozfile 08:42:50 INFO - Running setup.py install for mozhttpd 08:42:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozinfo 08:42:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozInstall 08:42:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozleak 08:42:50 INFO - Running setup.py install for mozlog 08:42:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for moznetwork 08:42:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:50 INFO - Running setup.py install for mozprocess 08:42:51 INFO - Running setup.py install for mozprofile 08:42:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozrunner 08:42:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Running setup.py install for mozscreenshot 08:42:51 INFO - Running setup.py install for moztest 08:42:51 INFO - Running setup.py install for mozversion 08:42:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:51 INFO - Cleaning up... 08:42:51 INFO - Return code: 0 08:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:51 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:51 INFO - 'HOME': '/Users/cltbld', 08:42:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:51 INFO - 'LOGNAME': 'cltbld', 08:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:51 INFO - 'MOZ_NO_REMOTE': '1', 08:42:51 INFO - 'NO_EM_RESTART': '1', 08:42:51 INFO - 'PAGER': '/bin/cat', 08:42:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:51 INFO - 'PWD': '/builds/slave/test', 08:42:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:51 INFO - 'SHELL': '/bin/bash', 08:42:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:51 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:51 INFO - 'USER': 'cltbld', 08:42:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:51 INFO - 'XPC_FLAGS': '0x0', 08:42:51 INFO - 'XPC_SERVICE_NAME': '0', 08:42:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-fwUjQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-jKQ5Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-xKr3tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-N5wA1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ipg5lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-uuo9ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-AD8lqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:52 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-ISEUo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-sGNP05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-GF6se_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-2LTeCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-miko9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-VTeC13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-pU3fWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-AOgEzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-MeoA3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:53 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)) 08:42:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:53 INFO - Running setup.py (path:/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/pip-E_ZAR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:56 INFO - Downloading blessings-1.6.tar.gz 08:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:56 INFO - Installing collected packages: blessings 08:42:56 INFO - Running setup.py install for blessings 08:42:56 INFO - Successfully installed blessings 08:42:56 INFO - Cleaning up... 08:42:56 INFO - Return code: 0 08:42:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:57 INFO - Reading from file tmpfile_stdout 08:42:57 INFO - Current package versions: 08:42:57 INFO - blessings == 1.6 08:42:57 INFO - blobuploader == 1.2.4 08:42:57 INFO - docopt == 0.6.1 08:42:57 INFO - functools32 == 3.2.3-2 08:42:57 INFO - jsonschema == 2.5.1 08:42:57 INFO - manifestparser == 1.1 08:42:57 INFO - mozInstall == 1.12 08:42:57 INFO - mozcrash == 1.0 08:42:57 INFO - mozdebug == 0.1 08:42:57 INFO - mozdevice == 0.48 08:42:57 INFO - mozfile == 1.2 08:42:57 INFO - mozhttpd == 0.7 08:42:57 INFO - mozinfo == 0.9 08:42:57 INFO - mozleak == 0.1 08:42:57 INFO - mozlog == 3.4 08:42:57 INFO - moznetwork == 0.27 08:42:57 INFO - mozprocess == 0.23 08:42:57 INFO - mozprofile == 0.28 08:42:57 INFO - mozrunner == 6.13 08:42:57 INFO - mozscreenshot == 0.1 08:42:57 INFO - mozsystemmonitor == 0.3 08:42:57 INFO - moztest == 0.7 08:42:57 INFO - mozversion == 1.4 08:42:57 INFO - psutil == 3.1.1 08:42:57 INFO - requests == 1.2.3 08:42:57 INFO - wsgiref == 0.1.2 08:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42: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 08:42: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 08:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:58 INFO - 'HOME': '/Users/cltbld', 08:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:58 INFO - 'LOGNAME': 'cltbld', 08:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:58 INFO - 'MOZ_NO_REMOTE': '1', 08:42:58 INFO - 'NO_EM_RESTART': '1', 08:42:58 INFO - 'PAGER': '/bin/cat', 08:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:58 INFO - 'PWD': '/builds/slave/test', 08:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:58 INFO - 'SHELL': '/bin/bash', 08:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:58 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:58 INFO - 'USER': 'cltbld', 08:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:58 INFO - 'XPC_FLAGS': '0x0', 08:42:58 INFO - 'XPC_SERVICE_NAME': '0', 08:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:58 INFO - Cleaning up... 08:42:58 INFO - Return code: 0 08:42:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:58 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 0x10e729490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e69f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc72d60360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, '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.2jqumpMJc1/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.4MMVl5lcr8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:42:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:42:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:58 INFO - 'HOME': '/Users/cltbld', 08:42:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:58 INFO - 'LOGNAME': 'cltbld', 08:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:58 INFO - 'MOZ_NO_REMOTE': '1', 08:42:58 INFO - 'NO_EM_RESTART': '1', 08:42:58 INFO - 'PAGER': '/bin/cat', 08:42:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:58 INFO - 'PWD': '/builds/slave/test', 08:42:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:58 INFO - 'SHELL': '/bin/bash', 08:42:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:42:58 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:42:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:58 INFO - 'USER': 'cltbld', 08:42:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:58 INFO - 'XPC_FLAGS': '0x0', 08:42:58 INFO - 'XPC_SERVICE_NAME': '0', 08:42:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:59 INFO - Cleaning up... 08:42:59 INFO - Return code: 0 08:42:59 INFO - Running post-action listener: _resource_record_post_action 08:42:59 INFO - Running post-action listener: _start_resource_monitoring 08:42:59 INFO - Starting resource monitoring. 08:42:59 INFO - [mozharness: 2016-11-28 16:42:59.193831Z] Finished create-virtualenv step (success) 08:42:59 INFO - [mozharness: 2016-11-28 16:42:59.194848Z] Running install step. 08:42:59 INFO - Running pre-action listener: _resource_record_pre_action 08:42:59 INFO - Running main action method: install 08:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:59 INFO - Reading from file tmpfile_stdout 08:42:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:59 INFO - Reading from file tmpfile_stdout 08:42:59 INFO - Output received: 08:42:59 INFO - Usage: mozinstall [options] installer 08:42:59 INFO - Options: 08:42:59 INFO - -h, --help show this help message and exit 08:42:59 INFO - -d DEST, --destination=DEST 08:42:59 INFO - Directory to install application into. [default: 08:42:59 INFO - "/builds/slave/test"] 08:42:59 INFO - --app=APP Application being installed. [default: firefox] 08:42:59 INFO - mkdir: /builds/slave/test/build/application 08:42:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:42:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:43:30 INFO - Reading from file tmpfile_stdout 08:43:30 INFO - Output received: 08:43:30 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:43:30 INFO - Running post-action listener: _resource_record_post_action 08:43:30 INFO - [mozharness: 2016-11-28 16:43:30.388505Z] Finished install step (success) 08:43:30 INFO - [mozharness: 2016-11-28 16:43:30.388644Z] Running run-tests step. 08:43:30 INFO - Running pre-action listener: _resource_record_pre_action 08:43:30 INFO - Running main action method: run_tests 08:43:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:43:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:43:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:43:30 INFO - 2016-11-28 08:43:30.403 screenresolution[1908:18664] starting screenresolution argv=screenresolution get 08:43:30 INFO - 2016-11-28 08:43:30.406 screenresolution[1908:18664] Display 0: 1600x1200x32@60 08:43:30 INFO - 2016-11-28 08:43:30.412 screenresolution[1909:18666] starting screenresolution argv=screenresolution list 08:43:30 INFO - Available Modes on Display 0 08:43:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:43:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:43:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:43:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:43:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:43:30 INFO - Intel Iris: 08:43:30 INFO - Chipset Model: Intel Iris 08:43:30 INFO - Type: GPU 08:43:30 INFO - Bus: Built-In 08:43:30 INFO - VRAM (Dynamic, Max): 1536 MB 08:43:30 INFO - Vendor: Intel (0x8086) 08:43:30 INFO - Device ID: 0x0a2e 08:43:30 INFO - Revision ID: 0x0009 08:43:30 INFO - Displays: 08:43:30 INFO - Display: 08:43:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:43:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:43:30 INFO - Display Serial Number: 1600x1200 60 08:43:30 INFO - Main Display: Yes 08:43:30 INFO - Mirror: Off 08:43:30 INFO - Online: Yes 08:43:30 INFO - Rotation: Supported 08:43:30 INFO - Return code: 0 08:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:30 INFO - Python 2.7.3 08:43:30 INFO - Return code: 0 08:43:30 INFO - grabbing minidump binary from tooltool 08:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:43:30 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 0x10e53dd30>, '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 0x10e3a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e535b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:43:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:43:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:43:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:30 INFO - Return code: 0 08:43:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:43:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:43:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0190 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2jqumpMJc1/Render', 08:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:30 INFO - 'HOME': '/Users/cltbld', 08:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:30 INFO - 'LOGNAME': 'cltbld', 08:43:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:30 INFO - 'MOZ_NO_REMOTE': '1', 08:43:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:30 INFO - 'NO_EM_RESTART': '1', 08:43:30 INFO - 'PAGER': '/bin/cat', 08:43:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:30 INFO - 'PWD': '/builds/slave/test', 08:43:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:30 INFO - 'SHELL': '/bin/bash', 08:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4MMVl5lcr8/Listeners', 08:43:30 INFO - 'TMPDIR': '/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/', 08:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:30 INFO - 'USER': 'cltbld', 08:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:30 INFO - 'XPC_FLAGS': '0x0', 08:43:30 INFO - 'XPC_SERVICE_NAME': '0', 08:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0190', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:43:30 INFO - mozversion application_buildid: 20161128061357 08:43:30 INFO - mozversion application_changeset: aed03debf4f236c5ccbd746f1a8fdb353a2b572b 08:43:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:43:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:30 INFO - mozversion application_name: Firefox 08:43:30 INFO - mozversion application_remotingname: firefox-dev 08:43:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:43:30 INFO - mozversion application_vendor: Mozilla 08:43:30 INFO - mozversion application_version: 52.0a2 08:43:30 INFO - mozversion platform_buildid: 20161128061357 08:43:30 INFO - mozversion platform_changeset: aed03debf4f236c5ccbd746f1a8fdb353a2b572b 08:43:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:43:30 INFO - mozversion platform_version: 52.0a2 08:43:30 INFO - using testdate: 1480351410 08:43:30 INFO - actual date: 1480351410 08:43:30 INFO - starting webserver on 'localhost:56588' 08:43:30 INFO - SUITE-START | Running 2 tests 08:43:30 INFO - TEST-START | dromaeo_css 08:43:30 INFO - operating with platform_type : mac_ 08:43:30 INFO - Initialising browser for dromaeo_css test... 08:43:31 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpPW3wy8/profile http://localhost:56588/getInfo.html) 08:43:33 INFO - PROCESS | 1919 | __metrics Screen width/height:1600/1200 08:43:33 INFO - PROCESS | 1919 | colorDepth:24 08:43:33 INFO - PROCESS | 1919 | Browser inner width/height: 1024/689 08:43:33 INFO - PROCESS | 1919 | __metrics 08:43:34 ERROR - PROCESS | 1919 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 08:43:34 INFO - TEST-INFO | 1919: exit 0 08:43:34 INFO - Browser initialized. 08:43:34 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:34 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpPW3wy8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:47 INFO - PROCESS | 1922 | RSS: Main: 229928960 08:43:47 INFO - PROCESS | 1922 | 08:44:36 INFO - PROCESS | 1922 | 1480351476712 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] 08:46:50 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56588/tests/dromaeo/cssquery-ext.html) 08:46:52 INFO - PROCESS | 1922 | RSS: Main: 232984576 08:46:52 INFO - PROCESS | 1922 | 08:49:54 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-ext.html (next: http://localhost:56588/tests/dromaeo/cssquery-jquery.html) 08:49:55 INFO - PROCESS | 1922 | RSS: Main: 243806208 08:49:55 INFO - PROCESS | 1922 | 08:52:57 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56588/tests/dromaeo/cssquery-mootools.html) 08:52:57 INFO - PROCESS | 1922 | RSS: Main: 246816768 08:52:57 INFO - PROCESS | 1922 | 08:55:59 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56588/tests/dromaeo/cssquery-prototype.html) 08:56:00 INFO - PROCESS | 1922 | RSS: Main: 246759424 08:56:00 INFO - PROCESS | 1922 | 08:59:03 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56588/tests/dromaeo/cssquery-yui.html) 08:59:03 INFO - PROCESS | 1922 | RSS: Main: 250318848 08:59:03 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | Cycle 1(1): loaded http://localhost:56588/tests/dromaeo/cssquery-yui.html (next: http://localhost:56588/tests/dromaeo/cssquery-dojo.html) 09:02:06 INFO - PROCESS | 1922 | RSS: Main: 251715584 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | __start_tp_report 09:02:06 INFO - PROCESS | 1922 | _x_x_mozilla_page_load 09:02:06 INFO - PROCESS | 1922 | _x_x_mozilla_page_load_details 09:02:06 INFO - PROCESS | 1922 | |i|pagename|runs| 09:02:06 INFO - PROCESS | 1922 | |0;dojo.html;2776.8750406231716;3364.058063742153;3374.2913988062505;3404.0808981574974;3414.6926776590103;5717.056685646869;5780.797672081478;5791.07342825148;5792.971035144829;5810.912836307453;5731.111677689954;5753.223314852494;5784.913226301598;5796;5816.33112192098;5218.739063046852;5238.47615238475;5248.816291429801;5255.579553635719;5311.787528498855;4440.444944381952;5279.9208011879855;5298.072837253484;5329.866753331159;5360.571154307646;5221.034108689885;5251.5798736101215;5314.681119132845;5317.760700768475;5323.760430780605;5254.632175747699;5290.153575427932;5297.020051290524;5311.415744268127;5362.91955620666;5230.973845130788;5304.124819404794;5320.255164277004;5365.678059316453;5387.622866399353;5591.384947655754;5903.232579764646;5932.673702946337;5934.821955341346;5970.791022314198;6121.0566939720375;6134.355892631254;6141.54737815085;6153.538484613672;6238.563300568962;4739.241721324606;5088.491150884919;5610;5728.968785618587;6187.257529096492;5010.423801262828;5234.241035049897;5990.760369585255;6004.54965877561;6011.4289142531825;6226.595271307441;6248.28144763349;6333.20834895638;6342.953412686855;6384;5236.685798852005;6169.5064394848305;6230.7507699691505;6252.593581417284;6291.087792270187;5496.532794712414;6205.503559715212;6248.625082495065;6250.312465628777;6282.057691346335;5937.52499800015;6124.350421260821;6146.938530614726;6157.692115394212;6167.167432396659;6183.721732522047;6191.4118158774845;6213.37866213375;6228.34602366754;6229.4393504584805;4266.31738921771;4933.481984391659;4982.028504441599;5007.574356179693;5021.949780502148;4400.44994375703;4410.735355878657;4430.712003719748;4451.710638808467;4471.910561788811;5786.826395208151;5942.257217847769;6013;6030.547708921848;6059.303180134253;6193.225846769154;6244.094606282064;6264.373562643699;6280.026595877646;6315.179026726496;5845.152452894306;5910.083936989773;5919.704014799329;5997.100434934795;6013.067974463965;5497.945020549823;5520.282363292827;5536;5558.249636299129;5572.219889215513;6401.935980640227;6420.101185833893;6425;6443.903341449882;6451.3548645135115;6140.381550880894;6143.818944274718;6217.409346112112;6273.027680709497;6283.654399008098;5293.47065293483;6347.650879201688;6366.172397588284;6373.553851230369;6394.23269207698;6163.229596300463;6203.658798766111;6223.315435302204;6223.875522489616;6226.439620434183;6081.574289799849;6122.97760420812;6163.8150855474405;6205.565610407228;6239.1577137085915;5248.921266181087;6116.785912493041;6120.325235636462;6185;6204.100405441276;6176.969115154396;6180.47465965398;6200.193974783249;6206;6217.595856269328;5830.708464576839;5918.141869428995;6076.270847498328;6084.368038837688;6110.938890611214;6088.969555152196;6117.614269788275;6117.9187529241;6128.785492507741;6175;6092.451679348703;6110.511159107172;6117.248930028971;6137.1101190328045;6142.662153581596 09:02:06 INFO - PROCESS | 1922 | |1;ext.html;477.87097483679383;486.0449217288028;515.3352175693356;517.4049842680914;520.8125074973011;32678;39743.60256397439;40090.1981960361;41597;41697.37453938186;41015.79492102543;41247.58752412475;41490.170196596126;41507.16985660285;41664.16671666565;7920.4059695523065;8699.086595907433;9281.257499400048;9439.197668198178;9514.429134251932;7267.854642907138;9417.90582094177;9461.668841590546;9465.574049167804;9504.192143667797;9425.057494250588;9461.006594307602;9496.477693726842;9543.04569543047;9551.0926461986;8848.911510884906;9446.197073248713;9460;9468.053194680546;9476;9405.90594094064;9511.239100871913;9520.761980950532;9526.380785249006;9529.047095290485;39165.804170979245;39364;39428.60571394278;39460.802695986626;39555.604443955766;3106.8757249709984;3301.6698330167033;3471.218975730466;3887.1836914248042;3968.7817170055637;29140;29312.56031159534;30340.848295758602;30663.69336306653;31293;3183.5065564837487;3193.3772914281726;3213.3573285343023;3215.3730022645595;3228.176814912182;436723;482988;489965;491359;492776;59484.40515594875;59558.40441595615;59984;60152;60292.397076029556;62955.05567416493;63410.731785364034;63618.68190659017;63635.72728545496;63786.6810665953;16050.839491605167;16101.436449724204;16271.674566508604;16289.755653665205;16355.754663680054;12140.696482588006;12358.62924112278;12441.813372799415;12480.875191247971;12515.561955331701;17976.820231797778;18469.168887400097;18472.538186545444;18534.25862965466;18551.979641119597;7725.575093369806;7743.92256077432;7964.960175199087;7983.560904150211;8113.634886430124;789.6407134753673;844.594594594598;975.4439969217619;998.4907697074544;1079.2768844873954;29363.265918351786;29432.26419339534;29483.262918426783;29920.031987204857;30131.397372052437;928.9442633442015;975.4586204656483;1073.3828048871774;1130.5477808876515;1205.15036898986;14784.408623655148;15340.616484587752;15361.078335299917;15435.305411256295;15447.073175609275;698645;703997;705555;707894;708869;45917.852053698254;46307.30539041917;55724.72137639286;56203.156952645746;56781.432185677615;1165.0854079547514;1171.625079974417;1208.546794951893;1323.1730168644597;1380.6203294094205;28571.28571785722;28686.282842929093;29038.7096129036;29442.411151776418;30285.697143028287;42388.576114238465;44498.11003779842;47035.52964470448;47295.76352118355;47392.76303618598;593645.1906442813;599003;601366;603283;603360;22510.212142574932;25886.870565647805;26138.215853523663;26751.598726019514;26791.330216744736;44996.77501612471;45224;45904.540954591364;46223;46303;32939.50590741189;36149;37253.6274637261;38341.424878627404;38444;37781.81109094437;38179.618203817605;38654.80672596619;38783.11176272382;39369;30413.543796842623;32055.839720801247;33630;36665.45001824921;37359.43960840535;32503.18742031468;33596.66403335935;34266.82866585651;34405;34416.82791586026;25642.974281029296;25738;25764;25789.742102578733;26089.347766305993 09:02:06 INFO - PROCESS | 1922 | |2;jquery.html;374.7919904453028;375.3693794425366;383.72947072314014;385.8823058967014;404.21985567854045;17808.28766849326;18160.819546729468;19395.903020484897;19405.514862128453;19563.804361956376;15846.920765396157;19349.22603095878;19791.604167916634;19809.801901980976;19830.305939292128;4463.754493502856;5261.263423120766;5312.893742125155;5342.439043900393;5443.836684899459;5278;5299.5230429261355;5406.83779486616;5408.486193811582;5409.891802163955;5387.1111266640955;5403.054465468547;5407.756650950697;5413.215083812845;5699.202111704365;5912.320083190445;6052.243469566304;6067.757289708428;6068.059450785136;6070.787522436738;5790.652560846321;5806.88386232273;5818.41815818419;5902.203202567642;5943.3462319144855;12884.54904078362;13090;13093.083484156114;15616.297266622916;25051.872665730087;1911.7897031326543;2018.4751964489192;2042.7855075217037;2291.7593652666396;2632.9468212714874;9847.261455390802;9884.851727224097;9945.850812237823;10367.32612380193;10390.688279351632;1856.303886042734;1865.1979648751033;1934.8971086480713;1958.5789055353025;1963.8919859407727;109827.45086274597;114381;121623.35499331311;122753;124211;11492.655220343404;11563.364014979088;11664.300141991507;11791.528338866348;11862.466189021343;13001.414936327888;14411.630895064953;14762.926185369004;14772.55682329532;14796.704065918837;7181.928180718126;7389;8416.663333466715;8530.658773648984;8657.610407531676;8270.75108591332;8411.957940210383;8435.493870367798;8502.234798868132;8643.481391116553;3987.601239876047;4544.818207271738;4552.339910712994;4576.405067341224;4639.675222734444;1900.4108726294892;1969.2615269274022;2003.0986056274735;2005.5387260929776;2014.174188582674;801.3028665061433;871.8012732492822;911.813212821181;934.1592566690033;1001.7044971733357;16062.75905861413;19634.50913727168;20577.48556286105;21125;21453.67819482709;404.9250888585621;411.9691023173274;416.74370262288477;425.5765513314272;431.14202736554034;5689.402612725687;5729.369769325371;5863.355030946593;6026.005709058044;6137.447629713347;626508;635226;637094;640709.7787066395;641649;80629;125245;128364.35817820851;128749;130763;436.45661151865494;450.59446498151925;451.8260469719182;452.40508731018605;452.5384108209608;11031.117510598971;11138.665840024812;11372.31766094037;11385.203035787416;11677.416129193676;52209.47790522046;52388.21417678662;52906.2064069047;54913.90172196613;56153;76279.47441051259;76593;78326;80181;80359;7931.405144614062;8163.591820409075;8224.753257402288;8248.803923430949;8311.584420779058;10349.379037257788;10560.207984401355;10823.945880270549;10991.230613856953;11109.666709998713;10444.477776111316;10458.26792124544;10553.102986245947;10710.250282480463;10931.83602245983;9569.425834449956;10401.68794936153;10500.684979450629;10619.787604247716;10709.464526773785;8791;10585.9470702646;10875.456227188768;10923.83614245771;11129.443527823738;6207.379262073757;7989.8402031960195;8180.427370084037;8244.711435099744;8276.131006244257;9264.351495395527;9416.76458088526;10004.24968127408;10416.697912760905;10992.065674417445 09:02:06 INFO - PROCESS | 1922 | |3;mootools.html;1499.2204053891974;1530.196646760451;1598.5284341119368;1697.711389063859;1717.86620830252;7730.922690773091;8019.759407217778;8251.669933202673;8750.21248087672;8784.4729316241;8241.175882411755;8518.957405212981;8556;8663.95668021659;8674.262687671555;2364.4443555764383;2370.798482129021;2379.5597814404305;2384.9046038158453;2391.80865530758;2377.524495100978;2406.795422389099;2407.9518409631796;2420.4674971506242;2428.9514209715794;2352.2472808701223;2357.1749887539395;2382.5473160099614;2386.737458879522;2387.868667223302;2010.0150926046279;2044.631966246075;2364.4325361913016;2378.250850981935;2391.9953619479775;2325.476767727248;2349.929502114939;2392.6889504364494;2402.2793162051316;2402.303332033708;7358.852822943565;8626.482411055356;8643.17889800468;8651.65393384264;8657.913420865774;5199.428062913114;5358.115910874701;5374.113271310229;5383.919241211385;5385.676859388449;3509.648535481234;3568.1793187567005;3587.802670853102;3637.563492380905;3650.3064417760543;1056.8467572201987;1061.1563806773634;1085.4301491716833;1122.2761318949313;1124.2973141786383;11192.776144477146;11289.887101128967;11314.434278285971;11325.037371823404;11348.319100853892;4515.932261016087;4654.045920586272;4727.479977202505;4737.478877323491;4807.61539076873;9796.16732577739;9798.951005244928;9851.50742462874;9863.654772082942;9864.210863130933;5322.92015619766;5325.334333208349;5330.653507521999;5335.706536140549;5337.839864804062;4292.678049146327;4304.332828411601;4798.7840547175465;4837.7097374157665;4873.293372460973;3817.58749262769;3834.69322454203;3901.0832454373767;3948.9140486366477;3962.9405558916637;1279.99520376504;1294.3463550906731;1295.4170623219588;1297.7469393468373;1301.531448678475;712.4158190283918;859.3769517100052;891.31814162166;899.325505870597;929.5538141692026;5638.238837756932;5697.715114244271;5719.685417302088;5747.166660834156;5980.700964951735;757.2219296240738;909.1635695160468;950.8763860698065;965.2567523007245;974.9853752193723;3684.8526058957877;3887.3391523441082;3949.19041596472;3952.466417033721;3963;9983.151432128205;10402.895971040192;10509.527071281658;10520.263581549218;10550.261481696207;9788.412695238309;10195.23535734808;10206.4386458744;10211.438370889673;10493.947530262452;7821.6871325147495;8005.279524842792;8029.638666260033;8149.959250203711;8191.221833925768;5473.589480789036;5515.586331025109;5564.749586268708;5701.144828275792;5941.405859414024;9354.625814967598;9541.570629321559;9550.37922535033;9562.56968436436;9581.185599223865;9294.25645948309;9638.807223855623;9676.758081047748;9798.902010979798;9874;7285.744998925013;7511.47419680639;7728.8454230916195;7995.600219988861;8160.14318496573;8056.234657707509;8124.8781268279845;8212.932318798517;8238.217369349903;8255.133211012757;7241.058662373857;7356;7387;7476.738314158978;7491.138519070377;7065.470089743187;7129.322714342129;7176.605286709281;7275.636218189175;7307;6748.7300507979135;6909.792706218822;6915.757948471981;6921.307869213038;6921.965390173017;4649.558291962258;4687.789049492849;4850.466448690711;4945.505449455026;5021.824236151717;4877.195262781602;4919.139150648693;4950.381202349707;5036.244563315386;5114.002769459919 09:02:06 INFO - PROCESS | 1922 | |4;prototype.html;273.7326179787583;292.6552491302465;296.17219870462054;304.33958310466284;309.7692219296624;4423.358613001113;4494.752788596626;5384.919226211605;5508.788066625341;5511.917321240179;4823.807047718087;5216.8695782605355;5236.581073514119;5275.208718692198;5360.9463905360935;3422.4502745454547;3743.232637309345;4059.2287465381555;4086.1419101988467;4101.958980410188;3911.6870650347905;4022.658074063708;4071.9185616287655;4115.695210682013;4140;3762.529683789526;3766.832281992591;3940;4015.6988225883174;4026.255142798577;3606.9639303607023;3712.7933421638077;4068.4100805383055;4088.669458408708;4102.871710279667;3521.9823900880588;3528.259065596202;3563.1804684922613;3570.1967057412135;3578.248567800765;4346.587074227943;5077.796888124508;5253.6322457428;5264.473552644743;5303.893922121536;4248.915021699549;4394.857337092347;4619.8152073917;4626.421697287839;4689.226277664181;5669.574781891333;5678.063119585264;5681.488666020078;5704.600677952545;5722.599418040739;3938.6849052075763;3957.406389041638;3966.0084978755312;3969.940450893239;3982.4026396040535;5506.862328441781;5723.535642199091;5885.234919460443;5885.882282354329;5976.880462390728;3149.7480201583817;3659.670629643345;3902.70729695274;3935.842566297316;3995.9200815983518;3906.8437262509183;3995.4805875236034;3995.9410756149646;3999.5000624921886;4026.8993275168355;4188.832446702158;4586.082783443325;4618.51505591908;4652.464966528893;4656.301554766812;4954.727489988085;5342.305500284938;5564.916526252109;5635.408282130399;5700.97149514258;1147.0594112827569;1265.6266401411606;1291.877271659191;1298.824469014416;1308.1627758234738;728.0208120078486;830.9169083091642;878.3631866896449;891.6789955615973;893.4058850864233;4001.83900693628;4812.593703148425;5062.291279220912;5192.273081768555;5213.428801271066;5066.620003499678;5180.611454140879;5212.149686861109;5555.50000499957;5633.985882541182;4279.379489973936;5073.289739436482;5139.434662187156;5157.484251574812;5173.422106257628;2393.9281821545383;2655.7916148152544;2757;2800.0479836855566;2884.9134525964255;4994.976029913859;5200.375954885362;5753.280839895013;5771.740271687784;5825.563082768809;4773.875625346757;4781.876259079114;4870.928395752929;5342.660836976889;5692.9468048410345;5088.618353623419;5372.462753724596;5679.858003549944;5725.914111288334;5751.367349591542;5503.917441238465;5526.49590583673;5530.97234513841;5583.162525621027;5610.39116810685;4855.587275081658;5317.112425089038;5366.892662146814;5374.596905232045;5474.343078830566;5599.244102046172;5719.936866921077;5756.597038207286;5770.913436298375;5795.710214489343;3150.33842892995;3269.6893795089427;3473.5484387030533;3834.175652234783;3971.3392027341174;5145.408278048072;5481.725913704378;5573.916391254053;5915.940840591539;5938.940610594012;5492.725363731717;5575.678848891979;5698.572607054404;5742.511886489695;5778;5107.1103691634335;5374.865628359323;5710.314762228559;5736.42635736423;5789.478946894799;4788.4253889533475;5084.923726144185;5612.915806262828;5643.717814109196;5692.032354499828;5092.898142037213;5245.606579506476;5337.891532844427;5657.558816329162;5719.342275638355;4513.526079761577;4916.557509824133;4922.652596234595;5554.833484968202;5590.01554448165 09:02:06 INFO - PROCESS | 1922 | |5;yui.html;604.9606775559588;683.6000939450421;697.0833354139306;743.4647054121033;751.6617522115049;13818.516351927685;14571.927140364283;14576.854231457683;14659.413623455062;14659.486917957873;13259.46962121514;13264.204147751117;13329.933350333258;13370.732585348287;13406.932965335183;652.5953908576689;683.3064439593817;806.3267171911461;820.9942820045457;839.2111415269658;832.3590835057003;833.0794472108324;834.1658341658342;839.7606682095604;840.5293035899915;855.7732200966749;881.2729498164008;883.4081165619051;884.7832281091141;886.0120965123873;857.5797859049052;879.2482427524438;880.1550511508959;880.3837313880277;880.9911900880974;644.6905485367004;646.670198198922;656.1175219329994;658.8385845467843;659.3538332434241;13488.595342139752;13662.316884155753;13720.245386503739;13744.65638359039;14420.206888621122;11808.232464889841;11861.94069029658;11887.524499020028;11968.940155299168;12038.217515861441;10746.892531074667;10824.18818588609;10866.45667716611;10871.619493317696;10970.177236707199;2629.513539995107;3492.545969024036;3556.7332450066347;3603.1892824114625;3695.9630403695887;85954.14045859524;87734;90608.54695726545;92696;97324.02675973221;9932.950335248423;10036.498175091216;10380.896191037993;10525.473726313654;10665.986731260518;18326.35857744999;18516.888986660844;18628.068596570116;18831.529211769815;18845.623087538173;5558.305211848519;6371.426571608577;7283.817904552323;7374.705011799468;7400.074990626172;3605.8737944171826;4165.66674666026;4204.495460544754;4211.557786432441;4229.97885010573;3235.223546348859;3343.331333733263;3356.7482438816696;3364.915877103092;3366.4781958796425;554.789180111555;601.9548533859978;606.1513880567242;622.433585437259;623.3517142172091;598.5510866849862;604.6070054464633;619.2383368456823;620.5842085802523;632.2286810091681;8194.713185038496;8616.612252448655;8681.913180868236;8725.563721814011;8934.28525717941;525.5716590978417;569.8689301460604;610.8900397928327;625.0468036244763;656.8817612829737;3911.8044097795564;4269.594388533084;4269.658427325807;4271.273883439822;4288.228118938621;67507.19283737022;120580;124061;124219;125160;108189;108680;108730;111589;111669.32496012567;61654.383456165764;76383.61808190924;94630.52684736533;94949.57575636372;96998;8717.825643487222;9285.814283714422;9322.161005509537;9885.752856178653;9900.603975840886;38240.08799560067;45909.77045114887;51186.97626047533;55909;57622;69581.95627065496;70888.64555677188;72826;80908.59545702234;81032;10249;12155.392230388623;12343.876561234272;12365.381730913597;12639.1784534005;12743.74512509726;13092.934535327262;13535.526256580972;13898.72202555923;13947.651308717363;12878.420471078636;12929;13023.739525209632;13091.083624146599;13171.934140329236;12350.62948111558;12583.056270779545;12585.748285034431;12646.494140234288;12766.936165319114;12223.93888030554;12493.25040497573;12916.095873289156;13014.4143513544;13418;10874.565017399216;11067.280626759235;11324.660260192208;11480.138989575647;11626.593069242535;11023.559057637605;11075.113990880549;11361.829572556253;11372.943135284271;11445.084393248686 09:02:06 INFO - PROCESS | 1922 | __end_tp_report 09:02:06 INFO - PROCESS | 1922 | __start_cc_report 09:02:06 INFO - PROCESS | 1922 | _x_x_mozilla_cycle_collect,368 09:02:06 INFO - PROCESS | 1922 | __end_cc_report 09:02:06 INFO - PROCESS | 1922 | __startTimestamp1480352526533__endTimestamp 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | ------- Summary: start ------- 09:02:06 INFO - PROCESS | 1922 | Number of tests: 6 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | [#0] dojo.html Cycles:165 Average:5745.21 Median:6013.00 stddev:667.59 (11.1%) stddev-sans-first:627.72 09:02:06 INFO - PROCESS | 1922 | Values: 2776.9 3364.1 3374.3 3404.1 3414.7 5717.1 5780.8 5791.1 5793.0 5810.9 5731.1 5753.2 5784.9 5796.0 5816.3 5218.7 5238.5 5248.8 5255.6 5311.8 4440.4 5279.9 5298.1 5329.9 5360.6 5221.0 5251.6 5314.7 5317.8 5323.8 5254.6 5290.2 5297.0 5311.4 5362.9 5231.0 5304.1 5320.3 5365.7 5387.6 5591.4 5903.2 5932.7 5934.8 5970.8 6121.1 6134.4 6141.5 6153.5 6238.6 4739.2 5088.5 5610.0 5729.0 6187.3 5010.4 5234.2 5990.8 6004.5 6011.4 6226.6 6248.3 6333.2 6343.0 6384.0 5236.7 6169.5 6230.8 6252.6 6291.1 5496.5 6205.5 6248.6 6250.3 6282.1 5937.5 6124.4 6146.9 6157.7 6167.2 6183.7 6191.4 6213.4 6228.3 6229.4 4266.3 4933.5 4982.0 5007.6 5021.9 4400.4 4410.7 4430.7 4451.7 4471.9 5786.8 5942.3 6013.0 6030.5 6059.3 6193.2 6244.1 6264.4 6280.0 6315.2 5845.2 5910.1 5919.7 5997.1 6013.1 5497.9 5520.3 5536.0 5558.2 5572.2 6401.9 6420.1 6425.0 6443.9 6451.4 6140.4 6143.8 6217.4 6273.0 6283.7 5293.5 6347.7 6366.2 6373.6 6394.2 6163.2 6203.7 6223.3 6223.9 6226.4 6081.6 6123.0 6163.8 6205.6 6239.2 5248.9 6116.8 6120.3 6185.0 6204.1 6177.0 6180.5 6200.2 6206.0 6217.6 5830.7 5918.1 6076.3 6084.4 6110.9 6089.0 6117.6 6117.9 6128.8 6175.0 6092.5 6110.5 6117.2 6137.1 6142.7 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | [#1] ext.html Cycles:180 Average:71703.97 Median:39916.90 stddev:161327.51 (404.2%) stddev-sans-first:161691.44 09:02:06 INFO - PROCESS | 1922 | Values: 477.9 486.0 515.3 517.4 520.8 32678.0 39743.6 40090.2 41597.0 41697.4 41015.8 41247.6 41490.2 41507.2 41664.2 7920.4 8699.1 9281.3 9439.2 9514.4 7267.9 9417.9 9461.7 9465.6 9504.2 9425.1 9461.0 9496.5 9543.0 9551.1 8848.9 9446.2 9460.0 9468.1 9476.0 9405.9 9511.2 9520.8 9526.4 9529.0 39165.8 39364.0 39428.6 39460.8 39555.6 3106.9 3301.7 3471.2 3887.2 3968.8 29140.0 29312.6 30340.8 30663.7 31293.0 3183.5 3193.4 3213.4 3215.4 3228.2 436723.0 482988.0 489965.0 491359.0 492776.0 59484.4 59558.4 59984.0 60152.0 60292.4 62955.1 63410.7 63618.7 63635.7 63786.7 16050.8 16101.4 16271.7 16289.8 16355.8 12140.7 12358.6 12441.8 12480.9 12515.6 17976.8 18469.2 18472.5 18534.3 18552.0 7725.6 7743.9 7965.0 7983.6 8113.6 789.6 844.6 975.4 998.5 1079.3 29363.3 29432.3 29483.3 29920.0 30131.4 928.9 975.5 1073.4 1130.5 1205.2 14784.4 15340.6 15361.1 15435.3 15447.1 698645.0 703997.0 705555.0 707894.0 708869.0 45917.9 46307.3 55724.7 56203.2 56781.4 1165.1 1171.6 1208.5 1323.2 1380.6 28571.3 28686.3 29038.7 29442.4 30285.7 42388.6 44498.1 47035.5 47295.8 47392.8 593645.2 599003.0 601366.0 603283.0 603360.0 22510.2 25886.9 26138.2 26751.6 26791.3 44996.8 45224.0 45904.5 46223.0 46303.0 32939.5 36149.0 37253.6 38341.4 38444.0 37781.8 38179.6 38654.8 38783.1 39369.0 30413.5 32055.8 33630.0 36665.5 37359.4 32503.2 33596.7 34266.8 34405.0 34416.8 25643.0 25738.0 25764.0 25789.7 26089.3 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | [#2] jquery.html Cycles:180 Average:34935.39 Median:414.36 stddev:105897.37 (25557.1%) stddev-sans-first:106162.64 09:02:06 INFO - PROCESS | 1922 | Values: 374.8 375.4 383.7 385.9 404.2 17808.3 18160.8 19395.9 19405.5 19563.8 15846.9 19349.2 19791.6 19809.8 19830.3 4463.8 5261.3 5312.9 5342.4 5443.8 5278.0 5299.5 5406.8 5408.5 5409.9 5387.1 5403.1 5407.8 5413.2 5699.2 5912.3 6052.2 6067.8 6068.1 6070.8 5790.7 5806.9 5818.4 5902.2 5943.3 12884.5 13090.0 13093.1 15616.3 25051.9 1911.8 2018.5 2042.8 2291.8 2632.9 9847.3 9884.9 9945.9 10367.3 10390.7 1856.3 1865.2 1934.9 1958.6 1963.9 109827.5 114381.0 121623.4 122753.0 124211.0 11492.7 11563.4 11664.3 11791.5 11862.5 13001.4 14411.6 14762.9 14772.6 14796.7 7181.9 7389.0 8416.7 8530.7 8657.6 8270.8 8412.0 8435.5 8502.2 8643.5 3987.6 4544.8 4552.3 4576.4 4639.7 1900.4 1969.3 2003.1 2005.5 2014.2 801.3 871.8 911.8 934.2 1001.7 16062.8 19634.5 20577.5 21125.0 21453.7 404.9 412.0 416.7 425.6 431.1 5689.4 5729.4 5863.4 6026.0 6137.4 626508.0 635226.0 637094.0 640709.8 641649.0 80629.0 125245.0 128364.4 128749.0 130763.0 436.5 450.6 451.8 452.4 452.5 11031.1 11138.7 11372.3 11385.2 11677.4 52209.5 52388.2 52906.2 54913.9 56153.0 76279.5 76593.0 78326.0 80181.0 80359.0 7931.4 8163.6 8224.8 8248.8 8311.6 10349.4 10560.2 10823.9 10991.2 11109.7 10444.5 10458.3 10553.1 10710.3 10931.8 9569.4 10401.7 10500.7 10619.8 10709.5 8791.0 10585.9 10875.5 10923.8 11129.4 6207.4 7989.8 8180.4 8244.7 8276.1 9264.4 9416.8 10004.2 10416.7 10992.1 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | [#3] mootools.html Cycles:180 Average:5600.36 Median:5327.99 stddev:3082.17 (57.8%) stddev-sans-first:3075.40 09:02:06 INFO - PROCESS | 1922 | Values: 1499.2 1530.2 1598.5 1697.7 1717.9 7730.9 8019.8 8251.7 8750.2 8784.5 8241.2 8519.0 8556.0 8664.0 8674.3 2364.4 2370.8 2379.6 2384.9 2391.8 2377.5 2406.8 2408.0 2420.5 2429.0 2352.2 2357.2 2382.5 2386.7 2387.9 2010.0 2044.6 2364.4 2378.3 2392.0 2325.5 2349.9 2392.7 2402.3 2402.3 7358.9 8626.5 8643.2 8651.7 8657.9 5199.4 5358.1 5374.1 5383.9 5385.7 3509.6 3568.2 3587.8 3637.6 3650.3 1056.8 1061.2 1085.4 1122.3 1124.3 11192.8 11289.9 11314.4 11325.0 11348.3 4515.9 4654.0 4727.5 4737.5 4807.6 9796.2 9799.0 9851.5 9863.7 9864.2 5322.9 5325.3 5330.7 5335.7 5337.8 4292.7 4304.3 4798.8 4837.7 4873.3 3817.6 3834.7 3901.1 3948.9 3962.9 1280.0 1294.3 1295.4 1297.7 1301.5 712.4 859.4 891.3 899.3 929.6 5638.2 5697.7 5719.7 5747.2 5980.7 757.2 909.2 950.9 965.3 975.0 3684.9 3887.3 3949.2 3952.5 3963.0 9983.2 10402.9 10509.5 10520.3 10550.3 9788.4 10195.2 10206.4 10211.4 10493.9 7821.7 8005.3 8029.6 8150.0 8191.2 5473.6 5515.6 5564.7 5701.1 5941.4 9354.6 9541.6 9550.4 9562.6 9581.2 9294.3 9638.8 9676.8 9798.9 9874.0 7285.7 7511.5 7728.8 7995.6 8160.1 8056.2 8124.9 8212.9 8238.2 8255.1 7241.1 7356.0 7387.0 7476.7 7491.1 7065.5 7129.3 7176.6 7275.6 7307.0 6748.7 6909.8 6915.8 6921.3 6922.0 4649.6 4687.8 4850.5 4945.5 5021.8 4877.2 4919.1 4950.4 5036.2 5114.0 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | [#4] prototype.html Cycles:180 Average:4483.95 Median:5081.36 stddev:1383.86 (27.2%) stddev-sans-first:1351.18 09:02:06 INFO - PROCESS | 1922 | Values: 273.7 292.7 296.2 304.3 309.8 4423.4 4494.8 5384.9 5508.8 5511.9 4823.8 5216.9 5236.6 5275.2 5360.9 3422.5 3743.2 4059.2 4086.1 4102.0 3911.7 4022.7 4071.9 4115.7 4140.0 3762.5 3766.8 3940.0 4015.7 4026.3 3607.0 3712.8 4068.4 4088.7 4102.9 3522.0 3528.3 3563.2 3570.2 3578.2 4346.6 5077.8 5253.6 5264.5 5303.9 4248.9 4394.9 4619.8 4626.4 4689.2 5669.6 5678.1 5681.5 5704.6 5722.6 3938.7 3957.4 3966.0 3969.9 3982.4 5506.9 5723.5 5885.2 5885.9 5976.9 3149.7 3659.7 3902.7 3935.8 3995.9 3906.8 3995.5 3995.9 3999.5 4026.9 4188.8 4586.1 4618.5 4652.5 4656.3 4954.7 5342.3 5564.9 5635.4 5701.0 1147.1 1265.6 1291.9 1298.8 1308.2 728.0 830.9 878.4 891.7 893.4 4001.8 4812.6 5062.3 5192.3 5213.4 5066.6 5180.6 5212.1 5555.5 5634.0 4279.4 5073.3 5139.4 5157.5 5173.4 2393.9 2655.8 2757.0 2800.0 2884.9 4995.0 5200.4 5753.3 5771.7 5825.6 4773.9 4781.9 4870.9 5342.7 5692.9 5088.6 5372.5 5679.9 5725.9 5751.4 5503.9 5526.5 5531.0 5583.2 5610.4 4855.6 5317.1 5366.9 5374.6 5474.3 5599.2 5719.9 5756.6 5770.9 5795.7 3150.3 3269.7 3473.5 3834.2 3971.3 5145.4 5481.7 5573.9 5915.9 5938.9 5492.7 5575.7 5698.6 5742.5 5778.0 5107.1 5374.9 5710.3 5736.4 5789.5 4788.4 5084.9 5612.9 5643.7 5692.0 5092.9 5245.6 5337.9 5657.6 5719.3 4513.5 4916.6 4922.7 5554.8 5590.0 09:02:06 INFO - PROCESS | 1922 | 09:02:06 INFO - PROCESS | 1922 | [#5] yui.html Cycles:180 Average:20797.35 Median:4038.74 stddev:31750.64 (786.2%) stddev-sans-first:31803.51 09:02:06 INFO - PROCESS | 1922 | Values: 605.0 683.6 697.1 743.5 751.7 13818.5 14571.9 14576.9 14659.4 14659.5 13259.5 13264.2 13329.9 13370.7 13406.9 652.6 683.3 806.3 821.0 839.2 832.4 833.1 834.2 839.8 840.5 855.8 881.3 883.4 884.8 886.0 857.6 879.2 880.2 880.4 881.0 644.7 646.7 656.1 658.8 659.4 13488.6 13662.3 13720.2 13744.7 14420.2 11808.2 11861.9 11887.5 11968.9 12038.2 10746.9 10824.2 10866.5 10871.6 10970.2 2629.5 3492.5 3556.7 3603.2 3696.0 85954.1 87734.0 90608.5 92696.0 97324.0 9933.0 10036.5 10380.9 10525.5 10666.0 18326.4 18516.9 18628.1 18831.5 18845.6 5558.3 6371.4 7283.8 7374.7 7400.1 3605.9 4165.7 4204.5 4211.6 4230.0 3235.2 3343.3 3356.7 3364.9 3366.5 554.8 602.0 606.2 622.4 623.4 598.6 604.6 619.2 620.6 632.2 8194.7 8616.6 8681.9 8725.6 8934.3 525.6 569.9 610.9 625.0 656.9 3911.8 4269.6 4269.7 4271.3 4288.2 67507.2 120580.0 124061.0 124219.0 125160.0 108189.0 108680.0 108730.0 111589.0 111669.3 61654.4 76383.6 94630.5 94949.6 96998.0 8717.8 9285.8 9322.2 9885.8 9900.6 38240.1 45909.8 51187.0 55909.0 57622.0 69582.0 70888.6 72826.0 80908.6 81032.0 10249.0 12155.4 12343.9 12365.4 12639.2 12743.7 13092.9 13535.5 13898.7 13947.7 12878.4 12929.0 13023.7 13091.1 13171.9 12350.6 12583.1 12585.7 12646.5 12766.9 12223.9 12493.3 12916.1 13014.4 13418.0 10874.6 11067.3 11324.7 11480.1 11626.6 11023.6 11075.1 11361.8 11372.9 11445.1 09:02:06 INFO - PROCESS | 1922 | -------- Summary: end -------- 09:02:06 INFO - PROCESS | 1922 | 09:02:07 INFO - TEST-INFO | 1922: exit 0 09:02:07 INFO - TEST-OK | dromaeo_css | took 1116153ms 09:02:07 INFO - TEST-START | kraken 09:02:07 INFO - operating with platform_type : mac_ 09:02:07 INFO - Initialising browser for kraken test... 09:02:07 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpzu0B0V/profile http://localhost:56588/getInfo.html) 09:02:10 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 09:02:10 INFO - PROCESS | 1926 | colorDepth:24 09:02:10 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 09:02:10 INFO - PROCESS | 1926 | __metrics 09:02:10 ERROR - PROCESS | 1926 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 09:02:11 INFO - TEST-INFO | 1926: exit 0 09:02:11 INFO - Browser initialized. 09:02:11 INFO - Running cycle 1/1 for kraken test... 09:02:11 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/T/tmpzu0B0V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:23 INFO - PROCESS | 1928 | RSS: Main: 229896192 09:02:23 INFO - PROCESS | 1928 | 09:02:26 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:27 INFO - PROCESS | 1928 | RSS: Main: 242065408 09:02:27 INFO - PROCESS | 1928 | 09:02:30 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-dft) 09:02:30 INFO - PROCESS | 1928 | RSS: Main: 249675776 09:02:30 INFO - PROCESS | 1928 | 09:02:34 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-fft) 09:02:34 INFO - PROCESS | 1928 | RSS: Main: 253390848 09:02:34 INFO - PROCESS | 1928 | 09:02:36 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56588/tests/kraken/driver.html?testName=audio-oscillator) 09:02:37 INFO - PROCESS | 1928 | RSS: Main: 253689856 09:02:37 INFO - PROCESS | 1928 | 09:02:39 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:40 INFO - PROCESS | 1928 | RSS: Main: 255004672 09:02:40 INFO - PROCESS | 1928 | 09:02:43 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56588/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:43 INFO - PROCESS | 1928 | RSS: Main: 258801664 09:02:43 INFO - PROCESS | 1928 | 09:02:46 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56588/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:47 INFO - PROCESS | 1928 | RSS: Main: 257916928 09:02:47 INFO - PROCESS | 1928 | 09:02:50 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56588/tests/kraken/driver.html?testName=json-parse-financial) 09:02:51 INFO - PROCESS | 1928 | RSS: Main: 258146304 09:02:51 INFO - PROCESS | 1928 | 09:02:52 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:53 INFO - PROCESS | 1928 | RSS: Main: 257667072 09:02:53 INFO - PROCESS | 1928 | 09:02:55 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:56 INFO - PROCESS | 1928 | RSS: Main: 257339392 09:02:56 INFO - PROCESS | 1928 | 09:02:58 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:58 INFO - PROCESS | 1928 | RSS: Main: 257417216 09:02:58 INFO - PROCESS | 1928 | 09:03:01 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:02 INFO - PROCESS | 1928 | RSS: Main: 257667072 09:03:02 INFO - PROCESS | 1928 | 09:03:05 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:06 INFO - PROCESS | 1928 | RSS: Main: 257536000 09:03:06 INFO - PROCESS | 1928 | 09:03:07 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56588/tests/kraken/driver.html?testName=ai-astar) 09:03:08 INFO - PROCESS | 1928 | RSS: Main: 259399680 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | __start_tp_report 09:03:08 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 09:03:08 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 09:03:08 INFO - PROCESS | 1928 | |i|pagename|runs| 09:03:08 INFO - PROCESS | 1928 | |0;ai-astar;107;119;118;120;120;118;121;120;119;122 09:03:08 INFO - PROCESS | 1928 | |1;audio-beat-detection;180;140;140;150;113;109;110;139;175;138 09:03:08 INFO - PROCESS | 1928 | |2;audio-dft;194;185;194;252;277;241;197;186;176;267 09:03:08 INFO - PROCESS | 1928 | |3;audio-fft;88;68;83;99;53;77;83;81;107;76 09:03:08 INFO - PROCESS | 1928 | |4;audio-oscillator;90;69;91;71;71;57;102;93;95;114 09:03:08 INFO - PROCESS | 1928 | |5;imaging-gaussian-blur;78;130;127;86;89;86;89;87;90;122 09:03:08 INFO - PROCESS | 1928 | |6;imaging-darkroom;163;100;116;164;117;100;100;129;122;100 09:03:08 INFO - PROCESS | 1928 | |7;imaging-desaturate;135;138;92;130;88;139;141;92;89;96 09:03:08 INFO - PROCESS | 1928 | |8;json-parse-financial;55;55;54;57;59;60;57;58;59;66 09:03:08 INFO - PROCESS | 1928 | |9;json-stringify-tinderbox;67;75;72;77;76;70;69;69;70;71 09:03:08 INFO - PROCESS | 1928 | |10;stanford-crypto-aes;87;86;85;88;86;83;86;88;87;79 09:03:08 INFO - PROCESS | 1928 | |11;stanford-crypto-ccm;149;154;150;142;153;167;159;152;216;155 09:03:08 INFO - PROCESS | 1928 | |12;stanford-crypto-pbkdf2;190;174;168;220;223;187;175;170;177;182 09:03:08 INFO - PROCESS | 1928 | |13;stanford-crypto-sha256-iterative;68;69;68;69;67;69;68;64;55;86 09:03:08 INFO - PROCESS | 1928 | __end_tp_report 09:03:08 INFO - PROCESS | 1928 | __start_cc_report 09:03:08 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,972 09:03:08 INFO - PROCESS | 1928 | __end_cc_report 09:03:08 INFO - PROCESS | 1928 | __startTimestamp1480352588142__endTimestamp 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | ------- Summary: start ------- 09:03:08 INFO - PROCESS | 1928 | Number of tests: 14 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#0] ai-astar Cycles:10 Average:118.40 Median:120.00 stddev:4.20 (3.5%) stddev-sans-first:1.32 09:03:08 INFO - PROCESS | 1928 | Values: 107.0 119.0 118.0 120.0 120.0 118.0 121.0 120.0 119.0 122.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:140.00 stddev:24.76 (17.7%) stddev-sans-first:21.46 09:03:08 INFO - PROCESS | 1928 | Values: 180.0 140.0 140.0 150.0 113.0 109.0 110.0 139.0 175.0 138.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#2] audio-dft Cycles:10 Average:216.90 Median:219.00 stddev:38.04 (17.4%) stddev-sans-first:39.44 09:03:08 INFO - PROCESS | 1928 | Values: 194.0 185.0 194.0 252.0 277.0 241.0 197.0 186.0 176.0 267.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#3] audio-fft Cycles:10 Average:81.50 Median:82.00 stddev:15.09 (18.4%) stddev-sans-first:15.82 09:03:08 INFO - PROCESS | 1928 | Values: 88.0 68.0 83.0 99.0 53.0 77.0 83.0 81.0 107.0 76.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:80.50 stddev:17.59 (21.9%) stddev-sans-first:18.58 09:03:08 INFO - PROCESS | 1928 | Values: 90.0 69.0 91.0 71.0 71.0 57.0 102.0 93.0 95.0 114.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#5] imaging-gaussian-blur Cycles:10 Average:98.40 Median:86.50 stddev:19.65 (22.7%) stddev-sans-first:19.40 09:03:08 INFO - PROCESS | 1928 | Values: 78.0 130.0 127.0 86.0 89.0 86.0 89.0 87.0 90.0 122.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#6] imaging-darkroom Cycles:10 Average:121.10 Median:119.50 stddev:24.68 (20.7%) stddev-sans-first:21.01 09:03:08 INFO - PROCESS | 1928 | Values: 163.0 100.0 116.0 164.0 117.0 100.0 100.0 129.0 122.0 100.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#7] imaging-desaturate Cycles:10 Average:114.00 Median:88.50 stddev:24.08 (27.2%) stddev-sans-first:24.32 09:03:08 INFO - PROCESS | 1928 | Values: 135.0 138.0 92.0 130.0 88.0 139.0 141.0 92.0 89.0 96.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.50 stddev:3.43 (5.9%) stddev-sans-first:3.46 09:03:08 INFO - PROCESS | 1928 | Values: 55.0 55.0 54.0 57.0 59.0 60.0 57.0 58.0 59.0 66.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#9] json-stringify-tinderbox Cycles:10 Average:71.60 Median:71.50 stddev:3.34 (4.7%) stddev-sans-first:3.10 09:03:08 INFO - PROCESS | 1928 | Values: 67.0 75.0 72.0 77.0 76.0 70.0 69.0 69.0 70.0 71.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:2.72 (3.1%) stddev-sans-first:2.83 09:03:08 INFO - PROCESS | 1928 | Values: 87.0 86.0 85.0 88.0 86.0 83.0 86.0 88.0 87.0 79.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:154.50 stddev:20.83 (13.5%) stddev-sans-first:21.73 09:03:08 INFO - PROCESS | 1928 | Values: 149.0 154.0 150.0 142.0 153.0 167.0 159.0 152.0 216.0 155.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:184.50 stddev:19.66 (10.7%) stddev-sans-first:20.82 09:03:08 INFO - PROCESS | 1928 | Values: 190.0 174.0 168.0 220.0 223.0 187.0 175.0 170.0 177.0 182.0 09:03:08 INFO - PROCESS | 1928 | 09:03:08 INFO - PROCESS | 1928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:7.54 (11.0%) stddev-sans-first:8.00 09:03:08 INFO - PROCESS | 1928 | Values: 68.0 69.0 68.0 69.0 67.0 69.0 68.0 64.0 55.0 86.0 09:03:08 INFO - PROCESS | 1928 | -------- Summary: end -------- 09:03:08 INFO - PROCESS | 1928 | 09:03:09 INFO - TEST-INFO | 1928: exit 0 09:03:09 INFO - TEST-OK | kraken | took 62024ms 09:03:09 INFO - SUITE-END | took 1178s 09:03:09 INFO - Completed test suite (00:19:38) 09:03:09 INFO - javascript benchmark 09:03:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7064.423519553952, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2776.8750406231716, 3364.058063742153, 3374.2913988062505, 3404.0808981574974, 3414.6926776590103, 5717.056685646869, 5780.797672081478, 5791.07342825148, 5792.971035144829, 5810.912836307453, 5731.111677689954, 5753.223314852494, 5784.913226301598, 5796.0, 5816.33112192098, 5218.739063046852, 5238.47615238475, 5248.816291429801, 5255.579553635719, 5311.787528498855, 4440.444944381952, 5279.9208011879855, 5298.072837253484, 5329.866753331159, 5360.571154307646, 5221.034108689885, 5251.5798736101215, 5314.681119132845, 5317.760700768475, 5323.760430780605, 5254.632175747699, 5290.153575427932, 5297.020051290524, 5311.415744268127, 5362.91955620666, 5230.973845130788, 5304.124819404794, 5320.255164277004, 5365.678059316453, 5387.622866399353, 5591.384947655754, 5903.232579764646, 5932.673702946337, 5934.821955341346, 5970.791022314198, 6121.0566939720375, 6134.355892631254, 6141.54737815085, 6153.538484613672, 6238.563300568962, 4739.241721324606, 5088.491150884919, 5610.0, 5728.968785618587, 6187.257529096492, 5010.423801262828, 5234.241035049897, 5990.760369585255, 6004.54965877561, 6011.4289142531825, 6226.595271307441, 6248.28144763349, 6333.20834895638, 6342.953412686855, 6384.0, 5236.685798852005, 6169.5064394848305, 6230.7507699691505, 6252.593581417284, 6291.087792270187, 5496.532794712414, 6205.503559715212, 6248.625082495065, 6250.312465628777, 6282.057691346335, 5937.52499800015, 6124.350421260821, 6146.938530614726, 6157.692115394212, 6167.167432396659, 6183.721732522047, 6191.4118158774845, 6213.37866213375, 6228.34602366754, 6229.4393504584805, 4266.31738921771, 4933.481984391659, 4982.028504441599, 5007.574356179693, 5021.949780502148, 4400.44994375703, 4410.735355878657, 4430.712003719748, 4451.710638808467, 4471.910561788811, 5786.826395208151, 5942.257217847769, 6013.0, 6030.547708921848, 6059.303180134253, 6193.225846769154, 6244.094606282064, 6264.373562643699, 6280.026595877646, 6315.179026726496, 5845.152452894306, 5910.083936989773, 5919.704014799329, 5997.100434934795, 6013.067974463965, 5497.945020549823, 5520.282363292827, 5536.0, 5558.249636299129, 5572.219889215513, 6401.935980640227, 6420.101185833893, 6425.0, 6443.903341449882, 6451.3548645135115, 6140.381550880894, 6143.818944274718, 6217.409346112112, 6273.027680709497, 6283.654399008098, 5293.47065293483, 6347.650879201688, 6366.172397588284, 6373.553851230369, 6394.23269207698, 6163.229596300463, 6203.658798766111, 6223.315435302204, 6223.875522489616, 6226.439620434183, 6081.574289799849, 6122.97760420812, 6163.8150855474405, 6205.565610407228, 6239.1577137085915, 5248.921266181087, 6116.785912493041, 6120.325235636462, 6185.0, 6204.100405441276, 6176.969115154396, 6180.47465965398, 6200.193974783249, 6206.0, 6217.595856269328, 5830.708464576839, 5918.141869428995, 6076.270847498328, 6084.368038837688, 6110.938890611214, 6088.969555152196, 6117.614269788275, 6117.9187529241, 6128.785492507741, 6175.0, 6092.451679348703, 6110.511159107172, 6117.248930028971, 6137.1101190328045, 6142.662153581596], "value": 5702.578781747192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.87097483679383, 486.0449217288028, 515.3352175693356, 517.4049842680914, 520.8125074973011, 32678.0, 39743.60256397439, 40090.1981960361, 41597.0, 41697.37453938186, 41015.79492102543, 41247.58752412475, 41490.170196596126, 41507.16985660285, 41664.16671666565, 7920.4059695523065, 8699.086595907433, 9281.257499400048, 9439.197668198178, 9514.429134251932, 7267.854642907138, 9417.90582094177, 9461.668841590546, 9465.574049167804, 9504.192143667797, 9425.057494250588, 9461.006594307602, 9496.477693726842, 9543.04569543047, 9551.0926461986, 8848.911510884906, 9446.197073248713, 9460.0, 9468.053194680546, 9476.0, 9405.90594094064, 9511.239100871913, 9520.761980950532, 9526.380785249006, 9529.047095290485, 39165.804170979245, 39364.0, 39428.60571394278, 39460.802695986626, 39555.604443955766, 3106.8757249709984, 3301.6698330167033, 3471.218975730466, 3887.1836914248042, 3968.7817170055637, 29140.0, 29312.56031159534, 30340.848295758602, 30663.69336306653, 31293.0, 3183.5065564837487, 3193.3772914281726, 3213.3573285343023, 3215.3730022645595, 3228.176814912182, 436723.0, 482988.0, 489965.0, 491359.0, 492776.0, 59484.40515594875, 59558.40441595615, 59984.0, 60152.0, 60292.397076029556, 62955.05567416493, 63410.731785364034, 63618.68190659017, 63635.72728545496, 63786.6810665953, 16050.839491605167, 16101.436449724204, 16271.674566508604, 16289.755653665205, 16355.754663680054, 12140.696482588006, 12358.62924112278, 12441.813372799415, 12480.875191247971, 12515.561955331701, 17976.820231797778, 18469.168887400097, 18472.538186545444, 18534.25862965466, 18551.979641119597, 7725.575093369806, 7743.92256077432, 7964.960175199087, 7983.560904150211, 8113.634886430124, 789.6407134753673, 844.594594594598, 975.4439969217619, 998.4907697074544, 1079.2768844873954, 29363.265918351786, 29432.26419339534, 29483.262918426783, 29920.031987204857, 30131.397372052437, 928.9442633442015, 975.4586204656483, 1073.3828048871774, 1130.5477808876515, 1205.15036898986, 14784.408623655148, 15340.616484587752, 15361.078335299917, 15435.305411256295, 15447.073175609275, 698645.0, 703997.0, 705555.0, 707894.0, 708869.0, 45917.852053698254, 46307.30539041917, 55724.72137639286, 56203.156952645746, 56781.432185677615, 1165.0854079547514, 1171.625079974417, 1208.546794951893, 1323.1730168644597, 1380.6203294094205, 28571.28571785722, 28686.282842929093, 29038.7096129036, 29442.411151776418, 30285.697143028287, 42388.576114238465, 44498.11003779842, 47035.52964470448, 47295.76352118355, 47392.76303618598, 593645.1906442813, 599003.0, 601366.0, 603283.0, 603360.0, 22510.212142574932, 25886.870565647805, 26138.215853523663, 26751.598726019514, 26791.330216744736, 44996.77501612471, 45224.0, 45904.540954591364, 46223.0, 46303.0, 32939.50590741189, 36149.0, 37253.6274637261, 38341.424878627404, 38444.0, 37781.81109094437, 38179.618203817605, 38654.80672596619, 38783.11176272382, 39369.0, 30413.543796842623, 32055.839720801247, 33630.0, 36665.45001824921, 37359.43960840535, 32503.18742031468, 33596.66403335935, 34266.82866585651, 34405.0, 34416.82791586026, 25642.974281029296, 25738.0, 25764.0, 25789.742102578733, 26089.347766305993], "value": 19594.115730769918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7919904453028, 375.3693794425366, 383.72947072314014, 385.8823058967014, 404.21985567854045, 17808.28766849326, 18160.819546729468, 19395.903020484897, 19405.514862128453, 19563.804361956376, 15846.920765396157, 19349.22603095878, 19791.604167916634, 19809.801901980976, 19830.305939292128, 4463.754493502856, 5261.263423120766, 5312.893742125155, 5342.439043900393, 5443.836684899459, 5278.0, 5299.5230429261355, 5406.83779486616, 5408.486193811582, 5409.891802163955, 5387.1111266640955, 5403.054465468547, 5407.756650950697, 5413.215083812845, 5699.202111704365, 5912.320083190445, 6052.243469566304, 6067.757289708428, 6068.059450785136, 6070.787522436738, 5790.652560846321, 5806.88386232273, 5818.41815818419, 5902.203202567642, 5943.3462319144855, 12884.54904078362, 13090.0, 13093.083484156114, 15616.297266622916, 25051.872665730087, 1911.7897031326543, 2018.4751964489192, 2042.7855075217037, 2291.7593652666396, 2632.9468212714874, 9847.261455390802, 9884.851727224097, 9945.850812237823, 10367.32612380193, 10390.688279351632, 1856.303886042734, 1865.1979648751033, 1934.8971086480713, 1958.5789055353025, 1963.8919859407727, 109827.45086274597, 114381.0, 121623.35499331311, 122753.0, 124211.0, 11492.655220343404, 11563.364014979088, 11664.300141991507, 11791.528338866348, 11862.466189021343, 13001.414936327888, 14411.630895064953, 14762.926185369004, 14772.55682329532, 14796.704065918837, 7181.928180718126, 7389.0, 8416.663333466715, 8530.658773648984, 8657.610407531676, 8270.75108591332, 8411.957940210383, 8435.493870367798, 8502.234798868132, 8643.481391116553, 3987.601239876047, 4544.818207271738, 4552.339910712994, 4576.405067341224, 4639.675222734444, 1900.4108726294892, 1969.2615269274022, 2003.0986056274735, 2005.5387260929776, 2014.174188582674, 801.3028665061433, 871.8012732492822, 911.813212821181, 934.1592566690033, 1001.7044971733357, 16062.75905861413, 19634.50913727168, 20577.48556286105, 21125.0, 21453.67819482709, 404.9250888585621, 411.9691023173274, 416.74370262288477, 425.5765513314272, 431.14202736554034, 5689.402612725687, 5729.369769325371, 5863.355030946593, 6026.005709058044, 6137.447629713347, 626508.0, 635226.0, 637094.0, 640709.7787066395, 641649.0, 80629.0, 125245.0, 128364.35817820851, 128749.0, 130763.0, 436.45661151865494, 450.59446498151925, 451.8260469719182, 452.40508731018605, 452.5384108209608, 11031.117510598971, 11138.665840024812, 11372.31766094037, 11385.203035787416, 11677.416129193676, 52209.47790522046, 52388.21417678662, 52906.2064069047, 54913.90172196613, 56153.0, 76279.47441051259, 76593.0, 78326.0, 80181.0, 80359.0, 7931.405144614062, 8163.591820409075, 8224.753257402288, 8248.803923430949, 8311.584420779058, 10349.379037257788, 10560.207984401355, 10823.945880270549, 10991.230613856953, 11109.666709998713, 10444.477776111316, 10458.26792124544, 10553.102986245947, 10710.250282480463, 10931.83602245983, 9569.425834449956, 10401.68794936153, 10500.684979450629, 10619.787604247716, 10709.464526773785, 8791.0, 10585.9470702646, 10875.456227188768, 10923.83614245771, 11129.443527823738, 6207.379262073757, 7989.8402031960195, 8180.427370084037, 8244.711435099744, 8276.131006244257, 9264.351495395527, 9416.76458088526, 10004.24968127408, 10416.697912760905, 10992.065674417445], "value": 8533.941007492658, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.2204053891974, 1530.196646760451, 1598.5284341119368, 1697.711389063859, 1717.86620830252, 7730.922690773091, 8019.759407217778, 8251.669933202673, 8750.21248087672, 8784.4729316241, 8241.175882411755, 8518.957405212981, 8556.0, 8663.95668021659, 8674.262687671555, 2364.4443555764383, 2370.798482129021, 2379.5597814404305, 2384.9046038158453, 2391.80865530758, 2377.524495100978, 2406.795422389099, 2407.9518409631796, 2420.4674971506242, 2428.9514209715794, 2352.2472808701223, 2357.1749887539395, 2382.5473160099614, 2386.737458879522, 2387.868667223302, 2010.0150926046279, 2044.631966246075, 2364.4325361913016, 2378.250850981935, 2391.9953619479775, 2325.476767727248, 2349.929502114939, 2392.6889504364494, 2402.2793162051316, 2402.303332033708, 7358.852822943565, 8626.482411055356, 8643.17889800468, 8651.65393384264, 8657.913420865774, 5199.428062913114, 5358.115910874701, 5374.113271310229, 5383.919241211385, 5385.676859388449, 3509.648535481234, 3568.1793187567005, 3587.802670853102, 3637.563492380905, 3650.3064417760543, 1056.8467572201987, 1061.1563806773634, 1085.4301491716833, 1122.2761318949313, 1124.2973141786383, 11192.776144477146, 11289.887101128967, 11314.434278285971, 11325.037371823404, 11348.319100853892, 4515.932261016087, 4654.045920586272, 4727.479977202505, 4737.478877323491, 4807.61539076873, 9796.16732577739, 9798.951005244928, 9851.50742462874, 9863.654772082942, 9864.210863130933, 5322.92015619766, 5325.334333208349, 5330.653507521999, 5335.706536140549, 5337.839864804062, 4292.678049146327, 4304.332828411601, 4798.7840547175465, 4837.7097374157665, 4873.293372460973, 3817.58749262769, 3834.69322454203, 3901.0832454373767, 3948.9140486366477, 3962.9405558916637, 1279.99520376504, 1294.3463550906731, 1295.4170623219588, 1297.7469393468373, 1301.531448678475, 712.4158190283918, 859.3769517100052, 891.31814162166, 899.325505870597, 929.5538141692026, 5638.238837756932, 5697.715114244271, 5719.685417302088, 5747.166660834156, 5980.700964951735, 757.2219296240738, 909.1635695160468, 950.8763860698065, 965.2567523007245, 974.9853752193723, 3684.8526058957877, 3887.3391523441082, 3949.19041596472, 3952.466417033721, 3963.0, 9983.151432128205, 10402.895971040192, 10509.527071281658, 10520.263581549218, 10550.261481696207, 9788.412695238309, 10195.23535734808, 10206.4386458744, 10211.438370889673, 10493.947530262452, 7821.6871325147495, 8005.279524842792, 8029.638666260033, 8149.959250203711, 8191.221833925768, 5473.589480789036, 5515.586331025109, 5564.749586268708, 5701.144828275792, 5941.405859414024, 9354.625814967598, 9541.570629321559, 9550.37922535033, 9562.56968436436, 9581.185599223865, 9294.25645948309, 9638.807223855623, 9676.758081047748, 9798.902010979798, 9874.0, 7285.744998925013, 7511.47419680639, 7728.8454230916195, 7995.600219988861, 8160.14318496573, 8056.234657707509, 8124.8781268279845, 8212.932318798517, 8238.217369349903, 8255.133211012757, 7241.058662373857, 7356.0, 7387.0, 7476.738314158978, 7491.138519070377, 7065.470089743187, 7129.322714342129, 7176.605286709281, 7275.636218189175, 7307.0, 6748.7300507979135, 6909.792706218822, 6915.757948471981, 6921.307869213038, 6921.965390173017, 4649.558291962258, 4687.789049492849, 4850.466448690711, 4945.505449455026, 5021.824236151717, 4877.195262781602, 4919.139150648693, 4950.381202349707, 5036.244563315386, 5114.002769459919], "value": 4525.579237412878, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.7326179787583, 292.6552491302465, 296.17219870462054, 304.33958310466284, 309.7692219296624, 4423.358613001113, 4494.752788596626, 5384.919226211605, 5508.788066625341, 5511.917321240179, 4823.807047718087, 5216.8695782605355, 5236.581073514119, 5275.208718692198, 5360.9463905360935, 3422.4502745454547, 3743.232637309345, 4059.2287465381555, 4086.1419101988467, 4101.958980410188, 3911.6870650347905, 4022.658074063708, 4071.9185616287655, 4115.695210682013, 4140.0, 3762.529683789526, 3766.832281992591, 3940.0, 4015.6988225883174, 4026.255142798577, 3606.9639303607023, 3712.7933421638077, 4068.4100805383055, 4088.669458408708, 4102.871710279667, 3521.9823900880588, 3528.259065596202, 3563.1804684922613, 3570.1967057412135, 3578.248567800765, 4346.587074227943, 5077.796888124508, 5253.6322457428, 5264.473552644743, 5303.893922121536, 4248.915021699549, 4394.857337092347, 4619.8152073917, 4626.421697287839, 4689.226277664181, 5669.574781891333, 5678.063119585264, 5681.488666020078, 5704.600677952545, 5722.599418040739, 3938.6849052075763, 3957.406389041638, 3966.0084978755312, 3969.940450893239, 3982.4026396040535, 5506.862328441781, 5723.535642199091, 5885.234919460443, 5885.882282354329, 5976.880462390728, 3149.7480201583817, 3659.670629643345, 3902.70729695274, 3935.842566297316, 3995.9200815983518, 3906.8437262509183, 3995.4805875236034, 3995.9410756149646, 3999.5000624921886, 4026.8993275168355, 4188.832446702158, 4586.082783443325, 4618.51505591908, 4652.464966528893, 4656.301554766812, 4954.727489988085, 5342.305500284938, 5564.916526252109, 5635.408282130399, 5700.97149514258, 1147.0594112827569, 1265.6266401411606, 1291.877271659191, 1298.824469014416, 1308.1627758234738, 728.0208120078486, 830.9169083091642, 878.3631866896449, 891.6789955615973, 893.4058850864233, 4001.83900693628, 4812.593703148425, 5062.291279220912, 5192.273081768555, 5213.428801271066, 5066.620003499678, 5180.611454140879, 5212.149686861109, 5555.50000499957, 5633.985882541182, 4279.379489973936, 5073.289739436482, 5139.434662187156, 5157.484251574812, 5173.422106257628, 2393.9281821545383, 2655.7916148152544, 2757.0, 2800.0479836855566, 2884.9134525964255, 4994.976029913859, 5200.375954885362, 5753.280839895013, 5771.740271687784, 5825.563082768809, 4773.875625346757, 4781.876259079114, 4870.928395752929, 5342.660836976889, 5692.9468048410345, 5088.618353623419, 5372.462753724596, 5679.858003549944, 5725.914111288334, 5751.367349591542, 5503.917441238465, 5526.49590583673, 5530.97234513841, 5583.162525621027, 5610.39116810685, 4855.587275081658, 5317.112425089038, 5366.892662146814, 5374.596905232045, 5474.343078830566, 5599.244102046172, 5719.936866921077, 5756.597038207286, 5770.913436298375, 5795.710214489343, 3150.33842892995, 3269.6893795089427, 3473.5484387030533, 3834.175652234783, 3971.3392027341174, 5145.408278048072, 5481.725913704378, 5573.916391254053, 5915.940840591539, 5938.940610594012, 5492.725363731717, 5575.678848891979, 5698.572607054404, 5742.511886489695, 5778.0, 5107.1103691634335, 5374.865628359323, 5710.314762228559, 5736.42635736423, 5789.478946894799, 4788.4253889533475, 5084.923726144185, 5612.915806262828, 5643.717814109196, 5692.032354499828, 5092.898142037213, 5245.606579506476, 5337.891532844427, 5657.558816329162, 5719.342275638355, 4513.526079761577, 4916.557509824133, 4922.652596234595, 5554.833484968202, 5590.01554448165], "value": 4034.654021816496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.9606775559588, 683.6000939450421, 697.0833354139306, 743.4647054121033, 751.6617522115049, 13818.516351927685, 14571.927140364283, 14576.854231457683, 14659.413623455062, 14659.486917957873, 13259.46962121514, 13264.204147751117, 13329.933350333258, 13370.732585348287, 13406.932965335183, 652.5953908576689, 683.3064439593817, 806.3267171911461, 820.9942820045457, 839.2111415269658, 832.3590835057003, 833.0794472108324, 834.1658341658342, 839.7606682095604, 840.5293035899915, 855.7732200966749, 881.2729498164008, 883.4081165619051, 884.7832281091141, 886.0120965123873, 857.5797859049052, 879.2482427524438, 880.1550511508959, 880.3837313880277, 880.9911900880974, 644.6905485367004, 646.670198198922, 656.1175219329994, 658.8385845467843, 659.3538332434241, 13488.595342139752, 13662.316884155753, 13720.245386503739, 13744.65638359039, 14420.206888621122, 11808.232464889841, 11861.94069029658, 11887.524499020028, 11968.940155299168, 12038.217515861441, 10746.892531074667, 10824.18818588609, 10866.45667716611, 10871.619493317696, 10970.177236707199, 2629.513539995107, 3492.545969024036, 3556.7332450066347, 3603.1892824114625, 3695.9630403695887, 85954.14045859524, 87734.0, 90608.54695726545, 92696.0, 97324.02675973221, 9932.950335248423, 10036.498175091216, 10380.896191037993, 10525.473726313654, 10665.986731260518, 18326.35857744999, 18516.888986660844, 18628.068596570116, 18831.529211769815, 18845.623087538173, 5558.305211848519, 6371.426571608577, 7283.817904552323, 7374.705011799468, 7400.074990626172, 3605.8737944171826, 4165.66674666026, 4204.495460544754, 4211.557786432441, 4229.97885010573, 3235.223546348859, 3343.331333733263, 3356.7482438816696, 3364.915877103092, 3366.4781958796425, 554.789180111555, 601.9548533859978, 606.1513880567242, 622.433585437259, 623.3517142172091, 598.5510866849862, 604.6070054464633, 619.2383368456823, 620.5842085802523, 632.2286810091681, 8194.713185038496, 8616.612252448655, 8681.913180868236, 8725.563721814011, 8934.28525717941, 525.5716590978417, 569.8689301460604, 610.8900397928327, 625.0468036244763, 656.8817612829737, 3911.8044097795564, 4269.594388533084, 4269.658427325807, 4271.273883439822, 4288.228118938621, 67507.19283737022, 120580.0, 124061.0, 124219.0, 125160.0, 108189.0, 108680.0, 108730.0, 111589.0, 111669.32496012567, 61654.383456165764, 76383.61808190924, 94630.52684736533, 94949.57575636372, 96998.0, 8717.825643487222, 9285.814283714422, 9322.161005509537, 9885.752856178653, 9900.603975840886, 38240.08799560067, 45909.77045114887, 51186.97626047533, 55909.0, 57622.0, 69581.95627065496, 70888.64555677188, 72826.0, 80908.59545702234, 81032.0, 10249.0, 12155.392230388623, 12343.876561234272, 12365.381730913597, 12639.1784534005, 12743.74512509726, 13092.934535327262, 13535.526256580972, 13898.72202555923, 13947.651308717363, 12878.420471078636, 12929.0, 13023.739525209632, 13091.083624146599, 13171.934140329236, 12350.62948111558, 12583.056270779545, 12585.748285034431, 12646.494140234288, 12766.936165319114, 12223.93888030554, 12493.25040497573, 12916.095873289156, 13014.4143513544, 13418.0, 10874.565017399216, 11067.280626759235, 11324.660260192208, 11480.138989575647, 11626.593069242535, 11023.559057637605, 11075.113990880549, 11361.829572556253, 11372.943135284271, 11445.084393248686], "value": 7138.196619390504, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 119.0, 118.0, 120.0, 120.0, 118.0, 121.0, 120.0, 119.0, 122.0], "value": 118.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 140.0, 140.0, 150.0, 113.0, 109.0, 110.0, 139.0, 175.0, 138.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 185.0, 194.0, 252.0, 277.0, 241.0, 197.0, 186.0, 176.0, 267.0], "value": 216.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 68.0, 83.0, 99.0, 53.0, 77.0, 83.0, 81.0, 107.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 69.0, 91.0, 71.0, 71.0, 57.0, 102.0, 93.0, 95.0, 114.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 130.0, 127.0, 86.0, 89.0, 86.0, 89.0, 87.0, 90.0, 122.0], "value": 98.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 100.0, 116.0, 164.0, 117.0, 100.0, 100.0, 129.0, 122.0, 100.0], "value": 121.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 138.0, 92.0, 130.0, 88.0, 139.0, 141.0, 92.0, 89.0, 96.0], "value": 114.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 57.0, 59.0, 60.0, 57.0, 58.0, 59.0, 66.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 72.0, 77.0, 76.0, 70.0, 69.0, 69.0, 70.0, 71.0], "value": 71.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 88.0, 86.0, 83.0, 86.0, 88.0, 87.0, 79.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 154.0, 150.0, 142.0, 153.0, 167.0, 159.0, 152.0, 216.0, 155.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 174.0, 168.0, 220.0, 223.0, 187.0, 175.0, 170.0, 177.0, 182.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 69.0, 67.0, 69.0, 68.0, 64.0, 55.0, 86.0], "value": 68.3, "unit": "score"}]}]} 09:03:09 INFO - Return code: 0 09:03:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:09 ERROR - # TBPL SUCCESS # 09:03:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:09 INFO - 2016-11-28 09:03:09.460 screenresolution[1933:21535] starting screenresolution argv=screenresolution get 09:03:09 INFO - 2016-11-28 09:03:09.464 screenresolution[1933:21535] Display 0: 1600x1200x32@60 09:03:09 INFO - 2016-11-28 09:03:09.470 screenresolution[1934:21538] starting screenresolution argv=screenresolution list 09:03:09 INFO - Available Modes on Display 0 09:03:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:09 INFO - Intel Iris: 09:03:09 INFO - Chipset Model: Intel Iris 09:03:09 INFO - Type: GPU 09:03:09 INFO - Bus: Built-In 09:03:09 INFO - VRAM (Dynamic, Max): 1536 MB 09:03:09 INFO - Vendor: Intel (0x8086) 09:03:09 INFO - Device ID: 0x0a2e 09:03:09 INFO - Revision ID: 0x0009 09:03:09 INFO - Displays: 09:03:09 INFO - Display: 09:03:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:09 INFO - Display Serial Number: 1600x1200 60 09:03:09 INFO - Main Display: Yes 09:03:09 INFO - Mirror: Off 09:03:09 INFO - Online: Yes 09:03:09 INFO - Rotation: Supported 09:03:09 INFO - Return code: 0 09:03:09 INFO - Running post-action listener: _resource_record_post_action 09:03:09 INFO - [mozharness: 2016-11-28 17:03:09.720306Z] Finished run-tests step (success) 09:03:09 INFO - Running post-run listener: _resource_record_post_run 09:03:09 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 163840; Write bytes: 658115072; Read time: 2; Write time: 1830 09:03:09 INFO - TinderboxPrint: CPU usage
54.5% 09:03:09 INFO - TinderboxPrint: I/O read bytes / time
163,840 / 2 09:03:09 INFO - TinderboxPrint: I/O write bytes / time
658,115,072 / 1,830 09:03:09 INFO - TinderboxPrint: CPU idle
2,201.4 (45.5%) 09:03:09 INFO - TinderboxPrint: CPU system
981.7 (20.3%) 09:03:09 INFO - TinderboxPrint: CPU user
1,658.5 (34.3%) 09:03:09 INFO - TinderboxPrint: Swap in / out
347,873,280 / 0 09:03:09 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 349086208; Write bytes: 347075072; Read time: 26883; Write time: 676 09:03:09 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 16384; Write bytes: 304756736; Read time: 0; Write time: 1128 09:03:10 INFO - Running post-run listener: _upload_blobber_files 09:03:10 INFO - Blob upload gear active. 09:03:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:11 INFO - (blobuploader) - INFO - Done attempting. 09:03:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:12 INFO - (blobuploader) - INFO - Done attempting. 09:03:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:16 INFO - (blobuploader) - INFO - Done attempting. 09:03:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:16 INFO - Return code: 0 09:03:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e08686f37e17b0467faf6b65ae3736a57d4992556a3b2b8289ef49f4e1b43d535d106428efd80cd030cf0918ce79a215773d475d280ade4789aea1969f6327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2bbf6ff320c62ab4bfeb84efb60b043ac1d10ab1e9952160b31db08fc0cf26b9550a30d5c13ef2dcafecee21b8b5f593c5bb66edcfe0af601b0e574b92e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/367662f7a638ecefffa58d676beb424bc0c40b7e765b2cab051db1e8018aac5fcc843b7d3cb2c3acb52c89c9136628131c037df4ca2860a050ce1b49a2ab5eb8"} 09:03:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:16 INFO - Contents: 09:03:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e08686f37e17b0467faf6b65ae3736a57d4992556a3b2b8289ef49f4e1b43d535d106428efd80cd030cf0918ce79a215773d475d280ade4789aea1969f6327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2bbf6ff320c62ab4bfeb84efb60b043ac1d10ab1e9952160b31db08fc0cf26b9550a30d5c13ef2dcafecee21b8b5f593c5bb66edcfe0af601b0e574b92e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/367662f7a638ecefffa58d676beb424bc0c40b7e765b2cab051db1e8018aac5fcc843b7d3cb2c3acb52c89c9136628131c037df4ca2860a050ce1b49a2ab5eb8"} 09:03:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:16 INFO - Copying logs to upload dir... 09:03:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.822387 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-11-28 09:03:16.288583) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 09:03:16.293772) ========= 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.2jqumpMJc1/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.4MMVl5lcr8/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e08686f37e17b0467faf6b65ae3736a57d4992556a3b2b8289ef49f4e1b43d535d106428efd80cd030cf0918ce79a215773d475d280ade4789aea1969f6327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2bbf6ff320c62ab4bfeb84efb60b043ac1d10ab1e9952160b31db08fc0cf26b9550a30d5c13ef2dcafecee21b8b5f593c5bb66edcfe0af601b0e574b92e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/367662f7a638ecefffa58d676beb424bc0c40b7e765b2cab051db1e8018aac5fcc843b7d3cb2c3acb52c89c9136628131c037df4ca2860a050ce1b49a2ab5eb8"} build_url:https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/FQvYy-e8SCWC2J9vu_keJA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e08686f37e17b0467faf6b65ae3736a57d4992556a3b2b8289ef49f4e1b43d535d106428efd80cd030cf0918ce79a215773d475d280ade4789aea1969f6327", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a2bbf6ff320c62ab4bfeb84efb60b043ac1d10ab1e9952160b31db08fc0cf26b9550a30d5c13ef2dcafecee21b8b5f593c5bb66edcfe0af601b0e574b92e23d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/367662f7a638ecefffa58d676beb424bc0c40b7e765b2cab051db1e8018aac5fcc843b7d3cb2c3acb52c89c9136628131c037df4ca2860a050ce1b49a2ab5eb8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 09:03:16.330646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 09:03:16.330973) ========= 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.2jqumpMJc1/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.4MMVl5lcr8/Listeners TMPDIR=/var/folders/wv/r2n7k9s14895rpd35vpv6gkw00000w/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.005227 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 09:03:16.379092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 09:03:16.382425) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 09:03:16.382751) ========= ========= Total master_lag: 0.20 =========