builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0266 starttime: 1474651531.76 results: success (0) buildid: 20160923072200 builduid: ba1d732cd7e744b5a76c252745767b50 revision: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.763341) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.763795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.764071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.787470) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.787792) ========= 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.P9iYAeJLGT/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.Dato3oxocj/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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-09-23 10:25:31-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 54.9M=0s 2016-09-23 10:25:31 (54.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073843 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.886858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.887621) ========= 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.P9iYAeJLGT/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.Dato3oxocj/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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.020861 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:31.937244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 10:25:31.937607) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 --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 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P9iYAeJLGT/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.Dato3oxocj/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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-09-23 10:25:32,020 truncating revision to first 12 chars 2016-09-23 10:25:32,021 Setting DEBUG logging. 2016-09-23 10:25:32,021 attempt 1/10 2016-09-23 10:25:32,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55a83c8bfcbc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 10:25:33,720 unpacking tar archive at: fx-team-55a83c8bfcbc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.965191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 10:25:33.927341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:33.927923) ========= script_repo_revision: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:33.928585) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:33.929048) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 10:25:33.949114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-23 10:25:33.949420) ========= /tools/buildbot/bin/python 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', '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.P9iYAeJLGT/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.Dato3oxocj/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:25:34 INFO - MultiFileLogger online at 20160923 10:25:34 in /builds/slave/test 10:25:34 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 10:25:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:25:34 INFO - {'append_to_log': False, 10:25:34 INFO - 'base_work_dir': '/builds/slave/test', 10:25:34 INFO - 'blob_upload_branch': 'Fx-Team', 10:25:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:25:34 INFO - 'branch': 'Fx-Team', 10:25:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:25:34 INFO - 'config_files': ('talos/mac_config.py',), 10:25:34 INFO - 'default_actions': ('clobber', 10:25:34 INFO - 'read-buildbot-config', 10:25:34 INFO - 'download-and-extract', 10:25:34 INFO - 'populate-webroot', 10:25:34 INFO - 'create-virtualenv', 10:25:34 INFO - 'install', 10:25:34 INFO - 'run-tests'), 10:25:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:25:34 INFO - 'download_minidump_stackwalk': True, 10:25:34 INFO - 'download_symbols': 'ondemand', 10:25:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:25:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:25:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:25:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:25:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:25:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:25:34 INFO - 'installer_path': 'installer.exe', 10:25:34 INFO - 'log_level': 'info', 10:25:34 INFO - 'log_name': 'talos', 10:25:34 INFO - 'log_to_console': True, 10:25:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:25:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:25:34 INFO - 'opt_config_files': (), 10:25:34 INFO - 'pip_index': False, 10:25:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:34 INFO - 'cmd': ('bash', 10:25:34 INFO - '-c', 10:25:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:34 INFO - 'enabled': True, 10:25:34 INFO - 'halt_on_failure': False, 10:25:34 INFO - 'name': 'check_screen_resolution'},), 10:25:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:25:34 INFO - 'cmd': ('bash', 10:25:34 INFO - '-c', 10:25:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:25:34 INFO - 'enabled': True, 10:25:34 INFO - 'halt_on_failure': False, 10:25:34 INFO - 'name': 'check_screen_resolution'},), 10:25:34 INFO - 'run_cmd_checks_enabled': True, 10:25:34 INFO - 'sps_profile': False, 10:25:34 INFO - 'sps_profile_interval': 0, 10:25:34 INFO - 'suite': 'dromaeojs-e10s', 10:25:34 INFO - 'system_bits': '32', 10:25:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:25:34 INFO - 'title': 't-yosemite-r7-0266', 10:25:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:25:34 INFO - 'use_talos_json': True, 10:25:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:25:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:25:34 INFO - 'work_dir': 'build'} 10:25:34 INFO - [mozharness: 2016-09-23 17:25:34.142736Z] Running clobber step. 10:25:34 INFO - Running pre-action listener: _resource_record_pre_action 10:25:34 INFO - Running main action method: clobber 10:25:34 INFO - rmtree: /builds/slave/test/build 10:25:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:25:35 INFO - Running post-action listener: _resource_record_post_action 10:25:35 INFO - [mozharness: 2016-09-23 17:25:35.007531Z] Finished clobber step (success) 10:25:35 INFO - [mozharness: 2016-09-23 17:25:35.007651Z] Running read-buildbot-config step. 10:25:35 INFO - Running pre-action listener: _resource_record_pre_action 10:25:35 INFO - Running main action method: read_buildbot_config 10:25:35 INFO - Using buildbot properties: 10:25:35 INFO - { 10:25:35 INFO - "project": "", 10:25:35 INFO - "product": "firefox", 10:25:35 INFO - "script_repo_revision": "production", 10:25:35 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:25:35 INFO - "repository": "", 10:25:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:25:35 INFO - "buildid": "20160923072200", 10:25:35 INFO - "pgo_build": "False", 10:25:35 INFO - "basedir": "/builds/slave/test", 10:25:35 INFO - "buildnumber": 102, 10:25:35 INFO - "slavename": "t-yosemite-r7-0266", 10:25:35 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:25:35 INFO - "platform": "yosemite_r7", 10:25:35 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 10:25:35 INFO - "branch": "fx-team", 10:25:35 INFO - "repo_path": "integration/fx-team", 10:25:35 INFO - "revision": "55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8", 10:25:35 INFO - "stage_platform": "macosx64", 10:25:35 INFO - "builduid": "ba1d732cd7e744b5a76c252745767b50", 10:25:35 INFO - "slavebuilddir": "test" 10:25:35 INFO - } 10:25:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 10:25:35 INFO - Running post-action listener: _resource_record_post_action 10:25:35 INFO - [mozharness: 2016-09-23 17:25:35.010950Z] Finished read-buildbot-config step (success) 10:25:35 INFO - [mozharness: 2016-09-23 17:25:35.011051Z] Running download-and-extract step. 10:25:35 INFO - Running pre-action listener: _resource_record_pre_action 10:25:35 INFO - Running main action method: download_and_extract 10:25:35 INFO - mkdir: /builds/slave/test/build/tests 10:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:25:35 INFO - trying https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 10:25:35 INFO - Downloading https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/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 10:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/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 10:25:36 INFO - Downloaded 1199 bytes. 10:25:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 10:25:36 INFO - Using the following test package requirements: 10:25:36 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:25:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 10:25:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 10:25:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'jsshell-mac.zip'], 10:25:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 10:25:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 10:25:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 10:25:36 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 10:25:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 10:25:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 10:25:36 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 10:25:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:25:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:25:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:25:36 INFO - Fetch https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:25:37 INFO - Expected file size: 16438816 10:25:44 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 10:25:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 10:25:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:25:44 INFO - Fetch https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 10:25:44 INFO - Expected file size: 16438816 10:25:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 10:25:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:25:51 INFO - Fetch https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 10:25:52 INFO - Expected file size: 14414059 10:25: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')]} 10:25:52 INFO - trying https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:25:52 INFO - Downloading https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 10:25:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/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 10:25:55 INFO - Downloaded 111559119 bytes. 10:25:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:25:55 INFO - mkdir: /builds/slave/test/properties 10:25:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:25:55 INFO - Writing to file /builds/slave/test/properties/build_url 10:25:55 INFO - Contents: 10:25:55 INFO - build_url:https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 10:25:56 INFO - Running post-action listener: _resource_record_post_action 10:25:56 INFO - Running post-action listener: set_extra_try_arguments 10:25:56 INFO - [mozharness: 2016-09-23 17:25:56.288526Z] Finished download-and-extract step (success) 10:25:56 INFO - [mozharness: 2016-09-23 17:25:56.288658Z] Running populate-webroot step. 10:25:56 INFO - Running pre-action listener: _resource_record_pre_action 10:25:56 INFO - Running main action method: populate_webroot 10:25:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:25:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:25:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:25:56 INFO - '--tppagecycles', 10:25:56 INFO - '7'], 10:25:56 INFO - 'tests': ['tsvgm']}}, 10:25:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:25:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:25:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:25:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:25:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:25:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['damp', 'tps']}, 10:25:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'tests': ['damp', 'tps']}, 10:25:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['dromaeo_dom']}, 10:25:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:25:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['basic_compositor_video']}, 10:25:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:25:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['a11yr', 10:25:56 INFO - 'ts_paint', 10:25:56 INFO - 'tpaint', 10:25:56 INFO - 'sessionrestore', 10:25:56 INFO - 'sessionrestore_no_auto_restore', 10:25:56 INFO - 'tabpaint']}, 10:25:56 INFO - 'other-e10s': {'tests': ['a11yr', 10:25:56 INFO - 'ts_paint', 10:25:56 INFO - 'tpaint', 10:25:56 INFO - 'sessionrestore', 10:25:56 INFO - 'sessionrestore_no_auto_restore', 10:25:56 INFO - 'tabpaint']}, 10:25:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:25:56 INFO - 'ts_paint', 10:25:56 INFO - 'tpaint', 10:25:56 INFO - 'sessionrestore', 10:25:56 INFO - 'sessionrestore_no_auto_restore', 10:25:56 INFO - 'tabpaint']}, 10:25:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:25:56 INFO - 'ts_paint', 10:25:56 INFO - 'tpaint', 10:25:56 INFO - 'sessionrestore', 10:25:56 INFO - 'sessionrestore_no_auto_restore', 10:25:56 INFO - 'tabpaint']}, 10:25:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['a11yr', 10:25:56 INFO - 'ts_paint', 10:25:56 INFO - 'tpaint', 10:25:56 INFO - 'sessionrestore', 10:25:56 INFO - 'sessionrestore_no_auto_restore', 10:25:56 INFO - 'tabpaint']}, 10:25:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['a11yr', 10:25:56 INFO - 'ts_paint', 10:25:56 INFO - 'tpaint', 10:25:56 INFO - 'sessionrestore', 10:25:56 INFO - 'sessionrestore_no_auto_restore', 10:25:56 INFO - 'tabpaint']}, 10:25:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['tsvgx', 10:25:56 INFO - 'tsvgr_opacity', 10:25:56 INFO - 'tart', 10:25:56 INFO - 'tscrollx', 10:25:56 INFO - 'cart']}, 10:25:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:25:56 INFO - 'tsvgr_opacity', 10:25:56 INFO - 'tart', 10:25:56 INFO - 'tscrollx', 10:25:56 INFO - 'cart']}, 10:25:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'talos_options': ['--disable-e10s'], 10:25:56 INFO - 'tests': ['tp5o']}, 10:25:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'tests': ['tp5o']}, 10:25:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'talos_options': ['--disable-e10s', 10:25:56 INFO - '--xperf_path', 10:25:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:56 INFO - 'tests': ['tp5n']}, 10:25:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:25:56 INFO - 'talos_options': ['--xperf_path', 10:25:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:25:56 INFO - 'tests': ['tp5n']}}, 10:25:56 INFO - 'talos.zip': {'path': '', 10:25:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:25:56 INFO - Running post-action listener: _resource_record_post_action 10:25:56 INFO - [mozharness: 2016-09-23 17:25:56.307442Z] Finished populate-webroot step (success) 10:25:56 INFO - [mozharness: 2016-09-23 17:25:56.307578Z] Running create-virtualenv step. 10:25:56 INFO - Running pre-action listener: _resource_record_pre_action 10:25:56 INFO - Running main action method: create_virtualenv 10:25:56 INFO - Creating virtualenv /builds/slave/test/build/venv 10:25:56 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 10:25:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:25:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:25:56 INFO - Using real prefix '/tools/python27' 10:25:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:25:57 INFO - Installing distribute.............................................................................................................................................................................................done. 10:25:59 INFO - Installing pip.................done. 10:26:00 INFO - Return code: 0 10:26:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:00 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:00 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 10:26:00 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 10:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:00 INFO - 'HOME': '/Users/cltbld', 10:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:00 INFO - 'LOGNAME': 'cltbld', 10:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:00 INFO - 'MOZ_NO_REMOTE': '1', 10:26:00 INFO - 'NO_EM_RESTART': '1', 10:26:00 INFO - 'PAGER': '/bin/cat', 10:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:00 INFO - 'PWD': '/builds/slave/test', 10:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:00 INFO - 'SHELL': '/bin/bash', 10:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:00 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:00 INFO - 'USER': 'cltbld', 10:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:00 INFO - 'XPC_FLAGS': '0x0', 10:26:00 INFO - 'XPC_SERVICE_NAME': '0', 10:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:00 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 10:26:00 INFO - Cleaning up... 10:26:00 INFO - Return code: 0 10:26:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:00 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:00 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 10:26:00 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 10:26:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:00 INFO - 'HOME': '/Users/cltbld', 10:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:00 INFO - 'LOGNAME': 'cltbld', 10:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:00 INFO - 'MOZ_NO_REMOTE': '1', 10:26:00 INFO - 'NO_EM_RESTART': '1', 10:26:00 INFO - 'PAGER': '/bin/cat', 10:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:00 INFO - 'PWD': '/builds/slave/test', 10:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:00 INFO - 'SHELL': '/bin/bash', 10:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:00 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:00 INFO - 'USER': 'cltbld', 10:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:00 INFO - 'XPC_FLAGS': '0x0', 10:26:00 INFO - 'XPC_SERVICE_NAME': '0', 10:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:00 INFO - Downloading/unpacking psutil>=3.1.1 10:26:00 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 10:26:00 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 10:26:00 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 10:26:00 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 10:26:00 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 10:26:00 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 10:26:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:03 INFO - Installing collected packages: psutil 10:26:03 INFO - Running setup.py install for psutil 10:26:03 INFO - building 'psutil._psutil_osx' extension 10:26:03 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 10:26:04 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 10:26:04 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 10:26:04 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 10:26:04 INFO - building 'psutil._psutil_posix' extension 10:26:04 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 10:26:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:26:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:26:04 INFO - ^ 10:26:04 INFO - 1 warning generated. 10:26:04 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 10:26:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:26:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:26:04 INFO - Successfully installed psutil 10:26:04 INFO - Cleaning up... 10:26:04 INFO - Return code: 0 10:26:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:26:04 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:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:04 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:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:04 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:04 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 10:26:04 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 10:26:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:04 INFO - 'HOME': '/Users/cltbld', 10:26:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:04 INFO - 'LOGNAME': 'cltbld', 10:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:04 INFO - 'MOZ_NO_REMOTE': '1', 10:26:04 INFO - 'NO_EM_RESTART': '1', 10:26:04 INFO - 'PAGER': '/bin/cat', 10:26:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:04 INFO - 'PWD': '/builds/slave/test', 10:26:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:04 INFO - 'SHELL': '/bin/bash', 10:26:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:04 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:04 INFO - 'USER': 'cltbld', 10:26:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:04 INFO - 'XPC_FLAGS': '0x0', 10:26:04 INFO - 'XPC_SERVICE_NAME': '0', 10:26:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:05 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 10:26:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:26:07 INFO - Installing collected packages: mozsystemmonitor 10:26:07 INFO - Running setup.py install for mozsystemmonitor 10:26:07 INFO - Successfully installed mozsystemmonitor 10:26:07 INFO - Cleaning up... 10:26:07 INFO - Return code: 0 10:26:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:26:07 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:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:07 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:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:07 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:07 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 10:26:07 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 10:26:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:07 INFO - 'HOME': '/Users/cltbld', 10:26:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:07 INFO - 'LOGNAME': 'cltbld', 10:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:07 INFO - 'MOZ_NO_REMOTE': '1', 10:26:07 INFO - 'NO_EM_RESTART': '1', 10:26:07 INFO - 'PAGER': '/bin/cat', 10:26:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:07 INFO - 'PWD': '/builds/slave/test', 10:26:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:07 INFO - 'SHELL': '/bin/bash', 10:26:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:07 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:07 INFO - 'USER': 'cltbld', 10:26:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:07 INFO - 'XPC_FLAGS': '0x0', 10:26:07 INFO - 'XPC_SERVICE_NAME': '0', 10:26:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:08 INFO - Downloading/unpacking jsonschema==2.5.1 10:26:08 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 10:26:08 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 10:26:08 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 10:26:08 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 10:26:08 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 10:26:08 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 10:26:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:26:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:26:10 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 10:26:10 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 10:26:10 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 10:26:10 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 10:26:10 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 10:26:10 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 10:26:10 INFO - Downloading functools32-3.2.3-2.tar.gz 10:26:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:26:11 INFO - warning: no files found matching '*.txt' 10:26:11 INFO - no previously-included directories found matching 'build' 10:26:11 INFO - no previously-included directories found matching 'dist' 10:26:11 INFO - no previously-included directories found matching '.git*' 10:26:11 INFO - Installing collected packages: jsonschema, functools32 10:26:11 INFO - Running setup.py install for functools32 10:26:11 INFO - warning: no files found matching '*.txt' 10:26:11 INFO - no previously-included directories found matching 'build' 10:26:11 INFO - no previously-included directories found matching 'dist' 10:26:11 INFO - no previously-included directories found matching '.git*' 10:26:11 INFO - Successfully installed jsonschema functools32 10:26:11 INFO - Cleaning up... 10:26:11 INFO - Return code: 0 10:26:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:26:11 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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:11 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 10:26:11 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 10:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:11 INFO - 'HOME': '/Users/cltbld', 10:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:11 INFO - 'LOGNAME': 'cltbld', 10:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:11 INFO - 'MOZ_NO_REMOTE': '1', 10:26:11 INFO - 'NO_EM_RESTART': '1', 10:26:11 INFO - 'PAGER': '/bin/cat', 10:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:11 INFO - 'PWD': '/builds/slave/test', 10:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:11 INFO - 'SHELL': '/bin/bash', 10:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:11 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:11 INFO - 'USER': 'cltbld', 10:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:11 INFO - 'XPC_FLAGS': '0x0', 10:26:11 INFO - 'XPC_SERVICE_NAME': '0', 10:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:26:11 INFO - Cleaning up... 10:26:11 INFO - Return code: 0 10:26:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:26:11 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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:11 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:11 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 10:26:11 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 10:26:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:11 INFO - 'HOME': '/Users/cltbld', 10:26:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:11 INFO - 'LOGNAME': 'cltbld', 10:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:11 INFO - 'MOZ_NO_REMOTE': '1', 10:26:11 INFO - 'NO_EM_RESTART': '1', 10:26:11 INFO - 'PAGER': '/bin/cat', 10:26:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:11 INFO - 'PWD': '/builds/slave/test', 10:26:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:11 INFO - 'SHELL': '/bin/bash', 10:26:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:11 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:11 INFO - 'USER': 'cltbld', 10:26:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:11 INFO - 'XPC_FLAGS': '0x0', 10:26:11 INFO - 'XPC_SERVICE_NAME': '0', 10:26:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:11 INFO - Downloading/unpacking blobuploader==1.2.4 10:26:11 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 10:26:11 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 10:26:11 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 10:26:11 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 10:26:11 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 10:26:11 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 10:26:14 INFO - Downloading blobuploader-1.2.4.tar.gz 10:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:26:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:26:14 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 10:26:14 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 10:26:14 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 10:26:14 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 10:26:14 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 10:26:14 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 10:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:26:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:26:15 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 10:26:15 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 10:26:15 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 10:26:15 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 10:26:15 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 10:26:15 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 10:26:15 INFO - Downloading docopt-0.6.1.tar.gz 10:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:26:15 INFO - Installing collected packages: blobuploader, requests, docopt 10:26:15 INFO - Running setup.py install for blobuploader 10:26:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:26:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:26:15 INFO - Running setup.py install for requests 10:26:16 INFO - Running setup.py install for docopt 10:26:16 INFO - Successfully installed blobuploader requests docopt 10:26:16 INFO - Cleaning up... 10:26:16 INFO - Return code: 0 10:26:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:16 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:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:16 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:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:16 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:16 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 10:26:16 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 10:26:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:16 INFO - 'HOME': '/Users/cltbld', 10:26:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:16 INFO - 'LOGNAME': 'cltbld', 10:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:16 INFO - 'MOZ_NO_REMOTE': '1', 10:26:16 INFO - 'NO_EM_RESTART': '1', 10:26:16 INFO - 'PAGER': '/bin/cat', 10:26:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:16 INFO - 'PWD': '/builds/slave/test', 10:26:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:16 INFO - 'SHELL': '/bin/bash', 10:26:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:16 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:16 INFO - 'USER': 'cltbld', 10:26:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:16 INFO - 'XPC_FLAGS': '0x0', 10:26:16 INFO - 'XPC_SERVICE_NAME': '0', 10:26:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:16 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-jgiC2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:16 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-M0Ccfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:16 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-qcatGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-_TkOax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-1j1UB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-peRrIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-J8cKLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-UwFLKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-56BIIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-whQpFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-diPfnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:17 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-mGnNUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:18 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-fIDFPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:18 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-Dus6tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:18 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-_cqk8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:18 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-N751o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:18 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-kXRr8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:26:18 INFO - Running setup.py install for manifestparser 10:26:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:26:18 INFO - Running setup.py install for mozcrash 10:26:18 INFO - Running setup.py install for mozdebug 10:26:18 INFO - Running setup.py install for mozdevice 10:26:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Running setup.py install for mozfile 10:26:19 INFO - Running setup.py install for mozhttpd 10:26:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Running setup.py install for mozinfo 10:26:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Running setup.py install for mozInstall 10:26:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:26:19 INFO - Running setup.py install for mozleak 10:26:19 INFO - Running setup.py install for mozlog 10:26:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:26:20 INFO - Running setup.py install for moznetwork 10:26:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:26:20 INFO - Running setup.py install for mozprocess 10:26:20 INFO - Running setup.py install for mozprofile 10:26:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:26:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:26:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:26:20 INFO - Running setup.py install for mozrunner 10:26:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:26:20 INFO - Running setup.py install for mozscreenshot 10:26:20 INFO - Running setup.py install for moztest 10:26:20 INFO - Running setup.py install for mozversion 10:26:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:26:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:26:21 INFO - Cleaning up... 10:26:21 INFO - Return code: 0 10:26:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26:21 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:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:21 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:26:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:21 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:21 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 10:26:21 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 10:26:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:21 INFO - 'HOME': '/Users/cltbld', 10:26:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:21 INFO - 'LOGNAME': 'cltbld', 10:26:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:21 INFO - 'MOZ_NO_REMOTE': '1', 10:26:21 INFO - 'NO_EM_RESTART': '1', 10:26:21 INFO - 'PAGER': '/bin/cat', 10:26:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:21 INFO - 'PWD': '/builds/slave/test', 10:26:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:21 INFO - 'SHELL': '/bin/bash', 10:26:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:21 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:21 INFO - 'USER': 'cltbld', 10:26:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:21 INFO - 'XPC_FLAGS': '0x0', 10:26:21 INFO - 'XPC_SERVICE_NAME': '0', 10:26:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:26:21 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-e19wrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:26:21 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)) 10:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:26:21 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-t2MELv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:26:21 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)) 10:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:26:21 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-5Qgt2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:26:21 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)) 10:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:26:21 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-PgcJ1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:26:21 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)) 10:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:26:21 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-KhMOfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:26:21 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)) 10:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:26:21 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-rJH_pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-Ws8zON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-YLMPJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-PIT0QY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-KKXzIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-1OZB08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-XbSH43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-IuoWCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-eUziFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:26:22 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)) 10:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:22 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-52tb3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:26:23 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)) 10:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:26:23 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-pojAb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:26:23 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)) 10:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:26:23 INFO - Running setup.py (path:/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/pip-cwG1hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:26:23 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)) 10:26:23 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)) 10:26:23 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)) 10:26:23 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)) 10:26:23 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)) 10:26:23 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)) 10:26:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:26:23 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 10:26:23 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 10:26:23 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 10:26:23 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 10:26:23 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 10:26:23 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 10:26:25 INFO - Downloading blessings-1.6.tar.gz 10:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:26:25 INFO - Installing collected packages: blessings 10:26:25 INFO - Running setup.py install for blessings 10:26:25 INFO - Successfully installed blessings 10:26:25 INFO - Cleaning up... 10:26:26 INFO - Return code: 0 10:26:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:26 INFO - Reading from file tmpfile_stdout 10:26:26 INFO - Current package versions: 10:26:26 INFO - blessings == 1.6 10:26:26 INFO - blobuploader == 1.2.4 10:26:26 INFO - docopt == 0.6.1 10:26:26 INFO - functools32 == 3.2.3-2 10:26:26 INFO - jsonschema == 2.5.1 10:26:26 INFO - manifestparser == 1.1 10:26:26 INFO - mozInstall == 1.12 10:26:26 INFO - mozcrash == 0.17 10:26:26 INFO - mozdebug == 0.1 10:26:26 INFO - mozdevice == 0.48 10:26:26 INFO - mozfile == 1.2 10:26:26 INFO - mozhttpd == 0.7 10:26:26 INFO - mozinfo == 0.9 10:26:26 INFO - mozleak == 0.1 10:26:26 INFO - mozlog == 3.4 10:26:26 INFO - moznetwork == 0.27 10:26:26 INFO - mozprocess == 0.23 10:26:26 INFO - mozprofile == 0.28 10:26:26 INFO - mozrunner == 6.12 10:26:26 INFO - mozscreenshot == 0.1 10:26:26 INFO - mozsystemmonitor == 0.3 10:26:26 INFO - moztest == 0.7 10:26:26 INFO - mozversion == 1.4 10:26:26 INFO - psutil == 3.1.1 10:26:26 INFO - requests == 1.2.3 10:26:26 INFO - wsgiref == 0.1.2 10:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26:26 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 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26:26 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 10:26:26 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 10:26:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:26 INFO - 'HOME': '/Users/cltbld', 10:26:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:26 INFO - 'LOGNAME': 'cltbld', 10:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:26 INFO - 'MOZ_NO_REMOTE': '1', 10:26:26 INFO - 'NO_EM_RESTART': '1', 10:26:26 INFO - 'PAGER': '/bin/cat', 10:26:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:26 INFO - 'PWD': '/builds/slave/test', 10:26:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:26 INFO - 'SHELL': '/bin/bash', 10:26:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:26 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:26 INFO - 'USER': 'cltbld', 10:26:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:26 INFO - 'XPC_FLAGS': '0x0', 10:26:26 INFO - 'XPC_SERVICE_NAME': '0', 10:26:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 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)) 10:26:26 INFO - Cleaning up... 10:26:26 INFO - Return code: 0 10:26:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:26: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')]} 10:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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')]} 10:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b5ac490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b522570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfcada1cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, '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.P9iYAeJLGT/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.Dato3oxocj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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 10:26: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', 'jsonschema'] in /builds/slave/test/build 10:26: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 jsonschema 10:26:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:26:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:26:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:26:26 INFO - 'HOME': '/Users/cltbld', 10:26:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:26:26 INFO - 'LOGNAME': 'cltbld', 10:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:26:26 INFO - 'MOZ_NO_REMOTE': '1', 10:26:26 INFO - 'NO_EM_RESTART': '1', 10:26:26 INFO - 'PAGER': '/bin/cat', 10:26:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:26:26 INFO - 'PWD': '/builds/slave/test', 10:26:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:26:26 INFO - 'SHELL': '/bin/bash', 10:26:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:26:26 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:26:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:26:26 INFO - 'USER': 'cltbld', 10:26:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:26:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:26:26 INFO - 'XPC_FLAGS': '0x0', 10:26:26 INFO - 'XPC_SERVICE_NAME': '0', 10:26:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:26:26 INFO - Cleaning up... 10:26:26 INFO - Return code: 0 10:26:26 INFO - Running post-action listener: _resource_record_post_action 10:26:26 INFO - Running post-action listener: _start_resource_monitoring 10:26:26 INFO - Starting resource monitoring. 10:26:26 INFO - [mozharness: 2016-09-23 17:26:26.859376Z] Finished create-virtualenv step (success) 10:26:26 INFO - [mozharness: 2016-09-23 17:26:26.860493Z] Running install step. 10:26:26 INFO - Running pre-action listener: _resource_record_pre_action 10:26:26 INFO - Running main action method: install 10:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:26:27 INFO - Reading from file tmpfile_stdout 10:26:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:26:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:26:27 INFO - Reading from file tmpfile_stdout 10:26:27 INFO - Output received: 10:26:27 INFO - Usage: mozinstall [options] installer 10:26:27 INFO - Options: 10:26:27 INFO - -h, --help show this help message and exit 10:26:27 INFO - -d DEST, --destination=DEST 10:26:27 INFO - Directory to install application into. [default: 10:26:27 INFO - "/builds/slave/test"] 10:26:27 INFO - --app=APP Application being installed. [default: firefox] 10:26:27 INFO - mkdir: /builds/slave/test/build/application 10:26:27 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'] 10:26:27 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:27:01 INFO - Reading from file tmpfile_stdout 10:27:01 INFO - Output received: 10:27:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:27:01 INFO - Running post-action listener: _resource_record_post_action 10:27:01 INFO - [mozharness: 2016-09-23 17:27:01.435771Z] Finished install step (success) 10:27:01 INFO - [mozharness: 2016-09-23 17:27:01.435912Z] Running run-tests step. 10:27:01 INFO - Running pre-action listener: _resource_record_pre_action 10:27:01 INFO - Running main action method: run_tests 10:27:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:27:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:27:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:27:01 INFO - 2016-09-23 10:27:01.450 screenresolution[1959:13100] starting screenresolution argv=screenresolution get 10:27:01 INFO - 2016-09-23 10:27:01.453 screenresolution[1959:13100] Display 0: 1600x1200x32@60 10:27:01 INFO - 2016-09-23 10:27:01.459 screenresolution[1960:13102] starting screenresolution argv=screenresolution list 10:27:01 INFO - Available Modes on Display 0 10:27:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:27:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:27:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:27:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:27:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:27:01 INFO - Intel Iris: 10:27:01 INFO - Chipset Model: Intel Iris 10:27:01 INFO - Type: GPU 10:27:01 INFO - Bus: Built-In 10:27:01 INFO - VRAM (Dynamic, Max): 1536 MB 10:27:01 INFO - Vendor: Intel (0x8086) 10:27:01 INFO - Device ID: 0x0a2e 10:27:01 INFO - Revision ID: 0x0009 10:27:01 INFO - Displays: 10:27:01 INFO - Display: 10:27:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:27:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:27:01 INFO - Display Serial Number: 1600x1200 60 10:27:01 INFO - Main Display: Yes 10:27:01 INFO - Mirror: Off 10:27:01 INFO - Online: Yes 10:27:01 INFO - Rotation: Supported 10:27:01 INFO - Return code: 0 10:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:27:01 INFO - Python 2.7.3 10:27:01 INFO - Return code: 0 10:27:01 INFO - grabbing minidump binary from tooltool 10:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:27:01 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 0x10b3c0d30>, '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 0x10b1e6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b3b8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:27:01 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:27:01 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:27:01 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:27:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:27:01 INFO - Return code: 0 10:27:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:27:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:27:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:27:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:27:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:27:01 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/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--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:27:01 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/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0266 --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:27:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P9iYAeJLGT/Render', 10:27:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:27:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:27:01 INFO - 'HOME': '/Users/cltbld', 10:27:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:27:01 INFO - 'LOGNAME': 'cltbld', 10:27:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:27:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:27:01 INFO - 'MOZ_NO_REMOTE': '1', 10:27:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:27:01 INFO - 'NO_EM_RESTART': '1', 10:27:01 INFO - 'PAGER': '/bin/cat', 10:27:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:27:01 INFO - 'PWD': '/builds/slave/test', 10:27:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:27:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:27:01 INFO - 'SHELL': '/bin/bash', 10:27:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Dato3oxocj/Listeners', 10:27:01 INFO - 'TMPDIR': '/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/', 10:27:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:27:01 INFO - 'USER': 'cltbld', 10:27:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:27:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:27:01 INFO - 'XPC_FLAGS': '0x0', 10:27:01 INFO - 'XPC_SERVICE_NAME': '0', 10:27:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:27:01 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/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0266', '--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:27:02 INFO - mozversion application_buildid: 20160923072200 10:27:02 INFO - mozversion application_changeset: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 10:27:02 INFO - mozversion application_display_name: Nightly 10:27:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:27:02 INFO - mozversion application_name: Firefox 10:27:02 INFO - mozversion application_remotingname: firefox 10:27:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:27:02 INFO - mozversion application_vendor: Mozilla 10:27:02 INFO - mozversion application_version: 52.0a1 10:27:02 INFO - mozversion platform_buildid: 20160923072200 10:27:02 INFO - mozversion platform_changeset: 55a83c8bfcbc3dd8b1d324883c1e68fd6d5bddf8 10:27:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:27:02 INFO - mozversion platform_version: 52.0a1 10:27:02 INFO - using testdate: 1474651622 10:27:02 INFO - actual date: 1474651622 10:27:02 INFO - starting webserver on 'localhost:52001' 10:27:02 INFO - SUITE-START | Running 2 tests 10:27:02 INFO - TEST-START | dromaeo_css 10:27:02 INFO - operating with platform_type : mac_ 10:27:02 INFO - Initialising browser for dromaeo_css test... 10:27:02 INFO - TEST-INFO | started process 1970 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpyhcERw/profile http://localhost:52001/getInfo.html) 10:27:04 INFO - PROCESS | 1970 | 2016-09-23 10:27:04.684 plugin-container[1972:13253] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3b, name = 'com.apple.tsm.portname' 10:27:04 INFO - PROCESS | 1970 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:04 INFO - PROCESS | 1970 | 2016-09-23 10:27:04.688 plugin-container[1972:13253] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b17, name = 'com.apple.CFPasteboardClient' 10:27:04 INFO - PROCESS | 1970 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:04 INFO - PROCESS | 1970 | 2016-09-23 10:27:04.688 plugin-container[1972:13253] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:04 INFO - PROCESS | 1970 | __metrics Screen width/height:1600/1200 10:27:04 INFO - PROCESS | 1970 | colorDepth:24 10:27:04 INFO - PROCESS | 1970 | Browser inner width/height: 1024/689 10:27:04 INFO - PROCESS | 1970 | __metrics 10:27:04 ERROR - PROCESS | 1970 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 10:27:05 INFO - TEST-INFO | 1970: exit 0 10:27:05 INFO - Browser initialized. 10:27:05 INFO - Running cycle 1/1 for dromaeo_css test... 10:27:05 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpyhcERw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:08 INFO - PROCESS | 1973 | 2016-09-23 10:27:08.341 plugin-container[1974:13365] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.tsm.portname' 10:27:08 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:08 INFO - PROCESS | 1973 | 2016-09-23 10:27:08.347 plugin-container[1974:13365] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f07, name = 'com.apple.CFPasteboardClient' 10:27:08 INFO - PROCESS | 1973 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:27:08 INFO - PROCESS | 1973 | 2016-09-23 10:27:08.347 plugin-container[1974:13365] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:27:17 INFO - PROCESS | 1973 | RSS: Main: 243077120 10:27:17 INFO - PROCESS | 1973 | 10:28:07 INFO - PROCESS | 1973 | 1474651687486 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:30:18 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:52001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52001/tests/dromaeo/cssquery-ext.html) 10:30:20 INFO - PROCESS | 1973 | RSS: Main: 258527232 10:30:20 INFO - PROCESS | 1973 | 10:33:22 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:52001/tests/dromaeo/cssquery-ext.html (next: http://localhost:52001/tests/dromaeo/cssquery-jquery.html) 10:33:23 INFO - PROCESS | 1973 | RSS: Main: 267030528 10:33:23 INFO - PROCESS | 1973 | 10:36:25 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:52001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52001/tests/dromaeo/cssquery-mootools.html) 10:36:26 INFO - PROCESS | 1973 | RSS: Main: 273866752 10:36:26 INFO - PROCESS | 1973 | 10:39:27 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:52001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52001/tests/dromaeo/cssquery-prototype.html) 10:39:28 INFO - PROCESS | 1973 | RSS: Main: 273567744 10:39:28 INFO - PROCESS | 1973 | 10:42:31 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:52001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52001/tests/dromaeo/cssquery-yui.html) 10:42:32 INFO - PROCESS | 1973 | RSS: Main: 278990848 10:42:32 INFO - PROCESS | 1973 | 10:45:34 INFO - PROCESS | 1973 | Cycle 1(1): loaded http://localhost:52001/tests/dromaeo/cssquery-yui.html (next: http://localhost:52001/tests/dromaeo/cssquery-dojo.html) 10:45:35 INFO - PROCESS | 1973 | RSS: Main: 281767936 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | __start_tp_report 10:45:35 INFO - PROCESS | 1973 | _x_x_mozilla_page_load 10:45:35 INFO - PROCESS | 1973 | _x_x_mozilla_page_load_details 10:45:35 INFO - PROCESS | 1973 | |i|pagename|runs| 10:45:35 INFO - PROCESS | 1973 | |0;dojo.html;2955.8522073896306;3181.743211431484;3358.2947581008;3373.207296285371;3379.138319728469;4670.1827180243445;5109.923351149727;5317.59083842782;5622.4939755422;5648.604597678164;4629.328747331635;5561.4716601922855;5643.548516118711;5729.0833466645345;5730.856728581787;4540.75129339431;4633.6524760642915;5063.721495317765;5175.042617115846;5188.195829646411;4655.3462351987755;5158.097332966735;5173;5252.606054545905;5321.680699158043;5068.847934561969;5219.295395121648;5224.738763061831;5238.266642670029;5277.023750606131;5122.564582010534;5127.102757017507;5151.098557752378;5168.741562921877;5210.140326846066;5125.769340379692;5149.253358263069;5173.3016042834115;5177.818776342848;5231.927454871742;5669.971650141723;5681.801136960186;5741.511971482429;5744.368119506851;5748.310202775652;6114.145302971524;6123.601965872204;6143.262808462969;6159.469135247669;6205.844853878644;6180.474659653934;6221.657808820513;6236.064590311489;6240.31356550779;6244.750209991595;5674.971625141848;5736.6558006519745;5815.389384114649;5834.416558344132;5874.3244526879525;6140.04415716754;6151.630902145796;6217.564770466114;6243.875122497525;6272.278687950853;5985.401459854067;6001.159837622649;6014.037753959433;6016.608920420159;6066.332703402622;6093.634381937098;6122.66325352101;6132.63204207749;6145.784897528565;6155.876882462326;5975.67133807636;6093.146959425684;6162.044883043135;6163.3528479509005;6212.875742485125;6149.354317796657;6237.844053898689;6241.906371404432;6254.468370188494;6256.436920677161;4816.036792641416;4877.097736918681;4909.4354149273295;4916.729579873141;4919.0899683558655;4370.344448332776;4378.452693413324;4398.076403955141;4461.687681862239;4492.977535112369;5015.423226329019;5868.38381969887;5878.617889837147;5885.646861188342;5888.911666325009;6193.287771906198;6244.12582238487;6244.812655620339;6246.875062498724;6275.780347687809;5659.5755318351285;5752.482276595127;5798.652080875161;5820.30156381237;5849.473547380671;5342.252084708144;5374.435684253175;5383.031054410166;5386.649867758583;5411.918821217685;6258.906116408258;6262.34245404226;6283.05754136874;6293;6293.244810622755;5120;5393.514583687487;5906.616069955439;6106.339326077157;6232.906506402498;6235.3452887446165;6244.843878903063;6252.687365631791;6258.311585725658;6264.2796078451565;4782.947751494666;5682.431756824284;6122.877542449215;6132.540059495466;6150.077488376779;4762.690425122356;5076.746162691925;6100.581173165739;6125.662799505599;6176.567640265138;6079.787207447718;6126.090206827809;6128.080787881675;6140.754369825336;6144.218176728698;6084.239470066242;6091.7563297467605;6093.969530152498;6099.969500152471;6103.511719062376;4556.567126123013;4985.177445721561;5028.969061342489;5792.362840087671;5933.080372542263;5502.202180683698;5934.139549765174;6039.033754599419;6070.969645151746;6136.478399336106;4840.2255639097575;5914.526837853047;5918.852028699317;5956.791512297049;5973.940260597338 10:45:35 INFO - PROCESS | 1973 | |1;ext.html;457.7207903179058;488.9975550122249;519.4182515582548;521.7078436075798;526.739264064288;39173.412398814005;41091.58908410919;41123.58876411243;41138.382924256126;41235.79382103085;34531.482027769605;41928;41931.79034104833;42471.362929556;42516.36225456613;9711.22310215183;9852.753681157992;9913.65302214419;9940.801183976317;9953;9740;9825.901740982606;9837.262205334593;9841.557129929135;9858.457784821832;9794.951025244864;9851.65519206828;9858.704238872846;9871.703848884545;9888.456134912576;9043.502607356593;9169.954150229272;9787.217022638171;9814.263930205192;9843.409395436296;9656.179224765903;9730.464824434654;9736.172425343855;9753.170980466668;9757.804843903154;40657;40989;40991.18017639661;41012.589874101475;41075.973100672425;3317.2204531934976;3457.396748660134;3534.929301413983;3536.876209332661;3578.248567800765;30703;31000.53499197514;31272.843635781905;31728.365432691447;31858.522122168186;3231.5475833383343;3258.5926759155104;3269.051974927268;3294.1435226840954;3353;455678;457408;457573.9999999967;459496.7025164886;459574;32513;33261.16847078794;57911.42088579144;58260.70869645625;58527.4147258522;33036.66963330336;33100.00699979004;33308.66691333104;33320.83377081839;33437.498437523456;14153.009289349853;14230.00389972692;14272.857271427152;14289.714205716036;14310.713785724227;10271.281010329354;11108.889111088987;12053.156279060382;12175.208611440228;12187.756244875052;7683.807904802313;7691.192424795316;7758.612069396508;7771.261730135628;7800.726974555977;2934.5158048922117;3212.3414699986447;3268.428025095599;3271.116798464401;3303.7026667599553;889.8442772514913;895.3821862914568;961.4615815143542;999.0758548342753;1009.1573536097294;27159.45681086367;28871.85564072166;29498.410031799245;29929.850350748544;30877.8456107718;1002.9648962286285;1057.1754031855164;1066.429460238784;1106.623747925709;1148.179051977823;15545.689086218212;15620.687586248212;15645.608859778597;15651.608709782347;16137.838621613868;591150.044249776;594664;596285;596985;608436;53492.46507534953;56614.43385566174;56857;57071.57321067007;57134.142987855215;1327.2036777933356;1329.6011196640968;1372.6980064385818;1374.780035194384;1376.6833628265556;29296.121116366543;29704.851475742482;29815;30311;30377;49111.75444122757;49363.50636493589;49374.75312623558;49567.75216123896;49670;507773;532419;533016;535797;537332;25996.480070398866;26038.609420858324;26442;26475.735242647326;26479.940802367688;43416.13167736691;43424.56575434332;43549.56450435455;45530.08939821119;45667.54332456633;38608.42087368636;39103;39104.608953911236;39323.606763931995;40190.99522511961;30274.09177724672;33715;36139;37979;38097.80951095227;31553.684463155994;32161.67838321587;35947.82026089957;36499.45250821186;37592.62407375891;32737.34525309528;33372.66627333696;34076.14809629779;34424.13939651529;34599.481007785405;24127.517449650557;25039.499210016063;25118.372040699127;25547.74452255528;25689.33019353736 10:45:35 INFO - PROCESS | 1973 | |2;jquery.html;361.9981900090499;365.4317536231161;369.59529315399647;377.3132898125409;394.78286942181813;18546.721799173025;19849.20603175875;20118.59762804743;20367.592648147045;20525.794742052574;19500.122494487747;19748.407547773553;19980.90105044222;20028.799712002874;20342;4711.340412342275;5857.26784151981;6062.33314335425;6064.818055458343;6097.542684298695;5960.0761881908375;5969.552283578749;6060.878782424371;6069.848253793669;6078.240219972504;5293.417724050351;5558.555315574744;5998.1602575639445;6017.458428741413;6074.392560743912;5556.805511807108;5690.118031705092;6095.512359011291;6114.144019837227;6147.846303842417;4980.277859710358;5750.769969201227;5951.166836642873;6002.399760024006;6015.548833837436;12825.35873206336;13071.08502404832;13096.738065238736;13111.409986550629;13320.533781317607;2248.9887550562307;2341.5316936612744;2386.4749755054036;2536.4546622476255;2822.590724344979;9484.525773711286;9993.850092248622;10203.897961020442;10259.846102308471;10344.5344959477;1746.1967494952337;1888.4051523769967;1911.3788018893915;1935.6709359408935;1956.0708663384921;108431;122777.38611306976;123929;124967;125520;11047.889521104686;11339.015672257487;11391.829122563167;11491.942540287246;11926.761464770829;14174;14281.357338919774;14311.78532322016;14327.713445731028;14363.92818035924;8224.013118425828;8465.957670211732;8478.06741258461;8609.513147175405;8647.481151130953;8384.790380240544;8394.076651568323;8441.240288373952;8541.95729021351;8550.18773216556;4429.512753597101;4480.193565158303;4518.43519560055;4612.446506419184;4648.233041548175;1913.933012344589;1919.1172060851886;1948.123344494983;1958.2362878477404;1990.532224927141;846.4751853850652;883.2448256740395;894.6197865907094;902.1911068308001;1022.2026819081128;19386.321478748177;20273.59452810965;20499;20512.692309615366;20685.17259309641;871.1549796697194;901.6844104563481;924.5469719837366;933.7992331648728;988.649029594498;10252.795648935515;10737.302075365076;10762.677119686421;10775.892241077489;10798.082163016232;497396;512378;538983;541280.7615771533;543803;86870;108562.45718771356;111505;119568.4021579904;127369;984.625842179967;1004.1314263162312;1044.8850626431085;1045.6810672744734;1047.5076713944434;18306.81693183051;18449.53876153107;18767.812321876605;18818.9649569275;19092.522686932938;52567;52921;53008.73495632497;54649.45350546444;54949.45050549603;81709;82288.58855705684;82441;83249.92375647895;83686.58156709178;7773.795061765435;7893.97378340812;7941.086775020715;8040.879386809085;8061.39539534549;10383.53274102652;12234.510619575118;12555;12729.809052864399;12960.740785184433;7576.62116894142;8944.329175311748;9591.896931852927;11182.217244793112;11263.7747245053;10740.946295268473;10835.295705779099;11089.168312376765;11120.833187502356;11303.321800691985;9517.619295228113;10083.546240419051;10844.783104338027;11119.27724697892;11357.37534435614;7650.6174691264105;7814.21857814214;7884.84230315402;8021.919780802117;8065.395095367753;10028.799424011333;10467.214958878267;10978.725531861768;11044.337339759319;11059.83410248863 10:45:35 INFO - PROCESS | 1973 | |3;mootools.html;1512.9773053404201;1557.6728886933743;1742.9912850435746;1845.095903007526;1860.469766116657;8073.51558906466;8329.416940814146;8540.530270835101;9118.863217051741;9137.131972462614;8564.48613083214;8847.601857916394;8864.77838054049;9009.639614415415;9025.638974441032;2062.3091264426434;2375.821813363996;2403.891824867885;2407.590709579376;2410.963835542468;2278.874661893595;2335.1593426366494;2410.602250628644;2422.7092748870073;2423.430493833948;2108.251570692405;2135.2740068376747;2305.7348404933477;2396.065534441569;2402.4474370894704;2356.634721618152;2362.102401087593;2379.4289370551114;2387.8209134314907;2391.2587097999676;2323.4191452136965;2329.5340931813535;2335.4161459635093;2335.6846825678485;2341.730700969393;8921.821563568757;9119.726408207764;9124.22444092253;9139.223166030895;9148.771280717969;5266.631335806495;5296.947030529723;5444.945550544483;5455.290812194389;5459.12653975362;3514.2620049789575;3668.413053911388;3698.8890333290046;3713;3718.609545997658;1053.6944286157004;1087.037971395313;1092.4428541443842;1100.9394483303415;1110.8500352452397;11866.466009029615;11894.82157767634;11935.283882967136;12000.21998570099;12000.63998080059;4162.438070860395;4181.832726690959;4655;4903.289023091632;4916.5820905222745;10174.4912754362;10281.794364112677;10283.691489255334;10287.639932602324;10293.485325733684;5434.809781657702;5470.152126420411;5474.09677403224;5474.288342515448;5489.560835133179;4435.866923992286;4639.164950308909;4765.594924431392;4914.852554423373;4991.9500804991485;3413.385590593717;3950.249452603996;3963.9405408918888;3974.3839704845795;4127.772972486542;1288.5168061976758;1302.4920281090383;1304.0480449272084;1310.9381401064977;1315.0860152194325;803.0483876606123;835.4694768821842;859.7119964811733;907.0022974727747;975.23444096384;5909.704514774244;5937.30786725781;5983.431574000463;6111.205543279345;6164.3835616438;423.4812354865327;823.7446391618618;949.0177666115675;1026.2867307221409;1054.0987455725244;3688.8524459021337;3941.467901833273;3996.620321069494;4014.3777714454304;4195.8741237762915;10678.893211067945;11035;11114.333140011626;11121.388323642115;11145;11060.115190784718;11065.668029959113;11075.667729968114;11085.057770089632;11097.00126988575;6841.62371069586;7830.09953855314;8231.547264900368;8232.423730338818;8412.957935210407;5971.910421343597;5981.983062879234;6072.908906366496;6116.235470566179;6210.906836397548;9826.115649591571;9829.754256143653;9895.25785566071;9963.452010139512;9973.401595904268;9563.139317461462;9674.564644591152;10108.797824043624;10116.393016419039;10173.847392288973;7095.858082838417;7288.817779555554;7532.924670753222;7571.810704732426;7629.046369203849;8509.10654381281;8647.26498247656;8756.204977979627;8768.693095741619;8895.644174232959;7541.283578060075;7697.846043078995;7751.108622508258;7827.452078354689;7869.803254918673;7465.477416580788;7571.621418928921;7574.545527268381;7621.847563048819;7739.92260077392;7135.750248741269;7177.892331614926;7228.855422891407;7247.9637601811655;7252.202257751748;4977.800887964441;4999;5068.113080211022;5109.131447653982;5247.422783493889;5078.3435926133125;5131.846044618667;5224.477552244745;5262.736863156751;5285.445028271976 10:45:35 INFO - PROCESS | 1973 | |4;prototype.html;303.7327152106147;307.55404663238295;312.9014360476449;313.1841552755073;314.7104663709387;4817.277408388743;5207.843764687065;5542.863712938848;5576.498115169634;5585.413531579182;4719.43366795985;5465.453454654533;5470.288862447876;5476.534494567956;5526.806561770329;3454.585449746034;3477.704395126411;3981.641652251297;4126.834926602933;4172.499300083979;3245.9837700811463;3522.982385088071;3978.8964607606113;4188.853390131346;4192.5807419258135;3110.813351198924;3685.318216130011;3859.9192226176574;4208.22147902639;4235.74585524868;3378.577677790276;4060.045889216032;4195.958040419588;4228.386883901832;4241.618254357092;3425.9657403426145;3432.4164891968426;3631;3643.2895585360866;3656.524651795276;4738.976305118486;5348.224507446437;5423.132298832168;5441.782328706847;5443.815368009719;4419.049904270597;4850.514948505156;4857.319975203474;4857.489963553811;4873.2699891538705;4957.950420495821;5306.442823503515;5768.74040668171;5872.0898260769645;5876.853078673024;3474.9575127461662;3949.1311911379453;3968.146848427602;3969.6625786808154;3983.0042489377656;5709.828705138811;5853;6077.848053798646;6195.44241018306;6200.782972595983;3923.588023257574;4013.7591744495426;4025.2352053109817;4030.0730831908827;4043.5132393578324;4035.435039094529;4049.797510124482;4063.1151882163404;4107.603414838909;4120.505539335299;4402.833249188903;4765.546508314927;4794.496577859344;4800.295894957309;4837.443693975238;4696.872750539846;4882.731449770296;5376.6505177164145;5838.824835254949;5891.675957822361;1075.1398880895254;1251.7997120460682;1289.1878116786365;1312.835895513061;1348.1978222957325;753.7135888362387;798.4650284309527;842.5871323051783;850.459957926721;852.7953291210065;4765.73788441639;5198.454162312978;5326.227696983993;5527.889442211133;5578.736439183123;5369.838904832861;6069.908951365733;6077.693295941393;6113.786017489367;6131.96934015336;5027.572656324181;5187.740612969336;5325.591621362331;5452.59105567084;5627.943720562742;2649.536331142081;2887.768978481716;3124.281415274454;3171.3340198558562;3179.1878629181147;5010.248462730547;5251.789928402897;5852.502537284378;6204.162438070893;6297.527685423612;5546.389897111315;5816.360200377955;5830.7084645767545;5864.299353187528;5904.988455887443;5923.526117910471;6282.654454005074;6293.527985401113;6300.9684951574945;6309.769594929036;4845.8061677532505;5705.115707065412;5928.970355148369;6008.309044459943;6151.538634602333;5876.206712093813;5924.585279030426;5941.732622032106;5982.4017598239825;6003.549733770072;5502.752376143163;5658.688772117573;5710.5717071219;5730.856728581819;6257.624542527463;3690.8189379398336;3710.6845918096183;3939.428782826417;3975.8807235782974;4012.3981402789814;4933.901321973469;5329.653572517774;5650.84157747669;6033.58210820448;6070.575059745775;4743.217369134054;4880;4891.486393928586;5818.505427038749;5878.823635290948;5175.560077393464;5651.350094739158;5827.70861456917;5830.53355731549;5851.882962340815;5700.315962084576;5726.026575482095;5727.656340619576;5729.140628905698;5739.770409183586;5071.210834041189;5364.570834333166;5446.346438427414;5515.751791169327;5842.123681447817;5285.630005899704;5529.336479622471;5559.749811258423;5695.202671625892;5733.9392212440835 10:45:35 INFO - PROCESS | 1973 | |5;yui.html;714.8570285942809;719.4028955966546;749.5165618176277;770.4953255617565;806.5201205282855;15371;16233.26950287237;16275.674486510263;16280.918595407036;16330.755038674415;14608.342624581892;14711.632209194775;14851.331690073946;14921.850781492181;14953.252337383141;666.9299723529033;692.5360008794095;828.9306794235429;836.9623366948487;868.8132051608903;844.8859403980446;853.0445900591346;858.4119877883638;858.7681326041965;862.1852349529697;908.8227795579832;915.5651065743751;915.6337465014014;918.8070505193884;919.0946917286467;902.7066203483894;904.891413030434;905.5110240470106;905.6467977488785;910.3536489092719;680.5610381304031;685.2120061928822;686.8866637004938;687.6871023684212;687.9896801547981;15395.384184632601;15512;15549.689006219813;15557.611059723598;15565.299561519645;14833.629159270997;14852.62868428298;14878.330475128645;14880.255987200704;14924.850751492564;11893.702657433547;12076.818847717292;12087.335196564185;12311.015118790476;12447.502099915993;3752.624737526253;3793.430985352192;3962.7622342659533;3991.521017477892;3996.200759848042;109981.45009274983;112016;112832.4358378211;113277.4336128314;113381.433092834;11150.330980141218;11168.274062185932;11236.606718764968;11276.32342059479;11580.76838463226;23664.763352366255;23756.287311380685;23768.286951391485;23796.810159491957;23853.880730596582;7111.502194846415;7152.785416437515;8106.959465202636;8244.876326855101;8296.211859873303;3706.5366829146355;3918;4079.7348172369293;4200.201961627342;4648.86053418398;3348.2878868116904;3424.383610950053;3670.504481894963;3692.8707495238077;3696;625.6152466233325;626.0390300888206;626.1421852062704;631.9905201421982;636.5035272487468;519.4441947116625;557.7295011919216;618.7184830901929;636.8634475209574;686.825528346533;9176.44941303524;9765.169960553432;10227.386356818615;10254.210232261083;10330.845037324447;560.4283630696666;652.9934700653027;673.8753330633848;682.160942041292;697.2887654592288;4465.933011004838;4773.498782627844;4817.566419022305;4846.927296090562;4887.877803054881;95483.52258238665;97453.5127324373;98695;161683.19158404367;162552;137277;140938;141504.68214389213;142463.86304205447;144597;101866;120604.39697801454;121003;121185.78814211921;121492;9228.584713687766;9257.35198536096;9279.953600231956;9294.860577091484;9296.256299496159;60287;66996;67095.32904671086;68716;69569.65215173892;65420.67289663521;68671.62656746937;69641.60716785738;79035.60482197552;82190.58904705438;13861.584152475441;13959.232242226775;13962.092463989808;14007.789883151965;14118.294085295489;14778.852211478177;14798.63003424923;14869.256537172882;14896.702065958836;15080.472183473526;13976;14015.789763153765;14281.285935703381;14579.817080153367;14636.121832690073;13837.515686950908;13976.440942362191;14146.646333841736;14478.420863165355;14662.266886655838;12053.397330133283;13614.93192534031;13817.585472435843;13837.238951857744;13861.861381386461;11485.712857178638;11526.59656912004;11942.820857686967;11955.103367247317;12008.699782505508;8461.576921153795;10210.489475526045;10537.789244215226;11162.609308674157;11465.656030319104 10:45:35 INFO - PROCESS | 1973 | __end_tp_report 10:45:35 INFO - PROCESS | 1973 | __start_cc_report 10:45:35 INFO - PROCESS | 1973 | _x_x_mozilla_cycle_collect,364 10:45:35 INFO - PROCESS | 1973 | __end_cc_report 10:45:35 INFO - PROCESS | 1973 | __startTimestamp1474652735230__endTimestamp 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | ------- Summary: start ------- 10:45:35 INFO - PROCESS | 1973 | Number of tests: 6 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | [#0] dojo.html Cycles:165 Average:5617.53 Median:5868.38 stddev:680.13 (11.6%) stddev-sans-first:649.37 10:45:35 INFO - PROCESS | 1973 | Values: 2955.9 3181.7 3358.3 3373.2 3379.1 4670.2 5109.9 5317.6 5622.5 5648.6 4629.3 5561.5 5643.5 5729.1 5730.9 4540.8 4633.7 5063.7 5175.0 5188.2 4655.3 5158.1 5173.0 5252.6 5321.7 5068.8 5219.3 5224.7 5238.3 5277.0 5122.6 5127.1 5151.1 5168.7 5210.1 5125.8 5149.3 5173.3 5177.8 5231.9 5670.0 5681.8 5741.5 5744.4 5748.3 6114.1 6123.6 6143.3 6159.5 6205.8 6180.5 6221.7 6236.1 6240.3 6244.8 5675.0 5736.7 5815.4 5834.4 5874.3 6140.0 6151.6 6217.6 6243.9 6272.3 5985.4 6001.2 6014.0 6016.6 6066.3 6093.6 6122.7 6132.6 6145.8 6155.9 5975.7 6093.1 6162.0 6163.4 6212.9 6149.4 6237.8 6241.9 6254.5 6256.4 4816.0 4877.1 4909.4 4916.7 4919.1 4370.3 4378.5 4398.1 4461.7 4493.0 5015.4 5868.4 5878.6 5885.6 5888.9 6193.3 6244.1 6244.8 6246.9 6275.8 5659.6 5752.5 5798.7 5820.3 5849.5 5342.3 5374.4 5383.0 5386.6 5411.9 6258.9 6262.3 6283.1 6293.0 6293.2 5120.0 5393.5 5906.6 6106.3 6232.9 6235.3 6244.8 6252.7 6258.3 6264.3 4782.9 5682.4 6122.9 6132.5 6150.1 4762.7 5076.7 6100.6 6125.7 6176.6 6079.8 6126.1 6128.1 6140.8 6144.2 6084.2 6091.8 6094.0 6100.0 6103.5 4556.6 4985.2 5029.0 5792.4 5933.1 5502.2 5934.1 6039.0 6071.0 6136.5 4840.2 5914.5 5918.9 5956.8 5973.9 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | [#1] ext.html Cycles:180 Average:64869.35 Median:39103.80 stddev:142015.22 (363.2%) stddev-sans-first:142331.27 10:45:35 INFO - PROCESS | 1973 | Values: 457.7 489.0 519.4 521.7 526.7 39173.4 41091.6 41123.6 41138.4 41235.8 34531.5 41928.0 41931.8 42471.4 42516.4 9711.2 9852.8 9913.7 9940.8 9953.0 9740.0 9825.9 9837.3 9841.6 9858.5 9795.0 9851.7 9858.7 9871.7 9888.5 9043.5 9170.0 9787.2 9814.3 9843.4 9656.2 9730.5 9736.2 9753.2 9757.8 40657.0 40989.0 40991.2 41012.6 41076.0 3317.2 3457.4 3534.9 3536.9 3578.2 30703.0 31000.5 31272.8 31728.4 31858.5 3231.5 3258.6 3269.1 3294.1 3353.0 455678.0 457408.0 457574.0 459496.7 459574.0 32513.0 33261.2 57911.4 58260.7 58527.4 33036.7 33100.0 33308.7 33320.8 33437.5 14153.0 14230.0 14272.9 14289.7 14310.7 10271.3 11108.9 12053.2 12175.2 12187.8 7683.8 7691.2 7758.6 7771.3 7800.7 2934.5 3212.3 3268.4 3271.1 3303.7 889.8 895.4 961.5 999.1 1009.2 27159.5 28871.9 29498.4 29929.9 30877.8 1003.0 1057.2 1066.4 1106.6 1148.2 15545.7 15620.7 15645.6 15651.6 16137.8 591150.0 594664.0 596285.0 596985.0 608436.0 53492.5 56614.4 56857.0 57071.6 57134.1 1327.2 1329.6 1372.7 1374.8 1376.7 29296.1 29704.9 29815.0 30311.0 30377.0 49111.8 49363.5 49374.8 49567.8 49670.0 507773.0 532419.0 533016.0 535797.0 537332.0 25996.5 26038.6 26442.0 26475.7 26479.9 43416.1 43424.6 43549.6 45530.1 45667.5 38608.4 39103.0 39104.6 39323.6 40191.0 30274.1 33715.0 36139.0 37979.0 38097.8 31553.7 32161.7 35947.8 36499.5 37592.6 32737.3 33372.7 34076.1 34424.1 34599.5 24127.5 25039.5 25118.4 25547.7 25689.3 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | [#2] jquery.html Cycles:180 Average:32320.78 Median:2461.46 stddev:88508.63 (3595.8%) stddev-sans-first:88724.39 10:45:35 INFO - PROCESS | 1973 | Values: 362.0 365.4 369.6 377.3 394.8 18546.7 19849.2 20118.6 20367.6 20525.8 19500.1 19748.4 19980.9 20028.8 20342.0 4711.3 5857.3 6062.3 6064.8 6097.5 5960.1 5969.6 6060.9 6069.8 6078.2 5293.4 5558.6 5998.2 6017.5 6074.4 5556.8 5690.1 6095.5 6114.1 6147.8 4980.3 5750.8 5951.2 6002.4 6015.5 12825.4 13071.1 13096.7 13111.4 13320.5 2249.0 2341.5 2386.5 2536.5 2822.6 9484.5 9993.9 10203.9 10259.8 10344.5 1746.2 1888.4 1911.4 1935.7 1956.1 108431.0 122777.4 123929.0 124967.0 125520.0 11047.9 11339.0 11391.8 11491.9 11926.8 14174.0 14281.4 14311.8 14327.7 14363.9 8224.0 8466.0 8478.1 8609.5 8647.5 8384.8 8394.1 8441.2 8542.0 8550.2 4429.5 4480.2 4518.4 4612.4 4648.2 1913.9 1919.1 1948.1 1958.2 1990.5 846.5 883.2 894.6 902.2 1022.2 19386.3 20273.6 20499.0 20512.7 20685.2 871.2 901.7 924.5 933.8 988.6 10252.8 10737.3 10762.7 10775.9 10798.1 497396.0 512378.0 538983.0 541280.8 543803.0 86870.0 108562.5 111505.0 119568.4 127369.0 984.6 1004.1 1044.9 1045.7 1047.5 18306.8 18449.5 18767.8 18819.0 19092.5 52567.0 52921.0 53008.7 54649.5 54949.5 81709.0 82288.6 82441.0 83249.9 83686.6 7773.8 7894.0 7941.1 8040.9 8061.4 10383.5 12234.5 12555.0 12729.8 12960.7 7576.6 8944.3 9591.9 11182.2 11263.8 10740.9 10835.3 11089.2 11120.8 11303.3 9517.6 10083.5 10844.8 11119.3 11357.4 7650.6 7814.2 7884.8 8021.9 8065.4 10028.8 10467.2 10978.7 11044.3 11059.8 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | [#3] mootools.html Cycles:180 Average:5801.98 Median:4984.88 stddev:3274.36 (65.7%) stddev-sans-first:3267.69 10:45:35 INFO - PROCESS | 1973 | Values: 1513.0 1557.7 1743.0 1845.1 1860.5 8073.5 8329.4 8540.5 9118.9 9137.1 8564.5 8847.6 8864.8 9009.6 9025.6 2062.3 2375.8 2403.9 2407.6 2411.0 2278.9 2335.2 2410.6 2422.7 2423.4 2108.3 2135.3 2305.7 2396.1 2402.4 2356.6 2362.1 2379.4 2387.8 2391.3 2323.4 2329.5 2335.4 2335.7 2341.7 8921.8 9119.7 9124.2 9139.2 9148.8 5266.6 5296.9 5444.9 5455.3 5459.1 3514.3 3668.4 3698.9 3713.0 3718.6 1053.7 1087.0 1092.4 1100.9 1110.9 11866.5 11894.8 11935.3 12000.2 12000.6 4162.4 4181.8 4655.0 4903.3 4916.6 10174.5 10281.8 10283.7 10287.6 10293.5 5434.8 5470.2 5474.1 5474.3 5489.6 4435.9 4639.2 4765.6 4914.9 4992.0 3413.4 3950.2 3963.9 3974.4 4127.8 1288.5 1302.5 1304.0 1310.9 1315.1 803.0 835.5 859.7 907.0 975.2 5909.7 5937.3 5983.4 6111.2 6164.4 423.5 823.7 949.0 1026.3 1054.1 3688.9 3941.5 3996.6 4014.4 4195.9 10678.9 11035.0 11114.3 11121.4 11145.0 11060.1 11065.7 11075.7 11085.1 11097.0 6841.6 7830.1 8231.5 8232.4 8413.0 5971.9 5982.0 6072.9 6116.2 6210.9 9826.1 9829.8 9895.3 9963.5 9973.4 9563.1 9674.6 10108.8 10116.4 10173.8 7095.9 7288.8 7532.9 7571.8 7629.0 8509.1 8647.3 8756.2 8768.7 8895.6 7541.3 7697.8 7751.1 7827.5 7869.8 7465.5 7571.6 7574.5 7621.8 7739.9 7135.8 7177.9 7228.9 7248.0 7252.2 4977.8 4999.0 5068.1 5109.1 5247.4 5078.3 5131.8 5224.5 5262.7 5285.4 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | [#4] prototype.html Cycles:180 Average:4655.81 Median:5296.04 stddev:1467.14 (27.7%) stddev-sans-first:1434.43 10:45:35 INFO - PROCESS | 1973 | Values: 303.7 307.6 312.9 313.2 314.7 4817.3 5207.8 5542.9 5576.5 5585.4 4719.4 5465.5 5470.3 5476.5 5526.8 3454.6 3477.7 3981.6 4126.8 4172.5 3246.0 3523.0 3978.9 4188.9 4192.6 3110.8 3685.3 3859.9 4208.2 4235.7 3378.6 4060.0 4196.0 4228.4 4241.6 3426.0 3432.4 3631.0 3643.3 3656.5 4739.0 5348.2 5423.1 5441.8 5443.8 4419.0 4850.5 4857.3 4857.5 4873.3 4958.0 5306.4 5768.7 5872.1 5876.9 3475.0 3949.1 3968.1 3969.7 3983.0 5709.8 5853.0 6077.8 6195.4 6200.8 3923.6 4013.8 4025.2 4030.1 4043.5 4035.4 4049.8 4063.1 4107.6 4120.5 4402.8 4765.5 4794.5 4800.3 4837.4 4696.9 4882.7 5376.7 5838.8 5891.7 1075.1 1251.8 1289.2 1312.8 1348.2 753.7 798.5 842.6 850.5 852.8 4765.7 5198.5 5326.2 5527.9 5578.7 5369.8 6069.9 6077.7 6113.8 6132.0 5027.6 5187.7 5325.6 5452.6 5627.9 2649.5 2887.8 3124.3 3171.3 3179.2 5010.2 5251.8 5852.5 6204.2 6297.5 5546.4 5816.4 5830.7 5864.3 5905.0 5923.5 6282.7 6293.5 6301.0 6309.8 4845.8 5705.1 5929.0 6008.3 6151.5 5876.2 5924.6 5941.7 5982.4 6003.5 5502.8 5658.7 5710.6 5730.9 6257.6 3690.8 3710.7 3939.4 3975.9 4012.4 4933.9 5329.7 5650.8 6033.6 6070.6 4743.2 4880.0 4891.5 5818.5 5878.8 5175.6 5651.4 5827.7 5830.5 5851.9 5700.3 5726.0 5727.7 5729.1 5739.8 5071.2 5364.6 5446.3 5515.8 5842.1 5285.6 5529.3 5559.7 5695.2 5733.9 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - PROCESS | 1973 | [#5] yui.html Cycles:180 Average:24588.50 Median:3547.44 stddev:38830.35 (1094.6%) stddev-sans-first:38897.91 10:45:35 INFO - PROCESS | 1973 | Values: 714.9 719.4 749.5 770.5 806.5 15371.0 16233.3 16275.7 16280.9 16330.8 14608.3 14711.6 14851.3 14921.9 14953.3 666.9 692.5 828.9 837.0 868.8 844.9 853.0 858.4 858.8 862.2 908.8 915.6 915.6 918.8 919.1 902.7 904.9 905.5 905.6 910.4 680.6 685.2 686.9 687.7 688.0 15395.4 15512.0 15549.7 15557.6 15565.3 14833.6 14852.6 14878.3 14880.3 14924.9 11893.7 12076.8 12087.3 12311.0 12447.5 3752.6 3793.4 3962.8 3991.5 3996.2 109981.5 112016.0 112832.4 113277.4 113381.4 11150.3 11168.3 11236.6 11276.3 11580.8 23664.8 23756.3 23768.3 23796.8 23853.9 7111.5 7152.8 8107.0 8244.9 8296.2 3706.5 3918.0 4079.7 4200.2 4648.9 3348.3 3424.4 3670.5 3692.9 3696.0 625.6 626.0 626.1 632.0 636.5 519.4 557.7 618.7 636.9 686.8 9176.4 9765.2 10227.4 10254.2 10330.8 560.4 653.0 673.9 682.2 697.3 4465.9 4773.5 4817.6 4846.9 4887.9 95483.5 97453.5 98695.0 161683.2 162552.0 137277.0 140938.0 141504.7 142463.9 144597.0 101866.0 120604.4 121003.0 121185.8 121492.0 9228.6 9257.4 9280.0 9294.9 9296.3 60287.0 66996.0 67095.3 68716.0 69569.7 65420.7 68671.6 69641.6 79035.6 82190.6 13861.6 13959.2 13962.1 14007.8 14118.3 14778.9 14798.6 14869.3 14896.7 15080.5 13976.0 14015.8 14281.3 14579.8 14636.1 13837.5 13976.4 14146.6 14478.4 14662.3 12053.4 13614.9 13817.6 13837.2 13861.9 11485.7 11526.6 11942.8 11955.1 12008.7 8461.6 10210.5 10537.8 11162.6 11465.7 10:45:35 INFO - PROCESS | 1973 | -------- Summary: end -------- 10:45:35 INFO - PROCESS | 1973 | 10:45:35 INFO - TEST-INFO | 1973: exit 0 10:45:35 INFO - TEST-OK | dromaeo_css | took 1113834ms 10:45:35 INFO - TEST-START | kraken 10:45:35 INFO - operating with platform_type : mac_ 10:45:35 INFO - Initialising browser for kraken test... 10:45:35 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpQztRHH/profile http://localhost:52001/getInfo.html) 10:45:38 INFO - PROCESS | 1980 | 2016-09-23 10:45:38.466 plugin-container[1981:15269] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8717, name = 'com.apple.tsm.portname' 10:45:38 INFO - PROCESS | 1980 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:38 INFO - PROCESS | 1980 | 2016-09-23 10:45:38.469 plugin-container[1981:15269] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 10:45:38 INFO - PROCESS | 1980 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:38 INFO - PROCESS | 1980 | 2016-09-23 10:45:38.469 plugin-container[1981:15269] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:45:38 INFO - PROCESS | 1980 | __metrics Screen width/height:1600/1200 10:45:38 INFO - PROCESS | 1980 | colorDepth:24 10:45:38 INFO - PROCESS | 1980 | Browser inner width/height: 1024/689 10:45:38 INFO - PROCESS | 1980 | __metrics 10:45:38 ERROR - PROCESS | 1980 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 10:45:39 INFO - TEST-INFO | 1980: exit 0 10:45:39 INFO - Browser initialized. 10:45:39 INFO - Running cycle 1/1 for kraken test... 10:45:39 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/T/tmpQztRHH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:45:41 INFO - PROCESS | 1982 | 2016-09-23 10:45:41.746 plugin-container[1983:15378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8823, name = 'com.apple.tsm.portname' 10:45:41 INFO - PROCESS | 1982 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:41 INFO - PROCESS | 1982 | 2016-09-23 10:45:41.750 plugin-container[1983:15378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 10:45:41 INFO - PROCESS | 1982 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:45:41 INFO - PROCESS | 1982 | 2016-09-23 10:45:41.750 plugin-container[1983:15378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:45:51 INFO - PROCESS | 1982 | RSS: Main: 239943680 10:45:51 INFO - PROCESS | 1982 | 10:45:54 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52001/tests/kraken/driver.html?testName=audio-beat-detection) 10:45:55 INFO - PROCESS | 1982 | RSS: Main: 253542400 10:45:55 INFO - PROCESS | 1982 | 10:45:58 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52001/tests/kraken/driver.html?testName=audio-dft) 10:45:58 INFO - PROCESS | 1982 | RSS: Main: 261144576 10:45:58 INFO - PROCESS | 1982 | 10:46:02 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52001/tests/kraken/driver.html?testName=audio-fft) 10:46:02 INFO - PROCESS | 1982 | RSS: Main: 261984256 10:46:02 INFO - PROCESS | 1982 | 10:46:04 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52001/tests/kraken/driver.html?testName=audio-oscillator) 10:46:05 INFO - PROCESS | 1982 | RSS: Main: 264114176 10:46:05 INFO - PROCESS | 1982 | 10:46:07 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:46:08 INFO - PROCESS | 1982 | RSS: Main: 264450048 10:46:08 INFO - PROCESS | 1982 | 10:46:11 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52001/tests/kraken/driver.html?testName=imaging-darkroom) 10:46:11 INFO - PROCESS | 1982 | RSS: Main: 265293824 10:46:11 INFO - PROCESS | 1982 | 10:46:15 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52001/tests/kraken/driver.html?testName=imaging-desaturate) 10:46:15 INFO - PROCESS | 1982 | RSS: Main: 265748480 10:46:15 INFO - PROCESS | 1982 | 10:46:18 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52001/tests/kraken/driver.html?testName=json-parse-financial) 10:46:19 INFO - PROCESS | 1982 | RSS: Main: 265547776 10:46:19 INFO - PROCESS | 1982 | 10:46:21 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:46:21 INFO - PROCESS | 1982 | RSS: Main: 265498624 10:46:21 INFO - PROCESS | 1982 | 10:46:23 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:46:24 INFO - PROCESS | 1982 | RSS: Main: 265441280 10:46:24 INFO - PROCESS | 1982 | 10:46:26 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:46:27 INFO - PROCESS | 1982 | RSS: Main: 265576448 10:46:27 INFO - PROCESS | 1982 | 10:46:30 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:46:30 INFO - PROCESS | 1982 | RSS: Main: 265859072 10:46:30 INFO - PROCESS | 1982 | 10:46:33 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:46:34 INFO - PROCESS | 1982 | RSS: Main: 265658368 10:46:34 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52001/tests/kraken/driver.html?testName=ai-astar) 10:46:36 INFO - PROCESS | 1982 | RSS: Main: 267325440 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | __start_tp_report 10:46:36 INFO - PROCESS | 1982 | _x_x_mozilla_page_load 10:46:36 INFO - PROCESS | 1982 | _x_x_mozilla_page_load_details 10:46:36 INFO - PROCESS | 1982 | |i|pagename|runs| 10:46:36 INFO - PROCESS | 1982 | |0;ai-astar;113;115;118;124;171;117;115;116;117;117 10:46:36 INFO - PROCESS | 1982 | |1;audio-beat-detection;141;109;144;142;128;110;103;119;160;99 10:46:36 INFO - PROCESS | 1982 | |2;audio-dft;209;261;186;181;169;182;224;218;214;192 10:46:36 INFO - PROCESS | 1982 | |3;audio-fft;80;61;59;84;60;63;83;86;79;60 10:46:36 INFO - PROCESS | 1982 | |4;audio-oscillator;91;98;72;87;102;60;111;104;105;118 10:46:36 INFO - PROCESS | 1982 | |5;imaging-gaussian-blur;106;86;85;131;89;113;86;117;127;87 10:46:36 INFO - PROCESS | 1982 | |6;imaging-darkroom;106;106;170;99;139;100;111;160;170;142 10:46:36 INFO - PROCESS | 1982 | |7;imaging-desaturate;91;94;92;92;94;134;145;141;89;95 10:46:36 INFO - PROCESS | 1982 | |8;json-parse-financial;57;57;56;56;57;58;79;88;88;65 10:46:36 INFO - PROCESS | 1982 | |9;json-stringify-tinderbox;71;71;70;71;79;73;69;69;71;71 10:46:36 INFO - PROCESS | 1982 | |10;stanford-crypto-aes;90;87;84;87;93;93;78;97;115;107 10:46:36 INFO - PROCESS | 1982 | |11;stanford-crypto-ccm;142;146;150;145;144;179;136;132;188;158 10:46:36 INFO - PROCESS | 1982 | |12;stanford-crypto-pbkdf2;173;173;182;240;212;175;235;239;185;174 10:46:36 INFO - PROCESS | 1982 | |13;stanford-crypto-sha256-iterative;68;69;69;70;72;67;68;71;67;67 10:46:36 INFO - PROCESS | 1982 | __end_tp_report 10:46:36 INFO - PROCESS | 1982 | __start_cc_report 10:46:36 INFO - PROCESS | 1982 | _x_x_mozilla_cycle_collect,947 10:46:36 INFO - PROCESS | 1982 | __end_cc_report 10:46:36 INFO - PROCESS | 1982 | __startTimestamp1474652796525__endTimestamp 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | ------- Summary: start ------- 10:46:36 INFO - PROCESS | 1982 | Number of tests: 14 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#0] ai-astar Cycles:10 Average:122.30 Median:117.00 stddev:17.35 (14.8%) stddev-sans-first:18.08 10:46:36 INFO - PROCESS | 1982 | Values: 113.0 115.0 118.0 124.0 171.0 117.0 115.0 116.0 117.0 117.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:141.50 stddev:20.59 (14.5%) stddev-sans-first:21.06 10:46:36 INFO - PROCESS | 1982 | Values: 141.0 109.0 144.0 142.0 128.0 110.0 103.0 119.0 160.0 99.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#2] audio-dft Cycles:10 Average:203.60 Median:211.50 stddev:27.23 (12.9%) stddev-sans-first:28.81 10:46:36 INFO - PROCESS | 1982 | Values: 209.0 261.0 186.0 181.0 169.0 182.0 224.0 218.0 214.0 192.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#3] audio-fft Cycles:10 Average:71.50 Median:79.50 stddev:11.69 (14.7%) stddev-sans-first:11.99 10:46:36 INFO - PROCESS | 1982 | Values: 80.0 61.0 59.0 84.0 60.0 63.0 83.0 86.0 79.0 60.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:66.00 stddev:17.82 (27.0%) stddev-sans-first:18.85 10:46:36 INFO - PROCESS | 1982 | Values: 91.0 98.0 72.0 87.0 102.0 60.0 111.0 104.0 105.0 118.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#5] imaging-gaussian-blur Cycles:10 Average:102.70 Median:85.50 stddev:18.31 (21.4%) stddev-sans-first:19.38 10:46:36 INFO - PROCESS | 1982 | Values: 106.0 86.0 85.0 131.0 89.0 113.0 86.0 117.0 127.0 87.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#6] imaging-darkroom Cycles:10 Average:130.30 Median:151.00 stddev:29.25 (19.4%) stddev-sans-first:29.67 10:46:36 INFO - PROCESS | 1982 | Values: 106.0 106.0 170.0 99.0 139.0 100.0 111.0 160.0 170.0 142.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#7] imaging-desaturate Cycles:10 Average:106.70 Median:92.00 stddev:23.19 (25.2%) stddev-sans-first:23.89 10:46:36 INFO - PROCESS | 1982 | Values: 91.0 94.0 92.0 92.0 94.0 134.0 145.0 141.0 89.0 95.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:61.50 stddev:13.52 (22.0%) stddev-sans-first:13.93 10:46:36 INFO - PROCESS | 1982 | Values: 57.0 57.0 56.0 56.0 57.0 58.0 79.0 88.0 88.0 65.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:2.88 (4.1%) stddev-sans-first:3.05 10:46:36 INFO - PROCESS | 1982 | Values: 71.0 71.0 70.0 71.0 79.0 73.0 69.0 69.0 71.0 71.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#10] stanford-crypto-aes Cycles:10 Average:93.10 Median:88.50 stddev:10.97 (12.4%) stddev-sans-first:11.58 10:46:36 INFO - PROCESS | 1982 | Values: 90.0 87.0 84.0 87.0 93.0 93.0 78.0 97.0 115.0 107.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:148.00 stddev:18.17 (12.3%) stddev-sans-first:18.90 10:46:36 INFO - PROCESS | 1982 | Values: 142.0 146.0 150.0 145.0 144.0 179.0 136.0 132.0 188.0 158.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.80 Median:198.50 stddev:29.41 (14.8%) stddev-sans-first:29.67 10:46:36 INFO - PROCESS | 1982 | Values: 173.0 173.0 182.0 240.0 212.0 175.0 235.0 239.0 185.0 174.0 10:46:36 INFO - PROCESS | 1982 | 10:46:36 INFO - PROCESS | 1982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.75 (2.5%) stddev-sans-first:1.83 10:46:36 INFO - PROCESS | 1982 | Values: 68.0 69.0 69.0 70.0 72.0 67.0 68.0 71.0 67.0 67.0 10:46:36 INFO - PROCESS | 1982 | -------- Summary: end -------- 10:46:36 INFO - PROCESS | 1982 | 10:46:37 INFO - TEST-INFO | 1982: exit 0 10:46:37 INFO - TEST-OK | kraken | took 61673ms 10:46:37 INFO - SUITE-END | took 1175s 10:46:37 INFO - Completed test suite (00:19:35) 10:46:37 INFO - javascript benchmark 10:46:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7241.424100162569, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2955.8522073896306, 3181.743211431484, 3358.2947581008, 3373.207296285371, 3379.138319728469, 4670.1827180243445, 5109.923351149727, 5317.59083842782, 5622.4939755422, 5648.604597678164, 4629.328747331635, 5561.4716601922855, 5643.548516118711, 5729.0833466645345, 5730.856728581787, 4540.75129339431, 4633.6524760642915, 5063.721495317765, 5175.042617115846, 5188.195829646411, 4655.3462351987755, 5158.097332966735, 5173.0, 5252.606054545905, 5321.680699158043, 5068.847934561969, 5219.295395121648, 5224.738763061831, 5238.266642670029, 5277.023750606131, 5122.564582010534, 5127.102757017507, 5151.098557752378, 5168.741562921877, 5210.140326846066, 5125.769340379692, 5149.253358263069, 5173.3016042834115, 5177.818776342848, 5231.927454871742, 5669.971650141723, 5681.801136960186, 5741.511971482429, 5744.368119506851, 5748.310202775652, 6114.145302971524, 6123.601965872204, 6143.262808462969, 6159.469135247669, 6205.844853878644, 6180.474659653934, 6221.657808820513, 6236.064590311489, 6240.31356550779, 6244.750209991595, 5674.971625141848, 5736.6558006519745, 5815.389384114649, 5834.416558344132, 5874.3244526879525, 6140.04415716754, 6151.630902145796, 6217.564770466114, 6243.875122497525, 6272.278687950853, 5985.401459854067, 6001.159837622649, 6014.037753959433, 6016.608920420159, 6066.332703402622, 6093.634381937098, 6122.66325352101, 6132.63204207749, 6145.784897528565, 6155.876882462326, 5975.67133807636, 6093.146959425684, 6162.044883043135, 6163.3528479509005, 6212.875742485125, 6149.354317796657, 6237.844053898689, 6241.906371404432, 6254.468370188494, 6256.436920677161, 4816.036792641416, 4877.097736918681, 4909.4354149273295, 4916.729579873141, 4919.0899683558655, 4370.344448332776, 4378.452693413324, 4398.076403955141, 4461.687681862239, 4492.977535112369, 5015.423226329019, 5868.38381969887, 5878.617889837147, 5885.646861188342, 5888.911666325009, 6193.287771906198, 6244.12582238487, 6244.812655620339, 6246.875062498724, 6275.780347687809, 5659.5755318351285, 5752.482276595127, 5798.652080875161, 5820.30156381237, 5849.473547380671, 5342.252084708144, 5374.435684253175, 5383.031054410166, 5386.649867758583, 5411.918821217685, 6258.906116408258, 6262.34245404226, 6283.05754136874, 6293.0, 6293.244810622755, 5120.0, 5393.514583687487, 5906.616069955439, 6106.339326077157, 6232.906506402498, 6235.3452887446165, 6244.843878903063, 6252.687365631791, 6258.311585725658, 6264.2796078451565, 4782.947751494666, 5682.431756824284, 6122.877542449215, 6132.540059495466, 6150.077488376779, 4762.690425122356, 5076.746162691925, 6100.581173165739, 6125.662799505599, 6176.567640265138, 6079.787207447718, 6126.090206827809, 6128.080787881675, 6140.754369825336, 6144.218176728698, 6084.239470066242, 6091.7563297467605, 6093.969530152498, 6099.969500152471, 6103.511719062376, 4556.567126123013, 4985.177445721561, 5028.969061342489, 5792.362840087671, 5933.080372542263, 5502.202180683698, 5934.139549765174, 6039.033754599419, 6070.969645151746, 6136.478399336106, 4840.2255639097575, 5914.526837853047, 5918.852028699317, 5956.791512297049, 5973.940260597338], "value": 5575.350736194064, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.7207903179058, 488.9975550122249, 519.4182515582548, 521.7078436075798, 526.739264064288, 39173.412398814005, 41091.58908410919, 41123.58876411243, 41138.382924256126, 41235.79382103085, 34531.482027769605, 41928.0, 41931.79034104833, 42471.362929556, 42516.36225456613, 9711.22310215183, 9852.753681157992, 9913.65302214419, 9940.801183976317, 9953.0, 9740.0, 9825.901740982606, 9837.262205334593, 9841.557129929135, 9858.457784821832, 9794.951025244864, 9851.65519206828, 9858.704238872846, 9871.703848884545, 9888.456134912576, 9043.502607356593, 9169.954150229272, 9787.217022638171, 9814.263930205192, 9843.409395436296, 9656.179224765903, 9730.464824434654, 9736.172425343855, 9753.170980466668, 9757.804843903154, 40657.0, 40989.0, 40991.18017639661, 41012.589874101475, 41075.973100672425, 3317.2204531934976, 3457.396748660134, 3534.929301413983, 3536.876209332661, 3578.248567800765, 30703.0, 31000.53499197514, 31272.843635781905, 31728.365432691447, 31858.522122168186, 3231.5475833383343, 3258.5926759155104, 3269.051974927268, 3294.1435226840954, 3353.0, 455678.0, 457408.0, 457573.9999999967, 459496.7025164886, 459574.0, 32513.0, 33261.16847078794, 57911.42088579144, 58260.70869645625, 58527.4147258522, 33036.66963330336, 33100.00699979004, 33308.66691333104, 33320.83377081839, 33437.498437523456, 14153.009289349853, 14230.00389972692, 14272.857271427152, 14289.714205716036, 14310.713785724227, 10271.281010329354, 11108.889111088987, 12053.156279060382, 12175.208611440228, 12187.756244875052, 7683.807904802313, 7691.192424795316, 7758.612069396508, 7771.261730135628, 7800.726974555977, 2934.5158048922117, 3212.3414699986447, 3268.428025095599, 3271.116798464401, 3303.7026667599553, 889.8442772514913, 895.3821862914568, 961.4615815143542, 999.0758548342753, 1009.1573536097294, 27159.45681086367, 28871.85564072166, 29498.410031799245, 29929.850350748544, 30877.8456107718, 1002.9648962286285, 1057.1754031855164, 1066.429460238784, 1106.623747925709, 1148.179051977823, 15545.689086218212, 15620.687586248212, 15645.608859778597, 15651.608709782347, 16137.838621613868, 591150.044249776, 594664.0, 596285.0, 596985.0, 608436.0, 53492.46507534953, 56614.43385566174, 56857.0, 57071.57321067007, 57134.142987855215, 1327.2036777933356, 1329.6011196640968, 1372.6980064385818, 1374.780035194384, 1376.6833628265556, 29296.121116366543, 29704.851475742482, 29815.0, 30311.0, 30377.0, 49111.75444122757, 49363.50636493589, 49374.75312623558, 49567.75216123896, 49670.0, 507773.0, 532419.0, 533016.0, 535797.0, 537332.0, 25996.480070398866, 26038.609420858324, 26442.0, 26475.735242647326, 26479.940802367688, 43416.13167736691, 43424.56575434332, 43549.56450435455, 45530.08939821119, 45667.54332456633, 38608.42087368636, 39103.0, 39104.608953911236, 39323.606763931995, 40190.99522511961, 30274.09177724672, 33715.0, 36139.0, 37979.0, 38097.80951095227, 31553.684463155994, 32161.67838321587, 35947.82026089957, 36499.45250821186, 37592.62407375891, 32737.34525309528, 33372.66627333696, 34076.14809629779, 34424.13939651529, 34599.481007785405, 24127.517449650557, 25039.499210016063, 25118.372040699127, 25547.74452255528, 25689.33019353736], "value": 18260.091492970827, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.9981900090499, 365.4317536231161, 369.59529315399647, 377.3132898125409, 394.78286942181813, 18546.721799173025, 19849.20603175875, 20118.59762804743, 20367.592648147045, 20525.794742052574, 19500.122494487747, 19748.407547773553, 19980.90105044222, 20028.799712002874, 20342.0, 4711.340412342275, 5857.26784151981, 6062.33314335425, 6064.818055458343, 6097.542684298695, 5960.0761881908375, 5969.552283578749, 6060.878782424371, 6069.848253793669, 6078.240219972504, 5293.417724050351, 5558.555315574744, 5998.1602575639445, 6017.458428741413, 6074.392560743912, 5556.805511807108, 5690.118031705092, 6095.512359011291, 6114.144019837227, 6147.846303842417, 4980.277859710358, 5750.769969201227, 5951.166836642873, 6002.399760024006, 6015.548833837436, 12825.35873206336, 13071.08502404832, 13096.738065238736, 13111.409986550629, 13320.533781317607, 2248.9887550562307, 2341.5316936612744, 2386.4749755054036, 2536.4546622476255, 2822.590724344979, 9484.525773711286, 9993.850092248622, 10203.897961020442, 10259.846102308471, 10344.5344959477, 1746.1967494952337, 1888.4051523769967, 1911.3788018893915, 1935.6709359408935, 1956.0708663384921, 108431.0, 122777.38611306976, 123929.0, 124967.0, 125520.0, 11047.889521104686, 11339.015672257487, 11391.829122563167, 11491.942540287246, 11926.761464770829, 14174.0, 14281.357338919774, 14311.78532322016, 14327.713445731028, 14363.92818035924, 8224.013118425828, 8465.957670211732, 8478.06741258461, 8609.513147175405, 8647.481151130953, 8384.790380240544, 8394.076651568323, 8441.240288373952, 8541.95729021351, 8550.18773216556, 4429.512753597101, 4480.193565158303, 4518.43519560055, 4612.446506419184, 4648.233041548175, 1913.933012344589, 1919.1172060851886, 1948.123344494983, 1958.2362878477404, 1990.532224927141, 846.4751853850652, 883.2448256740395, 894.6197865907094, 902.1911068308001, 1022.2026819081128, 19386.321478748177, 20273.59452810965, 20499.0, 20512.692309615366, 20685.17259309641, 871.1549796697194, 901.6844104563481, 924.5469719837366, 933.7992331648728, 988.649029594498, 10252.795648935515, 10737.302075365076, 10762.677119686421, 10775.892241077489, 10798.082163016232, 497396.0, 512378.0, 538983.0, 541280.7615771533, 543803.0, 86870.0, 108562.45718771356, 111505.0, 119568.4021579904, 127369.0, 984.625842179967, 1004.1314263162312, 1044.8850626431085, 1045.6810672744734, 1047.5076713944434, 18306.81693183051, 18449.53876153107, 18767.812321876605, 18818.9649569275, 19092.522686932938, 52567.0, 52921.0, 53008.73495632497, 54649.45350546444, 54949.45050549603, 81709.0, 82288.58855705684, 82441.0, 83249.92375647895, 83686.58156709178, 7773.795061765435, 7893.97378340812, 7941.086775020715, 8040.879386809085, 8061.39539534549, 10383.53274102652, 12234.510619575118, 12555.0, 12729.809052864399, 12960.740785184433, 7576.62116894142, 8944.329175311748, 9591.896931852927, 11182.217244793112, 11263.7747245053, 10740.946295268473, 10835.295705779099, 11089.168312376765, 11120.833187502356, 11303.321800691985, 9517.619295228113, 10083.546240419051, 10844.783104338027, 11119.27724697892, 11357.37534435614, 7650.6174691264105, 7814.21857814214, 7884.84230315402, 8021.919780802117, 8065.395095367753, 10028.799424011333, 10467.214958878267, 10978.725531861768, 11044.337339759319, 11059.83410248863], "value": 9269.825520856446, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.9773053404201, 1557.6728886933743, 1742.9912850435746, 1845.095903007526, 1860.469766116657, 8073.51558906466, 8329.416940814146, 8540.530270835101, 9118.863217051741, 9137.131972462614, 8564.48613083214, 8847.601857916394, 8864.77838054049, 9009.639614415415, 9025.638974441032, 2062.3091264426434, 2375.821813363996, 2403.891824867885, 2407.590709579376, 2410.963835542468, 2278.874661893595, 2335.1593426366494, 2410.602250628644, 2422.7092748870073, 2423.430493833948, 2108.251570692405, 2135.2740068376747, 2305.7348404933477, 2396.065534441569, 2402.4474370894704, 2356.634721618152, 2362.102401087593, 2379.4289370551114, 2387.8209134314907, 2391.2587097999676, 2323.4191452136965, 2329.5340931813535, 2335.4161459635093, 2335.6846825678485, 2341.730700969393, 8921.821563568757, 9119.726408207764, 9124.22444092253, 9139.223166030895, 9148.771280717969, 5266.631335806495, 5296.947030529723, 5444.945550544483, 5455.290812194389, 5459.12653975362, 3514.2620049789575, 3668.413053911388, 3698.8890333290046, 3713.0, 3718.609545997658, 1053.6944286157004, 1087.037971395313, 1092.4428541443842, 1100.9394483303415, 1110.8500352452397, 11866.466009029615, 11894.82157767634, 11935.283882967136, 12000.21998570099, 12000.63998080059, 4162.438070860395, 4181.832726690959, 4655.0, 4903.289023091632, 4916.5820905222745, 10174.4912754362, 10281.794364112677, 10283.691489255334, 10287.639932602324, 10293.485325733684, 5434.809781657702, 5470.152126420411, 5474.09677403224, 5474.288342515448, 5489.560835133179, 4435.866923992286, 4639.164950308909, 4765.594924431392, 4914.852554423373, 4991.9500804991485, 3413.385590593717, 3950.249452603996, 3963.9405408918888, 3974.3839704845795, 4127.772972486542, 1288.5168061976758, 1302.4920281090383, 1304.0480449272084, 1310.9381401064977, 1315.0860152194325, 803.0483876606123, 835.4694768821842, 859.7119964811733, 907.0022974727747, 975.23444096384, 5909.704514774244, 5937.30786725781, 5983.431574000463, 6111.205543279345, 6164.3835616438, 423.4812354865327, 823.7446391618618, 949.0177666115675, 1026.2867307221409, 1054.0987455725244, 3688.8524459021337, 3941.467901833273, 3996.620321069494, 4014.3777714454304, 4195.8741237762915, 10678.893211067945, 11035.0, 11114.333140011626, 11121.388323642115, 11145.0, 11060.115190784718, 11065.668029959113, 11075.667729968114, 11085.057770089632, 11097.00126988575, 6841.62371069586, 7830.09953855314, 8231.547264900368, 8232.423730338818, 8412.957935210407, 5971.910421343597, 5981.983062879234, 6072.908906366496, 6116.235470566179, 6210.906836397548, 9826.115649591571, 9829.754256143653, 9895.25785566071, 9963.452010139512, 9973.401595904268, 9563.139317461462, 9674.564644591152, 10108.797824043624, 10116.393016419039, 10173.847392288973, 7095.858082838417, 7288.817779555554, 7532.924670753222, 7571.810704732426, 7629.046369203849, 8509.10654381281, 8647.26498247656, 8756.204977979627, 8768.693095741619, 8895.644174232959, 7541.283578060075, 7697.846043078995, 7751.108622508258, 7827.452078354689, 7869.803254918673, 7465.477416580788, 7571.621418928921, 7574.545527268381, 7621.847563048819, 7739.92260077392, 7135.750248741269, 7177.892331614926, 7228.855422891407, 7247.9637601811655, 7252.202257751748, 4977.800887964441, 4999.0, 5068.113080211022, 5109.131447653982, 5247.422783493889, 5078.3435926133125, 5131.846044618667, 5224.477552244745, 5262.736863156751, 5285.445028271976], "value": 4638.591236188342, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.7327152106147, 307.55404663238295, 312.9014360476449, 313.1841552755073, 314.7104663709387, 4817.277408388743, 5207.843764687065, 5542.863712938848, 5576.498115169634, 5585.413531579182, 4719.43366795985, 5465.453454654533, 5470.288862447876, 5476.534494567956, 5526.806561770329, 3454.585449746034, 3477.704395126411, 3981.641652251297, 4126.834926602933, 4172.499300083979, 3245.9837700811463, 3522.982385088071, 3978.8964607606113, 4188.853390131346, 4192.5807419258135, 3110.813351198924, 3685.318216130011, 3859.9192226176574, 4208.22147902639, 4235.74585524868, 3378.577677790276, 4060.045889216032, 4195.958040419588, 4228.386883901832, 4241.618254357092, 3425.9657403426145, 3432.4164891968426, 3631.0, 3643.2895585360866, 3656.524651795276, 4738.976305118486, 5348.224507446437, 5423.132298832168, 5441.782328706847, 5443.815368009719, 4419.049904270597, 4850.514948505156, 4857.319975203474, 4857.489963553811, 4873.2699891538705, 4957.950420495821, 5306.442823503515, 5768.74040668171, 5872.0898260769645, 5876.853078673024, 3474.9575127461662, 3949.1311911379453, 3968.146848427602, 3969.6625786808154, 3983.0042489377656, 5709.828705138811, 5853.0, 6077.848053798646, 6195.44241018306, 6200.782972595983, 3923.588023257574, 4013.7591744495426, 4025.2352053109817, 4030.0730831908827, 4043.5132393578324, 4035.435039094529, 4049.797510124482, 4063.1151882163404, 4107.603414838909, 4120.505539335299, 4402.833249188903, 4765.546508314927, 4794.496577859344, 4800.295894957309, 4837.443693975238, 4696.872750539846, 4882.731449770296, 5376.6505177164145, 5838.824835254949, 5891.675957822361, 1075.1398880895254, 1251.7997120460682, 1289.1878116786365, 1312.835895513061, 1348.1978222957325, 753.7135888362387, 798.4650284309527, 842.5871323051783, 850.459957926721, 852.7953291210065, 4765.73788441639, 5198.454162312978, 5326.227696983993, 5527.889442211133, 5578.736439183123, 5369.838904832861, 6069.908951365733, 6077.693295941393, 6113.786017489367, 6131.96934015336, 5027.572656324181, 5187.740612969336, 5325.591621362331, 5452.59105567084, 5627.943720562742, 2649.536331142081, 2887.768978481716, 3124.281415274454, 3171.3340198558562, 3179.1878629181147, 5010.248462730547, 5251.789928402897, 5852.502537284378, 6204.162438070893, 6297.527685423612, 5546.389897111315, 5816.360200377955, 5830.7084645767545, 5864.299353187528, 5904.988455887443, 5923.526117910471, 6282.654454005074, 6293.527985401113, 6300.9684951574945, 6309.769594929036, 4845.8061677532505, 5705.115707065412, 5928.970355148369, 6008.309044459943, 6151.538634602333, 5876.206712093813, 5924.585279030426, 5941.732622032106, 5982.4017598239825, 6003.549733770072, 5502.752376143163, 5658.688772117573, 5710.5717071219, 5730.856728581819, 6257.624542527463, 3690.8189379398336, 3710.6845918096183, 3939.428782826417, 3975.8807235782974, 4012.3981402789814, 4933.901321973469, 5329.653572517774, 5650.84157747669, 6033.58210820448, 6070.575059745775, 4743.217369134054, 4880.0, 4891.486393928586, 5818.505427038749, 5878.823635290948, 5175.560077393464, 5651.350094739158, 5827.70861456917, 5830.53355731549, 5851.882962340815, 5700.315962084576, 5726.026575482095, 5727.656340619576, 5729.140628905698, 5739.770409183586, 5071.210834041189, 5364.570834333166, 5446.346438427414, 5515.751791169327, 5842.123681447817, 5285.630005899704, 5529.336479622471, 5559.749811258423, 5695.202671625892, 5733.9392212440835], "value": 4176.436716109394, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8570285942809, 719.4028955966546, 749.5165618176277, 770.4953255617565, 806.5201205282855, 15371.0, 16233.26950287237, 16275.674486510263, 16280.918595407036, 16330.755038674415, 14608.342624581892, 14711.632209194775, 14851.331690073946, 14921.850781492181, 14953.252337383141, 666.9299723529033, 692.5360008794095, 828.9306794235429, 836.9623366948487, 868.8132051608903, 844.8859403980446, 853.0445900591346, 858.4119877883638, 858.7681326041965, 862.1852349529697, 908.8227795579832, 915.5651065743751, 915.6337465014014, 918.8070505193884, 919.0946917286467, 902.7066203483894, 904.891413030434, 905.5110240470106, 905.6467977488785, 910.3536489092719, 680.5610381304031, 685.2120061928822, 686.8866637004938, 687.6871023684212, 687.9896801547981, 15395.384184632601, 15512.0, 15549.689006219813, 15557.611059723598, 15565.299561519645, 14833.629159270997, 14852.62868428298, 14878.330475128645, 14880.255987200704, 14924.850751492564, 11893.702657433547, 12076.818847717292, 12087.335196564185, 12311.015118790476, 12447.502099915993, 3752.624737526253, 3793.430985352192, 3962.7622342659533, 3991.521017477892, 3996.200759848042, 109981.45009274983, 112016.0, 112832.4358378211, 113277.4336128314, 113381.433092834, 11150.330980141218, 11168.274062185932, 11236.606718764968, 11276.32342059479, 11580.76838463226, 23664.763352366255, 23756.287311380685, 23768.286951391485, 23796.810159491957, 23853.880730596582, 7111.502194846415, 7152.785416437515, 8106.959465202636, 8244.876326855101, 8296.211859873303, 3706.5366829146355, 3918.0, 4079.7348172369293, 4200.201961627342, 4648.86053418398, 3348.2878868116904, 3424.383610950053, 3670.504481894963, 3692.8707495238077, 3696.0, 625.6152466233325, 626.0390300888206, 626.1421852062704, 631.9905201421982, 636.5035272487468, 519.4441947116625, 557.7295011919216, 618.7184830901929, 636.8634475209574, 686.825528346533, 9176.44941303524, 9765.169960553432, 10227.386356818615, 10254.210232261083, 10330.845037324447, 560.4283630696666, 652.9934700653027, 673.8753330633848, 682.160942041292, 697.2887654592288, 4465.933011004838, 4773.498782627844, 4817.566419022305, 4846.927296090562, 4887.877803054881, 95483.52258238665, 97453.5127324373, 98695.0, 161683.19158404367, 162552.0, 137277.0, 140938.0, 141504.68214389213, 142463.86304205447, 144597.0, 101866.0, 120604.39697801454, 121003.0, 121185.78814211921, 121492.0, 9228.584713687766, 9257.35198536096, 9279.953600231956, 9294.860577091484, 9296.256299496159, 60287.0, 66996.0, 67095.32904671086, 68716.0, 69569.65215173892, 65420.67289663521, 68671.62656746937, 69641.60716785738, 79035.60482197552, 82190.58904705438, 13861.584152475441, 13959.232242226775, 13962.092463989808, 14007.789883151965, 14118.294085295489, 14778.852211478177, 14798.63003424923, 14869.256537172882, 14896.702065958836, 15080.472183473526, 13976.0, 14015.789763153765, 14281.285935703381, 14579.817080153367, 14636.121832690073, 13837.515686950908, 13976.440942362191, 14146.646333841736, 14478.420863165355, 14662.266886655838, 12053.397330133283, 13614.93192534031, 13817.585472435843, 13837.238951857744, 13861.861381386461, 11485.712857178638, 11526.59656912004, 11942.820857686967, 11955.103367247317, 12008.699782505508, 8461.576921153795, 10210.489475526045, 10537.789244215226, 11162.609308674157, 11465.656030319104], "value": 7886.128098849837, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1607.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 118.0, 124.0, 171.0, 117.0, 115.0, 116.0, 117.0, 117.0], "value": 122.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 144.0, 142.0, 128.0, 110.0, 103.0, 119.0, 160.0, 99.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 261.0, 186.0, 181.0, 169.0, 182.0, 224.0, 218.0, 214.0, 192.0], "value": 203.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 59.0, 84.0, 60.0, 63.0, 83.0, 86.0, 79.0, 60.0], "value": 71.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 98.0, 72.0, 87.0, 102.0, 60.0, 111.0, 104.0, 105.0, 118.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 86.0, 85.0, 131.0, 89.0, 113.0, 86.0, 117.0, 127.0, 87.0], "value": 102.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 170.0, 99.0, 139.0, 100.0, 111.0, 160.0, 170.0, 142.0], "value": 130.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 92.0, 92.0, 94.0, 134.0, 145.0, 141.0, 89.0, 95.0], "value": 106.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 57.0, 58.0, 79.0, 88.0, 88.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 71.0, 79.0, 73.0, 69.0, 69.0, 71.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 84.0, 87.0, 93.0, 93.0, 78.0, 97.0, 115.0, 107.0], "value": 93.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 146.0, 150.0, 145.0, 144.0, 179.0, 136.0, 132.0, 188.0, 158.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 173.0, 182.0, 240.0, 212.0, 175.0, 235.0, 239.0, 185.0, 174.0], "value": 198.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 70.0, 72.0, 67.0, 68.0, 71.0, 67.0, 67.0], "value": 68.8, "unit": "score"}]}]} 10:46:37 INFO - Return code: 0 10:46:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:46:37 ERROR - # TBPL SUCCESS # 10:46:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:46:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:46:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:46:37 INFO - 2016-09-23 10:46:37.883 screenresolution[1987:15756] starting screenresolution argv=screenresolution get 10:46:37 INFO - 2016-09-23 10:46:37.885 screenresolution[1987:15756] Display 0: 1600x1200x32@60 10:46:37 INFO - 2016-09-23 10:46:37.891 screenresolution[1988:15759] starting screenresolution argv=screenresolution list 10:46:37 INFO - Available Modes on Display 0 10:46:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:46:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:46:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:46:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:46:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:46:38 INFO - Intel Iris: 10:46:38 INFO - Chipset Model: Intel Iris 10:46:38 INFO - Type: GPU 10:46:38 INFO - Bus: Built-In 10:46:38 INFO - VRAM (Dynamic, Max): 1536 MB 10:46:38 INFO - Vendor: Intel (0x8086) 10:46:38 INFO - Device ID: 0x0a2e 10:46:38 INFO - Revision ID: 0x0009 10:46:38 INFO - Displays: 10:46:38 INFO - Display: 10:46:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:46:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:46:38 INFO - Display Serial Number: 1600x1200 60 10:46:38 INFO - Main Display: Yes 10:46:38 INFO - Mirror: Off 10:46:38 INFO - Online: Yes 10:46:38 INFO - Rotation: Supported 10:46:38 INFO - Return code: 0 10:46:38 INFO - Running post-action listener: _resource_record_post_action 10:46:38 INFO - [mozharness: 2016-09-23 17:46:38.129733Z] Finished run-tests step (success) 10:46:38 INFO - Running post-run listener: _resource_record_post_run 10:46:38 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 1488384; Write bytes: 709127168; Read time: 14; Write time: 2015 10:46:38 INFO - TinderboxPrint: CPU usage
54.5% 10:46:38 INFO - TinderboxPrint: I/O read bytes / time
1,488,384 / 14 10:46:38 INFO - TinderboxPrint: I/O write bytes / time
709,127,168 / 2,015 10:46:38 INFO - TinderboxPrint: CPU idle
2,202.8 (45.5%) 10:46:38 INFO - TinderboxPrint: CPU system
980.5 (20.3%) 10:46:38 INFO - TinderboxPrint: CPU user
1,658.5 (34.3%) 10:46:38 INFO - TinderboxPrint: Swap in / out
408,207,360 / 0 10:46:38 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 396900864; Write bytes: 394989056; Read time: 29652; Write time: 813 10:46:38 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 1488384; Write bytes: 295226880; Read time: 14; Write time: 1151 10:46:38 INFO - Running post-run listener: _upload_blobber_files 10:46:38 INFO - Blob upload gear active. 10:46:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:46:38 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:46:38 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:46:38 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:46:39 INFO - (blobuploader) - INFO - Open directory for files ... 10:46:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:46:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:46:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:40 INFO - (blobuploader) - INFO - Done attempting. 10:46:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:46:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:46:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:41 INFO - (blobuploader) - INFO - Done attempting. 10:46:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:46:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:46:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:46:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:46:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:46:44 INFO - (blobuploader) - INFO - Done attempting. 10:46:44 INFO - (blobuploader) - INFO - Iteration through files over. 10:46:44 INFO - Return code: 0 10:46:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:46:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:46:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9126465c92a63ad8b21980212cc5f7026cd422777f8665d8ce11b0b8e0346a7f8da5a91b7fc8c8522f742cd7976956dd574ad5fbba257923556d70e4b252d0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894d90b8403da6d77baa2055874e364fab5eb71d42be51699b7946525cad5c8797e19acfac4695880cb48e4719a7aec5fcda0522551dc9a45e011867f7252024", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13ab225b04675f5c6080b87dce93c7dd46f55105b565fb81cec355f77b79a503f4836f055f2d3d951bc4f55bd56d6873e1485a0dbda3b99bfaaa9001c6c4273d"} 10:46:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:46:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:46:44 INFO - Contents: 10:46:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9126465c92a63ad8b21980212cc5f7026cd422777f8665d8ce11b0b8e0346a7f8da5a91b7fc8c8522f742cd7976956dd574ad5fbba257923556d70e4b252d0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894d90b8403da6d77baa2055874e364fab5eb71d42be51699b7946525cad5c8797e19acfac4695880cb48e4719a7aec5fcda0522551dc9a45e011867f7252024", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13ab225b04675f5c6080b87dce93c7dd46f55105b565fb81cec355f77b79a503f4836f055f2d3d951bc4f55bd56d6873e1485a0dbda3b99bfaaa9001c6c4273d"} 10:46:44 INFO - Running post-run listener: copy_logs_to_upload_dir 10:46:44 INFO - Copying logs to upload dir... 10:46:44 INFO - mkdir: /builds/slave/test/build/upload/logs 10:46:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.350623 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-09-23 10:46:44.340389) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 10:46:44.343966) ========= 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.P9iYAeJLGT/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.Dato3oxocj/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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/9126465c92a63ad8b21980212cc5f7026cd422777f8665d8ce11b0b8e0346a7f8da5a91b7fc8c8522f742cd7976956dd574ad5fbba257923556d70e4b252d0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894d90b8403da6d77baa2055874e364fab5eb71d42be51699b7946525cad5c8797e19acfac4695880cb48e4719a7aec5fcda0522551dc9a45e011867f7252024", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13ab225b04675f5c6080b87dce93c7dd46f55105b565fb81cec355f77b79a503f4836f055f2d3d951bc4f55bd56d6873e1485a0dbda3b99bfaaa9001c6c4273d"} build_url:https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010981 build_url: 'https://queue.taskcluster.net/v1/task/SyncsE5YTmSzVXD_cry6gw/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/9126465c92a63ad8b21980212cc5f7026cd422777f8665d8ce11b0b8e0346a7f8da5a91b7fc8c8522f742cd7976956dd574ad5fbba257923556d70e4b252d0b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/894d90b8403da6d77baa2055874e364fab5eb71d42be51699b7946525cad5c8797e19acfac4695880cb48e4719a7aec5fcda0522551dc9a45e011867f7252024", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/13ab225b04675f5c6080b87dce93c7dd46f55105b565fb81cec355f77b79a503f4836f055f2d3d951bc4f55bd56d6873e1485a0dbda3b99bfaaa9001c6c4273d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 10:46:44.377075) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:46:44.377384) ========= 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.P9iYAeJLGT/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.Dato3oxocj/Listeners TMPDIR=/var/folders/nt/w1wt5wh94cg0328j1nmkplv400000w/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.005235 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 10:46:44.426532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 10:46:44.426872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 10:46:44.427211) ========= ========= Total master_lag: 0.18 =========