builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0099 starttime: 1483009010.18 results: success (0) buildid: 20161229013937 builduid: f360bf03ea4e41b9ae05d6af79031c1b revision: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.184805) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.185273) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.185548) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.221837) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.222104) ========= 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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-12-29 02:56:50-- 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% 15.7M=0.001s 2016-12-29 02:56:50 (15.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.615126 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.861102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.861388) ========= 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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.026617 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:50.910376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-29 02:56:50.910741) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 --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 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-12-29 02:56:51,003 truncating revision to first 12 chars 2016-12-29 02:56:51,003 Setting DEBUG logging. 2016-12-29 02:56:51,003 attempt 1/10 2016-12-29 02:56:51,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/80e89a0b39c5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 02:56:51,952 unpacking tar archive at: mozilla-aurora-80e89a0b39c5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.220747 ========= master_lag: 1.00 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-12-29 02:56:53.135095) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:53.135382) ========= script_repo_revision: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:53.135732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:53.136007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 02:56:53.220092) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-29 02:56:53.220349) ========= /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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:56:53 INFO - MultiFileLogger online at 20161229 02:56:53 in /builds/slave/test 02:56:53 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 02:56:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:53 INFO - {'append_to_log': False, 02:56:53 INFO - 'base_work_dir': '/builds/slave/test', 02:56:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:56:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:53 INFO - 'branch': 'Mozilla-Aurora', 02:56:53 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:53 INFO - 'config_files': ('talos/mac_config.py',), 02:56:53 INFO - 'default_actions': ('clobber', 02:56:53 INFO - 'read-buildbot-config', 02:56:53 INFO - 'download-and-extract', 02:56:53 INFO - 'populate-webroot', 02:56:53 INFO - 'create-virtualenv', 02:56:53 INFO - 'install', 02:56:53 INFO - 'run-tests'), 02:56:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:53 INFO - 'download_minidump_stackwalk': True, 02:56:53 INFO - 'download_symbols': 'ondemand', 02:56:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:56:53 INFO - 'tooltool.py': '/tools/tooltool.py', 02:56:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:56:53 INFO - '/tools/misc-python/virtualenv.py')}, 02:56:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:53 INFO - 'installer_path': 'installer.exe', 02:56:53 INFO - 'log_level': 'info', 02:56:53 INFO - 'log_name': 'talos', 02:56:53 INFO - 'log_to_console': True, 02:56:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:56:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:56:53 INFO - 'opt_config_files': (), 02:56:53 INFO - 'pip_index': False, 02:56:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:56:53 INFO - 'cmd': ('bash', 02:56:53 INFO - '-c', 02:56:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:56:53 INFO - 'enabled': True, 02:56:53 INFO - 'halt_on_failure': False, 02:56:53 INFO - 'name': 'check_screen_resolution'},), 02:56:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:56:53 INFO - 'cmd': ('bash', 02:56:53 INFO - '-c', 02:56:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:56:53 INFO - 'enabled': True, 02:56:53 INFO - 'halt_on_failure': False, 02:56:53 INFO - 'name': 'check_screen_resolution'},), 02:56:53 INFO - 'run_cmd_checks_enabled': True, 02:56:53 INFO - 'sps_profile': False, 02:56:53 INFO - 'sps_profile_interval': 0, 02:56:53 INFO - 'suite': 'dromaeojs-e10s', 02:56:53 INFO - 'system_bits': '32', 02:56:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:53 INFO - 'title': 't-yosemite-r7-0099', 02:56:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:53 INFO - 'use_talos_json': True, 02:56:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:53 INFO - 'work_dir': 'build'} 02:56:53 INFO - [mozharness: 2016-12-29 10:56:53.448077Z] Running clobber step. 02:56:53 INFO - Running pre-action listener: _resource_record_pre_action 02:56:53 INFO - Running main action method: clobber 02:56:53 INFO - rmtree: /builds/slave/test/build 02:56:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:56:55 INFO - Running post-action listener: _resource_record_post_action 02:56:55 INFO - [mozharness: 2016-12-29 10:56:55.771421Z] Finished clobber step (success) 02:56:55 INFO - [mozharness: 2016-12-29 10:56:55.771556Z] Running read-buildbot-config step. 02:56:55 INFO - Running pre-action listener: _resource_record_pre_action 02:56:55 INFO - Running main action method: read_buildbot_config 02:56:55 INFO - Using buildbot properties: 02:56:55 INFO - { 02:56:55 INFO - "project": "", 02:56:55 INFO - "product": "firefox", 02:56:55 INFO - "script_repo_revision": "production", 02:56:55 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:56:55 INFO - "repository": "", 02:56:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:56:55 INFO - "buildid": "20161229013937", 02:56:55 INFO - "pgo_build": "False", 02:56:55 INFO - "basedir": "/builds/slave/test", 02:56:55 INFO - "buildnumber": 16, 02:56:55 INFO - "slavename": "t-yosemite-r7-0099", 02:56:55 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:56:55 INFO - "platform": "yosemite_r7", 02:56:55 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:56:55 INFO - "branch": "mozilla-aurora", 02:56:55 INFO - "repo_path": "releases/mozilla-aurora", 02:56:55 INFO - "revision": "80e89a0b39c5c21de97eb9f1ad1c60fcdc618992", 02:56:55 INFO - "stage_platform": "macosx64", 02:56:55 INFO - "builduid": "f360bf03ea4e41b9ae05d6af79031c1b", 02:56:55 INFO - "slavebuilddir": "test" 02:56:55 INFO - } 02:56:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:56:55 INFO - Running post-action listener: _resource_record_post_action 02:56:55 INFO - [mozharness: 2016-12-29 10:56:55.774944Z] Finished read-buildbot-config step (success) 02:56:55 INFO - [mozharness: 2016-12-29 10:56:55.775079Z] Running download-and-extract step. 02:56:55 INFO - Running pre-action listener: _resource_record_pre_action 02:56:55 INFO - Running main action method: download_and_extract 02:56:55 INFO - mkdir: /builds/slave/test/build/tests 02:56:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:55 INFO - trying https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:56:55 INFO - Downloading https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/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 02:56:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/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 02:56:56 INFO - Downloaded 1199 bytes. 02:56:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:56:56 INFO - Using the following test package requirements: 02:56:56 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:56:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:56:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:56:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'jsshell-mac.zip'], 02:56:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:56:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:56:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:56:56 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:56:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:56:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:56:56 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:56:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:56:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:56:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:56:56 INFO - Fetch https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:56:57 INFO - Http code: 200 02:56:57 INFO - via: 1.1 f46e4d7bc5419470a70eb57aa9c935c8.cloudfront.net (CloudFront) 02:56:57 INFO - x-amz-cf-id: yaqzEJVudnZHucGlId58D4Z46078e3M5-Zi4X6xY25HAIIzeCvA9Zg== 02:56:57 INFO - x-amz-version-id: XfcifysCQT7UqvFMVZAKdHeygxa4dIok 02:56:57 INFO - Expected file size: 16268413 02:56:57 INFO - Obtained file size: 16268413 02:57:04 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 02:57:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:57:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:57:04 INFO - Fetch https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:57:04 INFO - Http code: 200 02:57:04 INFO - via: 1.1 373880a309382d9266a9313233b86d25.cloudfront.net (CloudFront) 02:57:04 INFO - x-amz-cf-id: bLCsCxvfdUHsLBd6AjrNpvf7g0RovSJ-_25tbRS4dtdHddY5BtSoQA== 02:57:04 INFO - x-amz-version-id: XfcifysCQT7UqvFMVZAKdHeygxa4dIok 02:57:05 INFO - Expected file size: 16268413 02:57:05 INFO - Obtained file size: 16268413 02:57:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:57:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:57:11 INFO - Fetch https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:57:12 INFO - Http code: 200 02:57:12 INFO - via: 1.1 b04a4cffa8fb4f524ff7edcab1b5ae31.cloudfront.net (CloudFront) 02:57:12 INFO - x-amz-cf-id: WjY7YAttLKQ-9ufcUTaTq4GhRwWQb1colpZ-m-IGVy8mJXzRcwCSdQ== 02:57:12 INFO - x-amz-version-id: j9MDkeizv4DdCTKrPLbyGBSg8IRDrpHF 02:57:12 INFO - Expected file size: 14409038 02:57:12 INFO - Obtained file size: 14409038 02:57:12 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')]} 02:57:12 INFO - trying https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:57:12 INFO - Downloading https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:57:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/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 02:57:15 INFO - Downloaded 109824693 bytes. 02:57:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:57:15 INFO - mkdir: /builds/slave/test/properties 02:57:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:15 INFO - Contents: 02:57:15 INFO - build_url:https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:57:16 INFO - Running post-action listener: _resource_record_post_action 02:57:16 INFO - Running post-action listener: set_extra_try_arguments 02:57:16 INFO - [mozharness: 2016-12-29 10:57:16.239911Z] Finished download-and-extract step (success) 02:57:16 INFO - [mozharness: 2016-12-29 10:57:16.240018Z] Running populate-webroot step. 02:57:16 INFO - Running pre-action listener: _resource_record_pre_action 02:57:16 INFO - Running main action method: populate_webroot 02:57:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:16 INFO - '--tppagecycles', 02:57:16 INFO - '7'], 02:57:16 INFO - 'tests': ['tsvgm']}}, 02:57:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['damp', 'tps']}, 02:57:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'tests': ['damp', 'tps']}, 02:57:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['dromaeo_dom']}, 02:57:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['basic_compositor_video']}, 02:57:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:57:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['a11yr', 02:57:16 INFO - 'ts_paint', 02:57:16 INFO - 'tpaint', 02:57:16 INFO - 'sessionrestore', 02:57:16 INFO - 'sessionrestore_no_auto_restore', 02:57:16 INFO - 'tabpaint']}, 02:57:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:16 INFO - 'ts_paint', 02:57:16 INFO - 'tpaint', 02:57:16 INFO - 'sessionrestore', 02:57:16 INFO - 'sessionrestore_no_auto_restore', 02:57:16 INFO - 'tabpaint']}, 02:57:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:16 INFO - 'ts_paint', 02:57:16 INFO - 'tpaint', 02:57:16 INFO - 'sessionrestore', 02:57:16 INFO - 'sessionrestore_no_auto_restore', 02:57:16 INFO - 'tabpaint']}, 02:57:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:16 INFO - 'ts_paint', 02:57:16 INFO - 'tpaint', 02:57:16 INFO - 'sessionrestore', 02:57:16 INFO - 'sessionrestore_no_auto_restore', 02:57:16 INFO - 'tabpaint']}, 02:57:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['a11yr', 02:57:16 INFO - 'ts_paint', 02:57:16 INFO - 'tpaint', 02:57:16 INFO - 'sessionrestore', 02:57:16 INFO - 'sessionrestore_no_auto_restore', 02:57:16 INFO - 'tabpaint']}, 02:57:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['a11yr', 02:57:16 INFO - 'ts_paint', 02:57:16 INFO - 'tpaint', 02:57:16 INFO - 'sessionrestore', 02:57:16 INFO - 'sessionrestore_no_auto_restore', 02:57:16 INFO - 'tabpaint']}, 02:57:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['tsvgx', 02:57:16 INFO - 'tsvgr_opacity', 02:57:16 INFO - 'tart', 02:57:16 INFO - 'tscrollx', 02:57:16 INFO - 'cart']}, 02:57:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:16 INFO - 'tsvgr_opacity', 02:57:16 INFO - 'tart', 02:57:16 INFO - 'tscrollx', 02:57:16 INFO - 'cart']}, 02:57:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'talos_options': ['--disable-e10s'], 02:57:16 INFO - 'tests': ['tp5o']}, 02:57:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'tests': ['tp5o']}, 02:57:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'talos_options': ['--disable-e10s', 02:57:16 INFO - '--xperf_path', 02:57:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:16 INFO - 'tests': ['tp5n']}, 02:57:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:16 INFO - 'talos_options': ['--xperf_path', 02:57:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:16 INFO - 'tests': ['tp5n']}}, 02:57:16 INFO - 'talos.zip': {'path': '', 02:57:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:16 INFO - Running post-action listener: _resource_record_post_action 02:57:16 INFO - [mozharness: 2016-12-29 10:57:16.258721Z] Finished populate-webroot step (success) 02:57:16 INFO - [mozharness: 2016-12-29 10:57:16.258846Z] Running create-virtualenv step. 02:57:16 INFO - Running pre-action listener: _resource_record_pre_action 02:57:16 INFO - Running main action method: create_virtualenv 02:57:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:16 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 02:57:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:16 INFO - Using real prefix '/tools/python27' 02:57:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:19 INFO - Installing pip.................done. 02:57:19 INFO - Return code: 0 02:57:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:20 INFO - Reading from file tmpfile_stdout 02:57:20 INFO - Output received: 02:57:20 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) 02:57:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:20 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:20 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 02:57:20 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 02:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:20 INFO - 'HOME': '/Users/cltbld', 02:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:20 INFO - 'LOGNAME': 'cltbld', 02:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:20 INFO - 'MOZ_NO_REMOTE': '1', 02:57:20 INFO - 'NO_EM_RESTART': '1', 02:57:20 INFO - 'PAGER': '/bin/cat', 02:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:20 INFO - 'PWD': '/builds/slave/test', 02:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:20 INFO - 'SHELL': '/bin/bash', 02:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:20 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:20 INFO - 'USER': 'cltbld', 02:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:20 INFO - 'XPC_FLAGS': '0x0', 02:57:20 INFO - 'XPC_SERVICE_NAME': '0', 02:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:20 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 02:57:20 INFO - Cleaning up... 02:57:20 INFO - Return code: 0 02:57:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:20 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:20 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 02:57:20 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 02:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:20 INFO - 'HOME': '/Users/cltbld', 02:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:20 INFO - 'LOGNAME': 'cltbld', 02:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:20 INFO - 'MOZ_NO_REMOTE': '1', 02:57:20 INFO - 'NO_EM_RESTART': '1', 02:57:20 INFO - 'PAGER': '/bin/cat', 02:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:20 INFO - 'PWD': '/builds/slave/test', 02:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:20 INFO - 'SHELL': '/bin/bash', 02:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:20 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:20 INFO - 'USER': 'cltbld', 02:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:20 INFO - 'XPC_FLAGS': '0x0', 02:57:20 INFO - 'XPC_SERVICE_NAME': '0', 02:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:20 INFO - Downloading/unpacking psutil>=3.1.1 02:57:20 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 02:57:20 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 02:57:20 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 02:57:20 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 02:57:20 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 02:57:20 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 02:57:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:24 INFO - Installing collected packages: psutil 02:57:24 INFO - Running setup.py install for psutil 02:57:24 INFO - building 'psutil._psutil_osx' extension 02:57:24 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 02:57:25 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 02:57:25 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 02:57:25 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 02:57:25 INFO - building 'psutil._psutil_posix' extension 02:57:25 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 02:57:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:57:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:57:25 INFO - ^ 02:57:25 INFO - 1 warning generated. 02:57:25 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 02:57:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:25 INFO - Successfully installed psutil 02:57:25 INFO - Cleaning up... 02:57:25 INFO - Return code: 0 02:57:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:25 INFO - 'HOME': '/Users/cltbld', 02:57:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:25 INFO - 'LOGNAME': 'cltbld', 02:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:25 INFO - 'MOZ_NO_REMOTE': '1', 02:57:25 INFO - 'NO_EM_RESTART': '1', 02:57:25 INFO - 'PAGER': '/bin/cat', 02:57:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:25 INFO - 'PWD': '/builds/slave/test', 02:57:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:25 INFO - 'SHELL': '/bin/bash', 02:57:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:25 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:25 INFO - 'USER': 'cltbld', 02:57:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:25 INFO - 'XPC_FLAGS': '0x0', 02:57:25 INFO - 'XPC_SERVICE_NAME': '0', 02:57:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:28 INFO - Installing collected packages: mozsystemmonitor 02:57:28 INFO - Running setup.py install for mozsystemmonitor 02:57:29 INFO - Successfully installed mozsystemmonitor 02:57:29 INFO - Cleaning up... 02:57:29 INFO - Return code: 0 02:57:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:29 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')]} 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:29 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')]} 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:29 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:29 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 02:57:29 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 02:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:29 INFO - 'HOME': '/Users/cltbld', 02:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:29 INFO - 'LOGNAME': 'cltbld', 02:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:29 INFO - 'MOZ_NO_REMOTE': '1', 02:57:29 INFO - 'NO_EM_RESTART': '1', 02:57:29 INFO - 'PAGER': '/bin/cat', 02:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:29 INFO - 'PWD': '/builds/slave/test', 02:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:29 INFO - 'SHELL': '/bin/bash', 02:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:29 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:29 INFO - 'USER': 'cltbld', 02:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:29 INFO - 'XPC_FLAGS': '0x0', 02:57:29 INFO - 'XPC_SERVICE_NAME': '0', 02:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:29 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 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 02:57:32 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:32 INFO - warning: no files found matching '*.txt' 02:57:32 INFO - no previously-included directories found matching 'build' 02:57:32 INFO - no previously-included directories found matching 'dist' 02:57:32 INFO - no previously-included directories found matching '.git*' 02:57:32 INFO - Installing collected packages: jsonschema, functools32 02:57:32 INFO - Running setup.py install for functools32 02:57:32 INFO - warning: no files found matching '*.txt' 02:57:32 INFO - no previously-included directories found matching 'build' 02:57:32 INFO - no previously-included directories found matching 'dist' 02:57:32 INFO - no previously-included directories found matching '.git*' 02:57:32 INFO - Successfully installed jsonschema functools32 02:57:32 INFO - Cleaning up... 02:57:32 INFO - Return code: 0 02:57:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:32 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')]} 02:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:32 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')]} 02:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:32 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:32 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 02:57:32 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 02:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:32 INFO - 'HOME': '/Users/cltbld', 02:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:32 INFO - 'LOGNAME': 'cltbld', 02:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:32 INFO - 'MOZ_NO_REMOTE': '1', 02:57:32 INFO - 'NO_EM_RESTART': '1', 02:57:32 INFO - 'PAGER': '/bin/cat', 02:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:32 INFO - 'PWD': '/builds/slave/test', 02:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:32 INFO - 'SHELL': '/bin/bash', 02:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:32 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:32 INFO - 'USER': 'cltbld', 02:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:32 INFO - 'XPC_FLAGS': '0x0', 02:57:32 INFO - 'XPC_SERVICE_NAME': '0', 02:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:33 INFO - Cleaning up... 02:57:33 INFO - Return code: 0 02:57:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:33 INFO - 'HOME': '/Users/cltbld', 02:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:33 INFO - 'LOGNAME': 'cltbld', 02:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:33 INFO - 'MOZ_NO_REMOTE': '1', 02:57:33 INFO - 'NO_EM_RESTART': '1', 02:57:33 INFO - 'PAGER': '/bin/cat', 02:57:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:33 INFO - 'PWD': '/builds/slave/test', 02:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:33 INFO - 'SHELL': '/bin/bash', 02:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:33 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:33 INFO - 'USER': 'cltbld', 02:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:33 INFO - 'XPC_FLAGS': '0x0', 02:57:33 INFO - 'XPC_SERVICE_NAME': '0', 02:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:33 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:36 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:37 INFO - Downloading docopt-0.6.1.tar.gz 02:57:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:37 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:37 INFO - Running setup.py install for blobuploader 02:57:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:37 INFO - Running setup.py install for requests 02:57:38 INFO - Running setup.py install for docopt 02:57:38 INFO - Successfully installed blobuploader requests docopt 02:57:38 INFO - Cleaning up... 02:57:38 INFO - Return code: 0 02:57:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:38 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:38 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 02:57:38 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 02:57:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:38 INFO - 'HOME': '/Users/cltbld', 02:57:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:38 INFO - 'LOGNAME': 'cltbld', 02:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:38 INFO - 'MOZ_NO_REMOTE': '1', 02:57:38 INFO - 'NO_EM_RESTART': '1', 02:57:38 INFO - 'PAGER': '/bin/cat', 02:57:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:38 INFO - 'PWD': '/builds/slave/test', 02:57:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:38 INFO - 'SHELL': '/bin/bash', 02:57:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:38 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:38 INFO - 'USER': 'cltbld', 02:57:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:38 INFO - 'XPC_FLAGS': '0x0', 02:57:38 INFO - 'XPC_SERVICE_NAME': '0', 02:57:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-xXPxpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-es48yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-4FMlQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-csJMCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-quYEdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-EbzF9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-A6AXVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-jqMMPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-0WtVPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-FJWM5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-xRjsrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-4fezVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-aNVKAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-K3Qh62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-kbewCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-P2Dh8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-pm1K3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:40 INFO - Running setup.py install for manifestparser 02:57:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:40 INFO - Running setup.py install for mozcrash 02:57:40 INFO - Running setup.py install for mozdebug 02:57:40 INFO - Running setup.py install for mozdevice 02:57:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:57:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:40 INFO - Running setup.py install for mozfile 02:57:41 INFO - Running setup.py install for mozhttpd 02:57:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Running setup.py install for mozinfo 02:57:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Running setup.py install for mozInstall 02:57:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Running setup.py install for mozleak 02:57:41 INFO - Running setup.py install for mozlog 02:57:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Running setup.py install for moznetwork 02:57:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:41 INFO - Running setup.py install for mozprocess 02:57:42 INFO - Running setup.py install for mozprofile 02:57:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:42 INFO - Running setup.py install for mozrunner 02:57:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:42 INFO - Running setup.py install for mozscreenshot 02:57:42 INFO - Running setup.py install for moztest 02:57:42 INFO - Running setup.py install for mozversion 02:57:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:42 INFO - Cleaning up... 02:57:42 INFO - Return code: 0 02:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:42 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:42 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 02:57:42 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 02:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:42 INFO - 'HOME': '/Users/cltbld', 02:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:42 INFO - 'LOGNAME': 'cltbld', 02:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:42 INFO - 'MOZ_NO_REMOTE': '1', 02:57:42 INFO - 'NO_EM_RESTART': '1', 02:57:42 INFO - 'PAGER': '/bin/cat', 02:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:42 INFO - 'PWD': '/builds/slave/test', 02:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:42 INFO - 'SHELL': '/bin/bash', 02:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:42 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:42 INFO - 'USER': 'cltbld', 02:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:42 INFO - 'XPC_FLAGS': '0x0', 02:57:42 INFO - 'XPC_SERVICE_NAME': '0', 02:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Wrd4hV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-93ChvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-uo4r3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-7FZUWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-nX9v6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-IpiOr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-aYm85Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-wRrZF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:43 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)) 02:57:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-WSmfjp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-32Xbe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-O2fbqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-f55ZwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-UVM9ZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-aja_17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-jiV4t1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-9UqZ8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:44 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)) 02:57:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-YF461M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:44 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)) 02:57:44 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)) 02:57:44 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)) 02:57:44 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)) 02:57:44 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)) 02:57:44 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)) 02:57:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:47 INFO - Downloading blessings-1.6.tar.gz 02:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:47 INFO - Installing collected packages: blessings 02:57:47 INFO - Running setup.py install for blessings 02:57:47 INFO - Successfully installed blessings 02:57:47 INFO - Cleaning up... 02:57:47 INFO - Return code: 0 02:57:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:48 INFO - Reading from file tmpfile_stdout 02:57:48 INFO - Current package versions: 02:57:48 INFO - blessings == 1.6 02:57:48 INFO - blobuploader == 1.2.4 02:57:48 INFO - docopt == 0.6.1 02:57:48 INFO - functools32 == 3.2.3-2 02:57:48 INFO - jsonschema == 2.5.1 02:57:48 INFO - manifestparser == 1.1 02:57:48 INFO - mozInstall == 1.12 02:57:48 INFO - mozcrash == 1.0 02:57:48 INFO - mozdebug == 0.1 02:57:48 INFO - mozdevice == 0.48 02:57:48 INFO - mozfile == 1.2 02:57:48 INFO - mozhttpd == 0.7 02:57:48 INFO - mozinfo == 0.9 02:57:48 INFO - mozleak == 0.1 02:57:48 INFO - mozlog == 3.4 02:57:48 INFO - moznetwork == 0.27 02:57:48 INFO - mozprocess == 0.23 02:57:48 INFO - mozprofile == 0.28 02:57:48 INFO - mozrunner == 6.13 02:57:48 INFO - mozscreenshot == 0.1 02:57:48 INFO - mozsystemmonitor == 0.3 02:57:48 INFO - moztest == 0.7 02:57:48 INFO - mozversion == 1.4 02:57:48 INFO - psutil == 3.1.1 02:57:48 INFO - requests == 1.2.3 02:57:48 INFO - wsgiref == 0.1.2 02:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:48 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 02:57:48 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 02:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:48 INFO - 'HOME': '/Users/cltbld', 02:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:48 INFO - 'LOGNAME': 'cltbld', 02:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:48 INFO - 'MOZ_NO_REMOTE': '1', 02:57:48 INFO - 'NO_EM_RESTART': '1', 02:57:48 INFO - 'PAGER': '/bin/cat', 02:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:48 INFO - 'PWD': '/builds/slave/test', 02:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:48 INFO - 'SHELL': '/bin/bash', 02:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:48 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:48 INFO - 'USER': 'cltbld', 02:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:48 INFO - 'XPC_FLAGS': '0x0', 02:57:48 INFO - 'XPC_SERVICE_NAME': '0', 02:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 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)) 02:57:48 INFO - Cleaning up... 02:57:48 INFO - Return code: 0 02:57:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:48 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 0x10ad1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac94570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1114df360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, '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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 02:57:48 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 02:57:48 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 02:57:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:57:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:57:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:57:48 INFO - 'HOME': '/Users/cltbld', 02:57:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:57:48 INFO - 'LOGNAME': 'cltbld', 02:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:48 INFO - 'MOZ_NO_REMOTE': '1', 02:57:48 INFO - 'NO_EM_RESTART': '1', 02:57:48 INFO - 'PAGER': '/bin/cat', 02:57:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:48 INFO - 'PWD': '/builds/slave/test', 02:57:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:57:48 INFO - 'SHELL': '/bin/bash', 02:57:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:57:48 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:57:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:57:48 INFO - 'USER': 'cltbld', 02:57:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:57:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:48 INFO - 'XPC_FLAGS': '0x0', 02:57:48 INFO - 'XPC_SERVICE_NAME': '0', 02:57:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:48 INFO - Cleaning up... 02:57:48 INFO - Return code: 0 02:57:48 INFO - Running post-action listener: _resource_record_post_action 02:57:48 INFO - Running post-action listener: _start_resource_monitoring 02:57:48 INFO - Starting resource monitoring. 02:57:48 INFO - [mozharness: 2016-12-29 10:57:48.754601Z] Finished create-virtualenv step (success) 02:57:48 INFO - [mozharness: 2016-12-29 10:57:48.755621Z] Running install step. 02:57:48 INFO - Running pre-action listener: _resource_record_pre_action 02:57:48 INFO - Running main action method: install 02:57:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:49 INFO - Reading from file tmpfile_stdout 02:57:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:57:49 INFO - Reading from file tmpfile_stdout 02:57:49 INFO - Output received: 02:57:49 INFO - Usage: mozinstall [options] installer 02:57:49 INFO - Options: 02:57:49 INFO - -h, --help show this help message and exit 02:57:49 INFO - -d DEST, --destination=DEST 02:57:49 INFO - Directory to install application into. [default: 02:57:49 INFO - "/builds/slave/test"] 02:57:49 INFO - --app=APP Application being installed. [default: firefox] 02:57:49 INFO - mkdir: /builds/slave/test/build/application 02:57:49 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'] 02:57:49 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 02:58:19 INFO - Reading from file tmpfile_stdout 02:58:19 INFO - Output received: 02:58:19 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:58:19 INFO - Running post-action listener: _resource_record_post_action 02:58:19 INFO - [mozharness: 2016-12-29 10:58:19.811602Z] Finished install step (success) 02:58:19 INFO - [mozharness: 2016-12-29 10:58:19.811729Z] Running run-tests step. 02:58:19 INFO - Running pre-action listener: _resource_record_pre_action 02:58:19 INFO - Running main action method: run_tests 02:58:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:58:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:58:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:58:19 INFO - 2016-12-29 02:58:19.826 screenresolution[1630:8511] starting screenresolution argv=screenresolution get 02:58:19 INFO - 2016-12-29 02:58:19.828 screenresolution[1630:8511] Display 0: 1600x1200x32@60 02:58:19 INFO - 2016-12-29 02:58:19.835 screenresolution[1631:8513] starting screenresolution argv=screenresolution list 02:58:19 INFO - Available Modes on Display 0 02:58:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:58:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:58:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:58:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:58:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:58:20 INFO - Intel Iris: 02:58:20 INFO - Chipset Model: Intel Iris 02:58:20 INFO - Type: GPU 02:58:20 INFO - Bus: Built-In 02:58:20 INFO - VRAM (Dynamic, Max): 1536 MB 02:58:20 INFO - Vendor: Intel (0x8086) 02:58:20 INFO - Device ID: 0x0a2e 02:58:20 INFO - Revision ID: 0x0009 02:58:20 INFO - Displays: 02:58:20 INFO - Display: 02:58:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:58:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:58:20 INFO - Display Serial Number: 1600x1200 60 02:58:20 INFO - Main Display: Yes 02:58:20 INFO - Mirror: Off 02:58:20 INFO - Online: Yes 02:58:20 INFO - Rotation: Supported 02:58:20 INFO - Return code: 0 02:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:20 INFO - Python 2.7.3 02:58:20 INFO - Return code: 0 02:58:20 INFO - grabbing minidump binary from tooltool 02:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab32d30>, '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 0x10a998db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab2ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:58:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:58:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:58:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:20 INFO - Return code: 0 02:58:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:58:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:58:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:20 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/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 02:58:20 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/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 02:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C4BTrIEi6j/Render', 02:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:58:20 INFO - 'HOME': '/Users/cltbld', 02:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:58:20 INFO - 'LOGNAME': 'cltbld', 02:58:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:20 INFO - 'MOZ_NO_REMOTE': '1', 02:58:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:20 INFO - 'NO_EM_RESTART': '1', 02:58:20 INFO - 'PAGER': '/bin/cat', 02:58:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:20 INFO - 'PWD': '/builds/slave/test', 02:58:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:58:20 INFO - 'SHELL': '/bin/bash', 02:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZmOJeOMHmh/Listeners', 02:58:20 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 02:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:58:20 INFO - 'USER': 'cltbld', 02:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:20 INFO - 'XPC_FLAGS': '0x0', 02:58:20 INFO - 'XPC_SERVICE_NAME': '0', 02:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:58:20 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/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 02:58:20 INFO - mozversion application_buildid: 20161229013937 02:58:20 INFO - mozversion application_changeset: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 02:58:20 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:58:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:20 INFO - mozversion application_name: Firefox 02:58:20 INFO - mozversion application_remotingname: firefox-dev 02:58:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:58:20 INFO - mozversion application_vendor: Mozilla 02:58:20 INFO - mozversion application_version: 52.0a2 02:58:20 INFO - mozversion platform_buildid: 20161229013937 02:58:20 INFO - mozversion platform_changeset: 80e89a0b39c5c21de97eb9f1ad1c60fcdc618992 02:58:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:58:20 INFO - mozversion platform_version: 52.0a2 02:58:20 INFO - using testdate: 1483009100 02:58:20 INFO - actual date: 1483009100 02:58:20 INFO - starting webserver on 'localhost:49250' 02:58:20 INFO - SUITE-START | Running 2 tests 02:58:20 INFO - TEST-START | dromaeo_css 02:58:20 INFO - operating with platform_type : mac_ 02:58:20 INFO - Initialising browser for dromaeo_css test... 02:58:20 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmptf_i6s/profile http://localhost:49250/getInfo.html) 02:58:23 INFO - PROCESS | 1641 | 2016-12-29 02:58:23.377 plugin-container[1643:8694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 02:58:23 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:23 INFO - PROCESS | 1641 | 2016-12-29 02:58:23.382 plugin-container[1643:8694] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 02:58:23 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:23 INFO - PROCESS | 1641 | 2016-12-29 02:58:23.382 plugin-container[1643:8694] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:23 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 02:58:23 INFO - PROCESS | 1641 | colorDepth:24 02:58:23 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 02:58:23 INFO - PROCESS | 1641 | __metrics 02:58:23 ERROR - PROCESS | 1641 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:58:24 INFO - TEST-INFO | 1641: exit 0 02:58:24 INFO - Browser initialized. 02:58:24 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:24 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmptf_i6s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:26 INFO - PROCESS | 1645 | 2016-12-29 02:58:26.951 plugin-container[1646:8825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 02:58:26 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:26 INFO - PROCESS | 1645 | 2016-12-29 02:58:26.951 plugin-container[1646:8825] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 02:58:26 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:58:26 INFO - PROCESS | 1645 | 2016-12-29 02:58:26.951 plugin-container[1646:8825] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:58:36 INFO - PROCESS | 1645 | RSS: Main: 229629952 02:58:36 INFO - PROCESS | 1645 | 02:59:26 INFO - PROCESS | 1645 | 1483009166277 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:01:39 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 03:01:41 INFO - PROCESS | 1645 | RSS: Main: 233918464 03:01:41 INFO - PROCESS | 1645 | 03:04:43 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 03:04:44 INFO - PROCESS | 1645 | RSS: Main: 243236864 03:04:44 INFO - PROCESS | 1645 | 03:07:46 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 03:07:46 INFO - PROCESS | 1645 | RSS: Main: 246222848 03:07:46 INFO - PROCESS | 1645 | 03:10:48 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 03:10:49 INFO - PROCESS | 1645 | RSS: Main: 246345728 03:10:49 INFO - PROCESS | 1645 | 03:13:52 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 03:13:52 INFO - PROCESS | 1645 | RSS: Main: 249819136 03:13:52 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 03:16:55 INFO - PROCESS | 1645 | RSS: Main: 251002880 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | __start_tp_report 03:16:55 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 03:16:55 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 03:16:55 INFO - PROCESS | 1645 | |i|pagename|runs| 03:16:55 INFO - PROCESS | 1645 | |0;dojo.html;3388.610309814372;3392.694657480827;3396.3037577296654;3425.1094715373997;3441.4665726812336;4876.512348765122;5825.097109947959;5829.0964900440395;5850.970745146268;5898.823035308937;4798.448178459478;5827.562932780037;5917.437843404869;5925.7925972590965;5947.434993675604;4366.541513141122;5345.786168553253;5351.598630102739;5358.624896257264;5413.079776437995;5255.343082114736;5321.467853214667;5422.37642671092;5423;5446.564274858021;5176.171812510018;5238.73806309683;5252.975669744402;5276.997370499593;5379.81170659029;5188.221766734982;5224.608154388398;5272.604554658377;5328.280682107905;5334.146536554172;4656.254999200146;5100.974495127538;5167.4057483389515;5230.973845130788;5260.973695131538;4402.7358358498595;5289.915567308731;5867.618604790718;5869.853253668693;5896.764129434818;6213.596116252429;6274.435300822902;6278.058291256302;6289;6296.370362963713;6238.313785483593;6269.529785266123;6282.434580887696;6291.056341548759;6333.714982825784;5779.104238842986;5965.7613695452565;5983.820485385445;5986.880262394815;5991.400859913973;6252.249730032425;6277.654728989949;6298.559100862987;6321.1782468278825;6356.618602883842;6239.750409983641;6264.37356264379;6271.811845644638;6273.7176827042895;6274.152989346471;6199.163112979781;6235.96882015587;6281.842953926189;6297.2128483939505;6301.275353334334;6091.14723938649;6122.785702500391;6167.352427995085;6173.783917562864;6289.7484100636375;6113.567524283629;6271.43557079865;6278.340774218641;6282.465990390868;6294.150289710922;4943.382077240345;4982.975085124551;4986.977669577728;5008;5010.223415370623;4413.205622987893;4435.35687325336;4453.799579018952;4477.888052798641;4491;5732.799352022743;5941;5945.048792193228;6026.939730602638;6077.905976924108;6199.928255410752;6255;6255.343188965184;6255.468285195719;6263.906041409383;5824.271966004249;5911.379305172981;5918.733656985446;5920.171176035358;5975.372585878507;4999.775010124553;5434.64674796137;5497.5601951843755;5516.779328826882;5559.24950131727;5865.970670146622;6133.26400831903;6202.100695399232;6467.482601391877;6481.4166724994975;5372.516473517402;6048.425399587032;6193.81418557444;6201.534884883562;6299.275583307978;5914.704264786829;6413.486921046212;6430.839229019312;6441.420272175526;6576.605403675795;6268.592541484789;6275.466585340298;6288.371162883675;6291.496680265659;6326.715297811702;5119.539241468286;6019.367966363644;6175.567710260419;6216.378362163748;6254.155688981929;6194.349593292639;6202.782902598387;6235.314115447388;6236.594621349598;6246.906296405648;6157.630542167484;6158.168647232566;6162.876742465036;6254.9687251563455;6276.905846412216;5073.061483625541;5756;6012.939870601238;6012.969935150296;6071.089336599545;6085.300190477975;6090.056041313604;6147.938520614915;6165.167702360124;6187.84530386726;5022.296878436949;6069.725357674938;6073.696315184311;6092.45167934888;6105.786297479567 03:16:55 INFO - PROCESS | 1645 | |1;ext.html;422.05670326819563;518.4271380124961;520.9661372010819;547.4716898193243;551.5119119579176;28825.855870720643;37633.811830940875;37678.86963391096;37707.24585508288;37765.05587360314;37781;37952.86141415755;38287.61712382875;38386.42420363697;38442.42336364957;8073.152319006523;8146.3890208234325;8213.876791848126;8220.05469371021;8252.422330436872;9183.49490778007;9209.309301802357;9290.767730806716;9298.58156382961;9314.627414903429;9219.95390023049;9292.814143717122;9311.534423278843;9321.766955826124;9337.253019758404;9253.768655783591;9267.629294828199;9281.211097056725;9294.72115836526;9309.581068851918;9179.357444978854;9228.215601673866;9251.722448326562;9257.67598134062;9269;36853.89438316855;37236.44145337822;37250.44124338137;37345;37350.25299494022;3123.859426325821;3282.1138292661085;3335.949960750591;3467.514547963287;3717.5167228260425;28046.2988425291;28147.577786333222;28393.716062839314;28972.27569310784;29436.411271774658;2806.9157925262275;3130.550732136912;3145.7011583899493;3163.383140287645;3164.604424446944;474452;483140.5842970763;484374;488305;489298.55350723374;42848;49366.7658308538;53589.196162057604;53796;54292.45707542874;54044;56667;56934;57582;57643.423565763806;15645.60885977837;15667.921660391625;15730.842691573167;15794.447194348142;15835.841641583436;12380.752384952431;12482.875171248354;12489.875101249054;12514.937425312815;12517.186382885084;13593.728125437436;13759.656008599664;14321.427142914166;14452.638684032983;14510.492132775302;5234.895302093937;5774.653520788766;5973.462388385066;5983.790567330123;6067.484263837623;866.8093019535692;880.7489865388462;940.238406890421;1039.6984874386494;1056.1550759392455;28356.865725371168;28451.857740711162;29029.56455653167;29343.55984660232;29431.558526622117;907.8638204269413;1033.679559336593;1066.8879767624444;1085.0505807418508;1094.698957786599;14266.714665706628;14988.47540336083;15058.54824355271;15220.695586088215;15733;628994;630364;632626;632828;633962;53781.46218537843;54205.45794542083;54213;54268.45731542713;54295.45704542983;1332.8000799880097;1344.2539390638094;1363.372848489686;1366.7813149896167;1371.9245441500614;24113.553186808847;26285.08002219913;28820.71179288264;29292.707072929;29350.706492934798;52147.73926130345;53192;53268.4673153279;53318;53430;488370.55814720696;490732.54633726605;493750;497504;497815;24895;25057.248282551554;25220.49559008773;25322.493550129264;25449.491010180063;42743.786281068395;44196.33705494356;44725.88185295263;45068.87327816831;45094.647160585235;36058.63941360553;36554.8172259137;36622.633773661924;37450.625493744716;37723.622763773106;28180.85909570521;29766;31720.365592687554;34808.65191348054;37513;29526.557101643062;30555.54166687546;35905.28189436145;36420.90737277886;37170;23875.522489549763;30344.393112138074;32344.706211751265;32961.505577415875;33672.49491257584;21097.263775236996;21973.67039494377;24770.00919963181;25045.49909001846;25257.368565786004 03:16:55 INFO - PROCESS | 1645 | |2;jquery.html;372.74653235799656;378.4852600463371;389.36727817296895;390.8163163313242;407.35434336576526;14571.344289506971;14750.262486875667;17853.910730446347;19587.804121958776;19813.801861981377;15533.990290631129;15747.133907635076;16491.91754041228;17727.93632382058;19704.211831526758;4685;6005.309389420229;6012.158297838306;6012.969935150318;6033.456988871001;5625.156226566028;5879.029960056586;5947.702614869239;5959.165716799652;5993.940060599403;5721.7711291548285;5950.880982380349;5961.1058341248945;6067.120267561201;6075.210222671047;6068.6662233577135;6099.115628233925;6109.114178444101;6115;6142.692865356737;5104.693718376872;5424.457554244584;5456.0997435423105;5501.779928802843;5501.807436739695;13177.209367437888;13402.12886162406;13821.308934553232;23644.408889777893;23813.404664883343;2198.0103271596317;2301.1140710826285;2368.585497537924;2645.1535508637244;2893.8987135450157;9965.601375945025;10237;10304.072633462949;12284.815727764091;14660.633484162874;1819.5087326421792;1833.5599456130567;1859.4979355574055;1866.4773863318292;1899.591587808614;79475;117732;119352.40323798412;122085.38957305157;122120;9143.359964802534;11399.544018239343;11702.870039049167;11720.296782193096;11852;14511.782323265159;14571.125732456087;14593.489227876973;14606.196659183846;14642.121472711671;8323.250907418362;8581.313494920392;8589.398742087993;8670.393072484992;8713.52075635846;8372.916270837335;8424.789380265542;8488.915110848937;8579.656813727506;8620.310375169971;4510.120526497367;4587.128445595326;4592.609628181642;4613.930791038137;4663.300504924221;1720.7590937268792;1917.9232830686894;1926.7591551056119;1979.623871464417;1980.5543752655826;808.2483290539855;881.7531091294447;896.6996056321075;911.6581282019242;918.1461241045758;16491.752623710654;19243.711344329848;20973.84643844603;21156.047977841034;21582.676259856114;939.7650587353162;975.8926518083006;976.3702411944256;992.8560358747941;1003.3027046202965;8900.465972041698;10955.233133680566;11244.66266012021;11255.324680519196;11260.268082574607;577951;582458;584291;589385;595132;94344;97239.027609723;103798;107682;112080.4395978015;867.5011868175824;966.8888077871135;982.2829334585792;1001.1190152665753;1005.7385079879137;17551.561210969827;18044.909775451564;18263.269469221083;18365.81634183641;18443;49413;50951;51137.48862511476;51683.22475162951;52278.738606308245;74220;77634.6118269405;80189.59905200437;81216.18783812087;81314;5854.941450585439;7393.778186654194;7965.56189409588;8143.697008478615;8191.713290034821;11108.888911110786;12708.745825083632;12743.299118548568;12767;13058.738825223252;10762.162564879554;10915.126789856633;11081.83377249358;11106.222564420414;11248.493817778057;10939.617113400993;10999.285046472274;11048.281861678965;11069.944650276697;11318.377489237842;8846.292296616384;11115.666530004113;11140.610078647209;11152.330860148417;11475.885241147482;7518;7562.962185189259;7568.243175682388;7651.311381975649;7749.535027898344;9363.391379560308;11024.328040008779;11240.83138752903;11264.324140551593;11300.94349528247 03:16:55 INFO - PROCESS | 1645 | |3;mootools.html;1146.1747541769926;1398.6713122416234;1543.9845601543989;1737.0967097109497;1774.8668849836258;7494.700211991528;7756.844863102735;8003.559804210766;8482.44864083835;8505.702300419478;7557.752970759831;7712.691492340314;7982.52104873708;8385.287250583708;8412.873806892887;2306.146725711489;2349.18952961229;2354.682117914077;2355.4111472131967;2358.988205058972;2338.684277622516;2358.9528209435803;2381.154690085012;2384.725756537994;2395.2574701842395;2328.9417764555938;2342.7583380808114;2355.5524450354465;2360.799332056777;2368.846025008369;1937.4575118966711;2222.288867562381;2260.3557985974003;2286.4626812699003;2290.4044948313476;1828.7256911463253;2346.6480027995935;2356.32844639277;2358.8230882683697;2363.72817126031;8264.173582641688;8376.162383761635;8418.242358187792;8440.62017209227;8455.112213217646;4916.434610019858;5063.240513922904;5092.745362731848;5094.2103973884105;5112.565431938253;3319.751018673585;3478.9304213915834;3523.4362501999813;3627.474016267626;3628.546431696038;1018.7249442650517;1022.7340891368298;1086.0714089453481;1089.3844977587637;1096.5778175402527;10892.346459212473;10918.962698543626;11032.724181895517;11051.668449946514;11064.944675276573;4499.730016199039;4634.652401069933;4710.811567537328;4723.960728639694;4740.14677358072;9388.155066043952;9479.47862867549;9493.05069493045;9524.761880953032;9554.187894029086;5100.821471248489;5206.297149884793;5215.5135786300725;5232.136697444879;5239.921401178985;4260.4248426462655;4289.871303860889;4742.620590352833;4790.137775200497;4796.56830885222;3787.7311100780994;3832.405977073558;3867.5165604299464;3886.3393223152134;3925.941110883339;1253.642711827125;1275.5471807508386;1283.4417028592593;1284.794432890733;1285.0169620240524;801.9919800802033;884.5223579267124;899.1547944931743;914.6524320758069;921.2583869984727;5787.565932555075;5818.0340219675945;5877.265341832271;5891.617044892068;6082.543809214327;885.154677283193;915.7573243090586;920.1442658327686;935.2377812083131;982.6315131825565;3711.5175027246823;3783.1677031053123;3806.2006978534264;3840.1935593525113;3843.1929294847837;9960.302778805559;10317.380957142595;10363.94818025905;10375.27373083892;10397.32417392867;8650.3131889281;8789.472631642122;9627.614895404105;10304.330218535772;10341.586336546454;6414.711337989802;7481.139668938142;7798.22017798227;7932;7952.960235198787;5682.914756278742;5685.488306052475;5829.94170058294;5881;5904.0553511437965;7148.642567871481;7465.738699145504;9307.301952353737;9487.620495180116;9512.619495220113;9485.33602647808;9519.619215231312;9564.378315409476;9645.855312170463;9669.226461882892;6576.8355791105605;6787.864242715217;7014.754483593049;7135.393491553068;7273.3817625500305;7791.337736292478;8005;8011.439199255996;8028.157043510348;8032.959835200787;7061.2232654409;7216;7231.096112985877;7236.6019868907715;7333.413326933939;6996.125484314461;7071.43428525727;7125.1093613298335;7183.712651494091;7239.167495738057;6674.532782705358;6687.732490700318;6756.391924726799;6760.459163267025;6771.93228067713;4826.8793280168275;4847.587955023721;4850.345203397496;4860.198067318853;4911;4693.671442999094;4816.566509014206;4883.438404583519;4889.9975505020675;4930.6795058321095 03:16:55 INFO - PROCESS | 1645 | |4;prototype.html;305.4029372576613;309.39358856640985;317.49042786327936;318.2632206442085;319.94880819068953;5248.868778280545;5429.267048948391;5520.889582208353;5586.748596313166;5667.126271406592;4047.7368971016863;4499.762565294545;4672.299155126732;4756.0975609756115;5403.162509810976;4087.591240875911;4202.8318867245425;4214.831406743727;4233.909246250239;4240.851570195044;3324.734021278292;4017.9799101004455;4142.130152667944;4211.768352740598;4271.743695378287;3669.3028324618235;4051.7163798533966;4151.709380343377;4204.5585213552595;4213.431186789775;4147.714208595346;4170.040890595165;4184.937225941613;4195;4210.831566737327;3619.8371073301764;3671.816409179557;3674.6876515496215;3683.8158092095287;3689.0592898810633;4651.37206477128;5066;5382.273393091921;5426.348838139409;5467.398586155519;4422.314541246112;4792.640551958617;4805.014971930781;4822.710637361734;4863.103389678028;4683.250679891235;4719.693219940693;5780.7687692492245;5819.214406055171;5840.591158618899;3630.80030598317;3692.390755525362;3795.2978698940783;3876.7092468065007;4082.9591704082877;5197.662151960149;6009.278886533601;6049.758009679607;6106.450419462225;6109.450149486567;3348.5220936506807;3478.4608385700258;3755.080005398695;3959.940600890989;3983.8605648802154;3197.0089272325654;3332.6334103248623;3868.052327179859;3921.5490218624655;3946.1713040261293;4673.112108699404;4705.811767529329;4712.835050773207;4753.4295884493395;4755.83354582588;4615.561521655437;4626.953730462719;4722.598579120813;5836.824895253149;5856.837307853796;1085.7719878825378;1212.454395522001;1233.8278635296504;1283.1274733181526;1290.9612711618665;751.0949306086262;840.4285086141482;863.820884492663;886.6807949138305;891.6834523744108;4637.582617564435;5206.271122042917;5247.2129180623215;5256.39551451588;5262.605724220319;5053.898922021539;5362.45283490339;5384.5692344612335;5415.106507426231;5602.887942241132;4339.698090572815;4778.761061946889;4873.488283730228;5101.362329708786;5147.6911385317;2676.598510223443;2836.950328378513;2910.2433367324647;2933.4719750444697;2938.1773103531045;4395.494518130456;5716.714164291852;5814.854628634233;5834.766609335579;5864.824055278348;4647.790849411785;5195.9740201298755;5670.744816483269;5706.457886500776;5725.541956643458;4388.473383193909;5287;5715.399883012307;5778.994922640203;5797.709694825883;4898.632602554894;5146.713321669583;5168.664036837594;5632.662040277432;5701.486866182064;4542.818287268472;5034;5344.483911095119;5490.149026900836;5578.581606379619;5236.842894713165;5320.627556071193;5581.386047534686;5726.370099289158;5798.391168927371;3806.5154589710587;3934.7245692802376;3955.03101740064;3973.980130099447;4059.2693315203546;5138.820141295037;5154.278401023935;5937.554683398849;6081;6089.5737298388685;5138.717370544656;5357.678539287655;5596.496315331639;5833.212516310244;5903.793367232126;5795.5073818724195;5810.518317828926;5839.153322768259;5839.620424672383;5847.795327163529;4814.759262036814;4879.048585525788;5342.278792362981;5565.325126893429;5613.971930140323;5214.217867319932;5788.710564471844;5871.735771890189;5878.794242201502;5910.527157827278;4713.198756211384;5027.874303142305;5365.409804921534;5759.884802304015;5775.81595772874 03:16:55 INFO - PROCESS | 1645 | |5;yui.html;664.2726214794798;671.946244300456;689.1867596236441;691.7405972760218;805.1385018030702;14327.928360358197;14844.851551484495;14853.554393368217;14884;14902.77645835312;13019.349032548358;13495.325233738324;13629.318534073282;13652.38564264608;13683.931580342085;642.5566359212129;666.0808084842935;809.1665584447999;809.6842231529708;825.8307047055339;815.5962798414793;829.7966998085477;829.854775414303;831.5426515416527;831.7629475599456;876.3865294293988;881.0880738435688;882.8190221004711;883.2580632268892;884.6107712606432;849.8512760266929;861.6984055580559;873.9992708348937;875.6234819027816;876.4478378621428;610.9236345456818;650.2164891305965;652.4812773844804;659.307726886767;664.1266734244454;14363.784543231755;14663;14731.263436828116;14814.259287035713;15012.024218425877;12161.635150945485;12884.420201090974;12953.611391658265;12973.096668921855;13233.272170030645;10213.540390682438;10553.52509137083;10733.141348692086;10769.676909692722;10959.56161753529;3057.281538838371;3111.937761244785;3712.4988126602834;3716.739828212026;3724.366857634209;57933.71033144849;69881;75705.62147189229;87107.12892871117;93421.5328923351;9511.619535218513;9797.118259356692;9809.21526277896;9890;9982.1303241928;20957.952102395124;20983.160673572886;21009.159633614483;21017.369478915658;21057.157713691588;7258.782236532807;7603.5403147386905;7770.494917830436;7774.183710710294;7850.803729906684;4145.233131870614;4251.723637963522;4263.701540892108;4278.764667943293;4321.438213032286;3375.729941604666;3496.1958749487762;3502.1594817243677;3509.94735078974;3638.5269914911423;679.7858674517511;685.95541289816;691.4192078653955;700.1423256510734;701.2566679319938;571.240250466878;638.1321402892063;646.2678034351657;655.8524332025352;675.7634827810227;8795.252403545643;9007;9044.773880652905;9140.360174787702;9260.490673012915;598.9940100599025;646.3504178300777;649.2857856357969;662.5593980003243;664.4053572052985;4287.842282583747;4298.973623767843;4475.060237350193;4581.266997280419;4602.125596136723;112814;116021.41989290169;116270;116327;119525.40237298758;74099.62950185323;76049.61975190089;86035;86892.52429902733;99649;55075.44924550703;77325.61337193278;80571.38857222823;81360.18639813644;81849;9182.127697868691;9579.90420095818;9626.711198664052;9693.127618514367;9711.27165462579;46956.530434696586;48445.5155448441;53238.66903327293;54123.72938135284;54814.72592637011;53215.40353789392;63704;69994;70962;75355;11815.468303926516;12076.335801531;12480.563180288646;12524.499020039097;12649.87350126487;12173.75652486963;12361.690957726129;14083.084599501;14219.786703199254;14273.14361138335;12936.482540698267;13075.476980921037;13107.672308192372;13129.868701312864;13285.40215690277;12666;13044.02169837285;13058.869411306145;13134.737305254033;13314.267715275753;10580.841287380541;11240.156988225752;12307.200031998249;13175.538856139989;13602.727945441233;11073.944630276797;11236.831447528457;11255.549778008788;11705.414729263674;11767.176297659424;11415.429228538374;11490.478661822921;11495.425228738362;11561.826572601585;11562.537498499965 03:16:55 INFO - PROCESS | 1645 | __end_tp_report 03:16:55 INFO - PROCESS | 1645 | __start_cc_report 03:16:55 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,373 03:16:55 INFO - PROCESS | 1645 | __end_cc_report 03:16:55 INFO - PROCESS | 1645 | __startTimestamp1483010215519__endTimestamp 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | ------- Summary: start ------- 03:16:55 INFO - PROCESS | 1645 | Number of tests: 6 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5761.52 Median:6019.37 stddev:672.03 (11.2%) stddev-sans-first:647.80 03:16:55 INFO - PROCESS | 1645 | Values: 3388.6 3392.7 3396.3 3425.1 3441.5 4876.5 5825.1 5829.1 5851.0 5898.8 4798.4 5827.6 5917.4 5925.8 5947.4 4366.5 5345.8 5351.6 5358.6 5413.1 5255.3 5321.5 5422.4 5423.0 5446.6 5176.2 5238.7 5253.0 5277.0 5379.8 5188.2 5224.6 5272.6 5328.3 5334.1 4656.3 5101.0 5167.4 5231.0 5261.0 4402.7 5289.9 5867.6 5869.9 5896.8 6213.6 6274.4 6278.1 6289.0 6296.4 6238.3 6269.5 6282.4 6291.1 6333.7 5779.1 5965.8 5983.8 5986.9 5991.4 6252.2 6277.7 6298.6 6321.2 6356.6 6239.8 6264.4 6271.8 6273.7 6274.2 6199.2 6236.0 6281.8 6297.2 6301.3 6091.1 6122.8 6167.4 6173.8 6289.7 6113.6 6271.4 6278.3 6282.5 6294.2 4943.4 4983.0 4987.0 5008.0 5010.2 4413.2 4435.4 4453.8 4477.9 4491.0 5732.8 5941.0 5945.0 6026.9 6077.9 6199.9 6255.0 6255.3 6255.5 6263.9 5824.3 5911.4 5918.7 5920.2 5975.4 4999.8 5434.6 5497.6 5516.8 5559.2 5866.0 6133.3 6202.1 6467.5 6481.4 5372.5 6048.4 6193.8 6201.5 6299.3 5914.7 6413.5 6430.8 6441.4 6576.6 6268.6 6275.5 6288.4 6291.5 6326.7 5119.5 6019.4 6175.6 6216.4 6254.2 6194.3 6202.8 6235.3 6236.6 6246.9 6157.6 6158.2 6162.9 6255.0 6276.9 5073.1 5756.0 6012.9 6013.0 6071.1 6085.3 6090.1 6147.9 6165.2 6187.8 5022.3 6069.7 6073.7 6092.5 6105.8 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:65724.40 Median:37573.41 stddev:144605.84 (384.9%) stddev-sans-first:144928.37 03:16:55 INFO - PROCESS | 1645 | Values: 422.1 518.4 521.0 547.5 551.5 28825.9 37633.8 37678.9 37707.2 37765.1 37781.0 37952.9 38287.6 38386.4 38442.4 8073.2 8146.4 8213.9 8220.1 8252.4 9183.5 9209.3 9290.8 9298.6 9314.6 9220.0 9292.8 9311.5 9321.8 9337.3 9253.8 9267.6 9281.2 9294.7 9309.6 9179.4 9228.2 9251.7 9257.7 9269.0 36853.9 37236.4 37250.4 37345.0 37350.3 3123.9 3282.1 3335.9 3467.5 3717.5 28046.3 28147.6 28393.7 28972.3 29436.4 2806.9 3130.6 3145.7 3163.4 3164.6 474452.0 483140.6 484374.0 488305.0 489298.6 42848.0 49366.8 53589.2 53796.0 54292.5 54044.0 56667.0 56934.0 57582.0 57643.4 15645.6 15667.9 15730.8 15794.4 15835.8 12380.8 12482.9 12489.9 12514.9 12517.2 13593.7 13759.7 14321.4 14452.6 14510.5 5234.9 5774.7 5973.5 5983.8 6067.5 866.8 880.7 940.2 1039.7 1056.2 28356.9 28451.9 29029.6 29343.6 29431.6 907.9 1033.7 1066.9 1085.1 1094.7 14266.7 14988.5 15058.5 15220.7 15733.0 628994.0 630364.0 632626.0 632828.0 633962.0 53781.5 54205.5 54213.0 54268.5 54295.5 1332.8 1344.3 1363.4 1366.8 1371.9 24113.6 26285.1 28820.7 29292.7 29350.7 52147.7 53192.0 53268.5 53318.0 53430.0 488370.6 490732.5 493750.0 497504.0 497815.0 24895.0 25057.2 25220.5 25322.5 25449.5 42743.8 44196.3 44725.9 45068.9 45094.6 36058.6 36554.8 36622.6 37450.6 37723.6 28180.9 29766.0 31720.4 34808.7 37513.0 29526.6 30555.5 35905.3 36420.9 37170.0 23875.5 30344.4 32344.7 32961.5 33672.5 21097.3 21973.7 24770.0 25045.5 25257.4 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:33345.53 Median:375.62 stddev:97299.01 (25903.9%) stddev-sans-first:97540.46 03:16:55 INFO - PROCESS | 1645 | Values: 372.7 378.5 389.4 390.8 407.4 14571.3 14750.3 17853.9 19587.8 19813.8 15534.0 15747.1 16491.9 17727.9 19704.2 4685.0 6005.3 6012.2 6013.0 6033.5 5625.2 5879.0 5947.7 5959.2 5993.9 5721.8 5950.9 5961.1 6067.1 6075.2 6068.7 6099.1 6109.1 6115.0 6142.7 5104.7 5424.5 5456.1 5501.8 5501.8 13177.2 13402.1 13821.3 23644.4 23813.4 2198.0 2301.1 2368.6 2645.2 2893.9 9965.6 10237.0 10304.1 12284.8 14660.6 1819.5 1833.6 1859.5 1866.5 1899.6 79475.0 117732.0 119352.4 122085.4 122120.0 9143.4 11399.5 11702.9 11720.3 11852.0 14511.8 14571.1 14593.5 14606.2 14642.1 8323.3 8581.3 8589.4 8670.4 8713.5 8372.9 8424.8 8488.9 8579.7 8620.3 4510.1 4587.1 4592.6 4613.9 4663.3 1720.8 1917.9 1926.8 1979.6 1980.6 808.2 881.8 896.7 911.7 918.1 16491.8 19243.7 20973.8 21156.0 21582.7 939.8 975.9 976.4 992.9 1003.3 8900.5 10955.2 11244.7 11255.3 11260.3 577951.0 582458.0 584291.0 589385.0 595132.0 94344.0 97239.0 103798.0 107682.0 112080.4 867.5 966.9 982.3 1001.1 1005.7 17551.6 18044.9 18263.3 18365.8 18443.0 49413.0 50951.0 51137.5 51683.2 52278.7 74220.0 77634.6 80189.6 81216.2 81314.0 5854.9 7393.8 7965.6 8143.7 8191.7 11108.9 12708.7 12743.3 12767.0 13058.7 10762.2 10915.1 11081.8 11106.2 11248.5 10939.6 10999.3 11048.3 11069.9 11318.4 8846.3 11115.7 11140.6 11152.3 11475.9 7518.0 7563.0 7568.2 7651.3 7749.5 9363.4 11024.3 11240.8 11264.3 11300.9 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5435.49 Median:5106.69 stddev:2959.52 (58.0%) stddev-sans-first:2950.26 03:16:55 INFO - PROCESS | 1645 | Values: 1146.2 1398.7 1544.0 1737.1 1774.9 7494.7 7756.8 8003.6 8482.4 8505.7 7557.8 7712.7 7982.5 8385.3 8412.9 2306.1 2349.2 2354.7 2355.4 2359.0 2338.7 2359.0 2381.2 2384.7 2395.3 2328.9 2342.8 2355.6 2360.8 2368.8 1937.5 2222.3 2260.4 2286.5 2290.4 1828.7 2346.6 2356.3 2358.8 2363.7 8264.2 8376.2 8418.2 8440.6 8455.1 4916.4 5063.2 5092.7 5094.2 5112.6 3319.8 3478.9 3523.4 3627.5 3628.5 1018.7 1022.7 1086.1 1089.4 1096.6 10892.3 10919.0 11032.7 11051.7 11064.9 4499.7 4634.7 4710.8 4724.0 4740.1 9388.2 9479.5 9493.1 9524.8 9554.2 5100.8 5206.3 5215.5 5232.1 5239.9 4260.4 4289.9 4742.6 4790.1 4796.6 3787.7 3832.4 3867.5 3886.3 3925.9 1253.6 1275.5 1283.4 1284.8 1285.0 802.0 884.5 899.2 914.7 921.3 5787.6 5818.0 5877.3 5891.6 6082.5 885.2 915.8 920.1 935.2 982.6 3711.5 3783.2 3806.2 3840.2 3843.2 9960.3 10317.4 10363.9 10375.3 10397.3 8650.3 8789.5 9627.6 10304.3 10341.6 6414.7 7481.1 7798.2 7932.0 7953.0 5682.9 5685.5 5829.9 5881.0 5904.1 7148.6 7465.7 9307.3 9487.6 9512.6 9485.3 9519.6 9564.4 9645.9 9669.2 6576.8 6787.9 7014.8 7135.4 7273.4 7791.3 8005.0 8011.4 8028.2 8033.0 7061.2 7216.0 7231.1 7236.6 7333.4 6996.1 7071.4 7125.1 7183.7 7239.2 6674.5 6687.7 6756.4 6760.5 6771.9 4826.9 4847.6 4850.3 4860.2 4911.0 4693.7 4816.6 4883.4 4890.0 4930.7 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4520.54 Median:4888.84 stddev:1387.96 (28.4%) stddev-sans-first:1355.32 03:16:55 INFO - PROCESS | 1645 | Values: 305.4 309.4 317.5 318.3 319.9 5248.9 5429.3 5520.9 5586.7 5667.1 4047.7 4499.8 4672.3 4756.1 5403.2 4087.6 4202.8 4214.8 4233.9 4240.9 3324.7 4018.0 4142.1 4211.8 4271.7 3669.3 4051.7 4151.7 4204.6 4213.4 4147.7 4170.0 4184.9 4195.0 4210.8 3619.8 3671.8 3674.7 3683.8 3689.1 4651.4 5066.0 5382.3 5426.3 5467.4 4422.3 4792.6 4805.0 4822.7 4863.1 4683.3 4719.7 5780.8 5819.2 5840.6 3630.8 3692.4 3795.3 3876.7 4083.0 5197.7 6009.3 6049.8 6106.5 6109.5 3348.5 3478.5 3755.1 3959.9 3983.9 3197.0 3332.6 3868.1 3921.5 3946.2 4673.1 4705.8 4712.8 4753.4 4755.8 4615.6 4627.0 4722.6 5836.8 5856.8 1085.8 1212.5 1233.8 1283.1 1291.0 751.1 840.4 863.8 886.7 891.7 4637.6 5206.3 5247.2 5256.4 5262.6 5053.9 5362.5 5384.6 5415.1 5602.9 4339.7 4778.8 4873.5 5101.4 5147.7 2676.6 2837.0 2910.2 2933.5 2938.2 4395.5 5716.7 5814.9 5834.8 5864.8 4647.8 5196.0 5670.7 5706.5 5725.5 4388.5 5287.0 5715.4 5779.0 5797.7 4898.6 5146.7 5168.7 5632.7 5701.5 4542.8 5034.0 5344.5 5490.1 5578.6 5236.8 5320.6 5581.4 5726.4 5798.4 3806.5 3934.7 3955.0 3974.0 4059.3 5138.8 5154.3 5937.6 6081.0 6089.6 5138.7 5357.7 5596.5 5833.2 5903.8 5795.5 5810.5 5839.2 5839.6 5847.8 4814.8 4879.0 5342.3 5565.3 5614.0 5214.2 5788.7 5871.7 5878.8 5910.5 4713.2 5027.9 5365.4 5759.9 5775.8 03:16:55 INFO - PROCESS | 1645 | 03:16:55 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:19549.16 Median:47701.02 stddev:28354.97 (59.4%) stddev-sans-first:28399.06 03:16:55 INFO - PROCESS | 1645 | Values: 664.3 671.9 689.2 691.7 805.1 14327.9 14844.9 14853.6 14884.0 14902.8 13019.3 13495.3 13629.3 13652.4 13683.9 642.6 666.1 809.2 809.7 825.8 815.6 829.8 829.9 831.5 831.8 876.4 881.1 882.8 883.3 884.6 849.9 861.7 874.0 875.6 876.4 610.9 650.2 652.5 659.3 664.1 14363.8 14663.0 14731.3 14814.3 15012.0 12161.6 12884.4 12953.6 12973.1 13233.3 10213.5 10553.5 10733.1 10769.7 10959.6 3057.3 3111.9 3712.5 3716.7 3724.4 57933.7 69881.0 75705.6 87107.1 93421.5 9511.6 9797.1 9809.2 9890.0 9982.1 20958.0 20983.2 21009.2 21017.4 21057.2 7258.8 7603.5 7770.5 7774.2 7850.8 4145.2 4251.7 4263.7 4278.8 4321.4 3375.7 3496.2 3502.2 3509.9 3638.5 679.8 686.0 691.4 700.1 701.3 571.2 638.1 646.3 655.9 675.8 8795.3 9007.0 9044.8 9140.4 9260.5 599.0 646.4 649.3 662.6 664.4 4287.8 4299.0 4475.1 4581.3 4602.1 112814.0 116021.4 116270.0 116327.0 119525.4 74099.6 76049.6 86035.0 86892.5 99649.0 55075.4 77325.6 80571.4 81360.2 81849.0 9182.1 9579.9 9626.7 9693.1 9711.3 46956.5 48445.5 53238.7 54123.7 54814.7 53215.4 63704.0 69994.0 70962.0 75355.0 11815.5 12076.3 12480.6 12524.5 12649.9 12173.8 12361.7 14083.1 14219.8 14273.1 12936.5 13075.5 13107.7 13129.9 13285.4 12666.0 13044.0 13058.9 13134.7 13314.3 10580.8 11240.2 12307.2 13175.5 13602.7 11073.9 11236.8 11255.5 11705.4 11767.2 11415.4 11490.5 11495.4 11561.8 11562.5 03:16:55 INFO - PROCESS | 1645 | -------- Summary: end -------- 03:16:55 INFO - PROCESS | 1645 | 03:16:56 INFO - TEST-INFO | 1645: exit 0 03:16:56 INFO - TEST-OK | dromaeo_css | took 1115776ms 03:16:56 INFO - TEST-START | kraken 03:16:56 INFO - operating with platform_type : mac_ 03:16:56 INFO - Initialising browser for kraken test... 03:16:56 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpr6sGei/profile http://localhost:49250/getInfo.html) 03:16:59 INFO - PROCESS | 1655 | 2016-12-29 03:16:59.122 plugin-container[1656:11364] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x884b, name = 'com.apple.tsm.portname' 03:16:59 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:16:59 INFO - PROCESS | 1655 | 2016-12-29 03:16:59.126 plugin-container[1656:11364] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 03:16:59 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:16:59 INFO - PROCESS | 1655 | 2016-12-29 03:16:59.126 plugin-container[1656:11364] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:16:59 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 03:16:59 INFO - PROCESS | 1655 | colorDepth:24 03:16:59 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 03:16:59 INFO - PROCESS | 1655 | __metrics 03:16:59 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:17:00 INFO - TEST-INFO | 1655: exit 0 03:17:00 INFO - Browser initialized. 03:17:00 INFO - Running cycle 1/1 for kraken test... 03:17:00 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpr6sGei/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:02 INFO - PROCESS | 1657 | 2016-12-29 03:17:02.563 plugin-container[1658:11492] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8643, name = 'com.apple.tsm.portname' 03:17:02 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:02 INFO - PROCESS | 1657 | 2016-12-29 03:17:02.563 plugin-container[1658:11492] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x870f, name = 'com.apple.CFPasteboardClient' 03:17:02 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:17:02 INFO - PROCESS | 1657 | 2016-12-29 03:17:02.563 plugin-container[1658:11492] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:17:12 INFO - PROCESS | 1657 | RSS: Main: 229662720 03:17:12 INFO - PROCESS | 1657 | 03:17:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:16 INFO - PROCESS | 1657 | RSS: Main: 241549312 03:17:16 INFO - PROCESS | 1657 | 03:17:18 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 03:17:19 INFO - PROCESS | 1657 | RSS: Main: 249110528 03:17:19 INFO - PROCESS | 1657 | 03:17:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 03:17:23 INFO - PROCESS | 1657 | RSS: Main: 252964864 03:17:23 INFO - PROCESS | 1657 | 03:17:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 03:17:26 INFO - PROCESS | 1657 | RSS: Main: 253202432 03:17:26 INFO - PROCESS | 1657 | 03:17:28 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:28 INFO - PROCESS | 1657 | RSS: Main: 253755392 03:17:28 INFO - PROCESS | 1657 | 03:17:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:32 INFO - PROCESS | 1657 | RSS: Main: 257314816 03:17:32 INFO - PROCESS | 1657 | 03:17:35 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:36 INFO - PROCESS | 1657 | RSS: Main: 256917504 03:17:36 INFO - PROCESS | 1657 | 03:17:39 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 03:17:39 INFO - PROCESS | 1657 | RSS: Main: 258510848 03:17:39 INFO - PROCESS | 1657 | 03:17:41 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:42 INFO - PROCESS | 1657 | RSS: Main: 257138688 03:17:42 INFO - PROCESS | 1657 | 03:17:43 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:44 INFO - PROCESS | 1657 | RSS: Main: 257302528 03:17:44 INFO - PROCESS | 1657 | 03:17:46 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:47 INFO - PROCESS | 1657 | RSS: Main: 257318912 03:17:47 INFO - PROCESS | 1657 | 03:17:50 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:51 INFO - PROCESS | 1657 | RSS: Main: 257507328 03:17:51 INFO - PROCESS | 1657 | 03:17:54 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:54 INFO - PROCESS | 1657 | RSS: Main: 258035712 03:17:54 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 03:17:56 INFO - PROCESS | 1657 | RSS: Main: 259497984 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | __start_tp_report 03:17:56 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 03:17:56 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 03:17:56 INFO - PROCESS | 1657 | |i|pagename|runs| 03:17:56 INFO - PROCESS | 1657 | |0;ai-astar;136;174;170;117;118;118;118;117;119;119 03:17:56 INFO - PROCESS | 1657 | |1;audio-beat-detection;139;149;144;149;107;112;121;125;177;112 03:17:56 INFO - PROCESS | 1657 | |2;audio-dft;185;281;200;196;167;167;207;176;195;274 03:17:56 INFO - PROCESS | 1657 | |3;audio-fft;83;57;57;84;62;59;62;90;99;57 03:17:56 INFO - PROCESS | 1657 | |4;audio-oscillator;90;72;90;73;69;104;71;59;84;121 03:17:56 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;89;86;88;89;120;94;136;131;89;132 03:17:56 INFO - PROCESS | 1657 | |6;imaging-darkroom;97;100;99;98;99;98;125;169;106;100 03:17:56 INFO - PROCESS | 1657 | |7;imaging-desaturate;130;138;84;87;86;102;90;142;133;88 03:17:56 INFO - PROCESS | 1657 | |8;json-parse-financial;56;57;57;60;60;60;60;60;60;61 03:17:56 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;67;74;72;75;74;70;70;69;65;73 03:17:56 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;85;83;82;72;96;107;105;86;87;85 03:17:56 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;142;142;142;141;154;159;162;161;192;162 03:17:56 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;165;173;168;164;172;169;167;169;167;168 03:17:56 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;71;69;70;71;68;77;67;56;85;89 03:17:56 INFO - PROCESS | 1657 | __end_tp_report 03:17:56 INFO - PROCESS | 1657 | __start_cc_report 03:17:56 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,989 03:17:56 INFO - PROCESS | 1657 | __end_cc_report 03:17:56 INFO - PROCESS | 1657 | __startTimestamp1483010276661__endTimestamp 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | ------- Summary: start ------- 03:17:56 INFO - PROCESS | 1657 | Number of tests: 14 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:130.60 Median:119.00 stddev:22.56 (19.0%) stddev-sans-first:23.84 03:17:56 INFO - PROCESS | 1657 | Values: 136.0 174.0 170.0 117.0 118.0 118.0 118.0 117.0 119.0 119.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:141.50 stddev:22.03 (15.6%) stddev-sans-first:23.28 03:17:56 INFO - PROCESS | 1657 | Values: 139.0 149.0 144.0 149.0 107.0 112.0 121.0 125.0 177.0 112.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:204.80 Median:198.00 stddev:40.66 (20.5%) stddev-sans-first:42.49 03:17:56 INFO - PROCESS | 1657 | Values: 185.0 281.0 200.0 196.0 167.0 167.0 207.0 176.0 195.0 274.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:71.00 Median:72.50 stddev:16.17 (22.3%) stddev-sans-first:16.55 03:17:56 INFO - PROCESS | 1657 | Values: 83.0 57.0 57.0 84.0 62.0 59.0 62.0 90.0 99.0 57.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:83.30 Median:72.50 stddev:18.62 (25.7%) stddev-sans-first:19.59 03:17:56 INFO - PROCESS | 1657 | Values: 90.0 72.0 90.0 73.0 69.0 104.0 71.0 59.0 84.0 121.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:105.40 Median:88.50 stddev:21.42 (24.2%) stddev-sans-first:21.88 03:17:56 INFO - PROCESS | 1657 | Values: 89.0 86.0 88.0 89.0 120.0 94.0 136.0 131.0 89.0 132.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:109.10 Median:97.50 stddev:22.64 (23.2%) stddev-sans-first:23.59 03:17:56 INFO - PROCESS | 1657 | Values: 97.0 100.0 99.0 98.0 99.0 98.0 125.0 169.0 106.0 100.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:108.00 Median:85.00 stddev:24.55 (28.9%) stddev-sans-first:24.72 03:17:56 INFO - PROCESS | 1657 | Values: 130.0 138.0 84.0 87.0 86.0 102.0 90.0 142.0 133.0 88.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:59.10 Median:60.00 stddev:1.73 (2.9%) stddev-sans-first:1.42 03:17:56 INFO - PROCESS | 1657 | Values: 56.0 57.0 57.0 60.0 60.0 60.0 60.0 60.0 60.0 61.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:72.50 stddev:3.28 (4.5%) stddev-sans-first:3.16 03:17:56 INFO - PROCESS | 1657 | Values: 67.0 74.0 72.0 75.0 74.0 70.0 70.0 69.0 65.0 73.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:85.00 stddev:10.79 (12.7%) stddev-sans-first:11.36 03:17:56 INFO - PROCESS | 1657 | Values: 85.0 83.0 82.0 72.0 96.0 107.0 105.0 86.0 87.0 85.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:155.70 Median:160.00 stddev:15.70 (9.8%) stddev-sans-first:15.85 03:17:56 INFO - PROCESS | 1657 | Values: 142.0 142.0 142.0 141.0 154.0 159.0 162.0 161.0 192.0 162.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.50 stddev:2.78 (1.7%) stddev-sans-first:2.70 03:17:56 INFO - PROCESS | 1657 | Values: 165.0 173.0 168.0 164.0 172.0 169.0 167.0 169.0 167.0 168.0 03:17:56 INFO - PROCESS | 1657 | 03:17:56 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:71.00 stddev:9.39 (13.2%) stddev-sans-first:9.95 03:17:56 INFO - PROCESS | 1657 | Values: 71.0 69.0 70.0 71.0 68.0 77.0 67.0 56.0 85.0 89.0 03:17:56 INFO - PROCESS | 1657 | -------- Summary: end -------- 03:17:56 INFO - PROCESS | 1657 | 03:17:57 INFO - TEST-INFO | 1657: exit 0 03:17:57 INFO - TEST-OK | kraken | took 61646ms 03:17:57 INFO - SUITE-END | took 1177s 03:17:58 INFO - Completed test suite (00:19:37) 03:17:58 INFO - javascript benchmark 03:17:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7095.785454333322, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3388.610309814372, 3392.694657480827, 3396.3037577296654, 3425.1094715373997, 3441.4665726812336, 4876.512348765122, 5825.097109947959, 5829.0964900440395, 5850.970745146268, 5898.823035308937, 4798.448178459478, 5827.562932780037, 5917.437843404869, 5925.7925972590965, 5947.434993675604, 4366.541513141122, 5345.786168553253, 5351.598630102739, 5358.624896257264, 5413.079776437995, 5255.343082114736, 5321.467853214667, 5422.37642671092, 5423.0, 5446.564274858021, 5176.171812510018, 5238.73806309683, 5252.975669744402, 5276.997370499593, 5379.81170659029, 5188.221766734982, 5224.608154388398, 5272.604554658377, 5328.280682107905, 5334.146536554172, 4656.254999200146, 5100.974495127538, 5167.4057483389515, 5230.973845130788, 5260.973695131538, 4402.7358358498595, 5289.915567308731, 5867.618604790718, 5869.853253668693, 5896.764129434818, 6213.596116252429, 6274.435300822902, 6278.058291256302, 6289.0, 6296.370362963713, 6238.313785483593, 6269.529785266123, 6282.434580887696, 6291.056341548759, 6333.714982825784, 5779.104238842986, 5965.7613695452565, 5983.820485385445, 5986.880262394815, 5991.400859913973, 6252.249730032425, 6277.654728989949, 6298.559100862987, 6321.1782468278825, 6356.618602883842, 6239.750409983641, 6264.37356264379, 6271.811845644638, 6273.7176827042895, 6274.152989346471, 6199.163112979781, 6235.96882015587, 6281.842953926189, 6297.2128483939505, 6301.275353334334, 6091.14723938649, 6122.785702500391, 6167.352427995085, 6173.783917562864, 6289.7484100636375, 6113.567524283629, 6271.43557079865, 6278.340774218641, 6282.465990390868, 6294.150289710922, 4943.382077240345, 4982.975085124551, 4986.977669577728, 5008.0, 5010.223415370623, 4413.205622987893, 4435.35687325336, 4453.799579018952, 4477.888052798641, 4491.0, 5732.799352022743, 5941.0, 5945.048792193228, 6026.939730602638, 6077.905976924108, 6199.928255410752, 6255.0, 6255.343188965184, 6255.468285195719, 6263.906041409383, 5824.271966004249, 5911.379305172981, 5918.733656985446, 5920.171176035358, 5975.372585878507, 4999.775010124553, 5434.64674796137, 5497.5601951843755, 5516.779328826882, 5559.24950131727, 5865.970670146622, 6133.26400831903, 6202.100695399232, 6467.482601391877, 6481.4166724994975, 5372.516473517402, 6048.425399587032, 6193.81418557444, 6201.534884883562, 6299.275583307978, 5914.704264786829, 6413.486921046212, 6430.839229019312, 6441.420272175526, 6576.605403675795, 6268.592541484789, 6275.466585340298, 6288.371162883675, 6291.496680265659, 6326.715297811702, 5119.539241468286, 6019.367966363644, 6175.567710260419, 6216.378362163748, 6254.155688981929, 6194.349593292639, 6202.782902598387, 6235.314115447388, 6236.594621349598, 6246.906296405648, 6157.630542167484, 6158.168647232566, 6162.876742465036, 6254.9687251563455, 6276.905846412216, 5073.061483625541, 5756.0, 6012.939870601238, 6012.969935150296, 6071.089336599545, 6085.300190477975, 6090.056041313604, 6147.938520614915, 6165.167702360124, 6187.84530386726, 5022.296878436949, 6069.725357674938, 6073.696315184311, 6092.45167934888, 6105.786297479567], "value": 5720.656279997231, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.05670326819563, 518.4271380124961, 520.9661372010819, 547.4716898193243, 551.5119119579176, 28825.855870720643, 37633.811830940875, 37678.86963391096, 37707.24585508288, 37765.05587360314, 37781.0, 37952.86141415755, 38287.61712382875, 38386.42420363697, 38442.42336364957, 8073.152319006523, 8146.3890208234325, 8213.876791848126, 8220.05469371021, 8252.422330436872, 9183.49490778007, 9209.309301802357, 9290.767730806716, 9298.58156382961, 9314.627414903429, 9219.95390023049, 9292.814143717122, 9311.534423278843, 9321.766955826124, 9337.253019758404, 9253.768655783591, 9267.629294828199, 9281.211097056725, 9294.72115836526, 9309.581068851918, 9179.357444978854, 9228.215601673866, 9251.722448326562, 9257.67598134062, 9269.0, 36853.89438316855, 37236.44145337822, 37250.44124338137, 37345.0, 37350.25299494022, 3123.859426325821, 3282.1138292661085, 3335.949960750591, 3467.514547963287, 3717.5167228260425, 28046.2988425291, 28147.577786333222, 28393.716062839314, 28972.27569310784, 29436.411271774658, 2806.9157925262275, 3130.550732136912, 3145.7011583899493, 3163.383140287645, 3164.604424446944, 474452.0, 483140.5842970763, 484374.0, 488305.0, 489298.55350723374, 42848.0, 49366.7658308538, 53589.196162057604, 53796.0, 54292.45707542874, 54044.0, 56667.0, 56934.0, 57582.0, 57643.423565763806, 15645.60885977837, 15667.921660391625, 15730.842691573167, 15794.447194348142, 15835.841641583436, 12380.752384952431, 12482.875171248354, 12489.875101249054, 12514.937425312815, 12517.186382885084, 13593.728125437436, 13759.656008599664, 14321.427142914166, 14452.638684032983, 14510.492132775302, 5234.895302093937, 5774.653520788766, 5973.462388385066, 5983.790567330123, 6067.484263837623, 866.8093019535692, 880.7489865388462, 940.238406890421, 1039.6984874386494, 1056.1550759392455, 28356.865725371168, 28451.857740711162, 29029.56455653167, 29343.55984660232, 29431.558526622117, 907.8638204269413, 1033.679559336593, 1066.8879767624444, 1085.0505807418508, 1094.698957786599, 14266.714665706628, 14988.47540336083, 15058.54824355271, 15220.695586088215, 15733.0, 628994.0, 630364.0, 632626.0, 632828.0, 633962.0, 53781.46218537843, 54205.45794542083, 54213.0, 54268.45731542713, 54295.45704542983, 1332.8000799880097, 1344.2539390638094, 1363.372848489686, 1366.7813149896167, 1371.9245441500614, 24113.553186808847, 26285.08002219913, 28820.71179288264, 29292.707072929, 29350.706492934798, 52147.73926130345, 53192.0, 53268.4673153279, 53318.0, 53430.0, 488370.55814720696, 490732.54633726605, 493750.0, 497504.0, 497815.0, 24895.0, 25057.248282551554, 25220.49559008773, 25322.493550129264, 25449.491010180063, 42743.786281068395, 44196.33705494356, 44725.88185295263, 45068.87327816831, 45094.647160585235, 36058.63941360553, 36554.8172259137, 36622.633773661924, 37450.625493744716, 37723.622763773106, 28180.85909570521, 29766.0, 31720.365592687554, 34808.65191348054, 37513.0, 29526.557101643062, 30555.54166687546, 35905.28189436145, 36420.90737277886, 37170.0, 23875.522489549763, 30344.393112138074, 32344.706211751265, 32961.505577415875, 33672.49491257584, 21097.263775236996, 21973.67039494377, 24770.00919963181, 25045.49909001846, 25257.368565786004], "value": 18598.82144333585, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.74653235799656, 378.4852600463371, 389.36727817296895, 390.8163163313242, 407.35434336576526, 14571.344289506971, 14750.262486875667, 17853.910730446347, 19587.804121958776, 19813.801861981377, 15533.990290631129, 15747.133907635076, 16491.91754041228, 17727.93632382058, 19704.211831526758, 4685.0, 6005.309389420229, 6012.158297838306, 6012.969935150318, 6033.456988871001, 5625.156226566028, 5879.029960056586, 5947.702614869239, 5959.165716799652, 5993.940060599403, 5721.7711291548285, 5950.880982380349, 5961.1058341248945, 6067.120267561201, 6075.210222671047, 6068.6662233577135, 6099.115628233925, 6109.114178444101, 6115.0, 6142.692865356737, 5104.693718376872, 5424.457554244584, 5456.0997435423105, 5501.779928802843, 5501.807436739695, 13177.209367437888, 13402.12886162406, 13821.308934553232, 23644.408889777893, 23813.404664883343, 2198.0103271596317, 2301.1140710826285, 2368.585497537924, 2645.1535508637244, 2893.8987135450157, 9965.601375945025, 10237.0, 10304.072633462949, 12284.815727764091, 14660.633484162874, 1819.5087326421792, 1833.5599456130567, 1859.4979355574055, 1866.4773863318292, 1899.591587808614, 79475.0, 117732.0, 119352.40323798412, 122085.38957305157, 122120.0, 9143.359964802534, 11399.544018239343, 11702.870039049167, 11720.296782193096, 11852.0, 14511.782323265159, 14571.125732456087, 14593.489227876973, 14606.196659183846, 14642.121472711671, 8323.250907418362, 8581.313494920392, 8589.398742087993, 8670.393072484992, 8713.52075635846, 8372.916270837335, 8424.789380265542, 8488.915110848937, 8579.656813727506, 8620.310375169971, 4510.120526497367, 4587.128445595326, 4592.609628181642, 4613.930791038137, 4663.300504924221, 1720.7590937268792, 1917.9232830686894, 1926.7591551056119, 1979.623871464417, 1980.5543752655826, 808.2483290539855, 881.7531091294447, 896.6996056321075, 911.6581282019242, 918.1461241045758, 16491.752623710654, 19243.711344329848, 20973.84643844603, 21156.047977841034, 21582.676259856114, 939.7650587353162, 975.8926518083006, 976.3702411944256, 992.8560358747941, 1003.3027046202965, 8900.465972041698, 10955.233133680566, 11244.66266012021, 11255.324680519196, 11260.268082574607, 577951.0, 582458.0, 584291.0, 589385.0, 595132.0, 94344.0, 97239.027609723, 103798.0, 107682.0, 112080.4395978015, 867.5011868175824, 966.8888077871135, 982.2829334585792, 1001.1190152665753, 1005.7385079879137, 17551.561210969827, 18044.909775451564, 18263.269469221083, 18365.81634183641, 18443.0, 49413.0, 50951.0, 51137.48862511476, 51683.22475162951, 52278.738606308245, 74220.0, 77634.6118269405, 80189.59905200437, 81216.18783812087, 81314.0, 5854.941450585439, 7393.778186654194, 7965.56189409588, 8143.697008478615, 8191.713290034821, 11108.888911110786, 12708.745825083632, 12743.299118548568, 12767.0, 13058.738825223252, 10762.162564879554, 10915.126789856633, 11081.83377249358, 11106.222564420414, 11248.493817778057, 10939.617113400993, 10999.285046472274, 11048.281861678965, 11069.944650276697, 11318.377489237842, 8846.292296616384, 11115.666530004113, 11140.610078647209, 11152.330860148417, 11475.885241147482, 7518.0, 7562.962185189259, 7568.243175682388, 7651.311381975649, 7749.535027898344, 9363.391379560308, 11024.328040008779, 11240.83138752903, 11264.324140551593, 11300.94349528247], "value": 9271.863739017952, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1146.1747541769926, 1398.6713122416234, 1543.9845601543989, 1737.0967097109497, 1774.8668849836258, 7494.700211991528, 7756.844863102735, 8003.559804210766, 8482.44864083835, 8505.702300419478, 7557.752970759831, 7712.691492340314, 7982.52104873708, 8385.287250583708, 8412.873806892887, 2306.146725711489, 2349.18952961229, 2354.682117914077, 2355.4111472131967, 2358.988205058972, 2338.684277622516, 2358.9528209435803, 2381.154690085012, 2384.725756537994, 2395.2574701842395, 2328.9417764555938, 2342.7583380808114, 2355.5524450354465, 2360.799332056777, 2368.846025008369, 1937.4575118966711, 2222.288867562381, 2260.3557985974003, 2286.4626812699003, 2290.4044948313476, 1828.7256911463253, 2346.6480027995935, 2356.32844639277, 2358.8230882683697, 2363.72817126031, 8264.173582641688, 8376.162383761635, 8418.242358187792, 8440.62017209227, 8455.112213217646, 4916.434610019858, 5063.240513922904, 5092.745362731848, 5094.2103973884105, 5112.565431938253, 3319.751018673585, 3478.9304213915834, 3523.4362501999813, 3627.474016267626, 3628.546431696038, 1018.7249442650517, 1022.7340891368298, 1086.0714089453481, 1089.3844977587637, 1096.5778175402527, 10892.346459212473, 10918.962698543626, 11032.724181895517, 11051.668449946514, 11064.944675276573, 4499.730016199039, 4634.652401069933, 4710.811567537328, 4723.960728639694, 4740.14677358072, 9388.155066043952, 9479.47862867549, 9493.05069493045, 9524.761880953032, 9554.187894029086, 5100.821471248489, 5206.297149884793, 5215.5135786300725, 5232.136697444879, 5239.921401178985, 4260.4248426462655, 4289.871303860889, 4742.620590352833, 4790.137775200497, 4796.56830885222, 3787.7311100780994, 3832.405977073558, 3867.5165604299464, 3886.3393223152134, 3925.941110883339, 1253.642711827125, 1275.5471807508386, 1283.4417028592593, 1284.794432890733, 1285.0169620240524, 801.9919800802033, 884.5223579267124, 899.1547944931743, 914.6524320758069, 921.2583869984727, 5787.565932555075, 5818.0340219675945, 5877.265341832271, 5891.617044892068, 6082.543809214327, 885.154677283193, 915.7573243090586, 920.1442658327686, 935.2377812083131, 982.6315131825565, 3711.5175027246823, 3783.1677031053123, 3806.2006978534264, 3840.1935593525113, 3843.1929294847837, 9960.302778805559, 10317.380957142595, 10363.94818025905, 10375.27373083892, 10397.32417392867, 8650.3131889281, 8789.472631642122, 9627.614895404105, 10304.330218535772, 10341.586336546454, 6414.711337989802, 7481.139668938142, 7798.22017798227, 7932.0, 7952.960235198787, 5682.914756278742, 5685.488306052475, 5829.94170058294, 5881.0, 5904.0553511437965, 7148.642567871481, 7465.738699145504, 9307.301952353737, 9487.620495180116, 9512.619495220113, 9485.33602647808, 9519.619215231312, 9564.378315409476, 9645.855312170463, 9669.226461882892, 6576.8355791105605, 6787.864242715217, 7014.754483593049, 7135.393491553068, 7273.3817625500305, 7791.337736292478, 8005.0, 8011.439199255996, 8028.157043510348, 8032.959835200787, 7061.2232654409, 7216.0, 7231.096112985877, 7236.6019868907715, 7333.413326933939, 6996.125484314461, 7071.43428525727, 7125.1093613298335, 7183.712651494091, 7239.167495738057, 6674.532782705358, 6687.732490700318, 6756.391924726799, 6760.459163267025, 6771.93228067713, 4826.8793280168275, 4847.587955023721, 4850.345203397496, 4860.198067318853, 4911.0, 4693.671442999094, 4816.566509014206, 4883.438404583519, 4889.9975505020675, 4930.6795058321095], "value": 4416.778173011455, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.4029372576613, 309.39358856640985, 317.49042786327936, 318.2632206442085, 319.94880819068953, 5248.868778280545, 5429.267048948391, 5520.889582208353, 5586.748596313166, 5667.126271406592, 4047.7368971016863, 4499.762565294545, 4672.299155126732, 4756.0975609756115, 5403.162509810976, 4087.591240875911, 4202.8318867245425, 4214.831406743727, 4233.909246250239, 4240.851570195044, 3324.734021278292, 4017.9799101004455, 4142.130152667944, 4211.768352740598, 4271.743695378287, 3669.3028324618235, 4051.7163798533966, 4151.709380343377, 4204.5585213552595, 4213.431186789775, 4147.714208595346, 4170.040890595165, 4184.937225941613, 4195.0, 4210.831566737327, 3619.8371073301764, 3671.816409179557, 3674.6876515496215, 3683.8158092095287, 3689.0592898810633, 4651.37206477128, 5066.0, 5382.273393091921, 5426.348838139409, 5467.398586155519, 4422.314541246112, 4792.640551958617, 4805.014971930781, 4822.710637361734, 4863.103389678028, 4683.250679891235, 4719.693219940693, 5780.7687692492245, 5819.214406055171, 5840.591158618899, 3630.80030598317, 3692.390755525362, 3795.2978698940783, 3876.7092468065007, 4082.9591704082877, 5197.662151960149, 6009.278886533601, 6049.758009679607, 6106.450419462225, 6109.450149486567, 3348.5220936506807, 3478.4608385700258, 3755.080005398695, 3959.940600890989, 3983.8605648802154, 3197.0089272325654, 3332.6334103248623, 3868.052327179859, 3921.5490218624655, 3946.1713040261293, 4673.112108699404, 4705.811767529329, 4712.835050773207, 4753.4295884493395, 4755.83354582588, 4615.561521655437, 4626.953730462719, 4722.598579120813, 5836.824895253149, 5856.837307853796, 1085.7719878825378, 1212.454395522001, 1233.8278635296504, 1283.1274733181526, 1290.9612711618665, 751.0949306086262, 840.4285086141482, 863.820884492663, 886.6807949138305, 891.6834523744108, 4637.582617564435, 5206.271122042917, 5247.2129180623215, 5256.39551451588, 5262.605724220319, 5053.898922021539, 5362.45283490339, 5384.5692344612335, 5415.106507426231, 5602.887942241132, 4339.698090572815, 4778.761061946889, 4873.488283730228, 5101.362329708786, 5147.6911385317, 2676.598510223443, 2836.950328378513, 2910.2433367324647, 2933.4719750444697, 2938.1773103531045, 4395.494518130456, 5716.714164291852, 5814.854628634233, 5834.766609335579, 5864.824055278348, 4647.790849411785, 5195.9740201298755, 5670.744816483269, 5706.457886500776, 5725.541956643458, 4388.473383193909, 5287.0, 5715.399883012307, 5778.994922640203, 5797.709694825883, 4898.632602554894, 5146.713321669583, 5168.664036837594, 5632.662040277432, 5701.486866182064, 4542.818287268472, 5034.0, 5344.483911095119, 5490.149026900836, 5578.581606379619, 5236.842894713165, 5320.627556071193, 5581.386047534686, 5726.370099289158, 5798.391168927371, 3806.5154589710587, 3934.7245692802376, 3955.03101740064, 3973.980130099447, 4059.2693315203546, 5138.820141295037, 5154.278401023935, 5937.554683398849, 6081.0, 6089.5737298388685, 5138.717370544656, 5357.678539287655, 5596.496315331639, 5833.212516310244, 5903.793367232126, 5795.5073818724195, 5810.518317828926, 5839.153322768259, 5839.620424672383, 5847.795327163529, 4814.759262036814, 4879.048585525788, 5342.278792362981, 5565.325126893429, 5613.971930140323, 5214.217867319932, 5788.710564471844, 5871.735771890189, 5878.794242201502, 5910.527157827278, 4713.198756211384, 5027.874303142305, 5365.409804921534, 5759.884802304015, 5775.81595772874], "value": 4075.5069467237854, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.2726214794798, 671.946244300456, 689.1867596236441, 691.7405972760218, 805.1385018030702, 14327.928360358197, 14844.851551484495, 14853.554393368217, 14884.0, 14902.77645835312, 13019.349032548358, 13495.325233738324, 13629.318534073282, 13652.38564264608, 13683.931580342085, 642.5566359212129, 666.0808084842935, 809.1665584447999, 809.6842231529708, 825.8307047055339, 815.5962798414793, 829.7966998085477, 829.854775414303, 831.5426515416527, 831.7629475599456, 876.3865294293988, 881.0880738435688, 882.8190221004711, 883.2580632268892, 884.6107712606432, 849.8512760266929, 861.6984055580559, 873.9992708348937, 875.6234819027816, 876.4478378621428, 610.9236345456818, 650.2164891305965, 652.4812773844804, 659.307726886767, 664.1266734244454, 14363.784543231755, 14663.0, 14731.263436828116, 14814.259287035713, 15012.024218425877, 12161.635150945485, 12884.420201090974, 12953.611391658265, 12973.096668921855, 13233.272170030645, 10213.540390682438, 10553.52509137083, 10733.141348692086, 10769.676909692722, 10959.56161753529, 3057.281538838371, 3111.937761244785, 3712.4988126602834, 3716.739828212026, 3724.366857634209, 57933.71033144849, 69881.0, 75705.62147189229, 87107.12892871117, 93421.5328923351, 9511.619535218513, 9797.118259356692, 9809.21526277896, 9890.0, 9982.1303241928, 20957.952102395124, 20983.160673572886, 21009.159633614483, 21017.369478915658, 21057.157713691588, 7258.782236532807, 7603.5403147386905, 7770.494917830436, 7774.183710710294, 7850.803729906684, 4145.233131870614, 4251.723637963522, 4263.701540892108, 4278.764667943293, 4321.438213032286, 3375.729941604666, 3496.1958749487762, 3502.1594817243677, 3509.94735078974, 3638.5269914911423, 679.7858674517511, 685.95541289816, 691.4192078653955, 700.1423256510734, 701.2566679319938, 571.240250466878, 638.1321402892063, 646.2678034351657, 655.8524332025352, 675.7634827810227, 8795.252403545643, 9007.0, 9044.773880652905, 9140.360174787702, 9260.490673012915, 598.9940100599025, 646.3504178300777, 649.2857856357969, 662.5593980003243, 664.4053572052985, 4287.842282583747, 4298.973623767843, 4475.060237350193, 4581.266997280419, 4602.125596136723, 112814.0, 116021.41989290169, 116270.0, 116327.0, 119525.40237298758, 74099.62950185323, 76049.61975190089, 86035.0, 86892.52429902733, 99649.0, 55075.44924550703, 77325.61337193278, 80571.38857222823, 81360.18639813644, 81849.0, 9182.127697868691, 9579.90420095818, 9626.711198664052, 9693.127618514367, 9711.27165462579, 46956.530434696586, 48445.5155448441, 53238.66903327293, 54123.72938135284, 54814.72592637011, 53215.40353789392, 63704.0, 69994.0, 70962.0, 75355.0, 11815.468303926516, 12076.335801531, 12480.563180288646, 12524.499020039097, 12649.87350126487, 12173.75652486963, 12361.690957726129, 14083.084599501, 14219.786703199254, 14273.14361138335, 12936.482540698267, 13075.476980921037, 13107.672308192372, 13129.868701312864, 13285.40215690277, 12666.0, 13044.02169837285, 13058.869411306145, 13134.737305254033, 13314.267715275753, 10580.841287380541, 11240.156988225752, 12307.200031998249, 13175.538856139989, 13602.727945441233, 11073.944630276797, 11236.831447528457, 11255.549778008788, 11705.414729263674, 11767.176297659424, 11415.429228538374, 11490.478661822921, 11495.425228738362, 11561.826572601585, 11562.537498499965], "value": 7187.421707384999, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 174.0, 170.0, 117.0, 118.0, 118.0, 118.0, 117.0, 119.0, 119.0], "value": 130.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 149.0, 144.0, 149.0, 107.0, 112.0, 121.0, 125.0, 177.0, 112.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 281.0, 200.0, 196.0, 167.0, 167.0, 207.0, 176.0, 195.0, 274.0], "value": 204.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 57.0, 57.0, 84.0, 62.0, 59.0, 62.0, 90.0, 99.0, 57.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 90.0, 73.0, 69.0, 104.0, 71.0, 59.0, 84.0, 121.0], "value": 83.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 89.0, 120.0, 94.0, 136.0, 131.0, 89.0, 132.0], "value": 105.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 99.0, 98.0, 99.0, 98.0, 125.0, 169.0, 106.0, 100.0], "value": 109.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 84.0, 87.0, 86.0, 102.0, 90.0, 142.0, 133.0, 88.0], "value": 108.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0], "value": 59.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 72.0, 75.0, 74.0, 70.0, 70.0, 69.0, 65.0, 73.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 82.0, 72.0, 96.0, 107.0, 105.0, 86.0, 87.0, 85.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 142.0, 141.0, 154.0, 159.0, 162.0, 161.0, 192.0, 162.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 168.0, 164.0, 172.0, 169.0, 167.0, 169.0, 167.0, 168.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 71.0, 68.0, 77.0, 67.0, 56.0, 85.0, 89.0], "value": 72.3, "unit": "score"}]}]} 03:17:58 INFO - Return code: 0 03:17:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:58 ERROR - # TBPL SUCCESS # 03:17:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:17:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:17:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:17:58 INFO - 2016-12-29 03:17:58.456 screenresolution[1662:11881] starting screenresolution argv=screenresolution get 03:17:58 INFO - 2016-12-29 03:17:58.459 screenresolution[1662:11881] Display 0: 1600x1200x32@60 03:17:58 INFO - 2016-12-29 03:17:58.465 screenresolution[1663:11884] starting screenresolution argv=screenresolution list 03:17:58 INFO - Available Modes on Display 0 03:17:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:17:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:17:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:17:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:17:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:17:58 INFO - Intel Iris: 03:17:58 INFO - Chipset Model: Intel Iris 03:17:58 INFO - Type: GPU 03:17:58 INFO - Bus: Built-In 03:17:58 INFO - VRAM (Dynamic, Max): 1536 MB 03:17:58 INFO - Vendor: Intel (0x8086) 03:17:58 INFO - Device ID: 0x0a2e 03:17:58 INFO - Revision ID: 0x0009 03:17:58 INFO - Displays: 03:17:58 INFO - Display: 03:17:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:17:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:17:58 INFO - Display Serial Number: 1600x1200 60 03:17:58 INFO - Main Display: Yes 03:17:58 INFO - Mirror: Off 03:17:58 INFO - Online: Yes 03:17:58 INFO - Rotation: Supported 03:17:58 INFO - Return code: 0 03:17:58 INFO - Running post-action listener: _resource_record_post_action 03:17:58 INFO - [mozharness: 2016-12-29 11:17:58.698665Z] Finished run-tests step (success) 03:17:58 INFO - Running post-run listener: _resource_record_post_run 03:17:58 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 33823232; Write bytes: 663728640; Read time: 330; Write time: 1898 03:17:58 INFO - TinderboxPrint: CPU usage
54.4% 03:17:58 INFO - TinderboxPrint: I/O read bytes / time
33,823,232 / 330 03:17:58 INFO - TinderboxPrint: I/O write bytes / time
663,728,640 / 1,898 03:17:58 INFO - TinderboxPrint: CPU idle
2,207.2 (45.6%) 03:17:58 INFO - TinderboxPrint: CPU system
974.6 (20.1%) 03:17:58 INFO - TinderboxPrint: CPU user
1,656.0 (34.2%) 03:17:58 INFO - TinderboxPrint: Swap in / out
380,391,424 / 0 03:17:58 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 350071296; Write bytes: 351541248; Read time: 26803; Write time: 701 03:17:58 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 29440512; Write bytes: 310852096; Read time: 297; Write time: 1193 03:17:59 INFO - Running post-run listener: _upload_blobber_files 03:17:59 INFO - Blob upload gear active. 03:17:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:17:59 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:00 INFO - (blobuploader) - INFO - Done attempting. 03:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:01 INFO - (blobuploader) - INFO - Done attempting. 03:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:03 INFO - (blobuploader) - INFO - Done attempting. 03:18:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:03 INFO - Return code: 0 03:18:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83f5e521547f38c279229ffc5fbd60dcf247f2f986109874b4ddbed1ea441b5ec6c7405222a6b2676dab7160ded38de2d01b2178637a921a75433ae75b8777a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30893cbdf8b8fc0b5126763749ea2cd885ecd27974a1a5bc7006ac864defbe00eca939deed4e21d77abb01173637164bf47a5a9e315d6fa56f7bfe68d200cd35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cede13edd5e46f66f473dfc46a83632803bb937b2af35e51bb71357cb7565695c6f90203f3d6be8578dd9f3992a57f70968ecbcdfd843fab26ecb823006c13c"} 03:18:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:03 INFO - Contents: 03:18:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/83f5e521547f38c279229ffc5fbd60dcf247f2f986109874b4ddbed1ea441b5ec6c7405222a6b2676dab7160ded38de2d01b2178637a921a75433ae75b8777a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30893cbdf8b8fc0b5126763749ea2cd885ecd27974a1a5bc7006ac864defbe00eca939deed4e21d77abb01173637164bf47a5a9e315d6fa56f7bfe68d200cd35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cede13edd5e46f66f473dfc46a83632803bb937b2af35e51bb71357cb7565695c6f90203f3d6be8578dd9f3992a57f70968ecbcdfd843fab26ecb823006c13c"} 03:18:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:03 INFO - Copying logs to upload dir... 03:18:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.509239 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-12-29 03:18:03.793366) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:03.797330) ========= 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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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/83f5e521547f38c279229ffc5fbd60dcf247f2f986109874b4ddbed1ea441b5ec6c7405222a6b2676dab7160ded38de2d01b2178637a921a75433ae75b8777a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30893cbdf8b8fc0b5126763749ea2cd885ecd27974a1a5bc7006ac864defbe00eca939deed4e21d77abb01173637164bf47a5a9e315d6fa56f7bfe68d200cd35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cede13edd5e46f66f473dfc46a83632803bb937b2af35e51bb71357cb7565695c6f90203f3d6be8578dd9f3992a57f70968ecbcdfd843fab26ecb823006c13c"} build_url:https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/SzyL-sbPQImSl4jsyC132g/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/83f5e521547f38c279229ffc5fbd60dcf247f2f986109874b4ddbed1ea441b5ec6c7405222a6b2676dab7160ded38de2d01b2178637a921a75433ae75b8777a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30893cbdf8b8fc0b5126763749ea2cd885ecd27974a1a5bc7006ac864defbe00eca939deed4e21d77abb01173637164bf47a5a9e315d6fa56f7bfe68d200cd35", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2cede13edd5e46f66f473dfc46a83632803bb937b2af35e51bb71357cb7565695c6f90203f3d6be8578dd9f3992a57f70968ecbcdfd843fab26ecb823006c13c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:03.832349) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:03.832704) ========= 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.C4BTrIEi6j/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.ZmOJeOMHmh/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005376 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 03:18:03.882396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 03:18:03.882784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 03:18:03.883250) ========= ========= Total master_lag: 1.18 =========