builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0150 starttime: 1476464336.3 results: success (0) buildid: 20161014060236 builduid: 7478043fa8514665a2e0d751830488d6 revision: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.295422) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.296108) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.296422) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.321581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.322098) ========= 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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-14 09:58:56-- 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% 17.8M=0.001s 2016-10-14 09:58:56 (17.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090812 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.436259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.436718) ========= 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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.029965 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:56.486935) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 09:58:56.487287) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0c899672fff6ae00f5b3affbec48ee4daac35fa1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0c899672fff6ae00f5b3affbec48ee4daac35fa1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ATLA7wIzJb/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.3XHfo3gAdn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-14 09:58:56,556 truncating revision to first 12 chars 2016-10-14 09:58:56,556 Setting DEBUG logging. 2016-10-14 09:58:56,556 attempt 1/10 2016-10-14 09:58:56,556 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0c899672fff6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 09:58:58,342 unpacking tar archive at: fx-team-0c899672fff6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.019684 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-14 09:58:58.527207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:58.527560) ========= script_repo_revision: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:58.528060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:58.528329) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:58:58.544821) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-14 09:58:58.545253) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ATLA7wIzJb/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.3XHfo3gAdn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:58:58 INFO - MultiFileLogger online at 20161014 09:58:58 in /builds/slave/test 09:58:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:58:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:58:58 INFO - {'append_to_log': False, 09:58:58 INFO - 'base_work_dir': '/builds/slave/test', 09:58:58 INFO - 'blob_upload_branch': 'Fx-Team', 09:58:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:58:58 INFO - 'branch': 'Fx-Team', 09:58:58 INFO - 'buildbot_json_path': 'buildprops.json', 09:58:58 INFO - 'config_files': ('talos/mac_config.py',), 09:58:58 INFO - 'default_actions': ('clobber', 09:58:58 INFO - 'read-buildbot-config', 09:58:58 INFO - 'download-and-extract', 09:58:58 INFO - 'populate-webroot', 09:58:58 INFO - 'create-virtualenv', 09:58:58 INFO - 'install', 09:58:58 INFO - 'run-tests'), 09:58:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:58:58 INFO - 'download_minidump_stackwalk': True, 09:58:58 INFO - 'download_symbols': 'ondemand', 09:58:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:58:58 INFO - 'tooltool.py': '/tools/tooltool.py', 09:58:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:58:58 INFO - '/tools/misc-python/virtualenv.py')}, 09:58:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:58:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:58:58 INFO - 'installer_path': 'installer.exe', 09:58:58 INFO - 'log_level': 'info', 09:58:58 INFO - 'log_name': 'talos', 09:58:58 INFO - 'log_to_console': True, 09:58:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:58:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:58:58 INFO - 'opt_config_files': (), 09:58:58 INFO - 'pip_index': False, 09:58:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:58 INFO - 'cmd': ('bash', 09:58:58 INFO - '-c', 09:58:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:58 INFO - 'enabled': True, 09:58:58 INFO - 'halt_on_failure': False, 09:58:58 INFO - 'name': 'check_screen_resolution'},), 09:58:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:58:58 INFO - 'cmd': ('bash', 09:58:58 INFO - '-c', 09:58:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:58:58 INFO - 'enabled': True, 09:58:58 INFO - 'halt_on_failure': False, 09:58:58 INFO - 'name': 'check_screen_resolution'},), 09:58:58 INFO - 'run_cmd_checks_enabled': True, 09:58:58 INFO - 'sps_profile': False, 09:58:58 INFO - 'sps_profile_interval': 0, 09:58:58 INFO - 'suite': 'dromaeojs-e10s', 09:58:58 INFO - 'system_bits': '32', 09:58:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:58:58 INFO - 'title': 't-yosemite-r7-0150', 09:58:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:58:58 INFO - 'use_talos_json': True, 09:58:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:58:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:58:58 INFO - 'work_dir': 'build'} 09:58:58 INFO - [mozharness: 2016-10-14 16:58:58.745621Z] Running clobber step. 09:58:58 INFO - Running pre-action listener: _resource_record_pre_action 09:58:58 INFO - Running main action method: clobber 09:58:58 INFO - rmtree: /builds/slave/test/build 09:58:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:59:00 INFO - Running post-action listener: _resource_record_post_action 09:59:00 INFO - [mozharness: 2016-10-14 16:59:00.928947Z] Finished clobber step (success) 09:59:00 INFO - [mozharness: 2016-10-14 16:59:00.929116Z] Running read-buildbot-config step. 09:59:00 INFO - Running pre-action listener: _resource_record_pre_action 09:59:00 INFO - Running main action method: read_buildbot_config 09:59:00 INFO - Using buildbot properties: 09:59:00 INFO - { 09:59:00 INFO - "project": "", 09:59:00 INFO - "product": "firefox", 09:59:00 INFO - "script_repo_revision": "production", 09:59:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:59:00 INFO - "repository": "", 09:59:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:59:00 INFO - "buildid": "20161014060236", 09:59:00 INFO - "pgo_build": "False", 09:59:00 INFO - "basedir": "/builds/slave/test", 09:59:00 INFO - "buildnumber": 141, 09:59:00 INFO - "slavename": "t-yosemite-r7-0150", 09:59:00 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 09:59:00 INFO - "platform": "yosemite_r7", 09:59:00 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 09:59:00 INFO - "branch": "fx-team", 09:59:00 INFO - "repo_path": "integration/fx-team", 09:59:00 INFO - "revision": "0c899672fff6ae00f5b3affbec48ee4daac35fa1", 09:59:00 INFO - "stage_platform": "macosx64", 09:59:00 INFO - "builduid": "7478043fa8514665a2e0d751830488d6", 09:59:00 INFO - "slavebuilddir": "test" 09:59:00 INFO - } 09:59:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:59:00 INFO - Running post-action listener: _resource_record_post_action 09:59:00 INFO - [mozharness: 2016-10-14 16:59:00.933145Z] Finished read-buildbot-config step (success) 09:59:00 INFO - [mozharness: 2016-10-14 16:59:00.933278Z] Running download-and-extract step. 09:59:00 INFO - Running pre-action listener: _resource_record_pre_action 09:59:00 INFO - Running main action method: download_and_extract 09:59:00 INFO - mkdir: /builds/slave/test/build/tests 09:59:00 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')]} 09:59:00 INFO - trying https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:59:00 INFO - Downloading https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:59:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:59:02 INFO - Downloaded 1199 bytes. 09:59:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:59:02 INFO - Using the following test package requirements: 09:59:02 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:59:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:59:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:59:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'jsshell-mac.zip'], 09:59:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:59:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:59:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:59:02 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:59:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:59:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:59:02 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:59:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:59:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:59:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:59:02 INFO - Fetch https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:59:02 INFO - Http code: 200 09:59:02 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 09:59:02 INFO - x-amz-cf-id: e1nrf2yPXQuHE1UYk7jYgEOwhKLKMGle7tUN2V27nN4266L3qKKH0Q== 09:59:02 INFO - x-amz-version-id: 4GqmR2YMNE9vlv7DbUTmwYggMKhz_4q. 09:59:03 INFO - Expected file size: 16516955 09:59:03 INFO - Obtained file size: 16516955 09:59:09 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:59:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:59:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:59:09 INFO - Fetch https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:59:10 INFO - Http code: 200 09:59:10 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 09:59:10 INFO - x-amz-cf-id: QL09bKGrV4oqcd7iPbiTrCH907qbIDxX-Me8jfwXI8x9VU5V59kv4w== 09:59:10 INFO - x-amz-version-id: 4GqmR2YMNE9vlv7DbUTmwYggMKhz_4q. 09:59:10 INFO - Expected file size: 16516955 09:59:10 INFO - Obtained file size: 16516955 09:59:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:59:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:59:17 INFO - Fetch https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:59:17 INFO - Http code: 200 09:59:17 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 09:59:17 INFO - x-amz-cf-id: LEaj2v49SEDxrTVwI7dfTGuAdtW9Ib7vrgUnplw4hpJonFZMCv0Uxg== 09:59:17 INFO - x-amz-version-id: x3sa9RwhAgWW5TdEQNtC0pGE6TviijEx 09:59:18 INFO - Expected file size: 14409006 09:59:18 INFO - Obtained file size: 14409006 09:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:18 INFO - trying https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:59:18 INFO - Downloading https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:59:21 INFO - Downloaded 111921419 bytes. 09:59:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:59:21 INFO - mkdir: /builds/slave/test/properties 09:59:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:59:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:59:21 INFO - Contents: 09:59:21 INFO - build_url:https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:59:22 INFO - Running post-action listener: _resource_record_post_action 09:59:22 INFO - Running post-action listener: set_extra_try_arguments 09:59:22 INFO - [mozharness: 2016-10-14 16:59:22.061737Z] Finished download-and-extract step (success) 09:59:22 INFO - [mozharness: 2016-10-14 16:59:22.061856Z] Running populate-webroot step. 09:59:22 INFO - Running pre-action listener: _resource_record_pre_action 09:59:22 INFO - Running main action method: populate_webroot 09:59:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:59:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:59:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:59:22 INFO - '--tppagecycles', 09:59:22 INFO - '7'], 09:59:22 INFO - 'tests': ['tsvgm']}}, 09:59:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:59:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:59:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:59:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:59:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:59:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['damp', 'tps']}, 09:59:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'tests': ['damp', 'tps']}, 09:59:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['dromaeo_dom']}, 09:59:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:59:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['basic_compositor_video']}, 09:59:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:59:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['a11yr', 09:59:22 INFO - 'ts_paint', 09:59:22 INFO - 'tpaint', 09:59:22 INFO - 'sessionrestore', 09:59:22 INFO - 'sessionrestore_no_auto_restore', 09:59:22 INFO - 'tabpaint']}, 09:59:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:59:22 INFO - 'ts_paint', 09:59:22 INFO - 'tpaint', 09:59:22 INFO - 'sessionrestore', 09:59:22 INFO - 'sessionrestore_no_auto_restore', 09:59:22 INFO - 'tabpaint']}, 09:59:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:59:22 INFO - 'ts_paint', 09:59:22 INFO - 'tpaint', 09:59:22 INFO - 'sessionrestore', 09:59:22 INFO - 'sessionrestore_no_auto_restore', 09:59:22 INFO - 'tabpaint']}, 09:59:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:59:22 INFO - 'ts_paint', 09:59:22 INFO - 'tpaint', 09:59:22 INFO - 'sessionrestore', 09:59:22 INFO - 'sessionrestore_no_auto_restore', 09:59:22 INFO - 'tabpaint']}, 09:59:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['a11yr', 09:59:22 INFO - 'ts_paint', 09:59:22 INFO - 'tpaint', 09:59:22 INFO - 'sessionrestore', 09:59:22 INFO - 'sessionrestore_no_auto_restore', 09:59:22 INFO - 'tabpaint']}, 09:59:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['a11yr', 09:59:22 INFO - 'ts_paint', 09:59:22 INFO - 'tpaint', 09:59:22 INFO - 'sessionrestore', 09:59:22 INFO - 'sessionrestore_no_auto_restore', 09:59:22 INFO - 'tabpaint']}, 09:59:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['tsvgx', 09:59:22 INFO - 'tsvgr_opacity', 09:59:22 INFO - 'tart', 09:59:22 INFO - 'tscrollx', 09:59:22 INFO - 'cart']}, 09:59:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:59:22 INFO - 'tsvgr_opacity', 09:59:22 INFO - 'tart', 09:59:22 INFO - 'tscrollx', 09:59:22 INFO - 'cart']}, 09:59:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'talos_options': ['--disable-e10s'], 09:59:22 INFO - 'tests': ['tp5o']}, 09:59:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'tests': ['tp5o']}, 09:59:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'talos_options': ['--disable-e10s', 09:59:22 INFO - '--xperf_path', 09:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:22 INFO - 'tests': ['tp5n']}, 09:59:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:59:22 INFO - 'talos_options': ['--xperf_path', 09:59:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:59:22 INFO - 'tests': ['tp5n']}}, 09:59:22 INFO - 'talos.zip': {'path': '', 09:59:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:59:22 INFO - Running post-action listener: _resource_record_post_action 09:59:22 INFO - [mozharness: 2016-10-14 16:59:22.080586Z] Finished populate-webroot step (success) 09:59:22 INFO - [mozharness: 2016-10-14 16:59:22.080673Z] Running create-virtualenv step. 09:59:22 INFO - Running pre-action listener: _resource_record_pre_action 09:59:22 INFO - Running main action method: create_virtualenv 09:59:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:59:22 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 09:59:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:59:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:59:22 INFO - Using real prefix '/tools/python27' 09:59:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:59:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:59:25 INFO - Installing pip.................done. 09:59:25 INFO - Return code: 0 09:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:59:26 INFO - Reading from file tmpfile_stdout 09:59:26 INFO - Output received: 09:59:26 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) 09:59:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:26 INFO - 'HOME': '/Users/cltbld', 09:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:26 INFO - 'LOGNAME': 'cltbld', 09:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:26 INFO - 'MOZ_NO_REMOTE': '1', 09:59:26 INFO - 'NO_EM_RESTART': '1', 09:59:26 INFO - 'PAGER': '/bin/cat', 09:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:26 INFO - 'PWD': '/builds/slave/test', 09:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:26 INFO - 'SHELL': '/bin/bash', 09:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:26 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:26 INFO - 'USER': 'cltbld', 09:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:26 INFO - 'XPC_FLAGS': '0x0', 09:59:26 INFO - 'XPC_SERVICE_NAME': '0', 09:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:59:26 INFO - Cleaning up... 09:59:26 INFO - Return code: 0 09:59:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:26 INFO - 'HOME': '/Users/cltbld', 09:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:26 INFO - 'LOGNAME': 'cltbld', 09:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:26 INFO - 'MOZ_NO_REMOTE': '1', 09:59:26 INFO - 'NO_EM_RESTART': '1', 09:59:26 INFO - 'PAGER': '/bin/cat', 09:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:26 INFO - 'PWD': '/builds/slave/test', 09:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:26 INFO - 'SHELL': '/bin/bash', 09:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:26 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:26 INFO - 'USER': 'cltbld', 09:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:26 INFO - 'XPC_FLAGS': '0x0', 09:59:26 INFO - 'XPC_SERVICE_NAME': '0', 09:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:26 INFO - Downloading/unpacking psutil>=3.1.1 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:29 INFO - Installing collected packages: psutil 09:59:29 INFO - Running setup.py install for psutil 09:59:30 INFO - building 'psutil._psutil_osx' extension 09:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:59:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:59:30 INFO - building 'psutil._psutil_posix' extension 09:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:59:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:59:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:59:30 INFO - ^ 09:59:30 INFO - 1 warning generated. 09:59:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:59:31 INFO - Successfully installed psutil 09:59:31 INFO - Cleaning up... 09:59:31 INFO - Return code: 0 09:59:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:59:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:31 INFO - 'HOME': '/Users/cltbld', 09:59:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:31 INFO - 'LOGNAME': 'cltbld', 09:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:31 INFO - 'MOZ_NO_REMOTE': '1', 09:59:31 INFO - 'NO_EM_RESTART': '1', 09:59:31 INFO - 'PAGER': '/bin/cat', 09:59:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:31 INFO - 'PWD': '/builds/slave/test', 09:59:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:31 INFO - 'SHELL': '/bin/bash', 09:59:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:31 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:31 INFO - 'USER': 'cltbld', 09:59:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:31 INFO - 'XPC_FLAGS': '0x0', 09:59:31 INFO - 'XPC_SERVICE_NAME': '0', 09:59:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:59:34 INFO - Installing collected packages: mozsystemmonitor 09:59:34 INFO - Running setup.py install for mozsystemmonitor 09:59:34 INFO - Successfully installed mozsystemmonitor 09:59:34 INFO - Cleaning up... 09:59:34 INFO - Return code: 0 09:59:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:59:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:34 INFO - 'HOME': '/Users/cltbld', 09:59:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:34 INFO - 'LOGNAME': 'cltbld', 09:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:34 INFO - 'MOZ_NO_REMOTE': '1', 09:59:34 INFO - 'NO_EM_RESTART': '1', 09:59:34 INFO - 'PAGER': '/bin/cat', 09:59:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:34 INFO - 'PWD': '/builds/slave/test', 09:59:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:34 INFO - 'SHELL': '/bin/bash', 09:59:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:34 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:34 INFO - 'USER': 'cltbld', 09:59:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:34 INFO - 'XPC_FLAGS': '0x0', 09:59:34 INFO - 'XPC_SERVICE_NAME': '0', 09:59:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:34 INFO - Downloading/unpacking jsonschema==2.5.1 09:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:59:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59: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 09:59:37 INFO - Downloading functools32-3.2.3-2.tar.gz 09:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:59:37 INFO - warning: no files found matching '*.txt' 09:59:37 INFO - no previously-included directories found matching 'build' 09:59:37 INFO - no previously-included directories found matching 'dist' 09:59:37 INFO - no previously-included directories found matching '.git*' 09:59:37 INFO - Installing collected packages: jsonschema, functools32 09:59:37 INFO - Running setup.py install for functools32 09:59:37 INFO - warning: no files found matching '*.txt' 09:59:37 INFO - no previously-included directories found matching 'build' 09:59:37 INFO - no previously-included directories found matching 'dist' 09:59:37 INFO - no previously-included directories found matching '.git*' 09:59:37 INFO - Successfully installed jsonschema functools32 09:59:37 INFO - Cleaning up... 09:59:37 INFO - Return code: 0 09:59:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:37 INFO - 'HOME': '/Users/cltbld', 09:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:37 INFO - 'LOGNAME': 'cltbld', 09:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:37 INFO - 'MOZ_NO_REMOTE': '1', 09:59:37 INFO - 'NO_EM_RESTART': '1', 09:59:37 INFO - 'PAGER': '/bin/cat', 09:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:37 INFO - 'PWD': '/builds/slave/test', 09:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:37 INFO - 'SHELL': '/bin/bash', 09:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:37 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:37 INFO - 'USER': 'cltbld', 09:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:37 INFO - 'XPC_FLAGS': '0x0', 09:59:37 INFO - 'XPC_SERVICE_NAME': '0', 09:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:59:37 INFO - Cleaning up... 09:59:37 INFO - Return code: 0 09:59:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:37 INFO - 'HOME': '/Users/cltbld', 09:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:37 INFO - 'LOGNAME': 'cltbld', 09:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:37 INFO - 'MOZ_NO_REMOTE': '1', 09:59:37 INFO - 'NO_EM_RESTART': '1', 09:59:37 INFO - 'PAGER': '/bin/cat', 09:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:37 INFO - 'PWD': '/builds/slave/test', 09:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:37 INFO - 'SHELL': '/bin/bash', 09:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:37 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:37 INFO - 'USER': 'cltbld', 09:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:37 INFO - 'XPC_FLAGS': '0x0', 09:59:37 INFO - 'XPC_SERVICE_NAME': '0', 09:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:59:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:59:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:41 INFO - Downloading docopt-0.6.1.tar.gz 09:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:59:42 INFO - Installing collected packages: blobuploader, requests, docopt 09:59:42 INFO - Running setup.py install for blobuploader 09:59:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:59:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:59:42 INFO - Running setup.py install for requests 09:59:42 INFO - Running setup.py install for docopt 09:59:42 INFO - Successfully installed blobuploader requests docopt 09:59:42 INFO - Cleaning up... 09:59:42 INFO - Return code: 0 09:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59: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')]} 09:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59: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')]} 09:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:42 INFO - 'HOME': '/Users/cltbld', 09:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:42 INFO - 'LOGNAME': 'cltbld', 09:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:42 INFO - 'MOZ_NO_REMOTE': '1', 09:59:42 INFO - 'NO_EM_RESTART': '1', 09:59:42 INFO - 'PAGER': '/bin/cat', 09:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:42 INFO - 'PWD': '/builds/slave/test', 09:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:42 INFO - 'SHELL': '/bin/bash', 09:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:42 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:42 INFO - 'USER': 'cltbld', 09:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:42 INFO - 'XPC_FLAGS': '0x0', 09:59:42 INFO - 'XPC_SERVICE_NAME': '0', 09:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-fwxLfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_SU5Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-nCjfvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-LktjwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-VxzuOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yicrFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-HPYk4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Kv4p_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:43 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-cKoXpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-I1sPmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-lNOQfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-a7uBys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-8wGr0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-wtpAVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-O1uB6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-BcfiD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:44 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-cVhrdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:59:44 INFO - Running setup.py install for manifestparser 09:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozcrash 09:59:45 INFO - Running setup.py install for mozdebug 09:59:45 INFO - Running setup.py install for mozdevice 09:59:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozfile 09:59:45 INFO - Running setup.py install for mozhttpd 09:59:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozinfo 09:59:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:59:45 INFO - Running setup.py install for mozInstall 09:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Running setup.py install for mozleak 09:59:46 INFO - Running setup.py install for mozlog 09:59:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Running setup.py install for moznetwork 09:59:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Running setup.py install for mozprocess 09:59:46 INFO - Running setup.py install for mozprofile 09:59:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:59:46 INFO - Running setup.py install for mozrunner 09:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:59:47 INFO - Running setup.py install for mozscreenshot 09:59:47 INFO - Running setup.py install for moztest 09:59:47 INFO - Running setup.py install for mozversion 09:59:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:59:47 INFO - Cleaning up... 09:59:47 INFO - Return code: 0 09:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:47 INFO - 'HOME': '/Users/cltbld', 09:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:47 INFO - 'LOGNAME': 'cltbld', 09:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:47 INFO - 'MOZ_NO_REMOTE': '1', 09:59:47 INFO - 'NO_EM_RESTART': '1', 09:59:47 INFO - 'PAGER': '/bin/cat', 09:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:47 INFO - 'PWD': '/builds/slave/test', 09:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:47 INFO - 'SHELL': '/bin/bash', 09:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:47 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:47 INFO - 'USER': 'cltbld', 09:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:47 INFO - 'XPC_FLAGS': '0x0', 09:59:47 INFO - 'XPC_SERVICE_NAME': '0', 09:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:59:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-_8uIYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:59:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-q56JpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:59:47 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-pR2tuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-TYDZhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-m0r2we-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-tqbXu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-zyEWi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-RAb7JD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-c6a9Vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ILdwbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-nVdGIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:59:48 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-thEpJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:59:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-B6wftr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:59:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-a8I2s1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-mQUyt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:59:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-SDmPuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:59:49 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-w9ZhRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:59:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:59:52 INFO - Downloading blessings-1.6.tar.gz 09:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:59:52 INFO - Installing collected packages: blessings 09:59:52 INFO - Running setup.py install for blessings 09:59:52 INFO - Successfully installed blessings 09:59:52 INFO - Cleaning up... 09:59:52 INFO - Return code: 0 09:59:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:52 INFO - Reading from file tmpfile_stdout 09:59:52 INFO - Current package versions: 09:59:52 INFO - blessings == 1.6 09:59:52 INFO - blobuploader == 1.2.4 09:59:52 INFO - docopt == 0.6.1 09:59:52 INFO - functools32 == 3.2.3-2 09:59:52 INFO - jsonschema == 2.5.1 09:59:52 INFO - manifestparser == 1.1 09:59:52 INFO - mozInstall == 1.12 09:59:52 INFO - mozcrash == 0.17 09:59:52 INFO - mozdebug == 0.1 09:59:52 INFO - mozdevice == 0.48 09:59:52 INFO - mozfile == 1.2 09:59:52 INFO - mozhttpd == 0.7 09:59:52 INFO - mozinfo == 0.9 09:59:52 INFO - mozleak == 0.1 09:59:52 INFO - mozlog == 3.4 09:59:52 INFO - moznetwork == 0.27 09:59:52 INFO - mozprocess == 0.23 09:59:52 INFO - mozprofile == 0.28 09:59:52 INFO - mozrunner == 6.12 09:59:52 INFO - mozscreenshot == 0.1 09:59:52 INFO - mozsystemmonitor == 0.3 09:59:52 INFO - moztest == 0.7 09:59:52 INFO - mozversion == 1.4 09:59:52 INFO - psutil == 3.1.1 09:59:52 INFO - requests == 1.2.3 09:59:52 INFO - wsgiref == 0.1.2 09:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:53 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 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:53 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 09:59:53 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 09:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:53 INFO - 'HOME': '/Users/cltbld', 09:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:53 INFO - 'LOGNAME': 'cltbld', 09:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:53 INFO - 'MOZ_NO_REMOTE': '1', 09:59:53 INFO - 'NO_EM_RESTART': '1', 09:59:53 INFO - 'PAGER': '/bin/cat', 09:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:53 INFO - 'PWD': '/builds/slave/test', 09:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:53 INFO - 'SHELL': '/bin/bash', 09:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:53 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:53 INFO - 'USER': 'cltbld', 09:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:53 INFO - 'XPC_FLAGS': '0x0', 09:59:53 INFO - 'XPC_SERVICE_NAME': '0', 09:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 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)) 09:59:53 INFO - Cleaning up... 09:59:53 INFO - Return code: 0 09:59:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:54 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')]} 09:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:59:54 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 0x10fb53490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fac9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f945f340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, '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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:59:54 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 09:59:54 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 09:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 09:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:54 INFO - 'HOME': '/Users/cltbld', 09:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:54 INFO - 'LOGNAME': 'cltbld', 09:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:54 INFO - 'MOZ_NO_REMOTE': '1', 09:59:54 INFO - 'NO_EM_RESTART': '1', 09:59:54 INFO - 'PAGER': '/bin/cat', 09:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:54 INFO - 'PWD': '/builds/slave/test', 09:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:54 INFO - 'SHELL': '/bin/bash', 09:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 09:59:54 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:54 INFO - 'USER': 'cltbld', 09:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:54 INFO - 'XPC_FLAGS': '0x0', 09:59:54 INFO - 'XPC_SERVICE_NAME': '0', 09:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:59:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:59:54 INFO - Cleaning up... 09:59:54 INFO - Return code: 0 09:59:54 INFO - Running post-action listener: _resource_record_post_action 09:59:54 INFO - Running post-action listener: _start_resource_monitoring 09:59:54 INFO - Starting resource monitoring. 09:59:54 INFO - [mozharness: 2016-10-14 16:59:54.834012Z] Finished create-virtualenv step (success) 09:59:54 INFO - [mozharness: 2016-10-14 16:59:54.834993Z] Running install step. 09:59:54 INFO - Running pre-action listener: _resource_record_pre_action 09:59:54 INFO - Running main action method: install 09:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:59:55 INFO - Reading from file tmpfile_stdout 09:59:55 INFO - Detecting whether we're running mozinstall >=1.0... 09:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:59:55 INFO - Reading from file tmpfile_stdout 09:59:55 INFO - Output received: 09:59:55 INFO - Usage: mozinstall [options] installer 09:59:55 INFO - Options: 09:59:55 INFO - -h, --help show this help message and exit 09:59:55 INFO - -d DEST, --destination=DEST 09:59:55 INFO - Directory to install application into. [default: 09:59:55 INFO - "/builds/slave/test"] 09:59:55 INFO - --app=APP Application being installed. [default: firefox] 09:59:55 INFO - mkdir: /builds/slave/test/build/application 09:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:00:29 INFO - Reading from file tmpfile_stdout 10:00:29 INFO - Output received: 10:00:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:00:29 INFO - Running post-action listener: _resource_record_post_action 10:00:29 INFO - [mozharness: 2016-10-14 17:00:29.154208Z] Finished install step (success) 10:00:29 INFO - [mozharness: 2016-10-14 17:00:29.154349Z] Running run-tests step. 10:00:29 INFO - Running pre-action listener: _resource_record_pre_action 10:00:29 INFO - Running main action method: run_tests 10:00:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:00:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:00:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:00:29 INFO - 2016-10-14 10:00:29.168 screenresolution[1637:7507] starting screenresolution argv=screenresolution get 10:00:29 INFO - 2016-10-14 10:00:29.171 screenresolution[1637:7507] Display 0: 1600x1200x32@60 10:00:29 INFO - 2016-10-14 10:00:29.177 screenresolution[1638:7509] starting screenresolution argv=screenresolution list 10:00:29 INFO - Available Modes on Display 0 10:00:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:00:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:00:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:00:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:00:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:00:29 INFO - Intel Iris: 10:00:29 INFO - Chipset Model: Intel Iris 10:00:29 INFO - Type: GPU 10:00:29 INFO - Bus: Built-In 10:00:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:00:29 INFO - Vendor: Intel (0x8086) 10:00:29 INFO - Device ID: 0x0a2e 10:00:29 INFO - Revision ID: 0x0009 10:00:29 INFO - Displays: 10:00:29 INFO - Display: 10:00:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:00:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:00:29 INFO - Display Serial Number: 1600x1200 60 10:00:29 INFO - Main Display: Yes 10:00:29 INFO - Mirror: Off 10:00:29 INFO - Online: Yes 10:00:29 INFO - Rotation: Supported 10:00:29 INFO - Return code: 0 10:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:00:29 INFO - Python 2.7.3 10:00:29 INFO - Return code: 0 10:00:29 INFO - grabbing minidump binary from tooltool 10:00: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')]} 10:00:29 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 0x10f967d30>, '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 0x10f78ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f95fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:00:29 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 10:00:29 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 10:00:29 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 10:00:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:00:29 INFO - Return code: 0 10:00:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:00:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:00:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:00:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:00:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:00:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 10:00:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --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 10:00:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ATLA7wIzJb/Render', 10:00:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:00:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:00:29 INFO - 'HOME': '/Users/cltbld', 10:00:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:00:29 INFO - 'LOGNAME': 'cltbld', 10:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:29 INFO - 'MOZ_NO_REMOTE': '1', 10:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:00:29 INFO - 'NO_EM_RESTART': '1', 10:00:29 INFO - 'PAGER': '/bin/cat', 10:00:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:29 INFO - 'PWD': '/builds/slave/test', 10:00:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:00:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:00:29 INFO - 'SHELL': '/bin/bash', 10:00:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3XHfo3gAdn/Listeners', 10:00:29 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 10:00:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:00:29 INFO - 'USER': 'cltbld', 10:00:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:00:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:29 INFO - 'XPC_FLAGS': '0x0', 10:00:29 INFO - 'XPC_SERVICE_NAME': '0', 10:00:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:00:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--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 10:00:29 INFO - mozversion application_buildid: 20161014060236 10:00:29 INFO - mozversion application_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 10:00:29 INFO - mozversion application_display_name: Nightly 10:00:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:00:29 INFO - mozversion application_name: Firefox 10:00:29 INFO - mozversion application_remotingname: firefox 10:00:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:00:29 INFO - mozversion application_vendor: Mozilla 10:00:29 INFO - mozversion application_version: 52.0a1 10:00:29 INFO - mozversion platform_buildid: 20161014060236 10:00:29 INFO - mozversion platform_changeset: 0c899672fff6ae00f5b3affbec48ee4daac35fa1 10:00:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:00:29 INFO - mozversion platform_version: 52.0a1 10:00:29 INFO - using testdate: 1476464429 10:00:29 INFO - actual date: 1476464429 10:00:29 INFO - starting webserver on 'localhost:49268' 10:00:29 INFO - SUITE-START | Running 2 tests 10:00:29 INFO - TEST-START | dromaeo_css 10:00:29 INFO - operating with platform_type : mac_ 10:00:29 INFO - Initialising browser for dromaeo_css test... 10:00:29 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpnq4DDu/profile http://localhost:49268/getInfo.html) 10:00:32 INFO - PROCESS | 1648 | 2016-10-14 10:00:32.673 plugin-container[1650:7678] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 10:00:32 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:00:32 INFO - PROCESS | 1648 | 2016-10-14 10:00:32.675 plugin-container[1650:7678] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 10:00:32 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:00:32 INFO - PROCESS | 1648 | 2016-10-14 10:00:32.676 plugin-container[1650:7678] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:00:32 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:00:32 INFO - PROCESS | 1648 | colorDepth:24 10:00:32 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:00:32 INFO - PROCESS | 1648 | __metrics 10:00:32 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 10:00:33 INFO - TEST-INFO | 1648: exit 0 10:00:33 INFO - Browser initialized. 10:00:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:00:33 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpnq4DDu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:00:35 INFO - PROCESS | 1651 | 2016-10-14 10:00:35.825 plugin-container[1652:7797] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x463b, name = 'com.apple.tsm.portname' 10:00:35 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:00:35 INFO - PROCESS | 1651 | 2016-10-14 10:00:35.825 plugin-container[1652:7797] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 10:00:35 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:00:35 INFO - PROCESS | 1651 | 2016-10-14 10:00:35.825 plugin-container[1652:7797] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:00:45 INFO - PROCESS | 1651 | RSS: Main: 237391872 10:00:45 INFO - PROCESS | 1651 | 10:01:35 INFO - PROCESS | 1651 | 1476464495188 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] 10:03:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49268/tests/dromaeo/cssquery-ext.html) 10:03:50 INFO - PROCESS | 1651 | RSS: Main: 250408960 10:03:50 INFO - PROCESS | 1651 | 10:06:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-ext.html (next: http://localhost:49268/tests/dromaeo/cssquery-jquery.html) 10:06:53 INFO - PROCESS | 1651 | RSS: Main: 262651904 10:06:53 INFO - PROCESS | 1651 | 10:09:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49268/tests/dromaeo/cssquery-mootools.html) 10:09:55 INFO - PROCESS | 1651 | RSS: Main: 268419072 10:09:55 INFO - PROCESS | 1651 | 10:12:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49268/tests/dromaeo/cssquery-prototype.html) 10:12:58 INFO - PROCESS | 1651 | RSS: Main: 268206080 10:12:58 INFO - PROCESS | 1651 | 10:16:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49268/tests/dromaeo/cssquery-yui.html) 10:16:01 INFO - PROCESS | 1651 | RSS: Main: 273600512 10:16:01 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49268/tests/dromaeo/cssquery-yui.html (next: http://localhost:49268/tests/dromaeo/cssquery-dojo.html) 10:19:04 INFO - PROCESS | 1651 | RSS: Main: 275996672 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | __start_tp_report 10:19:04 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 10:19:04 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 10:19:04 INFO - PROCESS | 1651 | |i|pagename|runs| 10:19:04 INFO - PROCESS | 1651 | |0;dojo.html;2783.902563410281;3371.2246183377824;3398.8130652814084;3404.710599599034;3405.2338223899624;4251.914961700764;5273.077211487994;5647.265855438787;5669.63147395419;5678.772849086036;4687.929681054787;5654.123610840316;5657.23627310313;5676.403977582357;5758.049921762915;5170.819021334254;5204.245384419257;5254.632175747699;5277.261183434322;5285.867853303679;5214.374275086976;5303.946960530403;5314.362276526822;5350.5184533391985;5397.62216644835;5136.434992150897;5173.948260517384;5308.044551980642;5310.62825602208;5341;5151.6136289778415;5170.431252562215;5282.418933917266;5312.468753124656;5333.040052790496;5142.61430392722;5169.922451163236;5189.766460509286;5192.4547922468355;5283.101872681654;5431.456854314537;5539.113741801333;5673.801416950387;5716.428357164292;5746.942530574683;6058;6065.302490213638;6120.53855959212;6150.231221097363;6211.068339749074;6258.34287399821;6273.309935907047;6273.905891411632;6276.748930042792;6311.305756366796;4832.661713680044;5778.56660750437;5780.988327042751;5787.479126878559;5791.507721843606;6166.290876549254;6190.3190649028575;6206.968965155235;6214.471769899609;6225.097360882737;6115.724792384353;6122.1542093545395;6122.204113465221;6128.816135515942;6145.416185462464;5993.4905533029305;6198.411150940653;6216.5391133083685;6266.686665666698;6279.654618995908;5769.8557536061935;6018.789342372996;6107.328193898667;6160.199174107337;6212.596181248205;6185.505159587312;6197.318294987548;6222.844428889223;6238.376162383725;6282.151909492251;4906.288588154769;4945.282933974553;4955.40535135786;4955.752212389366;4979.526944940225;4323.437953066082;4338.891527711832;4388.341748737715;4406.633943477532;4443.37792709021;5745.540356771448;5769;5772.884542309131;5784.363719990798;5803.216565763652;6247.937520624827;6262.718177682015;6268.310485846553;6277.2781130170615;6279;4741.810327586858;5638.436156384329;5668.943310566841;5701.686407247641;5775.537956963432;5329.866753331198;5337.146056630921;5356.276902618097;5359.464053594687;5378.381486129145;6241.407066328691;6256.374362563798;6266.154069200691;6287.371262873676;6376.489880809524;6110.602810817282;6129.419919118862;6139.877202456015;6203.782867599793;6217.502599791916;5353.678779273256;6047.153398524122;6285.59143655661;6304.117423560613;6307.96846015767;4873.4882837301575;5015.523525265094;5229.529342359206;5232.7645255964335;5602.635828671123;6099.786507472217;6128.264608247039;6264.812055638338;6267;6307.180066591313;5177.223416487557;6051.33435322123;6072.635641861502;6139.403755023815;6151.738893526726;4771.95228047715;6086.1175129606845;6138.478229350377;6149.354317796746;6176.783812566496;5559.416261292506;5721.370649228665;5871.530277577698;5942.494887934401;5997.280326360865;6125.499252683121;6132.386761323832;6148.231471066117;6158.353372895782;6167.814965551041;5993.580449368503;5998.220231370068;6047.455728984412;6051.788187413419;6061.605995610271 10:19:04 INFO - PROCESS | 1651 | |1;ext.html;469.57738035767824;473.7938996536506;532.8268312798339;533.565144407308;557.8884223155368;38416.615833841686;40260.39609405861;40320.79839600802;40356;40484.79757601212;41163;41686.58313416865;41747.16505669885;41922;41939.79030104853;9486.098820612047;9639.855402168972;9657;9669.419834809934;9705.320627556073;9233.584488698025;9543.713688589354;9639.325247232697;9647.035296470367;9653.806923861519;9636.132748052674;9678.903210967906;9685.757856053584;9703.951480242624;9732.221422286235;9579.904200958006;9647.469389183592;9650.131488166064;9670.419774813534;9698.854517182248;8003.639836207385;9425.575849086808;9483.952580237055;9524.14282714552;9579.323618366827;39774.00564985869;40097.79951100255;40183.19633607341;40240.19519609591;40485.39271910924;3268.3953468608383;3392.3384939936477;3911.550171730259;4141.855035073758;4247.702660813744;30008.399832003455;30572.8471357644;31330.53004204916;31358.843205784055;31382.686173138205;3171.444997125494;3292.917677058069;3300.389427955836;3349.0455220262106;3353.178471274529;474352;477666;485013;485497;486956;57301.567460813814;57577.712111440014;57632;57658;57718.422815772145;59954;60138.39861601416;60167.699161503915;60220;60314;14928.02967807089;15686.529404117895;15760.896737228284;15937.681246375008;15938;12438;12524.937375313066;12570.308633025088;12576.74846503083;12623.431945562472;11916.404179790976;14649.707005859824;14744;15140.772888406682;15248.618784530476;4875.871134148417;5194.182276027117;6059.272887253558;6115.541334399938;6166.4758495527485;845.8054647431002;916.7937214126769;925.2967744514083;982.7444864335324;1028.830243009895;29100.563491547644;29590.852045739633;29621.407571848442;30255.848720756254;30324.54513182304;989.1839232633107;1078.099786678117;1093.812375249501;1114.2757207814984;1147.7474955509774;12932.547360842513;15422.305996230196;15495.922520387327;15500;16159.030458172312;170707;172271;172575;172609;173272;57131;57305.42694573084;57391.42608573944;57480;57529.712351438815;1294.3140135728079;1335.1588499245606;1366.7881478370869;1368.6852024034329;1372.945082196701;28081.43837123287;29692.55461168041;29799.510024498253;30326.545101823933;30342.696573033987;46966.53033469622;48474.03051939012;49014;49073.018539629724;49199.50800492092;565780;567275;567290;567615;568216;30901.536476952413;31914.840425797724;39644.008899777735;39664.40503392394;39764.60235397725;45945.54054459546;46013.309800353694;46014.769926150155;47251.05497890092;47380;38523.807380964034;38948.02629934161;39091.14817222263;39453.605463944994;39960;37669.81165094157;37805.86582402532;38016.47934082606;38741.41887871628;38948.80525597354;37144.6285537152;38154.80922595481;38193.80903095467;38341;40062.79968600138;31046;34705.87648109855;34753.65246347504;34798.65201347954;37131;25181.87409062943;25334.239972800846;25543.105991290216;25697.486050278516;25785.871070644527 10:19:04 INFO - PROCESS | 1651 | |2;jquery.html;354.1323756795849;364.56434560699955;366.41556717036326;371.0760207084361;390.05800990607685;19252.518687032814;20040.69938950917;20542.38372848817;20765.584688306226;20930.895345523288;19566.413007609757;19840.603187936267;20143.19427222909;20318.390448286536;20353.694694579593;4734.621230301585;5651.06757385031;5951.464368206861;5965.850853728648;6513.674316284167;6513;6604.57070290432;6613.702383392735;6618.172728408949;6626.469882409396;5643.209950606918;5997.430244126823;6026.276846778371;6089.665068421235;6520.902186467207;5983.461488466037;6024.48791852693;6043.667598282114;6068.757249710006;6229.2836323822885;4597.586217240431;5171.844844654629;5704.344000439961;5768.336641286264;5774.787294668125;10560.630377936812;12817.423215955305;19386.4184074478;23688.881555592285;23866.880665596735;2004.3686238834866;2084.5622419291967;2108.325335892515;2127.361791462555;2180.1279488204686;9605.759856003586;9960.302778805486;10001.749956251078;12632.368381580884;14394.712105757826;1751.903645299508;1848.186797808973;1911.961760764777;1940.8738432001874;1944.1251436853331;100579.49710251403;102890.48554757253;104663;105301.94698053075;105920.05599580062;10087.546060427298;10614.840777388345;11140.888591114148;11175;11360.375179365048;13990.230537320342;14000.789988150185;14024.929875350557;14037.78943315851;14039;7940.1265860755275;8121.984751906011;8180.222878826502;8200.179982001871;8328.875066874001;7933.087694915043;8041.477303975223;8049;8088.595570221465;8240.381971352173;4117.258893399157;4338.761368124783;4360.520342762294;4375.453068366454;4446.822127114944;1705.744138379253;1880.2291060665061;1908.3606991657673;1927.575933294673;1933.5456167800837;849.7833052571679;882.7572417585216;906.3700727994112;935.1490143968956;960.4333443268505;19420.61158776845;19860.60278794416;19963.60072798536;20197.798022019593;20501.794982050287;898.2454738020094;937.2736129499692;946.2477330522252;955.8614000969959;961.6297725375641;10174.236932230113;10620.89379106199;10660.733481663021;10732.731681707864;10794;476301;551279;566656;578599;580449;119492;123849.76150238383;125134;125287;128780;953.3469573342283;957.30595318395;974.2741657465092;986.1913231150388;988.7972965542046;18204.271829126686;18298.817011830244;18334.266629335212;18343.35798247055;18370.989595572373;41623.1675366497;49036.01927961492;51429.971400572525;51485.7425712884;52310.73844630752;74914.25085749073;75240.62379688067;78865;79802;80040;7425.740099096506;7541.321281084509;7667.961660191663;7724;7781.221877812173;10436.739081522719;11557.479913404086;11756.70608234801;12108.757824843278;12234.204776689487;10116.59533618647;10217.029382208679;10413.687589372332;10433.21750868703;10535.736606584896;9801.313908026656;10179.541920613738;10199.38803671782;10401.323913945569;10455.738606534898;8286.378521611025;8415.789605259917;10423.322484038514;10519.474026298807;10596.841047384141;6458.1281526995135;6868.210155831944;7364.705411783683;7567.205443428361;7628.656710448154;8686.133575919805;9788.657396991071;10179.134773544332;10415.635452759117;10444.321119127233 10:19:04 INFO - PROCESS | 1651 | |3;mootools.html;1450.9347079381428;1500.9174495402751;1740.7475915992181;1854.805245449227;1891.489297889569;7865.213478652132;8162.836743265131;8484.490930544172;8881.200691937733;8894.644214231423;8342.874856877137;8640;8668.91331086689;8700.303975681945;8727.432716873398;1960.735300734404;2286.622707253305;2331.0559223514506;2332.521833024226;2344.871032093234;2288.7139107611547;2306.3426923326856;2345.651250530943;2348.236823032513;2348.8473249238746;1930.5077205312696;2307.169419009164;2317.965230521535;2329.8369114162015;2345.3198572414067;1801.9639607207848;1907.6280125375558;1910.8184722451344;1914.664933636608;1975.9703604445945;2030.801826922123;2237.9216727414464;2285.405794493427;2311.15642790382;2325.5348930214027;8742.737717868475;8792.956035219848;8800.515971621558;8831.161039701217;8845.29237660992;4524.185646583614;5127.077126117298;5306.442823503515;5320.467953204688;5323.148296272617;3394.6435624259593;3461.4115600348;3615;3622.0582648511577;3631.638135699113;850.2942557677175;986.5264672956949;1047.2093569355163;1051.800157969991;1058.629479682105;9610.51947402627;10470;11549.249298795552;11640.010599099087;11654.417279136009;3751.3810221313724;4510.857342762161;4632.745199014019;4691.7184968901975;4704.835330763407;8298.585070746438;9767.681363016043;9835.950820245853;9838.36050656705;9876.308658393988;4482.910341793146;5201.271821944931;5243.737813109329;5259.0796610593;5282.286891269629;3761.605031471711;4146.4402305688345;4295.806688699016;4677.713628752121;4755.524447555217;3345.631980482145;3488.773229740059;3793.260314238752;3853.653171214548;3991.0820511281986;979.6571200080058;1033.4729288062993;1212.6847019774923;1218.7562487502535;1219.7865373559591;818.4843548564367;831.9209675080857;843.6541018182515;846.703653721205;945.4799860077068;5550.361708403505;5900.20347253124;5945.970270148621;6011.008183649649;6018.7291571878495;807.6325272001226;875.9474431534128;942.3168203052869;968.6319198704447;999.895011023832;3654.470101835219;3688.6680198782237;3848.7113466490127;3867.284552357823;3975.105601239698;10398.220133490018;10802.72993175177;10821.18841086906;10823.458827058615;10835.404052777172;10527.315724477885;10632.202584806171;10694.465276736131;10777.676669699922;10779.838302425469;7751.689932402754;8054.154313796967;8056.476329038594;8071.475354102082;8072.717454889051;5207.609429292894;5509.705219273547;5627.577931655224;5710.685912274865;5768.769249229984;9378.109079637423;9559.330846840654;9689.176420004378;9698.981606931171;9718.659846905324;9382.29632777558;9757.219422446045;9762.316637835283;9768.804623907625;9791.755206119904;6882.380585747307;7153.961121080467;7267.963660181666;7446.590437525988;7603.467757256939;8153.306968907709;8400.28597569189;8445.113263107285;8445.577721113797;8446.83106337882;7335.926640733738;7450;7477.327040566375;7572.734954276574;7575;7187.065681461377;7237.312455316736;7289.781306560812;7368.300011498899;7395.445341599294;6833.3166683331265;6841.965790171017;6905.89641155373;6911.619860907698;6924.3421874921805;4872.269159626085;4922.975385123194;4946.629002824874;4990.950090499194;5016.849494515171;4878.438979517259;4890.510948905081;4993.900121997613;5031.7735701894235;5125.692458452505 10:19:04 INFO - PROCESS | 1651 | |4;prototype.html;237.60913297625405;285.9285178705325;303.558322640558;305.57982773686183;306.6736365220422;4529.818807247706;5301.151815709487;5379.547522169012;5413.242146099545;5449.99175152597;5108.544064941492;5361.356637203531;5412.810551630694;5426.403095659474;5439.401665816757;3396.269801992571;3442.569678790151;3455.6544345565494;4149.564295748948;4153.356229784388;3635.291118231946;3983.3228351180223;4137.834486620547;4144.730592511477;4147.21202971436;3380.5943286805496;3593.82030898454;4059.7564146151326;4079.1841631673637;4147.4815648044;3997.020729921159;4092.3043082676018;4104.024582177927;4123.3196522573735;4137.358709400048;3019.3206528531123;3316.9834150829333;3517.032815975602;3531.858725650971;3594.6944509716704;5221.2951251580935;5227.712475813829;5248.6588371755715;5276;5311.336082989626;3869.187470631171;3892.824822882977;4645.372874661911;4647.535246475325;4677.672562920597;4498.685092043558;5393.649412788156;5684.664103935572;5686.947914635805;5694.402087780765;2907.5057240269207;3636.254567813592;3790.7156963227867;3898.4152377143373;3934.567197608261;5204.297419848348;5997.460228579449;6031.487323577458;6063.272407311107;6090.543209259324;3808.7143464240294;3820.7707537547835;3898.2593307272095;3902.843886244518;3913.7064720146104;3934.7442416243425;3946.2502124596235;3955.1891862168186;3965.7818819965178;3998.7600743955454;3932.901677458029;4191.2874811281545;4248.171606536757;4582.358469814229;4620.768961551977;4459.487158976694;4687.851476388239;4845.6123510119105;5792.681402522818;5852.736626851802;1185.0105162189668;1256.3466997161609;1306.6994591244068;1350.4598160735588;1354.539456584766;764.3388468974408;778.9912063877292;803.3492870774575;825.2902503846688;827.2637352756052;3913.6477717005037;4555.72665640056;4563.722157795823;4566.036604260134;4642.930356044662;4015.4980627421573;4143;4168.7290326128705;4423.469183697976;4823.469418364048;3681.5214022177483;3706.9073273167846;3863.47392779856;4082.632563069338;4584.358189853423;2190.671399290119;2254.864708117518;2328.4411741181993;2572.3954870605394;2586.0948667966063;4450.465944086665;5067.265246539231;5095.821646242363;5098.694078355311;5133.948660513347;3874.7481413708583;4718.985418135048;5061.506855477643;5076.562835446015;5134.640575159778;4007.8797636070963;4363.345498175299;4592.931106033412;4938.8765280868265;5142.814303920743;4554.157480866051;4699.942512934563;4748.691335063209;4848.442429120696;4942.4316203637045;4027.8993025174605;4491.71985983993;4939.086269040239;4966.006798640215;4977.527134922177;4335.144638005454;4371;4769.639028680686;5136.6147538935475;5208.244804503402;2905.651321841308;3380.814055226986;3500.212452198337;3525.5945566260207;3692.243090166563;5793.594448388572;5909.409059094056;5909.699866029467;5910.261217347832;5932.288125424977;4863;5014.52362025607;5637.420238148723;5670.404607516316;5732.127691462224;4301.2257793597455;4729.739864307496;4997.625178111583;5630.0576301176025;5697.062998580503;5543.334799824047;5561.4716601922755;5580.804671836466;5585.218069470358;5589.888202235851;4488;4863.4650188479945;5214.366744793855;5409.83770486886;5675.517581005495;4994.675346102492;5166.767495462788;5443.237946687546;5502.532284755841;5528.668279903219 10:19:04 INFO - PROCESS | 1651 | |5;yui.html;682.3926705232341;711.9359257666808;736.2784471218206;803.5821372886098;817.5565799877663;15655.53033408998;16025.358985640574;16358.672826543461;16363.100029498373;16378.935369200994;11307.925747054038;13238.404271807767;14757.631059223524;14834.961552691317;14951.775723364131;869.6130222051174;891.4517571693394;891.7012800711736;892.4600616626944;895.3016647015338;883.8409086364452;886;891.7636826241052;893.1738142218454;895.7178488776015;936.2837429366506;939.7979434421597;943.8584212368131;945.0643862576069;946.186279799372;926.3700683535193;927.5084205371164;931.2549960031947;935.6725146198844;937.2782957123011;700.1528150937372;700.3591713582066;703.4583370804503;703.4794252253347;704.232386698501;13557.118787278796;13591.86408135916;13595.728085438235;13613.727725445435;13647.181169129884;12185.87814121865;12591.37043147848;12606.621801345975;12683.175593586388;13294.86705132946;12689.809652855121;12707.809382859265;12948.805767913489;13471.797923031163;13603.523876664369;4417.504935134654;4507.639388848885;4512.819487220508;4539.114872599845;4723.220668589679;116125;118741;119805;120277;121021;8916.866247006301;10654.147668186526;10720.46397680113;10768.56925722978;11277.154213433862;20534.486637834172;20653.690194647093;20771.58456830855;20869.68695469569;21048;7430;7656.157822639617;7691.693450182655;7784.06712773809;7895.894574759538;4378.124375124988;4382.517923028464;4408.382826404306;4408.823647054082;4418.226810308183;3349.547811045478;3407.2844702612233;3422.6577342265573;3451.3960056989927;3464.7574669772875;663.5255792108666;672.8586996730644;675.746595026865;681.9829504262334;682.3483573187594;525.1282870435059;583.7198144890476;603.6921170203141;611.6513587255222;621.1149112514648;8434.451760635538;8693.347998900108;8839.911600883908;8927.24118449939;9020.368574199743;578.2425023219596;593.9316978547436;611.1627070912789;619.662284055191;648.2998361769278;4287.121140166259;4293.742375457483;4355.651547876162;4553.795079221443;4592.2193227151465;140345;144612;150136;156821;158205;99931;105383;128122;137364;140619;71557;98363;107434.46282768536;111515;114045.4297728506;8684.565771711515;9500.42997420157;9520.52397380142;9732.854007190039;9827.31208815376;62589;63043.739125218155;64025.719485610956;64429.67785161044;66341;79494.20505794868;83973;85684.85890846569;86360;89227;9991.900080999098;11947.940260298643;12298;12829.93585032069;13504.729905402033;14429.639259018608;14574.534998652372;14854.702905942037;14874.776878346616;14900.105993640416;12973.610791676265;13112.934435327763;13234.933825330812;13623.455061797813;13820.756131948174;11876.821847672465;13635.86364136346;13756.65608359799;13976.930115349765;14014;12886.226826390446;13515.729685406433;13518.729625407634;13529.526466573623;13684.042117051711;9369.672061477815;11272.887271127513;11466.082713383075;11741.180117081865;11800.350980696145;10038.146757525692;10275.229357798045;10467.633632822815;11202.32786032808;11308.886911130783 10:19:04 INFO - PROCESS | 1651 | __end_tp_report 10:19:04 INFO - PROCESS | 1651 | __start_cc_report 10:19:04 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,363 10:19:04 INFO - PROCESS | 1651 | __end_cc_report 10:19:04 INFO - PROCESS | 1651 | __startTimestamp1476465544545__endTimestamp 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | ------- Summary: start ------- 10:19:04 INFO - PROCESS | 1651 | Number of tests: 6 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5655.98 Median:5784.36 stddev:667.39 (11.5%) stddev-sans-first:630.26 10:19:04 INFO - PROCESS | 1651 | Values: 2783.9 3371.2 3398.8 3404.7 3405.2 4251.9 5273.1 5647.3 5669.6 5678.8 4687.9 5654.1 5657.2 5676.4 5758.0 5170.8 5204.2 5254.6 5277.3 5285.9 5214.4 5303.9 5314.4 5350.5 5397.6 5136.4 5173.9 5308.0 5310.6 5341.0 5151.6 5170.4 5282.4 5312.5 5333.0 5142.6 5169.9 5189.8 5192.5 5283.1 5431.5 5539.1 5673.8 5716.4 5746.9 6058.0 6065.3 6120.5 6150.2 6211.1 6258.3 6273.3 6273.9 6276.7 6311.3 4832.7 5778.6 5781.0 5787.5 5791.5 6166.3 6190.3 6207.0 6214.5 6225.1 6115.7 6122.2 6122.2 6128.8 6145.4 5993.5 6198.4 6216.5 6266.7 6279.7 5769.9 6018.8 6107.3 6160.2 6212.6 6185.5 6197.3 6222.8 6238.4 6282.2 4906.3 4945.3 4955.4 4955.8 4979.5 4323.4 4338.9 4388.3 4406.6 4443.4 5745.5 5769.0 5772.9 5784.4 5803.2 6247.9 6262.7 6268.3 6277.3 6279.0 4741.8 5638.4 5668.9 5701.7 5775.5 5329.9 5337.1 5356.3 5359.5 5378.4 6241.4 6256.4 6266.2 6287.4 6376.5 6110.6 6129.4 6139.9 6203.8 6217.5 5353.7 6047.2 6285.6 6304.1 6308.0 4873.5 5015.5 5229.5 5232.8 5602.6 6099.8 6128.3 6264.8 6267.0 6307.2 5177.2 6051.3 6072.6 6139.4 6151.7 4772.0 6086.1 6138.5 6149.4 6176.8 5559.4 5721.4 5871.5 5942.5 5997.3 6125.5 6132.4 6148.2 6158.4 6167.8 5993.6 5998.2 6047.5 6051.8 6061.6 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:56609.85 Median:40140.50 stddev:118150.80 (294.3%) stddev-sans-first:118407.05 10:19:04 INFO - PROCESS | 1651 | Values: 469.6 473.8 532.8 533.6 557.9 38416.6 40260.4 40320.8 40356.0 40484.8 41163.0 41686.6 41747.2 41922.0 41939.8 9486.1 9639.9 9657.0 9669.4 9705.3 9233.6 9543.7 9639.3 9647.0 9653.8 9636.1 9678.9 9685.8 9704.0 9732.2 9579.9 9647.5 9650.1 9670.4 9698.9 8003.6 9425.6 9484.0 9524.1 9579.3 39774.0 40097.8 40183.2 40240.2 40485.4 3268.4 3392.3 3911.6 4141.9 4247.7 30008.4 30572.8 31330.5 31358.8 31382.7 3171.4 3292.9 3300.4 3349.0 3353.2 474352.0 477666.0 485013.0 485497.0 486956.0 57301.6 57577.7 57632.0 57658.0 57718.4 59954.0 60138.4 60167.7 60220.0 60314.0 14928.0 15686.5 15760.9 15937.7 15938.0 12438.0 12524.9 12570.3 12576.7 12623.4 11916.4 14649.7 14744.0 15140.8 15248.6 4875.9 5194.2 6059.3 6115.5 6166.5 845.8 916.8 925.3 982.7 1028.8 29100.6 29590.9 29621.4 30255.8 30324.5 989.2 1078.1 1093.8 1114.3 1147.7 12932.5 15422.3 15495.9 15500.0 16159.0 170707.0 172271.0 172575.0 172609.0 173272.0 57131.0 57305.4 57391.4 57480.0 57529.7 1294.3 1335.2 1366.8 1368.7 1372.9 28081.4 29692.6 29799.5 30326.5 30342.7 46966.5 48474.0 49014.0 49073.0 49199.5 565780.0 567275.0 567290.0 567615.0 568216.0 30901.5 31914.8 39644.0 39664.4 39764.6 45945.5 46013.3 46014.8 47251.1 47380.0 38523.8 38948.0 39091.1 39453.6 39960.0 37669.8 37805.9 38016.5 38741.4 38948.8 37144.6 38154.8 38193.8 38341.0 40062.8 31046.0 34705.9 34753.7 34798.7 37131.0 25181.9 25334.2 25543.1 25697.5 25785.9 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:32653.20 Median:368.75 stddev:92237.85 (25013.9%) stddev-sans-first:92464.72 10:19:04 INFO - PROCESS | 1651 | Values: 354.1 364.6 366.4 371.1 390.1 19252.5 20040.7 20542.4 20765.6 20930.9 19566.4 19840.6 20143.2 20318.4 20353.7 4734.6 5651.1 5951.5 5965.9 6513.7 6513.0 6604.6 6613.7 6618.2 6626.5 5643.2 5997.4 6026.3 6089.7 6520.9 5983.5 6024.5 6043.7 6068.8 6229.3 4597.6 5171.8 5704.3 5768.3 5774.8 10560.6 12817.4 19386.4 23688.9 23866.9 2004.4 2084.6 2108.3 2127.4 2180.1 9605.8 9960.3 10001.7 12632.4 14394.7 1751.9 1848.2 1912.0 1940.9 1944.1 100579.5 102890.5 104663.0 105301.9 105920.1 10087.5 10614.8 11140.9 11175.0 11360.4 13990.2 14000.8 14024.9 14037.8 14039.0 7940.1 8122.0 8180.2 8200.2 8328.9 7933.1 8041.5 8049.0 8088.6 8240.4 4117.3 4338.8 4360.5 4375.5 4446.8 1705.7 1880.2 1908.4 1927.6 1933.5 849.8 882.8 906.4 935.1 960.4 19420.6 19860.6 19963.6 20197.8 20501.8 898.2 937.3 946.2 955.9 961.6 10174.2 10620.9 10660.7 10732.7 10794.0 476301.0 551279.0 566656.0 578599.0 580449.0 119492.0 123849.8 125134.0 125287.0 128780.0 953.3 957.3 974.3 986.2 988.8 18204.3 18298.8 18334.3 18343.4 18371.0 41623.2 49036.0 51430.0 51485.7 52310.7 74914.3 75240.6 78865.0 79802.0 80040.0 7425.7 7541.3 7668.0 7724.0 7781.2 10436.7 11557.5 11756.7 12108.8 12234.2 10116.6 10217.0 10413.7 10433.2 10535.7 9801.3 10179.5 10199.4 10401.3 10455.7 8286.4 8415.8 10423.3 10519.5 10596.8 6458.1 6868.2 7364.7 7567.2 7628.7 8686.1 9788.7 10179.1 10415.6 10444.3 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5566.86 Median:5225.67 stddev:3161.08 (60.5%) stddev-sans-first:3154.82 10:19:04 INFO - PROCESS | 1651 | Values: 1450.9 1500.9 1740.7 1854.8 1891.5 7865.2 8162.8 8484.5 8881.2 8894.6 8342.9 8640.0 8668.9 8700.3 8727.4 1960.7 2286.6 2331.1 2332.5 2344.9 2288.7 2306.3 2345.7 2348.2 2348.8 1930.5 2307.2 2318.0 2329.8 2345.3 1802.0 1907.6 1910.8 1914.7 1976.0 2030.8 2237.9 2285.4 2311.2 2325.5 8742.7 8793.0 8800.5 8831.2 8845.3 4524.2 5127.1 5306.4 5320.5 5323.1 3394.6 3461.4 3615.0 3622.1 3631.6 850.3 986.5 1047.2 1051.8 1058.6 9610.5 10470.0 11549.2 11640.0 11654.4 3751.4 4510.9 4632.7 4691.7 4704.8 8298.6 9767.7 9836.0 9838.4 9876.3 4482.9 5201.3 5243.7 5259.1 5282.3 3761.6 4146.4 4295.8 4677.7 4755.5 3345.6 3488.8 3793.3 3853.7 3991.1 979.7 1033.5 1212.7 1218.8 1219.8 818.5 831.9 843.7 846.7 945.5 5550.4 5900.2 5946.0 6011.0 6018.7 807.6 875.9 942.3 968.6 999.9 3654.5 3688.7 3848.7 3867.3 3975.1 10398.2 10802.7 10821.2 10823.5 10835.4 10527.3 10632.2 10694.5 10777.7 10779.8 7751.7 8054.2 8056.5 8071.5 8072.7 5207.6 5509.7 5627.6 5710.7 5768.8 9378.1 9559.3 9689.2 9699.0 9718.7 9382.3 9757.2 9762.3 9768.8 9791.8 6882.4 7154.0 7268.0 7446.6 7603.5 8153.3 8400.3 8445.1 8445.6 8446.8 7335.9 7450.0 7477.3 7572.7 7575.0 7187.1 7237.3 7289.8 7368.3 7395.4 6833.3 6842.0 6905.9 6911.6 6924.3 4872.3 4923.0 4946.6 4991.0 5016.8 4878.4 4890.5 4993.9 5031.8 5125.7 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4257.04 Median:4574.20 stddev:1332.82 (29.1%) stddev-sans-first:1301.97 10:19:04 INFO - PROCESS | 1651 | Values: 237.6 285.9 303.6 305.6 306.7 4529.8 5301.2 5379.5 5413.2 5450.0 5108.5 5361.4 5412.8 5426.4 5439.4 3396.3 3442.6 3455.7 4149.6 4153.4 3635.3 3983.3 4137.8 4144.7 4147.2 3380.6 3593.8 4059.8 4079.2 4147.5 3997.0 4092.3 4104.0 4123.3 4137.4 3019.3 3317.0 3517.0 3531.9 3594.7 5221.3 5227.7 5248.7 5276.0 5311.3 3869.2 3892.8 4645.4 4647.5 4677.7 4498.7 5393.6 5684.7 5686.9 5694.4 2907.5 3636.3 3790.7 3898.4 3934.6 5204.3 5997.5 6031.5 6063.3 6090.5 3808.7 3820.8 3898.3 3902.8 3913.7 3934.7 3946.3 3955.2 3965.8 3998.8 3932.9 4191.3 4248.2 4582.4 4620.8 4459.5 4687.9 4845.6 5792.7 5852.7 1185.0 1256.3 1306.7 1350.5 1354.5 764.3 779.0 803.3 825.3 827.3 3913.6 4555.7 4563.7 4566.0 4642.9 4015.5 4143.0 4168.7 4423.5 4823.5 3681.5 3706.9 3863.5 4082.6 4584.4 2190.7 2254.9 2328.4 2572.4 2586.1 4450.5 5067.3 5095.8 5098.7 5133.9 3874.7 4719.0 5061.5 5076.6 5134.6 4007.9 4363.3 4592.9 4938.9 5142.8 4554.2 4699.9 4748.7 4848.4 4942.4 4027.9 4491.7 4939.1 4966.0 4977.5 4335.1 4371.0 4769.6 5136.6 5208.2 2905.7 3380.8 3500.2 3525.6 3692.2 5793.6 5909.4 5909.7 5910.3 5932.3 4863.0 5014.5 5637.4 5670.4 5732.1 4301.2 4729.7 4997.6 5630.1 5697.1 5543.3 5561.5 5580.8 5585.2 5589.9 4488.0 4863.5 5214.4 5409.8 5675.5 4994.7 5166.8 5443.2 5502.5 5528.7 10:19:04 INFO - PROCESS | 1651 | 10:19:04 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24451.03 Median:4324.70 stddev:39239.39 (907.3%) stddev-sans-first:39308.88 10:19:04 INFO - PROCESS | 1651 | Values: 682.4 711.9 736.3 803.6 817.6 15655.5 16025.4 16358.7 16363.1 16378.9 11307.9 13238.4 14757.6 14835.0 14951.8 869.6 891.5 891.7 892.5 895.3 883.8 886.0 891.8 893.2 895.7 936.3 939.8 943.9 945.1 946.2 926.4 927.5 931.3 935.7 937.3 700.2 700.4 703.5 703.5 704.2 13557.1 13591.9 13595.7 13613.7 13647.2 12185.9 12591.4 12606.6 12683.2 13294.9 12689.8 12707.8 12948.8 13471.8 13603.5 4417.5 4507.6 4512.8 4539.1 4723.2 116125.0 118741.0 119805.0 120277.0 121021.0 8916.9 10654.1 10720.5 10768.6 11277.2 20534.5 20653.7 20771.6 20869.7 21048.0 7430.0 7656.2 7691.7 7784.1 7895.9 4378.1 4382.5 4408.4 4408.8 4418.2 3349.5 3407.3 3422.7 3451.4 3464.8 663.5 672.9 675.7 682.0 682.3 525.1 583.7 603.7 611.7 621.1 8434.5 8693.3 8839.9 8927.2 9020.4 578.2 593.9 611.2 619.7 648.3 4287.1 4293.7 4355.7 4553.8 4592.2 140345.0 144612.0 150136.0 156821.0 158205.0 99931.0 105383.0 128122.0 137364.0 140619.0 71557.0 98363.0 107434.5 111515.0 114045.4 8684.6 9500.4 9520.5 9732.9 9827.3 62589.0 63043.7 64025.7 64429.7 66341.0 79494.2 83973.0 85684.9 86360.0 89227.0 9991.9 11947.9 12298.0 12829.9 13504.7 14429.6 14574.5 14854.7 14874.8 14900.1 12973.6 13112.9 13234.9 13623.5 13820.8 11876.8 13635.9 13756.7 13976.9 14014.0 12886.2 13515.7 13518.7 13529.5 13684.0 9369.7 11272.9 11466.1 11741.2 11800.4 10038.1 10275.2 10467.6 11202.3 11308.9 10:19:04 INFO - PROCESS | 1651 | -------- Summary: end -------- 10:19:04 INFO - PROCESS | 1651 | 10:19:05 INFO - TEST-INFO | 1651: exit 0 10:19:05 INFO - TEST-OK | dromaeo_css | took 1115616ms 10:19:05 INFO - TEST-START | kraken 10:19:05 INFO - operating with platform_type : mac_ 10:19:05 INFO - Initialising browser for kraken test... 10:19:05 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp3DHjIM/profile http://localhost:49268/getInfo.html) 10:19:08 INFO - PROCESS | 1662 | 2016-10-14 10:19:08.134 plugin-container[1663:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 10:19:08 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:08 INFO - PROCESS | 1662 | 2016-10-14 10:19:08.137 plugin-container[1663:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f2f, name = 'com.apple.CFPasteboardClient' 10:19:08 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:08 INFO - PROCESS | 1662 | 2016-10-14 10:19:08.137 plugin-container[1663:10151] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:19:08 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 10:19:08 INFO - PROCESS | 1662 | colorDepth:24 10:19:08 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 10:19:08 INFO - PROCESS | 1662 | __metrics 10:19:08 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 10:19:09 INFO - TEST-INFO | 1662: exit 0 10:19:09 INFO - Browser initialized. 10:19:09 INFO - Running cycle 1/1 for kraken test... 10:19:09 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp3DHjIM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:19:11 INFO - PROCESS | 1664 | 2016-10-14 10:19:11.470 plugin-container[1665:10266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 10:19:11 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:11 INFO - PROCESS | 1664 | 2016-10-14 10:19:11.470 plugin-container[1665:10266] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e13, name = 'com.apple.CFPasteboardClient' 10:19:11 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:19:11 INFO - PROCESS | 1664 | 2016-10-14 10:19:11.470 plugin-container[1665:10266] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:19:21 INFO - PROCESS | 1664 | RSS: Main: 237502464 10:19:21 INFO - PROCESS | 1664 | 10:19:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection) 10:19:25 INFO - PROCESS | 1664 | RSS: Main: 249794560 10:19:25 INFO - PROCESS | 1664 | 10:19:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-dft) 10:19:28 INFO - PROCESS | 1664 | RSS: Main: 258400256 10:19:28 INFO - PROCESS | 1664 | 10:19:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-fft) 10:19:32 INFO - PROCESS | 1664 | RSS: Main: 260648960 10:19:32 INFO - PROCESS | 1664 | 10:19:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator) 10:19:34 INFO - PROCESS | 1664 | RSS: Main: 261529600 10:19:34 INFO - PROCESS | 1664 | 10:19:37 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:19:37 INFO - PROCESS | 1664 | RSS: Main: 261734400 10:19:37 INFO - PROCESS | 1664 | 10:19:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom) 10:19:41 INFO - PROCESS | 1664 | RSS: Main: 262426624 10:19:41 INFO - PROCESS | 1664 | 10:19:44 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate) 10:19:44 INFO - PROCESS | 1664 | RSS: Main: 263770112 10:19:44 INFO - PROCESS | 1664 | 10:19:47 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial) 10:19:48 INFO - PROCESS | 1664 | RSS: Main: 264040448 10:19:48 INFO - PROCESS | 1664 | 10:19:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:19:50 INFO - PROCESS | 1664 | RSS: Main: 263462912 10:19:50 INFO - PROCESS | 1664 | 10:19:52 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:19:52 INFO - PROCESS | 1664 | RSS: Main: 263561216 10:19:52 INFO - PROCESS | 1664 | 10:19:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:19:55 INFO - PROCESS | 1664 | RSS: Main: 263598080 10:19:55 INFO - PROCESS | 1664 | 10:19:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:19:59 INFO - PROCESS | 1664 | RSS: Main: 264024064 10:19:59 INFO - PROCESS | 1664 | 10:20:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:20:03 INFO - PROCESS | 1664 | RSS: Main: 264097792 10:20:03 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49268/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49268/tests/kraken/driver.html?testName=ai-astar) 10:20:05 INFO - PROCESS | 1664 | RSS: Main: 265359360 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | __start_tp_report 10:20:05 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 10:20:05 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 10:20:05 INFO - PROCESS | 1664 | |i|pagename|runs| 10:20:05 INFO - PROCESS | 1664 | |0;ai-astar;116;118;118;118;117;118;117;119;121;160 10:20:05 INFO - PROCESS | 1664 | |1;audio-beat-detection;150;115;118;153;118;118;118;148;180;115 10:20:05 INFO - PROCESS | 1664 | |2;audio-dft;195;211;229;197;201;198;199;196;229;279 10:20:05 INFO - PROCESS | 1664 | |3;audio-fft;81;58;60;87;62;58;60;74;111;53 10:20:05 INFO - PROCESS | 1664 | |4;audio-oscillator;92;73;108;104;86;61;117;97;103;119 10:20:05 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;109;108;88;88;90;86;90;88;90;102 10:20:05 INFO - PROCESS | 1664 | |6;imaging-darkroom;96;98;104;96;96;96;96;96;106;108 10:20:05 INFO - PROCESS | 1664 | |7;imaging-desaturate;89;89;95;86;91;88;92;93;89;89 10:20:05 INFO - PROCESS | 1664 | |8;json-parse-financial;57;57;54;59;57;59;58;57;59;56 10:20:05 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;71;72;76;82;75;72;71;73;73;73 10:20:05 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;89;110;116;111;102;112;113;117;112;114 10:20:05 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;156;165;155;164;165;162;165;136;209;165 10:20:05 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;176;175;175;173;178;177;177;174;178;174 10:20:05 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;72;69;70;72;71;70;70;72;73;71 10:20:05 INFO - PROCESS | 1664 | __end_tp_report 10:20:05 INFO - PROCESS | 1664 | __start_cc_report 10:20:05 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,932 10:20:05 INFO - PROCESS | 1664 | __end_cc_report 10:20:05 INFO - PROCESS | 1664 | __startTimestamp1476465605351__endTimestamp 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | ------- Summary: start ------- 10:20:05 INFO - PROCESS | 1664 | Number of tests: 14 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:122.20 Median:118.00 stddev:13.35 (11.3%) stddev-sans-first:13.97 10:20:05 INFO - PROCESS | 1664 | Values: 116.0 118.0 118.0 118.0 117.0 118.0 117.0 119.0 121.0 160.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:133.00 stddev:22.78 (17.1%) stddev-sans-first:23.35 10:20:05 INFO - PROCESS | 1664 | Values: 150.0 115.0 118.0 153.0 118.0 118.0 118.0 148.0 180.0 115.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:213.40 Median:206.00 stddev:26.47 (12.8%) stddev-sans-first:27.22 10:20:05 INFO - PROCESS | 1664 | Values: 195.0 211.0 229.0 197.0 201.0 198.0 199.0 196.0 229.0 279.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:70.40 Median:61.00 stddev:18.09 (29.7%) stddev-sans-first:18.78 10:20:05 INFO - PROCESS | 1664 | Values: 81.0 58.0 60.0 87.0 62.0 58.0 60.0 74.0 111.0 53.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:67.00 stddev:18.55 (27.7%) stddev-sans-first:19.62 10:20:05 INFO - PROCESS | 1664 | Values: 92.0 73.0 108.0 104.0 86.0 61.0 117.0 97.0 103.0 119.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:88.00 stddev:8.85 (10.1%) stddev-sans-first:7.51 10:20:05 INFO - PROCESS | 1664 | Values: 109.0 108.0 88.0 88.0 90.0 86.0 90.0 88.0 90.0 102.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:96.00 stddev:4.83 (5.0%) stddev-sans-first:4.98 10:20:05 INFO - PROCESS | 1664 | Values: 96.0 98.0 104.0 96.0 96.0 96.0 96.0 96.0 106.0 108.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:90.10 Median:90.00 stddev:2.64 (2.9%) stddev-sans-first:2.77 10:20:05 INFO - PROCESS | 1664 | Values: 89.0 89.0 95.0 86.0 91.0 88.0 92.0 93.0 89.0 89.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:1.57 (2.7%) stddev-sans-first:1.66 10:20:05 INFO - PROCESS | 1664 | Values: 57.0 57.0 54.0 59.0 57.0 59.0 58.0 57.0 59.0 56.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:73.80 Median:73.00 stddev:3.29 (4.5%) stddev-sans-first:3.33 10:20:05 INFO - PROCESS | 1664 | Values: 71.0 72.0 76.0 82.0 75.0 72.0 71.0 73.0 73.0 73.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:109.60 Median:113.50 stddev:8.32 (7.3%) stddev-sans-first:4.34 10:20:05 INFO - PROCESS | 1664 | Values: 89.0 110.0 116.0 111.0 102.0 112.0 113.0 117.0 112.0 114.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:164.20 Median:165.00 stddev:18.14 (11.0%) stddev-sans-first:19.00 10:20:05 INFO - PROCESS | 1664 | Values: 156.0 165.0 155.0 164.0 165.0 162.0 165.0 136.0 209.0 165.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:176.50 stddev:1.77 (1.0%) stddev-sans-first:1.87 10:20:05 INFO - PROCESS | 1664 | Values: 176.0 175.0 175.0 173.0 178.0 177.0 177.0 174.0 178.0 174.0 10:20:05 INFO - PROCESS | 1664 | 10:20:05 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.50 stddev:1.25 (1.7%) stddev-sans-first:1.27 10:20:05 INFO - PROCESS | 1664 | Values: 72.0 69.0 70.0 72.0 71.0 70.0 70.0 72.0 73.0 71.0 10:20:05 INFO - PROCESS | 1664 | -------- Summary: end -------- 10:20:05 INFO - PROCESS | 1664 | 10:20:06 INFO - TEST-INFO | 1664: exit 0 10:20:06 INFO - TEST-OK | kraken | took 60852ms 10:20:06 INFO - SUITE-END | took 1176s 10:20:06 INFO - Completed test suite (00:19:36) 10:20:06 INFO - javascript benchmark 10:20:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7114.691408901739, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2783.902563410281, 3371.2246183377824, 3398.8130652814084, 3404.710599599034, 3405.2338223899624, 4251.914961700764, 5273.077211487994, 5647.265855438787, 5669.63147395419, 5678.772849086036, 4687.929681054787, 5654.123610840316, 5657.23627310313, 5676.403977582357, 5758.049921762915, 5170.819021334254, 5204.245384419257, 5254.632175747699, 5277.261183434322, 5285.867853303679, 5214.374275086976, 5303.946960530403, 5314.362276526822, 5350.5184533391985, 5397.62216644835, 5136.434992150897, 5173.948260517384, 5308.044551980642, 5310.62825602208, 5341.0, 5151.6136289778415, 5170.431252562215, 5282.418933917266, 5312.468753124656, 5333.040052790496, 5142.61430392722, 5169.922451163236, 5189.766460509286, 5192.4547922468355, 5283.101872681654, 5431.456854314537, 5539.113741801333, 5673.801416950387, 5716.428357164292, 5746.942530574683, 6058.0, 6065.302490213638, 6120.53855959212, 6150.231221097363, 6211.068339749074, 6258.34287399821, 6273.309935907047, 6273.905891411632, 6276.748930042792, 6311.305756366796, 4832.661713680044, 5778.56660750437, 5780.988327042751, 5787.479126878559, 5791.507721843606, 6166.290876549254, 6190.3190649028575, 6206.968965155235, 6214.471769899609, 6225.097360882737, 6115.724792384353, 6122.1542093545395, 6122.204113465221, 6128.816135515942, 6145.416185462464, 5993.4905533029305, 6198.411150940653, 6216.5391133083685, 6266.686665666698, 6279.654618995908, 5769.8557536061935, 6018.789342372996, 6107.328193898667, 6160.199174107337, 6212.596181248205, 6185.505159587312, 6197.318294987548, 6222.844428889223, 6238.376162383725, 6282.151909492251, 4906.288588154769, 4945.282933974553, 4955.40535135786, 4955.752212389366, 4979.526944940225, 4323.437953066082, 4338.891527711832, 4388.341748737715, 4406.633943477532, 4443.37792709021, 5745.540356771448, 5769.0, 5772.884542309131, 5784.363719990798, 5803.216565763652, 6247.937520624827, 6262.718177682015, 6268.310485846553, 6277.2781130170615, 6279.0, 4741.810327586858, 5638.436156384329, 5668.943310566841, 5701.686407247641, 5775.537956963432, 5329.866753331198, 5337.146056630921, 5356.276902618097, 5359.464053594687, 5378.381486129145, 6241.407066328691, 6256.374362563798, 6266.154069200691, 6287.371262873676, 6376.489880809524, 6110.602810817282, 6129.419919118862, 6139.877202456015, 6203.782867599793, 6217.502599791916, 5353.678779273256, 6047.153398524122, 6285.59143655661, 6304.117423560613, 6307.96846015767, 4873.4882837301575, 5015.523525265094, 5229.529342359206, 5232.7645255964335, 5602.635828671123, 6099.786507472217, 6128.264608247039, 6264.812055638338, 6267.0, 6307.180066591313, 5177.223416487557, 6051.33435322123, 6072.635641861502, 6139.403755023815, 6151.738893526726, 4771.95228047715, 6086.1175129606845, 6138.478229350377, 6149.354317796746, 6176.783812566496, 5559.416261292506, 5721.370649228665, 5871.530277577698, 5942.494887934401, 5997.280326360865, 6125.499252683121, 6132.386761323832, 6148.231471066117, 6158.353372895782, 6167.814965551041, 5993.580449368503, 5998.220231370068, 6047.455728984412, 6051.788187413419, 6061.605995610271], "value": 5614.371861358695, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [469.57738035767824, 473.7938996536506, 532.8268312798339, 533.565144407308, 557.8884223155368, 38416.615833841686, 40260.39609405861, 40320.79839600802, 40356.0, 40484.79757601212, 41163.0, 41686.58313416865, 41747.16505669885, 41922.0, 41939.79030104853, 9486.098820612047, 9639.855402168972, 9657.0, 9669.419834809934, 9705.320627556073, 9233.584488698025, 9543.713688589354, 9639.325247232697, 9647.035296470367, 9653.806923861519, 9636.132748052674, 9678.903210967906, 9685.757856053584, 9703.951480242624, 9732.221422286235, 9579.904200958006, 9647.469389183592, 9650.131488166064, 9670.419774813534, 9698.854517182248, 8003.639836207385, 9425.575849086808, 9483.952580237055, 9524.14282714552, 9579.323618366827, 39774.00564985869, 40097.79951100255, 40183.19633607341, 40240.19519609591, 40485.39271910924, 3268.3953468608383, 3392.3384939936477, 3911.550171730259, 4141.855035073758, 4247.702660813744, 30008.399832003455, 30572.8471357644, 31330.53004204916, 31358.843205784055, 31382.686173138205, 3171.444997125494, 3292.917677058069, 3300.389427955836, 3349.0455220262106, 3353.178471274529, 474352.0, 477666.0, 485013.0, 485497.0, 486956.0, 57301.567460813814, 57577.712111440014, 57632.0, 57658.0, 57718.422815772145, 59954.0, 60138.39861601416, 60167.699161503915, 60220.0, 60314.0, 14928.02967807089, 15686.529404117895, 15760.896737228284, 15937.681246375008, 15938.0, 12438.0, 12524.937375313066, 12570.308633025088, 12576.74846503083, 12623.431945562472, 11916.404179790976, 14649.707005859824, 14744.0, 15140.772888406682, 15248.618784530476, 4875.871134148417, 5194.182276027117, 6059.272887253558, 6115.541334399938, 6166.4758495527485, 845.8054647431002, 916.7937214126769, 925.2967744514083, 982.7444864335324, 1028.830243009895, 29100.563491547644, 29590.852045739633, 29621.407571848442, 30255.848720756254, 30324.54513182304, 989.1839232633107, 1078.099786678117, 1093.812375249501, 1114.2757207814984, 1147.7474955509774, 12932.547360842513, 15422.305996230196, 15495.922520387327, 15500.0, 16159.030458172312, 170707.0, 172271.0, 172575.0, 172609.0, 173272.0, 57131.0, 57305.42694573084, 57391.42608573944, 57480.0, 57529.712351438815, 1294.3140135728079, 1335.1588499245606, 1366.7881478370869, 1368.6852024034329, 1372.945082196701, 28081.43837123287, 29692.55461168041, 29799.510024498253, 30326.545101823933, 30342.696573033987, 46966.53033469622, 48474.03051939012, 49014.0, 49073.018539629724, 49199.50800492092, 565780.0, 567275.0, 567290.0, 567615.0, 568216.0, 30901.536476952413, 31914.840425797724, 39644.008899777735, 39664.40503392394, 39764.60235397725, 45945.54054459546, 46013.309800353694, 46014.769926150155, 47251.05497890092, 47380.0, 38523.807380964034, 38948.02629934161, 39091.14817222263, 39453.605463944994, 39960.0, 37669.81165094157, 37805.86582402532, 38016.47934082606, 38741.41887871628, 38948.80525597354, 37144.6285537152, 38154.80922595481, 38193.80903095467, 38341.0, 40062.79968600138, 31046.0, 34705.87648109855, 34753.65246347504, 34798.65201347954, 37131.0, 25181.87409062943, 25334.239972800846, 25543.105991290216, 25697.486050278516, 25785.871070644527], "value": 19054.7216800526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.1323756795849, 364.56434560699955, 366.41556717036326, 371.0760207084361, 390.05800990607685, 19252.518687032814, 20040.69938950917, 20542.38372848817, 20765.584688306226, 20930.895345523288, 19566.413007609757, 19840.603187936267, 20143.19427222909, 20318.390448286536, 20353.694694579593, 4734.621230301585, 5651.06757385031, 5951.464368206861, 5965.850853728648, 6513.674316284167, 6513.0, 6604.57070290432, 6613.702383392735, 6618.172728408949, 6626.469882409396, 5643.209950606918, 5997.430244126823, 6026.276846778371, 6089.665068421235, 6520.902186467207, 5983.461488466037, 6024.48791852693, 6043.667598282114, 6068.757249710006, 6229.2836323822885, 4597.586217240431, 5171.844844654629, 5704.344000439961, 5768.336641286264, 5774.787294668125, 10560.630377936812, 12817.423215955305, 19386.4184074478, 23688.881555592285, 23866.880665596735, 2004.3686238834866, 2084.5622419291967, 2108.325335892515, 2127.361791462555, 2180.1279488204686, 9605.759856003586, 9960.302778805486, 10001.749956251078, 12632.368381580884, 14394.712105757826, 1751.903645299508, 1848.186797808973, 1911.961760764777, 1940.8738432001874, 1944.1251436853331, 100579.49710251403, 102890.48554757253, 104663.0, 105301.94698053075, 105920.05599580062, 10087.546060427298, 10614.840777388345, 11140.888591114148, 11175.0, 11360.375179365048, 13990.230537320342, 14000.789988150185, 14024.929875350557, 14037.78943315851, 14039.0, 7940.1265860755275, 8121.984751906011, 8180.222878826502, 8200.179982001871, 8328.875066874001, 7933.087694915043, 8041.477303975223, 8049.0, 8088.595570221465, 8240.381971352173, 4117.258893399157, 4338.761368124783, 4360.520342762294, 4375.453068366454, 4446.822127114944, 1705.744138379253, 1880.2291060665061, 1908.3606991657673, 1927.575933294673, 1933.5456167800837, 849.7833052571679, 882.7572417585216, 906.3700727994112, 935.1490143968956, 960.4333443268505, 19420.61158776845, 19860.60278794416, 19963.60072798536, 20197.798022019593, 20501.794982050287, 898.2454738020094, 937.2736129499692, 946.2477330522252, 955.8614000969959, 961.6297725375641, 10174.236932230113, 10620.89379106199, 10660.733481663021, 10732.731681707864, 10794.0, 476301.0, 551279.0, 566656.0, 578599.0, 580449.0, 119492.0, 123849.76150238383, 125134.0, 125287.0, 128780.0, 953.3469573342283, 957.30595318395, 974.2741657465092, 986.1913231150388, 988.7972965542046, 18204.271829126686, 18298.817011830244, 18334.266629335212, 18343.35798247055, 18370.989595572373, 41623.1675366497, 49036.01927961492, 51429.971400572525, 51485.7425712884, 52310.73844630752, 74914.25085749073, 75240.62379688067, 78865.0, 79802.0, 80040.0, 7425.740099096506, 7541.321281084509, 7667.961660191663, 7724.0, 7781.221877812173, 10436.739081522719, 11557.479913404086, 11756.70608234801, 12108.757824843278, 12234.204776689487, 10116.59533618647, 10217.029382208679, 10413.687589372332, 10433.21750868703, 10535.736606584896, 9801.313908026656, 10179.541920613738, 10199.38803671782, 10401.323913945569, 10455.738606534898, 8286.378521611025, 8415.789605259917, 10423.322484038514, 10519.474026298807, 10596.841047384141, 6458.1281526995135, 6868.210155831944, 7364.705411783683, 7567.205443428361, 7628.656710448154, 8686.133575919805, 9788.657396991071, 10179.134773544332, 10415.635452759117, 10444.321119127233], "value": 9157.422041394946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.9347079381428, 1500.9174495402751, 1740.7475915992181, 1854.805245449227, 1891.489297889569, 7865.213478652132, 8162.836743265131, 8484.490930544172, 8881.200691937733, 8894.644214231423, 8342.874856877137, 8640.0, 8668.91331086689, 8700.303975681945, 8727.432716873398, 1960.735300734404, 2286.622707253305, 2331.0559223514506, 2332.521833024226, 2344.871032093234, 2288.7139107611547, 2306.3426923326856, 2345.651250530943, 2348.236823032513, 2348.8473249238746, 1930.5077205312696, 2307.169419009164, 2317.965230521535, 2329.8369114162015, 2345.3198572414067, 1801.9639607207848, 1907.6280125375558, 1910.8184722451344, 1914.664933636608, 1975.9703604445945, 2030.801826922123, 2237.9216727414464, 2285.405794493427, 2311.15642790382, 2325.5348930214027, 8742.737717868475, 8792.956035219848, 8800.515971621558, 8831.161039701217, 8845.29237660992, 4524.185646583614, 5127.077126117298, 5306.442823503515, 5320.467953204688, 5323.148296272617, 3394.6435624259593, 3461.4115600348, 3615.0, 3622.0582648511577, 3631.638135699113, 850.2942557677175, 986.5264672956949, 1047.2093569355163, 1051.800157969991, 1058.629479682105, 9610.51947402627, 10470.0, 11549.249298795552, 11640.010599099087, 11654.417279136009, 3751.3810221313724, 4510.857342762161, 4632.745199014019, 4691.7184968901975, 4704.835330763407, 8298.585070746438, 9767.681363016043, 9835.950820245853, 9838.36050656705, 9876.308658393988, 4482.910341793146, 5201.271821944931, 5243.737813109329, 5259.0796610593, 5282.286891269629, 3761.605031471711, 4146.4402305688345, 4295.806688699016, 4677.713628752121, 4755.524447555217, 3345.631980482145, 3488.773229740059, 3793.260314238752, 3853.653171214548, 3991.0820511281986, 979.6571200080058, 1033.4729288062993, 1212.6847019774923, 1218.7562487502535, 1219.7865373559591, 818.4843548564367, 831.9209675080857, 843.6541018182515, 846.703653721205, 945.4799860077068, 5550.361708403505, 5900.20347253124, 5945.970270148621, 6011.008183649649, 6018.7291571878495, 807.6325272001226, 875.9474431534128, 942.3168203052869, 968.6319198704447, 999.895011023832, 3654.470101835219, 3688.6680198782237, 3848.7113466490127, 3867.284552357823, 3975.105601239698, 10398.220133490018, 10802.72993175177, 10821.18841086906, 10823.458827058615, 10835.404052777172, 10527.315724477885, 10632.202584806171, 10694.465276736131, 10777.676669699922, 10779.838302425469, 7751.689932402754, 8054.154313796967, 8056.476329038594, 8071.475354102082, 8072.717454889051, 5207.609429292894, 5509.705219273547, 5627.577931655224, 5710.685912274865, 5768.769249229984, 9378.109079637423, 9559.330846840654, 9689.176420004378, 9698.981606931171, 9718.659846905324, 9382.29632777558, 9757.219422446045, 9762.316637835283, 9768.804623907625, 9791.755206119904, 6882.380585747307, 7153.961121080467, 7267.963660181666, 7446.590437525988, 7603.467757256939, 8153.306968907709, 8400.28597569189, 8445.113263107285, 8445.577721113797, 8446.83106337882, 7335.926640733738, 7450.0, 7477.327040566375, 7572.734954276574, 7575.0, 7187.065681461377, 7237.312455316736, 7289.781306560812, 7368.300011498899, 7395.445341599294, 6833.3166683331265, 6841.965790171017, 6905.89641155373, 6911.619860907698, 6924.3421874921805, 4872.269159626085, 4922.975385123194, 4946.629002824874, 4990.950090499194, 5016.849494515171, 4878.438979517259, 4890.510948905081, 4993.900121997613, 5031.7735701894235, 5125.692458452505], "value": 4439.390232158409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [237.60913297625405, 285.9285178705325, 303.558322640558, 305.57982773686183, 306.6736365220422, 4529.818807247706, 5301.151815709487, 5379.547522169012, 5413.242146099545, 5449.99175152597, 5108.544064941492, 5361.356637203531, 5412.810551630694, 5426.403095659474, 5439.401665816757, 3396.269801992571, 3442.569678790151, 3455.6544345565494, 4149.564295748948, 4153.356229784388, 3635.291118231946, 3983.3228351180223, 4137.834486620547, 4144.730592511477, 4147.21202971436, 3380.5943286805496, 3593.82030898454, 4059.7564146151326, 4079.1841631673637, 4147.4815648044, 3997.020729921159, 4092.3043082676018, 4104.024582177927, 4123.3196522573735, 4137.358709400048, 3019.3206528531123, 3316.9834150829333, 3517.032815975602, 3531.858725650971, 3594.6944509716704, 5221.2951251580935, 5227.712475813829, 5248.6588371755715, 5276.0, 5311.336082989626, 3869.187470631171, 3892.824822882977, 4645.372874661911, 4647.535246475325, 4677.672562920597, 4498.685092043558, 5393.649412788156, 5684.664103935572, 5686.947914635805, 5694.402087780765, 2907.5057240269207, 3636.254567813592, 3790.7156963227867, 3898.4152377143373, 3934.567197608261, 5204.297419848348, 5997.460228579449, 6031.487323577458, 6063.272407311107, 6090.543209259324, 3808.7143464240294, 3820.7707537547835, 3898.2593307272095, 3902.843886244518, 3913.7064720146104, 3934.7442416243425, 3946.2502124596235, 3955.1891862168186, 3965.7818819965178, 3998.7600743955454, 3932.901677458029, 4191.2874811281545, 4248.171606536757, 4582.358469814229, 4620.768961551977, 4459.487158976694, 4687.851476388239, 4845.6123510119105, 5792.681402522818, 5852.736626851802, 1185.0105162189668, 1256.3466997161609, 1306.6994591244068, 1350.4598160735588, 1354.539456584766, 764.3388468974408, 778.9912063877292, 803.3492870774575, 825.2902503846688, 827.2637352756052, 3913.6477717005037, 4555.72665640056, 4563.722157795823, 4566.036604260134, 4642.930356044662, 4015.4980627421573, 4143.0, 4168.7290326128705, 4423.469183697976, 4823.469418364048, 3681.5214022177483, 3706.9073273167846, 3863.47392779856, 4082.632563069338, 4584.358189853423, 2190.671399290119, 2254.864708117518, 2328.4411741181993, 2572.3954870605394, 2586.0948667966063, 4450.465944086665, 5067.265246539231, 5095.821646242363, 5098.694078355311, 5133.948660513347, 3874.7481413708583, 4718.985418135048, 5061.506855477643, 5076.562835446015, 5134.640575159778, 4007.8797636070963, 4363.345498175299, 4592.931106033412, 4938.8765280868265, 5142.814303920743, 4554.157480866051, 4699.942512934563, 4748.691335063209, 4848.442429120696, 4942.4316203637045, 4027.8993025174605, 4491.71985983993, 4939.086269040239, 4966.006798640215, 4977.527134922177, 4335.144638005454, 4371.0, 4769.639028680686, 5136.6147538935475, 5208.244804503402, 2905.651321841308, 3380.814055226986, 3500.212452198337, 3525.5945566260207, 3692.243090166563, 5793.594448388572, 5909.409059094056, 5909.699866029467, 5910.261217347832, 5932.288125424977, 4863.0, 5014.52362025607, 5637.420238148723, 5670.404607516316, 5732.127691462224, 4301.2257793597455, 4729.739864307496, 4997.625178111583, 5630.0576301176025, 5697.062998580503, 5543.334799824047, 5561.4716601922755, 5580.804671836466, 5585.218069470358, 5589.888202235851, 4488.0, 4863.4650188479945, 5214.366744793855, 5409.83770486886, 5675.517581005495, 4994.675346102492, 5166.767495462788, 5443.237946687546, 5502.532284755841, 5528.668279903219], "value": 3835.806287031451, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.3926705232341, 711.9359257666808, 736.2784471218206, 803.5821372886098, 817.5565799877663, 15655.53033408998, 16025.358985640574, 16358.672826543461, 16363.100029498373, 16378.935369200994, 11307.925747054038, 13238.404271807767, 14757.631059223524, 14834.961552691317, 14951.775723364131, 869.6130222051174, 891.4517571693394, 891.7012800711736, 892.4600616626944, 895.3016647015338, 883.8409086364452, 886.0, 891.7636826241052, 893.1738142218454, 895.7178488776015, 936.2837429366506, 939.7979434421597, 943.8584212368131, 945.0643862576069, 946.186279799372, 926.3700683535193, 927.5084205371164, 931.2549960031947, 935.6725146198844, 937.2782957123011, 700.1528150937372, 700.3591713582066, 703.4583370804503, 703.4794252253347, 704.232386698501, 13557.118787278796, 13591.86408135916, 13595.728085438235, 13613.727725445435, 13647.181169129884, 12185.87814121865, 12591.37043147848, 12606.621801345975, 12683.175593586388, 13294.86705132946, 12689.809652855121, 12707.809382859265, 12948.805767913489, 13471.797923031163, 13603.523876664369, 4417.504935134654, 4507.639388848885, 4512.819487220508, 4539.114872599845, 4723.220668589679, 116125.0, 118741.0, 119805.0, 120277.0, 121021.0, 8916.866247006301, 10654.147668186526, 10720.46397680113, 10768.56925722978, 11277.154213433862, 20534.486637834172, 20653.690194647093, 20771.58456830855, 20869.68695469569, 21048.0, 7430.0, 7656.157822639617, 7691.693450182655, 7784.06712773809, 7895.894574759538, 4378.124375124988, 4382.517923028464, 4408.382826404306, 4408.823647054082, 4418.226810308183, 3349.547811045478, 3407.2844702612233, 3422.6577342265573, 3451.3960056989927, 3464.7574669772875, 663.5255792108666, 672.8586996730644, 675.746595026865, 681.9829504262334, 682.3483573187594, 525.1282870435059, 583.7198144890476, 603.6921170203141, 611.6513587255222, 621.1149112514648, 8434.451760635538, 8693.347998900108, 8839.911600883908, 8927.24118449939, 9020.368574199743, 578.2425023219596, 593.9316978547436, 611.1627070912789, 619.662284055191, 648.2998361769278, 4287.121140166259, 4293.742375457483, 4355.651547876162, 4553.795079221443, 4592.2193227151465, 140345.0, 144612.0, 150136.0, 156821.0, 158205.0, 99931.0, 105383.0, 128122.0, 137364.0, 140619.0, 71557.0, 98363.0, 107434.46282768536, 111515.0, 114045.4297728506, 8684.565771711515, 9500.42997420157, 9520.52397380142, 9732.854007190039, 9827.31208815376, 62589.0, 63043.739125218155, 64025.719485610956, 64429.67785161044, 66341.0, 79494.20505794868, 83973.0, 85684.85890846569, 86360.0, 89227.0, 9991.900080999098, 11947.940260298643, 12298.0, 12829.93585032069, 13504.729905402033, 14429.639259018608, 14574.534998652372, 14854.702905942037, 14874.776878346616, 14900.105993640416, 12973.610791676265, 13112.934435327763, 13234.933825330812, 13623.455061797813, 13820.756131948174, 11876.821847672465, 13635.86364136346, 13756.65608359799, 13976.930115349765, 14014.0, 12886.226826390446, 13515.729685406433, 13518.729625407634, 13529.526466573623, 13684.042117051711, 9369.672061477815, 11272.887271127513, 11466.082713383075, 11741.180117081865, 11800.350980696145, 10038.146757525692, 10275.229357798045, 10467.633632822815, 11202.32786032808, 11308.886911130783], "value": 7773.760968376677, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 119.0, 121.0, 160.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 118.0, 153.0, 118.0, 118.0, 118.0, 148.0, 180.0, 115.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 211.0, 229.0, 197.0, 201.0, 198.0, 199.0, 196.0, 229.0, 279.0], "value": 213.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 87.0, 62.0, 58.0, 60.0, 74.0, 111.0, 53.0], "value": 70.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 73.0, 108.0, 104.0, 86.0, 61.0, 117.0, 97.0, 103.0, 119.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 108.0, 88.0, 88.0, 90.0, 86.0, 90.0, 88.0, 90.0, 102.0], "value": 93.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 104.0, 96.0, 96.0, 96.0, 96.0, 96.0, 106.0, 108.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 95.0, 86.0, 91.0, 88.0, 92.0, 93.0, 89.0, 89.0], "value": 90.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 59.0, 57.0, 59.0, 58.0, 57.0, 59.0, 56.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 76.0, 82.0, 75.0, 72.0, 71.0, 73.0, 73.0, 73.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 110.0, 116.0, 111.0, 102.0, 112.0, 113.0, 117.0, 112.0, 114.0], "value": 109.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 155.0, 164.0, 165.0, 162.0, 165.0, 136.0, 209.0, 165.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 175.0, 175.0, 173.0, 178.0, 177.0, 177.0, 174.0, 178.0, 174.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 72.0, 71.0, 70.0, 70.0, 72.0, 73.0, 71.0], "value": 71.0, "unit": "score"}]}]} 10:20:06 INFO - Return code: 0 10:20:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:20:06 ERROR - # TBPL SUCCESS # 10:20:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:20:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:20:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:20:06 INFO - 2016-10-14 10:20:06.692 screenresolution[1669:10652] starting screenresolution argv=screenresolution get 10:20:06 INFO - 2016-10-14 10:20:06.695 screenresolution[1669:10652] Display 0: 1600x1200x32@60 10:20:06 INFO - 2016-10-14 10:20:06.701 screenresolution[1670:10655] starting screenresolution argv=screenresolution list 10:20:06 INFO - Available Modes on Display 0 10:20:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:20:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:20:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:20:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:20:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:20:06 INFO - Intel Iris: 10:20:06 INFO - Chipset Model: Intel Iris 10:20:06 INFO - Type: GPU 10:20:06 INFO - Bus: Built-In 10:20:06 INFO - VRAM (Dynamic, Max): 1536 MB 10:20:06 INFO - Vendor: Intel (0x8086) 10:20:06 INFO - Device ID: 0x0a2e 10:20:06 INFO - Revision ID: 0x0009 10:20:06 INFO - Displays: 10:20:06 INFO - Display: 10:20:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:20:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:20:06 INFO - Display Serial Number: 1600x1200 60 10:20:06 INFO - Main Display: Yes 10:20:06 INFO - Mirror: Off 10:20:06 INFO - Online: Yes 10:20:06 INFO - Rotation: Supported 10:20:06 INFO - Return code: 0 10:20:06 INFO - Running post-action listener: _resource_record_post_action 10:20:06 INFO - [mozharness: 2016-10-14 17:20:06.935310Z] Finished run-tests step (success) 10:20:06 INFO - Running post-run listener: _resource_record_post_run 10:20:07 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 39152128; Write bytes: 712854016; Read time: 384; Write time: 2079 10:20:07 INFO - TinderboxPrint: CPU usage
54.7% 10:20:07 INFO - TinderboxPrint: I/O read bytes / time
39,152,128 / 384 10:20:07 INFO - TinderboxPrint: I/O write bytes / time
712,854,016 / 2,079 10:20:07 INFO - TinderboxPrint: CPU idle
2,194.4 (45.3%) 10:20:07 INFO - TinderboxPrint: CPU system
982.4 (20.3%) 10:20:07 INFO - TinderboxPrint: CPU user
1,668.9 (34.4%) 10:20:07 INFO - TinderboxPrint: Swap in / out
447,213,568 / 0 10:20:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403227136; Write bytes: 396994560; Read time: 29597; Write time: 759 10:20:07 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 37038592; Write bytes: 301453824; Read time: 360; Write time: 1282 10:20:07 INFO - Running post-run listener: _upload_blobber_files 10:20:07 INFO - Blob upload gear active. 10:20:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:20:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:20:07 INFO - (blobuploader) - INFO - Open directory for files ... 10:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:08 INFO - (blobuploader) - INFO - Done attempting. 10:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:09 INFO - (blobuploader) - INFO - Done attempting. 10:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:20:12 INFO - (blobuploader) - INFO - Done attempting. 10:20:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:20:12 INFO - Return code: 0 10:20:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:20:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:20:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa95b0c1ac3537f4899cc1e8c48b5a32180768323ff546132dcb315a69365e5fb37e7ac355be86c05540cc952593a8d74f08abd283f56b70f14739fb3b57e12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b74c8d9aec630ebc1a6ebaec5abec34466d9176d34b721ad3090c48f072260008dfbc849364b345a9d560dc94f21e96050bbdb36d00f7f90bb0c95189863ab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076dc36d40c4411f42a1cff531cffc0dd681ee9031252736e693db23d5cea08329a762ba9a851f1557e206e987919623590c1885d428a2604f62d3baec666db6"} 10:20:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:20:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:20:12 INFO - Contents: 10:20:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa95b0c1ac3537f4899cc1e8c48b5a32180768323ff546132dcb315a69365e5fb37e7ac355be86c05540cc952593a8d74f08abd283f56b70f14739fb3b57e12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b74c8d9aec630ebc1a6ebaec5abec34466d9176d34b721ad3090c48f072260008dfbc849364b345a9d560dc94f21e96050bbdb36d00f7f90bb0c95189863ab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076dc36d40c4411f42a1cff531cffc0dd681ee9031252736e693db23d5cea08329a762ba9a851f1557e206e987919623590c1885d428a2604f62d3baec666db6"} 10:20:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:20:12 INFO - Copying logs to upload dir... 10:20:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:20:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.710687 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-14 10:20:12.294076) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:12.297187) ========= 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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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/Fx-Team/sha512/9fa95b0c1ac3537f4899cc1e8c48b5a32180768323ff546132dcb315a69365e5fb37e7ac355be86c05540cc952593a8d74f08abd283f56b70f14739fb3b57e12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b74c8d9aec630ebc1a6ebaec5abec34466d9176d34b721ad3090c48f072260008dfbc849364b345a9d560dc94f21e96050bbdb36d00f7f90bb0c95189863ab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076dc36d40c4411f42a1cff531cffc0dd681ee9031252736e693db23d5cea08329a762ba9a851f1557e206e987919623590c1885d428a2604f62d3baec666db6"} build_url:https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011269 build_url: 'https://queue.taskcluster.net/v1/task/abFjVlQyQE-dB4QPh0PlBw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa95b0c1ac3537f4899cc1e8c48b5a32180768323ff546132dcb315a69365e5fb37e7ac355be86c05540cc952593a8d74f08abd283f56b70f14739fb3b57e12", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6b74c8d9aec630ebc1a6ebaec5abec34466d9176d34b721ad3090c48f072260008dfbc849364b345a9d560dc94f21e96050bbdb36d00f7f90bb0c95189863ab3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/076dc36d40c4411f42a1cff531cffc0dd681ee9031252736e693db23d5cea08329a762ba9a851f1557e206e987919623590c1885d428a2604f62d3baec666db6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:12.330057) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:12.330432) ========= 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.ATLA7wIzJb/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.3XHfo3gAdn/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005110 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:20:12.380682) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:20:12.381280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:20:12.381882) ========= ========= Total master_lag: 0.17 =========