builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0273 starttime: 1486643721.65 results: success (0) buildid: 20170209025020 builduid: dd62ecee9b0b4bea9b73a4d0a27acae4 revision: b772e0f4138540113e91a46c99bb0d14ecc8acca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.649400) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.649898) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.650185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.675581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.675911) ========= 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.wLXYS4k88z/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.3CybCgu9I1/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 --2017-02-09 04:35:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.82M=0.001s 2017-02-09 04:35:21 (9.82 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089875 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.789035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.789376) ========= 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.wLXYS4k88z/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.3CybCgu9I1/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.020440 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:21.848052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 04:35:21.848610) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b772e0f4138540113e91a46c99bb0d14ecc8acca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b772e0f4138540113e91a46c99bb0d14ecc8acca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wLXYS4k88z/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.3CybCgu9I1/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 2017-02-09 04:35:21,957 truncating revision to first 12 chars 2017-02-09 04:35:21,957 Setting DEBUG logging. 2017-02-09 04:35:21,957 attempt 1/10 2017-02-09 04:35:21,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b772e0f41385?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 04:35:23,183 unpacking tar archive at: mozilla-central-b772e0f41385/testing/mozharness/ program finished with exit code 0 elapsedTime=1.507221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 04:35:23.379223) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:23.379556) ========= script_repo_revision: b772e0f4138540113e91a46c99bb0d14ecc8acca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:23.379929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:23.380215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 04:35:23.399668) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-09 04:35:23.400011) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wLXYS4k88z/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.3CybCgu9I1/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:35:23 INFO - MultiFileLogger online at 20170209 04:35:23 in /builds/slave/test 04:35:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:35:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:23 INFO - {'append_to_log': False, 04:35:23 INFO - 'base_work_dir': '/builds/slave/test', 04:35:23 INFO - 'blob_upload_branch': 'Firefox', 04:35:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:23 INFO - 'branch': 'Firefox', 04:35:23 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:23 INFO - 'config_files': ('talos/mac_config.py',), 04:35:23 INFO - 'default_actions': ('clobber', 04:35:23 INFO - 'read-buildbot-config', 04:35:23 INFO - 'download-and-extract', 04:35:23 INFO - 'populate-webroot', 04:35:23 INFO - 'create-virtualenv', 04:35:23 INFO - 'install', 04:35:23 INFO - 'run-tests'), 04:35:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:23 INFO - 'download_minidump_stackwalk': True, 04:35:23 INFO - 'download_symbols': 'ondemand', 04:35:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:23 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:23 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:23 INFO - 'installer_path': 'installer.exe', 04:35:23 INFO - 'log_level': 'info', 04:35:23 INFO - 'log_name': 'talos', 04:35:23 INFO - 'log_to_console': True, 04:35:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:35:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:35:23 INFO - 'opt_config_files': (), 04:35:23 INFO - 'pip_index': False, 04:35:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:23 INFO - 'cmd': ('bash', 04:35:23 INFO - '-c', 04:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:23 INFO - 'enabled': True, 04:35:23 INFO - 'halt_on_failure': False, 04:35:23 INFO - 'name': 'check_screen_resolution'},), 04:35:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:23 INFO - 'cmd': ('bash', 04:35:23 INFO - '-c', 04:35:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:23 INFO - 'enabled': True, 04:35:23 INFO - 'halt_on_failure': False, 04:35:23 INFO - 'name': 'check_screen_resolution'},), 04:35:23 INFO - 'run_cmd_checks_enabled': True, 04:35:23 INFO - 'sps_profile': False, 04:35:23 INFO - 'sps_profile_interval': 0, 04:35:23 INFO - 'suite': 'dromaeojs-e10s', 04:35:23 INFO - 'system_bits': '32', 04:35:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:23 INFO - 'title': 't-yosemite-r7-0273', 04:35:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:23 INFO - 'use_talos_json': True, 04:35:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:23 INFO - 'work_dir': 'build'} 04:35:23 INFO - [mozharness: 2017-02-09 12:35:23.627854Z] Running clobber step. 04:35:23 INFO - Running pre-action listener: _resource_record_pre_action 04:35:23 INFO - Running main action method: clobber 04:35:23 INFO - rmtree: /builds/slave/test/build 04:35:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:23 INFO - Running post-action listener: _resource_record_post_action 04:35:23 INFO - [mozharness: 2017-02-09 12:35:23.997883Z] Finished clobber step (success) 04:35:23 INFO - [mozharness: 2017-02-09 12:35:23.998008Z] Running read-buildbot-config step. 04:35:23 INFO - Running pre-action listener: _resource_record_pre_action 04:35:23 INFO - Running main action method: read_buildbot_config 04:35:23 INFO - Using buildbot properties: 04:35:23 INFO - { 04:35:23 INFO - "project": "", 04:35:23 INFO - "product": "firefox", 04:35:23 INFO - "script_repo_revision": "production", 04:35:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:35:23 INFO - "repository": "", 04:35:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:35:23 INFO - "buildid": "20170209025020", 04:35:23 INFO - "pgo_build": "False", 04:35:23 INFO - "basedir": "/builds/slave/test", 04:35:23 INFO - "buildnumber": 68, 04:35:24 INFO - "slavename": "t-yosemite-r7-0273", 04:35:24 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 04:35:24 INFO - "platform": "yosemite_r7", 04:35:24 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:35:24 INFO - "branch": "mozilla-central", 04:35:24 INFO - "repo_path": "mozilla-central", 04:35:24 INFO - "revision": "b772e0f4138540113e91a46c99bb0d14ecc8acca", 04:35:24 INFO - "stage_platform": "macosx64", 04:35:24 INFO - "builduid": "dd62ecee9b0b4bea9b73a4d0a27acae4", 04:35:24 INFO - "slavebuilddir": "test" 04:35:24 INFO - } 04:35:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:35:24 INFO - Running post-action listener: _resource_record_post_action 04:35:24 INFO - [mozharness: 2017-02-09 12:35:24.001379Z] Finished read-buildbot-config step (success) 04:35:24 INFO - [mozharness: 2017-02-09 12:35:24.001511Z] Running download-and-extract step. 04:35:24 INFO - Running pre-action listener: _resource_record_pre_action 04:35:24 INFO - Running main action method: download_and_extract 04:35:24 INFO - mkdir: /builds/slave/test/build/tests 04:35:24 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')]} 04:35:24 INFO - trying https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:35:25 INFO - Downloaded 1199 bytes. 04:35:25 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:25 INFO - Using the following test package requirements: 04:35:25 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:35:25 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:35:25 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:35:25 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'jsshell-mac.zip'], 04:35:25 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:35:25 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:35:25 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:35:25 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:35:25 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:35:25 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:25 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:35:25 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:35:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:35:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:35:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:35:26 INFO - Expected file size: 34943070 04:35:26 INFO - Obtained file size: 34943070 04:35:33 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:35:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:35:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:35:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:35:34 INFO - Expected file size: 34943070 04:35:34 INFO - Obtained file size: 34943070 04:35:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:35:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:35:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:35:42 INFO - Expected file size: 14403454 04:35:42 INFO - Obtained file size: 14403454 04:35:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:42 INFO - trying https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:35:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:35:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:35:44 INFO - Downloaded 70303506 bytes. 04:35:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:35:44 INFO - mkdir: /builds/slave/test/properties 04:35:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:35:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:35:44 INFO - Contents: 04:35:44 INFO - build_url:https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:35:44 INFO - Running post-action listener: _resource_record_post_action 04:35:44 INFO - Running post-action listener: set_extra_try_arguments 04:35:44 INFO - [mozharness: 2017-02-09 12:35:44.989750Z] Finished download-and-extract step (success) 04:35:44 INFO - [mozharness: 2017-02-09 12:35:44.989880Z] Running populate-webroot step. 04:35:44 INFO - Running pre-action listener: _resource_record_pre_action 04:35:44 INFO - Running main action method: populate_webroot 04:35:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:35:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:35:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:35:44 INFO - '--tppagecycles', 04:35:44 INFO - '7'], 04:35:44 INFO - 'tests': ['tsvgm']}}, 04:35:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:35:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:35:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:35:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:35:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:35:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:35:44 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:35:44 INFO - 'talos_options': ['--disable-e10s'], 04:35:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:35:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:35:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:35:45 INFO - 'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['damp', 'tps']}, 04:35:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:35:45 INFO - 'tests': ['damp', 'tps']}, 04:35:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['dromaeo_dom']}, 04:35:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:35:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['basic_compositor_video']}, 04:35:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:35:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['a11yr', 04:35:45 INFO - 'ts_paint', 04:35:45 INFO - 'tpaint', 04:35:45 INFO - 'sessionrestore', 04:35:45 INFO - 'sessionrestore_no_auto_restore', 04:35:45 INFO - 'tabpaint']}, 04:35:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:35:45 INFO - 'ts_paint', 04:35:45 INFO - 'tpaint', 04:35:45 INFO - 'sessionrestore', 04:35:45 INFO - 'sessionrestore_no_auto_restore', 04:35:45 INFO - 'tabpaint']}, 04:35:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:35:45 INFO - 'ts_paint', 04:35:45 INFO - 'tpaint', 04:35:45 INFO - 'sessionrestore', 04:35:45 INFO - 'sessionrestore_no_auto_restore', 04:35:45 INFO - 'tabpaint']}, 04:35:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:35:45 INFO - 'ts_paint', 04:35:45 INFO - 'tpaint', 04:35:45 INFO - 'sessionrestore', 04:35:45 INFO - 'sessionrestore_no_auto_restore', 04:35:45 INFO - 'tabpaint']}, 04:35:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['a11yr', 04:35:45 INFO - 'ts_paint', 04:35:45 INFO - 'tpaint', 04:35:45 INFO - 'sessionrestore', 04:35:45 INFO - 'sessionrestore_no_auto_restore', 04:35:45 INFO - 'tabpaint']}, 04:35:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['a11yr', 04:35:45 INFO - 'ts_paint', 04:35:45 INFO - 'tpaint', 04:35:45 INFO - 'sessionrestore', 04:35:45 INFO - 'sessionrestore_no_auto_restore', 04:35:45 INFO - 'tabpaint']}, 04:35:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['tsvgx', 04:35:45 INFO - 'tsvgr_opacity', 04:35:45 INFO - 'tart', 04:35:45 INFO - 'tscrollx', 04:35:45 INFO - 'cart', 04:35:45 INFO - 'tsvg_static']}, 04:35:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:35:45 INFO - 'tsvgr_opacity', 04:35:45 INFO - 'tart', 04:35:45 INFO - 'tscrollx', 04:35:45 INFO - 'cart', 04:35:45 INFO - 'tsvg_static']}, 04:35:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:35:45 INFO - 'talos_options': ['--disable-e10s'], 04:35:45 INFO - 'tests': ['tp5o']}, 04:35:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:35:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:35:45 INFO - 'talos_options': ['--disable-e10s', 04:35:45 INFO - '--xperf_path', 04:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:45 INFO - 'tests': ['tp5n']}, 04:35:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:35:45 INFO - 'talos_options': ['--xperf_path', 04:35:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:35:45 INFO - 'tests': ['tp5n']}}, 04:35:45 INFO - 'talos.zip': {'path': '', 04:35:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:35:45 INFO - Running post-action listener: _resource_record_post_action 04:35:45 INFO - [mozharness: 2017-02-09 12:35:45.008562Z] Finished populate-webroot step (success) 04:35:45 INFO - [mozharness: 2017-02-09 12:35:45.008674Z] Running create-virtualenv step. 04:35:45 INFO - Running pre-action listener: _resource_record_pre_action 04:35:45 INFO - Running main action method: create_virtualenv 04:35:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:35:45 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 04:35:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:35:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:35:45 INFO - Using real prefix '/tools/python27' 04:35:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:35:45 INFO - Installing distribute.............................................................................................................................................................................................done. 04:35:48 INFO - Installing pip.................done. 04:35:48 INFO - Return code: 0 04:35:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:35:48 INFO - Reading from file tmpfile_stdout 04:35:48 INFO - Output received: 04:35:48 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:35:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:48 INFO - 'HOME': '/Users/cltbld', 04:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:48 INFO - 'LOGNAME': 'cltbld', 04:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:48 INFO - 'MOZ_NO_REMOTE': '1', 04:35:48 INFO - 'NO_EM_RESTART': '1', 04:35:48 INFO - 'PAGER': '/bin/cat', 04:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:48 INFO - 'PWD': '/builds/slave/test', 04:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:48 INFO - 'SHELL': '/bin/bash', 04:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:35:48 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:48 INFO - 'USER': 'cltbld', 04:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:48 INFO - 'XPC_FLAGS': '0x0', 04:35:48 INFO - 'XPC_SERVICE_NAME': '0', 04:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:49 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 04:35:49 INFO - Cleaning up... 04:35:49 INFO - Return code: 0 04:35:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:35:49 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')]} 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:49 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')]} 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:49 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:35:49 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 04:35:49 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 04:35:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:35:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:49 INFO - 'HOME': '/Users/cltbld', 04:35:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:49 INFO - 'LOGNAME': 'cltbld', 04:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:49 INFO - 'MOZ_NO_REMOTE': '1', 04:35:49 INFO - 'NO_EM_RESTART': '1', 04:35:49 INFO - 'PAGER': '/bin/cat', 04:35:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:49 INFO - 'PWD': '/builds/slave/test', 04:35:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:49 INFO - 'SHELL': '/bin/bash', 04:35:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:35:49 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:35:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:49 INFO - 'USER': 'cltbld', 04:35:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:49 INFO - 'XPC_FLAGS': '0x0', 04:35:49 INFO - 'XPC_SERVICE_NAME': '0', 04:35:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:49 INFO - Downloading/unpacking psutil>=3.1.1 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:54 INFO - Installing collected packages: psutil 04:35:54 INFO - Running setup.py install for psutil 04:35:54 INFO - building 'psutil._psutil_osx' extension 04:35:54 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 04:35:54 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 04:35:54 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 04:35:54 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 04:35:54 INFO - building 'psutil._psutil_posix' extension 04:35:54 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 04:35:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:35:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:35:54 INFO - ^ 04:35:54 INFO - 1 warning generated. 04:35:54 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 04:35:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:35:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:35:54 INFO - Successfully installed psutil 04:35:54 INFO - Cleaning up... 04:35:55 INFO - Return code: 0 04:35:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:55 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:35:55 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 04:35:55 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 04:35:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:35:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:55 INFO - 'HOME': '/Users/cltbld', 04:35:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:55 INFO - 'LOGNAME': 'cltbld', 04:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:55 INFO - 'MOZ_NO_REMOTE': '1', 04:35:55 INFO - 'NO_EM_RESTART': '1', 04:35:55 INFO - 'PAGER': '/bin/cat', 04:35:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:55 INFO - 'PWD': '/builds/slave/test', 04:35:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:55 INFO - 'SHELL': '/bin/bash', 04:35:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:35:55 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:35:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:55 INFO - 'USER': 'cltbld', 04:35:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:55 INFO - 'XPC_FLAGS': '0x0', 04:35:55 INFO - 'XPC_SERVICE_NAME': '0', 04:35:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:35:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:35:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:35:58 INFO - Installing collected packages: mozsystemmonitor 04:35:58 INFO - Running setup.py install for mozsystemmonitor 04:35:58 INFO - Successfully installed mozsystemmonitor 04:35:58 INFO - Cleaning up... 04:35:58 INFO - Return code: 0 04:35:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:35:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:35:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:35:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:35:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:35:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:35:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:35:58 INFO - 'HOME': '/Users/cltbld', 04:35:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:35:58 INFO - 'LOGNAME': 'cltbld', 04:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:35:58 INFO - 'MOZ_NO_REMOTE': '1', 04:35:58 INFO - 'NO_EM_RESTART': '1', 04:35:58 INFO - 'PAGER': '/bin/cat', 04:35:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:35:58 INFO - 'PWD': '/builds/slave/test', 04:35:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:35:58 INFO - 'SHELL': '/bin/bash', 04:35:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:35:58 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:35:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:35:58 INFO - 'USER': 'cltbld', 04:35:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:35:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:35:58 INFO - 'XPC_FLAGS': '0x0', 04:35:58 INFO - 'XPC_SERVICE_NAME': '0', 04:35:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:35:58 INFO - Downloading/unpacking jsonschema==2.5.1 04:35:58 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 04:35:58 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 04:35:58 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 04:35:58 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 04:35:58 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 04:35:58 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 04:36:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:01 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 04:36:01 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 04:36:01 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 04:36:01 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 04:36:01 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 04:36:01 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 04:36:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:01 INFO - warning: no files found matching '*.txt' 04:36:01 INFO - no previously-included directories found matching 'build' 04:36:01 INFO - no previously-included directories found matching 'dist' 04:36:01 INFO - no previously-included directories found matching '.git*' 04:36:01 INFO - Installing collected packages: jsonschema, functools32 04:36:01 INFO - Running setup.py install for functools32 04:36:01 INFO - warning: no files found matching '*.txt' 04:36:01 INFO - no previously-included directories found matching 'build' 04:36:01 INFO - no previously-included directories found matching 'dist' 04:36:01 INFO - no previously-included directories found matching '.git*' 04:36:01 INFO - Successfully installed jsonschema functools32 04:36:01 INFO - Cleaning up... 04:36:01 INFO - Return code: 0 04:36:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:01 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:36:01 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 04:36:01 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 04:36:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:01 INFO - 'HOME': '/Users/cltbld', 04:36:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:01 INFO - 'LOGNAME': 'cltbld', 04:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:01 INFO - 'MOZ_NO_REMOTE': '1', 04:36:01 INFO - 'NO_EM_RESTART': '1', 04:36:01 INFO - 'PAGER': '/bin/cat', 04:36:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:01 INFO - 'PWD': '/builds/slave/test', 04:36:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:01 INFO - 'SHELL': '/bin/bash', 04:36:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:01 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:01 INFO - 'USER': 'cltbld', 04:36:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:01 INFO - 'XPC_FLAGS': '0x0', 04:36:01 INFO - 'XPC_SERVICE_NAME': '0', 04:36:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:02 INFO - Cleaning up... 04:36:02 INFO - Return code: 0 04:36:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:02 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')]} 04:36:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:02 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')]} 04:36:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:02 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:36:02 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 04:36:02 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 04:36:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:02 INFO - 'HOME': '/Users/cltbld', 04:36:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:02 INFO - 'LOGNAME': 'cltbld', 04:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:02 INFO - 'MOZ_NO_REMOTE': '1', 04:36:02 INFO - 'NO_EM_RESTART': '1', 04:36:02 INFO - 'PAGER': '/bin/cat', 04:36:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:02 INFO - 'PWD': '/builds/slave/test', 04:36:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:02 INFO - 'SHELL': '/bin/bash', 04:36:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:02 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:02 INFO - 'USER': 'cltbld', 04:36:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:02 INFO - 'XPC_FLAGS': '0x0', 04:36:02 INFO - 'XPC_SERVICE_NAME': '0', 04:36:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:02 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 04:36:02 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 04:36:02 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 04:36:02 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 04:36:02 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 04:36:02 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 04:36:05 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36: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 04:36:06 INFO - Downloading docopt-0.6.1.tar.gz 04:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:06 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:06 INFO - Running setup.py install for blobuploader 04:36:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:06 INFO - Running setup.py install for requests 04:36:07 INFO - Running setup.py install for docopt 04:36:07 INFO - Successfully installed blobuploader requests docopt 04:36:07 INFO - Cleaning up... 04:36:07 INFO - Return code: 0 04:36:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:07 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:36:07 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 04:36:07 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 04:36:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:07 INFO - 'HOME': '/Users/cltbld', 04:36:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:07 INFO - 'LOGNAME': 'cltbld', 04:36:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:07 INFO - 'MOZ_NO_REMOTE': '1', 04:36:07 INFO - 'NO_EM_RESTART': '1', 04:36:07 INFO - 'PAGER': '/bin/cat', 04:36:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:07 INFO - 'PWD': '/builds/slave/test', 04:36:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:07 INFO - 'SHELL': '/bin/bash', 04:36:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:07 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:07 INFO - 'USER': 'cltbld', 04:36:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:07 INFO - 'XPC_FLAGS': '0x0', 04:36:07 INFO - 'XPC_SERVICE_NAME': '0', 04:36:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-YpWHjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-UU3mPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-dqUFId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-fRrCF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:07 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-FIF5T4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vcsrFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Hu5quf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-2i8W6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-qmT2St-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-Pa4avD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-k4HnZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-w0mzdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-7j_Quk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:08 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-t2WIX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-hYncS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-ijSGkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:09 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-7AFm8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:09 INFO - Running setup.py install for manifestparser 04:36:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:09 INFO - Running setup.py install for mozcrash 04:36:09 INFO - Running setup.py install for mozdebug 04:36:09 INFO - Running setup.py install for mozdevice 04:36:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:09 INFO - Running setup.py install for mozfile 04:36:10 INFO - Running setup.py install for mozhttpd 04:36:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Running setup.py install for mozinfo 04:36:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Running setup.py install for mozInstall 04:36:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Running setup.py install for mozleak 04:36:10 INFO - Running setup.py install for mozlog 04:36:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Running setup.py install for moznetwork 04:36:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:10 INFO - Running setup.py install for mozprocess 04:36:11 INFO - Running setup.py install for mozprofile 04:36:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:11 INFO - Running setup.py install for mozrunner 04:36:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:11 INFO - Running setup.py install for mozscreenshot 04:36:11 INFO - Running setup.py install for moztest 04:36:11 INFO - Running setup.py install for mozversion 04:36:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:11 INFO - Cleaning up... 04:36:11 INFO - Return code: 0 04:36:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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')]} 04:36:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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')]} 04:36:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:11 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:36:11 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 04:36:11 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 04:36:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:11 INFO - 'HOME': '/Users/cltbld', 04:36:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:11 INFO - 'LOGNAME': 'cltbld', 04:36:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:11 INFO - 'MOZ_NO_REMOTE': '1', 04:36:11 INFO - 'NO_EM_RESTART': '1', 04:36:11 INFO - 'PAGER': '/bin/cat', 04:36:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:11 INFO - 'PWD': '/builds/slave/test', 04:36:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:11 INFO - 'SHELL': '/bin/bash', 04:36:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:11 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:11 INFO - 'USER': 'cltbld', 04:36:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:11 INFO - 'XPC_FLAGS': '0x0', 04:36:11 INFO - 'XPC_SERVICE_NAME': '0', 04:36:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-jQXfqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:12 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)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-nC0vil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-rlqOym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:12 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)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vOyMnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-D3121J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:12 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)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1pqbZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:12 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)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-7EFBBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:12 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)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-t3DVE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:12 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)) 04:36:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:12 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-C5DJ7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:13 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-9AvDTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:13 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-cEV7m3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:13 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-vWaF30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-0rd5Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:13 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-1eJBy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-_zD5Bz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:13 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-F4HrFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:36:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:13 INFO - Running setup.py (path:/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/pip-LoEbFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:13 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)) 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:13 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)) 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:13 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 04:36:13 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 04:36:13 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 04:36:13 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 04:36:13 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 04:36:13 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 04:36:16 INFO - Downloading blessings-1.6.tar.gz 04:36:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:16 INFO - Installing collected packages: blessings 04:36:16 INFO - Running setup.py install for blessings 04:36:16 INFO - Successfully installed blessings 04:36:16 INFO - Cleaning up... 04:36:16 INFO - Return code: 0 04:36:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:17 INFO - Reading from file tmpfile_stdout 04:36:17 INFO - Current package versions: 04:36:17 INFO - blessings == 1.6 04:36:17 INFO - blobuploader == 1.2.4 04:36:17 INFO - docopt == 0.6.1 04:36:17 INFO - functools32 == 3.2.3-2 04:36:17 INFO - jsonschema == 2.5.1 04:36:17 INFO - manifestparser == 1.1 04:36:17 INFO - mozInstall == 1.12 04:36:17 INFO - mozcrash == 1.0 04:36:17 INFO - mozdebug == 0.1 04:36:17 INFO - mozdevice == 0.49 04:36:17 INFO - mozfile == 1.2 04:36:17 INFO - mozhttpd == 0.7 04:36:17 INFO - mozinfo == 0.9 04:36:17 INFO - mozleak == 0.1 04:36:17 INFO - mozlog == 3.4 04:36:17 INFO - moznetwork == 0.27 04:36:17 INFO - mozprocess == 0.24 04:36:17 INFO - mozprofile == 0.28 04:36:17 INFO - mozrunner == 6.13 04:36:17 INFO - mozscreenshot == 0.1 04:36:17 INFO - mozsystemmonitor == 0.3 04:36:17 INFO - moztest == 0.8 04:36:17 INFO - mozversion == 1.4 04:36:17 INFO - psutil == 3.1.1 04:36:17 INFO - requests == 1.2.3 04:36:17 INFO - wsgiref == 0.1.2 04:36:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36:17 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')]} 04:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:17 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')]} 04:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:18 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:36:18 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 04:36:18 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 04:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:18 INFO - 'HOME': '/Users/cltbld', 04:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:18 INFO - 'LOGNAME': 'cltbld', 04:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:18 INFO - 'MOZ_NO_REMOTE': '1', 04:36:18 INFO - 'NO_EM_RESTART': '1', 04:36:18 INFO - 'PAGER': '/bin/cat', 04:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:18 INFO - 'PWD': '/builds/slave/test', 04:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:18 INFO - 'SHELL': '/bin/bash', 04:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:18 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:18 INFO - 'USER': 'cltbld', 04:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:18 INFO - 'XPC_FLAGS': '0x0', 04:36:18 INFO - 'XPC_SERVICE_NAME': '0', 04:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 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)) 04:36:18 INFO - Cleaning up... 04:36:18 INFO - Return code: 0 04:36:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:18 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 0x103fc8b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103fcb768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa391c60ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, '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.wLXYS4k88z/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.3CybCgu9I1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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 04:36:18 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 04:36:18 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 04:36:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:18 INFO - 'HOME': '/Users/cltbld', 04:36:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:18 INFO - 'LOGNAME': 'cltbld', 04:36:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:18 INFO - 'MOZ_NO_REMOTE': '1', 04:36:18 INFO - 'NO_EM_RESTART': '1', 04:36:18 INFO - 'PAGER': '/bin/cat', 04:36:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:18 INFO - 'PWD': '/builds/slave/test', 04:36:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:18 INFO - 'SHELL': '/bin/bash', 04:36:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:18 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:18 INFO - 'USER': 'cltbld', 04:36:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:18 INFO - 'XPC_FLAGS': '0x0', 04:36:18 INFO - 'XPC_SERVICE_NAME': '0', 04:36:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:18 INFO - Cleaning up... 04:36:18 INFO - Return code: 0 04:36:18 INFO - Running post-action listener: _resource_record_post_action 04:36:18 INFO - Running post-action listener: _start_resource_monitoring 04:36:18 INFO - Starting resource monitoring. 04:36:18 INFO - [mozharness: 2017-02-09 12:36:18.931338Z] Finished create-virtualenv step (success) 04:36:18 INFO - [mozharness: 2017-02-09 12:36:18.932261Z] Running install step. 04:36:18 INFO - Running pre-action listener: _resource_record_pre_action 04:36:18 INFO - Running main action method: install 04:36:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:19 INFO - Reading from file tmpfile_stdout 04:36:19 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:19 INFO - Reading from file tmpfile_stdout 04:36:19 INFO - Output received: 04:36:19 INFO - Usage: mozinstall [options] installer 04:36:19 INFO - Options: 04:36:19 INFO - -h, --help show this help message and exit 04:36:19 INFO - -d DEST, --destination=DEST 04:36:19 INFO - Directory to install application into. [default: 04:36:19 INFO - "/builds/slave/test"] 04:36:19 INFO - --app=APP Application being installed. [default: firefox] 04:36:19 INFO - mkdir: /builds/slave/test/build/application 04:36:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:36:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:36:41 INFO - Reading from file tmpfile_stdout 04:36:41 INFO - Output received: 04:36:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:36:41 INFO - Running post-action listener: _resource_record_post_action 04:36:41 INFO - [mozharness: 2017-02-09 12:36:41.171141Z] Finished install step (success) 04:36:41 INFO - [mozharness: 2017-02-09 12:36:41.171283Z] Running run-tests step. 04:36:41 INFO - Running pre-action listener: _resource_record_pre_action 04:36:41 INFO - Running main action method: run_tests 04:36:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:36:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:36:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:36:41 INFO - 2017-02-09 04:36:41.185 screenresolution[1980:281490] starting screenresolution argv=screenresolution get 04:36:41 INFO - 2017-02-09 04:36:41.188 screenresolution[1980:281490] Display 0: 1600x1200x32@60 04:36:41 INFO - 2017-02-09 04:36:41.194 screenresolution[1981:281493] starting screenresolution argv=screenresolution list 04:36:41 INFO - Available Modes on Display 0 04:36:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:36:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:36:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:36:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:36:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:36:41 INFO - Intel Iris: 04:36:41 INFO - Chipset Model: Intel Iris 04:36:41 INFO - Type: GPU 04:36:41 INFO - Bus: Built-In 04:36:41 INFO - VRAM (Dynamic, Max): 1536 MB 04:36:41 INFO - Vendor: Intel (0x8086) 04:36:41 INFO - Device ID: 0x0a2e 04:36:41 INFO - Revision ID: 0x0009 04:36:41 INFO - Displays: 04:36:41 INFO - Display: 04:36:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:36:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:36:41 INFO - Display Serial Number: 1600x1200 60 04:36:41 INFO - Main Display: Yes 04:36:41 INFO - Mirror: Off 04:36:41 INFO - Online: Yes 04:36:41 INFO - Rotation: Supported 04:36:41 INFO - Return code: 0 04:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:36:41 INFO - Python 2.7.3 04:36:41 INFO - Return code: 0 04:36:41 INFO - grabbing minidump binary from tooltool 04:36:41 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')]} 04:36:41 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 0x103da6d30>, '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 0x103ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103d9bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:36:41 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 04:36:41 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 04:36:41 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 04:36:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:36:41 INFO - Return code: 0 04:36:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:36:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:36:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:36:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:36:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:36:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 04:36:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0273 --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 04:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wLXYS4k88z/Render', 04:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:41 INFO - 'HOME': '/Users/cltbld', 04:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:41 INFO - 'LOGNAME': 'cltbld', 04:36:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:36:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:41 INFO - 'MOZ_NO_REMOTE': '1', 04:36:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:36:41 INFO - 'NO_EM_RESTART': '1', 04:36:41 INFO - 'PAGER': '/bin/cat', 04:36:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:41 INFO - 'PWD': '/builds/slave/test', 04:36:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:41 INFO - 'SHELL': '/bin/bash', 04:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3CybCgu9I1/Listeners', 04:36:41 INFO - 'TMPDIR': '/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/', 04:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:41 INFO - 'USER': 'cltbld', 04:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:41 INFO - 'XPC_FLAGS': '0x0', 04:36:41 INFO - 'XPC_SERVICE_NAME': '0', 04:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0273', '--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 04:36:41 INFO - mozversion application_buildid: 20170209025020 04:36:41 INFO - mozversion application_changeset: b772e0f4138540113e91a46c99bb0d14ecc8acca 04:36:41 INFO - mozversion application_display_name: Nightly 04:36:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:36:41 INFO - mozversion application_name: Firefox 04:36:41 INFO - mozversion application_remotingname: firefox 04:36:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:36:41 INFO - mozversion application_vendor: Mozilla 04:36:41 INFO - mozversion application_version: 54.0a1 04:36:41 INFO - mozversion platform_buildid: 20170209025020 04:36:41 INFO - mozversion platform_changeset: b772e0f4138540113e91a46c99bb0d14ecc8acca 04:36:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:36:41 INFO - mozversion platform_version: 54.0a1 04:36:41 INFO - using testdate: 1486643801 04:36:41 INFO - actual date: 1486643801 04:36:41 INFO - starting webserver on 'localhost:49311' 04:36:41 INFO - SUITE-START | Running 2 tests 04:36:41 INFO - TEST-START | dromaeo_css 04:36:41 INFO - operating with platform_type : mac_ 04:36:41 INFO - Initialising browser for dromaeo_css test... 04:36:41 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpKD1xDm/profile http://localhost:49311/getInfo.html) 04:36:44 INFO - PROCESS | 1991 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:36:44 INFO - PROCESS | 1991 | 2017-02-09 04:36:44.846 plugin-container[1995:281666] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3b, name = 'com.apple.tsm.portname' 04:36:44 INFO - PROCESS | 1991 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:44 INFO - PROCESS | 1991 | 2017-02-09 04:36:44.849 plugin-container[1995:281666] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 04:36:44 INFO - PROCESS | 1991 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:44 INFO - PROCESS | 1991 | 2017-02-09 04:36:44.849 plugin-container[1995:281666] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:44 INFO - PROCESS | 1991 | __metrics Screen width/height:1600/1200 04:36:44 INFO - PROCESS | 1991 | colorDepth:24 04:36:44 INFO - PROCESS | 1991 | Browser inner width/height: 1024/689 04:36:44 INFO - PROCESS | 1991 | __metrics 04:36:44 ERROR - PROCESS | 1991 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:36:45 INFO - TEST-INFO | 1991: exit 0 04:36:45 INFO - Browser initialized. 04:36:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:36:45 INFO - TEST-INFO | started process 1996 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpKD1xDm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:36:48 INFO - PROCESS | 1996 | 2017-02-09 04:36:48.294 plugin-container[1997:281782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 04:36:48 INFO - PROCESS | 1996 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:48 INFO - PROCESS | 1996 | 2017-02-09 04:36:48.294 plugin-container[1997:281782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 04:36:48 INFO - PROCESS | 1996 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:36:48 INFO - PROCESS | 1996 | 2017-02-09 04:36:48.294 plugin-container[1997:281782] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:36:58 INFO - PROCESS | 1996 | RSS: Main: 233095168 04:36:58 INFO - PROCESS | 1996 | 04:40:00 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49311/tests/dromaeo/cssquery-ext.html) 04:40:02 INFO - PROCESS | 1996 | RSS: Main: 256536576 04:40:02 INFO - PROCESS | 1996 | 04:41:46 INFO - PROCESS | 1996 | ************************* 04:41:46 INFO - PROCESS | 1996 | A coding exception was thrown and uncaught in a Task. 04:41:46 INFO - PROCESS | 1996 | 04:41:46 ERROR - PROCESS | 1996 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:41:46 INFO - PROCESS | 1996 | Full stack: 04:41:46 INFO - PROCESS | 1996 | ************************* 04:43:04 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-ext.html (next: http://localhost:49311/tests/dromaeo/cssquery-jquery.html) 04:43:05 INFO - PROCESS | 1996 | RSS: Main: 264110080 04:43:05 INFO - PROCESS | 1996 | 04:46:07 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49311/tests/dromaeo/cssquery-mootools.html) 04:46:07 INFO - PROCESS | 1996 | RSS: Main: 275124224 04:46:07 INFO - PROCESS | 1996 | 04:49:09 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49311/tests/dromaeo/cssquery-prototype.html) 04:49:10 INFO - PROCESS | 1996 | RSS: Main: 269152256 04:49:10 INFO - PROCESS | 1996 | 04:52:13 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49311/tests/dromaeo/cssquery-yui.html) 04:52:13 INFO - PROCESS | 1996 | RSS: Main: 274128896 04:52:13 INFO - PROCESS | 1996 | 04:55:16 INFO - PROCESS | 1996 | Cycle 1(1): loaded http://localhost:49311/tests/dromaeo/cssquery-yui.html (next: http://localhost:49311/tests/dromaeo/cssquery-dojo.html) 04:55:17 INFO - PROCESS | 1996 | RSS: Main: 275685376 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | __start_tp_report 04:55:17 INFO - PROCESS | 1996 | _x_x_mozilla_page_load 04:55:17 INFO - PROCESS | 1996 | _x_x_mozilla_page_load_details 04:55:17 INFO - PROCESS | 1996 | |i|pagename|runs| 04:55:17 INFO - PROCESS | 1996 | |0;dojo.html;2658.5746280595104;2762.599423083652;3314.055494184158;3348.5312056312114;3352.748543859211;5501.889962200764;5537.335519737632;5560.193771903072;5579.721013949302;5594.664320140794;5564.888702225953;5566.666000040001;5568.916466253009;5593.328800543941;5624.606277560572;4999.700017998914;5082.95799361132;5153.665011774223;5226.242194881759;5233.633645644806;5128.8974220515565;5201.141811601081;5247.449017853128;5252.343457067866;5290.92063619046;4986.927810520756;5058.392992840846;5060.797568097271;5131.717755523445;5137.6660517066275;5130.615203859726;5139.177731562932;5142.07442660321;5165.199394093921;5195.922061169085;5089.160288552384;5119.078565858144;5125.256837758504;5163.070647283487;5207.817726379559;4290.721103128318;4925.990172014728;5053.292539044537;5520.475554822286;5611.915821262684;6039.214902062748;6114.875284800388;6127.220070483952;6134.589663226396;6139.614800607363;6126.466494332852;6129.448349648508;6171.074338849164;6175.536834737412;6184.81445556634;5506.752196151183;5563.5271001964475;5741.8564535886935;5742.2247996520355;5764.682942438164;5098.872528186751;6118.694065296718;6145.784897528565;6181.84545386369;6202.658853762996;5734.741936612862;5830.533557315404;5888.499477544457;6029.969850150721;6037.184980027728;6125.540584456184;6142.907856382158;6144.77104579086;6148.661823599745;6168.753249869955;5829.970850145807;6123.28262147438;6125.635385022116;6132.324915438508;6133.028644417026;5906;6084.574079814371;6096.268447786205;6118.265808102967;6164.568480206342;4915.238138088602;4915.680480768739;4919.852404427873;4940.530649588283;4959.950400495949;4425.889352766142;4436.401085853433;4441.156180325728;4442.555744425532;4471.195184866755;5419.972900135474;5479.986202552541;5506.64206826555;5633.971830140905;5648.435156484319;5141;6124.838682352462;6167.753289868445;6168.568200226031;6214.8135555933395;5620.57845661577;5673.602847800615;5682.516986056232;5684.516816070598;5684.54523638108;5217.895642087213;5250.553702935294;5301.363836339664;5337.306150200449;5418.864528386743;6108.888502348253;6189.566730329014;6202.844928876633;6217.285012223471;6228.283747369111;6164.445199932027;6170.167027451416;6183.536234782319;6191.226096737908;6198.194234749634;5210.426853046086;6044.032954727222;6129.8784197560135;6188.288346840171;6230.127782110599;4622;6008.849778755566;6023.247094113236;6048.395160483917;6131.233595800525;5943.632964418294;5964.522838172849;6109.877802444015;6114.48026917717;6119.663418511846;5766.740496677743;5834.533237341087;5902.321233058254;5934.851628709317;5959.986802243716;6000.5799594028;6007.098935159761;6009;6027.789027384196;6047.274327080779;5720.39935806751;5799.014167591604;5863.442972917566;5864.794732184353;5879.412058794257;5682.14767784819;5747.1379293106365;5804.622699524517;5841.240638716939;6023.608465449732;5539.695316757617;5541.33503979525;5546.528545073714;5550.139728342114;5579.386267510489 04:55:17 INFO - PROCESS | 1996 | |1;ext.html;457.5721700210304;457.70706747681487;512.7180050971964;521.0178812937614;534.989300213996;32206.516902246454;32272.838635806816;39159.0210244744;39174.60825391745;39309.01727456815;40504.79747601258;41271.793641031756;41282.38076428856;41369.37945930806;41424.58575414245;9003.324750643695;10633.202509811756;11000.944995275053;11030.834537481944;11159.27464714791;9505.52472376382;10724.892751072468;10819.891801081967;10945.398003109825;10953.780924381548;9505.952470237638;9827.312088153833;10439.478026098703;10929.56281748733;10966.122710183206;10803.513841877095;10868.510917008754;10868.67393978178;10874.836877446845;10910.727231819188;10643.893561064368;10678.733031674192;10728.195385346053;10787.83818242727;10818.837717434166;35951.64048359509;36371.4544281836;36377.81811090954;36394;36453.81773091144;3731.2350968051483;3785.318642644323;3793.6016718244464;3806.200697853454;3809.847606095753;23040.539189216288;27004.459910801674;27304.726952730416;27488.862555687294;27538.586921196198;3045.4061458015694;3101.2246938265434;3111.471049921519;3137.278425962019;3193.8562764675644;446572;446911.765441174;447638;448929;452260;35696.821515892254;44892.77553612276;53842.19236711453;54926.72536637291;55102;49858;52355;54671;56986;57299.84301412809;14114.364853581408;14720.043197192148;14722.337494812758;14731;14773.113613183243;11325.433728313552;11376.317420954769;11408.94295528517;11430.142739294586;11440.370779607036;14797.778033329509;16478.505644830435;16991.98048117117;17161.056141912064;17308.567285817702;7434.739784107638;7514.774556763306;7522.736704215326;7619.65679562644;7651.655675494616;816.4856140631364;826.9297109745739;831.8045259364045;839.2530647723531;848.5375470368664;25842.483150336888;26088.73911260901;28119.57820632692;29155;29641.25896852596;995.5669283861544;1004.924630652704;1031.1235449867552;1053.7365658585354;1196.2355525599844;15319.693606127816;15453.150076745887;15535.223238838013;15560.766588501181;15631.983921045095;528133;530198;530420;530954;534542;56732.149017764765;56947.43052569504;57018.574535636944;57473.425265747646;57709;1291.367230057284;1351.1420248142501;1352.932353382327;1357.2942070123481;1363.8022486739367;24863.87568062148;25554.74445255524;28035.859820700767;29018.12945611635;29800.850995744884;48595;48732.025359493324;49928.51072339178;50032;52879.678008050105;396938;476479;476996;485859;486597;21749.891250543646;22260.77739222587;24210.87894560516;24554;24912.875435622707;41268.587314126475;41365.58634413738;41493.962650933965;42028;42427.575724242364;30791.538126927666;32875.342493149525;34256.62973481132;34299.314013719086;35081;33407;34143;35003.82498087493;35006.47490287699;35620;34349.14127146841;34527.30945381028;34597.30805383828;34754.82622586972;34895;29579.852100739357;30784.230394240323;30819.38361232718;30845.845770771004;31077.067687969397;19715.507112322306;23243.0702771894;23458.061677532707;23841;24020.39949001289 04:55:17 INFO - PROCESS | 1996 | |2;jquery.html;377.712938166993;380.89642848400297;386.1658816955376;395.18788888833444;415.96009975062344;13669.65825854354;19431.222751089957;19675.901620491877;20332.390028299156;20609.175632974682;20110.893900835486;20285.0871710773;21070.367888963316;21225.893870530665;21240.681389779125;5422.810201642934;5742.368339482654;5851.79518716845;5926.436988486109;5945.019071853139;5593.636413633121;5728.22668939692;5800.419958004208;5822.1266809978415;5835.854103647401;5703.8574035649235;5776.960147173507;5782.884342313151;5783.768649254025;5783.768649254046;5521.1442226454965;5716.371199168088;5770.249867517238;5777.653340799545;5778.50882674971;5116.360454943132;5116.641835071547;5120.92318615221;5129.204973229155;5137.2037334213255;20929.581408371898;24653.63019554708;25288.856129726308;25311;25328.240152795446;2612.7779138773226;2678.8392696438277;2691.300261931912;2710.2817753295394;2710.5934109883674;9500.90739564952;10295.691129266059;14978;15402.845971540253;15923.52229433119;1551.2553974092386;1761.4891681412375;1834.5780470491727;1840.0707642640514;1855.2486243071578;109322;127537;136821;137550;140242;10050.798984020425;10720.249582529148;10984.395858227714;11606.94196529012;11750.059995200363;12998.675033124247;13031.47874085026;13048.739025219442;13189.538366157138;14920.552383428514;6407.487401007908;6525.902111468332;7758.95254140695;8385.496870187808;8452.915470845335;7981.561014144278;7985.281324680806;7994.680212791423;8064;8144.389170812213;4765.499622539653;4777.498362671939;4809.975950120297;4839.249916262985;4948.90102197954;1660.800703915538;1831.6336732653256;1960.5686748915216;2052.127845665586;2071.2336435518955;699.0632552379835;746.302207436049;769.2691942654388;777.1412589089089;784.6351446577255;17996.820031799776;21482.57034859294;21724.43786804757;22169.45288753792;22297.10811567519;759.5480688990042;761.9447065813888;818.0428898189133;829.6808075160524;830.8213734047209;11058.834117488244;11568.249988807715;11694.94152529249;11713.355765432983;11716.004139648225;682133;687078;688910;694081;702814;97612;142365;144083;147348;150787;1009.2934945538153;1037.273908264218;1056.3503445381189;1057.0644979193469;1058.142904247562;18027.2789088435;18710.719339210194;19839;19898.801011989694;20255.59488810245;53321.7333913328;55990;56454.1531877014;56509.71745141412;59663;46738;63862;77359;80825;80987.19012810032;7333.816654583678;7633.351165151024;7709.689352809924;8172.101068882299;8560.957195213985;11583.942080289544;12698.555550555686;12755.426005829946;13237.338133093113;13330.200187988752;11010.284331518425;11243.156763242627;11276.718082047686;11364.318140911571;11660.06719462458;10717.464126793473;10991.670249892515;11069.667909962714;11424.543018279175;11465;10921.781564368826;11044.179708325404;11701.239419437708;11834.053275738093;11881.5841445549;7055.435565154878;8406.243438090602;8487.575621219037;8496.575171241537;8554.31565474773;8219.630116644885;9040.367174297737;11368.488418021043;11421.885781142082;11498.08015358786 04:55:17 INFO - PROCESS | 1996 | |3;mootools.html;1272.4464857786857;1320.4520124148478;1386.8197134372533;1412.7103943691545;1425.0238586568203;8076.71731489398;8081.111077781439;8388.748337549883;8504.829903401936;8532.70135545256;8361.038480574736;8453.87319190211;8474.364422668294;8488.151184881508;8523.488590684563;2129.9787002129974;2249.8200143988524;2251.8761468119246;2255.0077965695123;2264.6977987657083;2235.1729859951843;2247.6291411917014;2264.003838311146;2264.1622599638076;2278.3392816083315;2222.4554984028937;2222.8999695013763;2253.7746225377496;2258.5369999150216;2259.8531095478825;2094.371688493446;2230.2528652901296;2245.1917309768633;2252.51570912253;2256.593813113639;1902.7431296774896;1932.8646994710375;2025.767036790773;2257.582347265745;2270.943226419336;8186.345092392594;8376.371772117116;8423.536705481196;8462.78843028923;8504.23461888433;5030.094582975063;5201.765920533585;5205.297284866532;5207.218917162418;5213.426523082458;3319.4854797506423;3442.5180474733556;3452.861885524576;3466.2027733621157;3523.3834079036324;1184.8222766584995;1185.7984142695761;1221.584661215191;1223.4127618743053;1236.876312368765;10828.566857325697;10841.078508326802;10853.51159197838;10864.837027444595;10933.343999360064;4134.586541345841;4364.279893817548;4446.755428451466;4447.266201076786;4492.438445194351;7231.16841563227;8579.613917373734;8641.049484556694;8648;8655.52394618302;4157.563455837094;4430.800613972379;4955.677880937799;5071.41678706946;5091.465396133352;4490.640748740093;4578.908421831545;4697.248440249544;4761.381020467317;4781.306710526954;3425.9828700856337;3433.1073920780777;3473.913152171216;3485.7908525488047;3511.2801875615437;974.9853752193723;1124.814405623063;1125.9887401125884;1137.5108703257679;1141.2695874640071;807.3097501636134;860.5525126933959;880.700561808988;914.0630853375211;917.2295271971443;5640.887182256414;5682.801101961411;5687.232223649754;5761.452661997104;6020.277566691937;833.983320333602;960.6589660670501;960.711786464058;964.4358050540372;1007.5566750629699;3583.6953858922284;3607.603163651996;3699.3711069118312;3790.8673196437994;3833.0609000794984;9800.313978021613;10130.898691013143;10145.289829711997;10150.695479135638;10150.98490150979;10002.599896004223;10082.546285417175;10084.445355505371;10088.243381746252;10094.899051009543;6604.273529911706;7911.97144371228;7918.881216781753;7940.444168908121;7946.6424010919645;5506.339239291311;5531.336239651107;5543.667379957215;5590.44095590454;5853.619514731528;9062.864057039282;9266.258699303904;9278.164965152899;9296.535173241176;9325.533723313943;8963.731088067369;9222.769430764285;9336.859947100935;9352.485613291063;9461.195798357217;7016.543924644881;7136.6788494518905;7161.534500257467;7167.928320716726;7176.856462870818;7819.648115834915;7824.921750782647;7894.1316455188735;7909.52542847431;7920.5247685139075;7020.122484689414;7085.078939737801;7127.10911136108;7160.319769622086;7230.530015548972;5741.971290143522;6994.825129371807;6995.965020174866;7022.262662420577;7142.428605711634;6271.122042914087;6359.87280254383;6407.935920640734;6422.389872962061;6425.646589437439;4082.4692789937117;4108.897277567965;4453.866384008485;4543.659225558163;4610.723356598614;4489.506154323087;4866.367372241586;4985.255160693729;5043.596512278936;5157 04:55:17 INFO - PROCESS | 1996 | |4;prototype.html;315.2890232525654;344.9758516903818;352.11091992718383;357.7406380374228;362.98548058077677;4315;4720.5515476029805;5209.453007434222;5298.894022119555;5394.7032913189805;5204.817831375903;5251.396089449714;5264.499872512115;5267.9990801747645;5276.258834584587;3238.805671659702;3372.29181871806;3878.45701601776;4017.6785857131504;4029.1594425929648;3579.7673151245085;3718.2749363874054;3971.7021223408215;4030.8186131624147;4053.655439287649;3576.3204991051616;3861.3242682530586;3887.2614203301423;3935.724499285051;3937.676770705283;3073.830939298338;3465.6014558325865;3894.493715816954;3906.277338692351;3937.606239376068;3046.664866864643;3446.0351101691567;3447.6554143883905;3458.844352004166;3470.9826450867836;4917.926231106536;5043.67216130954;5058.645894787366;5157.355330583677;5188.9881473112755;4190.371444283352;4426.800793964279;4480.753558554278;4484.663650226246;4487;4840.733759643218;5219.799446127374;5238.266642670029;5372.623916325859;5504.559635229172;2980.3890202508433;3299.977007127774;3787.9053023674355;3793.3172029034763;3816.255830113129;5127.307813445174;5476.863078423032;5697.943020569741;5717.8570535736935;5749.9425005750245;3426.3832510148413;3516.894493165209;3664.157243833933;3749.8188070757624;3828.73198876076;3403.0811680846527;3874.360730479439;3880.9223815523533;3884.378499440076;3930.3514920037874;4131.421600975866;4501.77491125449;4528.660350473728;4555.248384016666;4573.787946194261;5259.737013149327;5493.423190565013;5558.527525160326;5626.803061892814;5634.7182640867795;1029.156092004564;1143.9199256051998;1263.109507797001;1273.7707212701803;1279.5201799325253;775.6393277126164;796.3708670150633;847.732639703647;862.5385418800911;870.2646263906988;4328.783560821947;4432.246518091933;4445.4885338984905;4696.430712658404;4928.654994150446;4667.439907211156;4975.925361119586;5065.6200784941275;5422.457754224625;5476.342838859283;3797.3164830330807;4390.253656878338;4426.933595996063;4858.951410485921;4895.755212239374;2683.6645419322585;2736.8357898525755;2792.3298408381843;2911.5733290687413;2923.9766081871176;4703.988642441823;5081.3140226069745;5422.7017514036315;5661.886762264731;5700.781421747876;4915.156816193928;5075.949240507622;5189.6886186828915;5255.710935898486;5732.34078081026;4959.7272150032095;4987.855222254538;5384.784608615611;5457.836264912059;5591.189277554813;4647.675412507554;4702;4809.44691360498;5380.219868119179;5486.31421072366;4409.40473036136;4527.524609916043;4845.0067736114715;5391.784328626811;5473.480019398151;5521.889562208814;5614.45602459327;5674.0494942628775;5681.517071049007;5702.800401985911;3802.258559580855;3803;3806.657400833938;3811.313963486599;3816.94274585887;5700.087985922399;5711.7429715662065;5725.484706376446;5756.827295181151;5760.567957403296;4448.377227188261;5360.525855389643;5522.392536820867;5537.640053396516;5547.084731019498;4458.84070141772;4640.148676598483;4713.599344055794;5454.281901201109;5571.637843540157;4831.5651591355545;4856.8300109495995;5055.620828437955;5060.569851562511;5405.783768649368;4801.719183388002;4868.95131048685;5466.316710411199;5486.725663716718;5699.914501282401;5123.052235336475;5251.002309561171;5286.894262114659;5293.364796224478;5328.626996110235 04:55:17 INFO - PROCESS | 1996 | |5;yui.html;595.886781511513;706.5019161491145;745.8993035940148;764.7820371194207;811.8701007838745;14417.495387661435;15418.460353887616;15419.537413877588;15456.45902393415;15471.381144754196;13531.323433828295;14097.929510352435;14163.92918035411;14301.141931484119;14321;859.9957000215006;880.8810810540559;896.8923729152478;897.8428774964387;899.1817446124029;885.2519620920312;891.189017993626;891.9152680495342;893.0266010049078;894.0969620683125;937.409432057806;939.9906000940006;940.3887473142478;943.1087622197026;952.538019060755;931.7204838548408;938.4932136646203;939.3847030195233;939.8872135343734;941.3175447800324;666.8066260784367;700.7652436433801;701.4528667639249;702.9789106326818;707.1514182980444;15090.924545377313;15099.924500377538;15362.385504579803;15486.380544778196;15654.452094176762;14336.354864031144;14484.710305793931;14512.346944387527;14521.636959076108;14578;9604.711858644252;10729.658792650918;10977.670669879917;11962.58130965412;11985.460654270579;3643.417053271464;3652.2695460907657;3813.199228162089;3845.3270677631303;3865.942010869839;77953;95623.52188239084;97120.51439742756;97609.0239097607;98233.5088324561;9587.760305992266;10522.473876306154;10895.855935126856;11071.72320691973;11086.833697494543;19556.608867822564;21607.67588486174;21721.456963576038;22317.107315707515;22388.664170037464;7635.809104772314;7689.154193038761;7711.383089352838;7803.648835802289;7848.13670496245;4199.832006719758;4242.193983143255;4256.233877901946;4259.424977628042;4392.2094023075515;3640;3749.9437508437395;3752;3752.887413377603;3753.4557489163917;685.85939882324;690.5545922879814;696.5681277607915;697.2156324135348;697.888337865939;655.3021032600361;678.0737938874083;697.930206979298;700.7477308169055;702.9753958611424;9836.803263934682;9919.156871665846;9933.602655893683;10327.32872363294;10352.896471035343;554.6810583914265;570.8201916396322;582.2837909371412;590.5364289033089;602;4545.204589196944;4638.512956139624;4882.292067650242;4956.355673762388;4970.950290497049;83862;85892;88815;96516.03483965211;97616;73840.89238661424;75796.62101689457;75965.6201718999;84539;86866.13133868708;55472;59389.406105939255;66054.33945660578;67485.66257168683;67596.6620166896;9109.635614575343;9284.72145835626;9330.393524420891;9348.252139828934;9355.719328420158;45232.54767452284;47202;47410.762946185045;47739.522604773505;47771.761141194074;59781.40218597758;60502.69748651228;60780;61198;61737;12521.749565008467;12751;12789.424475898793;12921.870781292442;13109.557948625834;14127.223002734949;14161.645958850699;14444.711105778037;14512.274386280433;14819.184944828137;13172.538961136313;13395.641743302756;13534.323283835965;13961.860381396056;13983.230922299372;12942.547010854574;13562.525311614047;14024.29878506091;14039.789403159166;14073.155610663393;12598.244105353708;13041.543545975845;13365.198088114745;13491.123076999964;13491.32543372847;10875.40185289785;11142.554297827995;11203.831942521032;11554.711132221426;11690.181687281809;10797;10878.292910960763;11015.669529914116;11052.447377630926;11068.391238481961 04:55:17 INFO - PROCESS | 1996 | __end_tp_report 04:55:17 INFO - PROCESS | 1996 | __start_cc_report 04:55:17 INFO - PROCESS | 1996 | _x_x_mozilla_cycle_collect,415 04:55:17 INFO - PROCESS | 1996 | __end_cc_report 04:55:17 INFO - PROCESS | 1996 | __startTimestamp1486644917040__endTimestamp 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | ------- Summary: start ------- 04:55:17 INFO - PROCESS | 1996 | Number of tests: 6 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | [#0] dojo.html Cycles:165 Average:5582.05 Median:5720.40 stddev:649.10 (11.3%) stddev-sans-first:609.23 04:55:17 INFO - PROCESS | 1996 | Values: 2658.6 2762.6 3314.1 3348.5 3352.7 5501.9 5537.3 5560.2 5579.7 5594.7 5564.9 5566.7 5568.9 5593.3 5624.6 4999.7 5083.0 5153.7 5226.2 5233.6 5128.9 5201.1 5247.4 5252.3 5290.9 4986.9 5058.4 5060.8 5131.7 5137.7 5130.6 5139.2 5142.1 5165.2 5195.9 5089.2 5119.1 5125.3 5163.1 5207.8 4290.7 4926.0 5053.3 5520.5 5611.9 6039.2 6114.9 6127.2 6134.6 6139.6 6126.5 6129.4 6171.1 6175.5 6184.8 5506.8 5563.5 5741.9 5742.2 5764.7 5098.9 6118.7 6145.8 6181.8 6202.7 5734.7 5830.5 5888.5 6030.0 6037.2 6125.5 6142.9 6144.8 6148.7 6168.8 5830.0 6123.3 6125.6 6132.3 6133.0 5906.0 6084.6 6096.3 6118.3 6164.6 4915.2 4915.7 4919.9 4940.5 4960.0 4425.9 4436.4 4441.2 4442.6 4471.2 5420.0 5480.0 5506.6 5634.0 5648.4 5141.0 6124.8 6167.8 6168.6 6214.8 5620.6 5673.6 5682.5 5684.5 5684.5 5217.9 5250.6 5301.4 5337.3 5418.9 6108.9 6189.6 6202.8 6217.3 6228.3 6164.4 6170.2 6183.5 6191.2 6198.2 5210.4 6044.0 6129.9 6188.3 6230.1 4622.0 6008.8 6023.2 6048.4 6131.2 5943.6 5964.5 6109.9 6114.5 6119.7 5766.7 5834.5 5902.3 5934.9 5960.0 6000.6 6007.1 6009.0 6027.8 6047.3 5720.4 5799.0 5863.4 5864.8 5879.4 5682.1 5747.1 5804.6 5841.2 6023.6 5539.7 5541.3 5546.5 5550.1 5579.4 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | [#1] ext.html Cycles:180 Average:61127.80 Median:34199.81 stddev:128588.02 (376.0%) stddev-sans-first:128868.06 04:55:17 INFO - PROCESS | 1996 | Values: 457.6 457.7 512.7 521.0 535.0 32206.5 32272.8 39159.0 39174.6 39309.0 40504.8 41271.8 41282.4 41369.4 41424.6 9003.3 10633.2 11000.9 11030.8 11159.3 9505.5 10724.9 10819.9 10945.4 10953.8 9506.0 9827.3 10439.5 10929.6 10966.1 10803.5 10868.5 10868.7 10874.8 10910.7 10643.9 10678.7 10728.2 10787.8 10818.8 35951.6 36371.5 36377.8 36394.0 36453.8 3731.2 3785.3 3793.6 3806.2 3809.8 23040.5 27004.5 27304.7 27488.9 27538.6 3045.4 3101.2 3111.5 3137.3 3193.9 446572.0 446911.8 447638.0 448929.0 452260.0 35696.8 44892.8 53842.2 54926.7 55102.0 49858.0 52355.0 54671.0 56986.0 57299.8 14114.4 14720.0 14722.3 14731.0 14773.1 11325.4 11376.3 11408.9 11430.1 11440.4 14797.8 16478.5 16992.0 17161.1 17308.6 7434.7 7514.8 7522.7 7619.7 7651.7 816.5 826.9 831.8 839.3 848.5 25842.5 26088.7 28119.6 29155.0 29641.3 995.6 1004.9 1031.1 1053.7 1196.2 15319.7 15453.2 15535.2 15560.8 15632.0 528133.0 530198.0 530420.0 530954.0 534542.0 56732.1 56947.4 57018.6 57473.4 57709.0 1291.4 1351.1 1352.9 1357.3 1363.8 24863.9 25554.7 28035.9 29018.1 29800.9 48595.0 48732.0 49928.5 50032.0 52879.7 396938.0 476479.0 476996.0 485859.0 486597.0 21749.9 22260.8 24210.9 24554.0 24912.9 41268.6 41365.6 41494.0 42028.0 42427.6 30791.5 32875.3 34256.6 34299.3 35081.0 33407.0 34143.0 35003.8 35006.5 35620.0 34349.1 34527.3 34597.3 34754.8 34895.0 29579.9 30784.2 30819.4 30845.8 31077.1 19715.5 23243.1 23458.1 23841.0 24020.4 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | [#2] jquery.html Cycles:180 Average:38014.33 Median:13970.51 stddev:115041.89 (823.5%) stddev-sans-first:115329.90 04:55:17 INFO - PROCESS | 1996 | Values: 377.7 380.9 386.2 395.2 416.0 13669.7 19431.2 19675.9 20332.4 20609.2 20110.9 20285.1 21070.4 21225.9 21240.7 5422.8 5742.4 5851.8 5926.4 5945.0 5593.6 5728.2 5800.4 5822.1 5835.9 5703.9 5777.0 5782.9 5783.8 5783.8 5521.1 5716.4 5770.2 5777.7 5778.5 5116.4 5116.6 5120.9 5129.2 5137.2 20929.6 24653.6 25288.9 25311.0 25328.2 2612.8 2678.8 2691.3 2710.3 2710.6 9500.9 10295.7 14978.0 15402.8 15923.5 1551.3 1761.5 1834.6 1840.1 1855.2 109322.0 127537.0 136821.0 137550.0 140242.0 10050.8 10720.2 10984.4 11606.9 11750.1 12998.7 13031.5 13048.7 13189.5 14920.6 6407.5 6525.9 7759.0 8385.5 8452.9 7981.6 7985.3 7994.7 8064.0 8144.4 4765.5 4777.5 4810.0 4839.2 4948.9 1660.8 1831.6 1960.6 2052.1 2071.2 699.1 746.3 769.3 777.1 784.6 17996.8 21482.6 21724.4 22169.5 22297.1 759.5 761.9 818.0 829.7 830.8 11058.8 11568.2 11694.9 11713.4 11716.0 682133.0 687078.0 688910.0 694081.0 702814.0 97612.0 142365.0 144083.0 147348.0 150787.0 1009.3 1037.3 1056.4 1057.1 1058.1 18027.3 18710.7 19839.0 19898.8 20255.6 53321.7 55990.0 56454.2 56509.7 59663.0 46738.0 63862.0 77359.0 80825.0 80987.2 7333.8 7633.4 7709.7 8172.1 8561.0 11583.9 12698.6 12755.4 13237.3 13330.2 11010.3 11243.2 11276.7 11364.3 11660.1 10717.5 10991.7 11069.7 11424.5 11465.0 10921.8 11044.2 11701.2 11834.1 11881.6 7055.4 8406.2 8487.6 8496.6 8554.3 8219.6 9040.4 11368.5 11421.9 11498.1 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | [#3] mootools.html Cycles:180 Average:5353.04 Median:5036.85 stddev:2979.92 (59.2%) stddev-sans-first:2972.49 04:55:17 INFO - PROCESS | 1996 | Values: 1272.4 1320.5 1386.8 1412.7 1425.0 8076.7 8081.1 8388.7 8504.8 8532.7 8361.0 8453.9 8474.4 8488.2 8523.5 2130.0 2249.8 2251.9 2255.0 2264.7 2235.2 2247.6 2264.0 2264.2 2278.3 2222.5 2222.9 2253.8 2258.5 2259.9 2094.4 2230.3 2245.2 2252.5 2256.6 1902.7 1932.9 2025.8 2257.6 2270.9 8186.3 8376.4 8423.5 8462.8 8504.2 5030.1 5201.8 5205.3 5207.2 5213.4 3319.5 3442.5 3452.9 3466.2 3523.4 1184.8 1185.8 1221.6 1223.4 1236.9 10828.6 10841.1 10853.5 10864.8 10933.3 4134.6 4364.3 4446.8 4447.3 4492.4 7231.2 8579.6 8641.0 8648.0 8655.5 4157.6 4430.8 4955.7 5071.4 5091.5 4490.6 4578.9 4697.2 4761.4 4781.3 3426.0 3433.1 3473.9 3485.8 3511.3 975.0 1124.8 1126.0 1137.5 1141.3 807.3 860.6 880.7 914.1 917.2 5640.9 5682.8 5687.2 5761.5 6020.3 834.0 960.7 960.7 964.4 1007.6 3583.7 3607.6 3699.4 3790.9 3833.1 9800.3 10130.9 10145.3 10150.7 10151.0 10002.6 10082.5 10084.4 10088.2 10094.9 6604.3 7912.0 7918.9 7940.4 7946.6 5506.3 5531.3 5543.7 5590.4 5853.6 9062.9 9266.3 9278.2 9296.5 9325.5 8963.7 9222.8 9336.9 9352.5 9461.2 7016.5 7136.7 7161.5 7167.9 7176.9 7819.6 7824.9 7894.1 7909.5 7920.5 7020.1 7085.1 7127.1 7160.3 7230.5 5742.0 6994.8 6996.0 7022.3 7142.4 6271.1 6359.9 6407.9 6422.4 6425.6 4082.5 4108.9 4453.9 4543.7 4610.7 4489.5 4866.4 4985.3 5043.6 5157.0 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | [#4] prototype.html Cycles:180 Average:4333.39 Median:4820.51 stddev:1331.07 (27.6%) stddev-sans-first:1300.19 04:55:17 INFO - PROCESS | 1996 | Values: 315.3 345.0 352.1 357.7 363.0 4315.0 4720.6 5209.5 5298.9 5394.7 5204.8 5251.4 5264.5 5268.0 5276.3 3238.8 3372.3 3878.5 4017.7 4029.2 3579.8 3718.3 3971.7 4030.8 4053.7 3576.3 3861.3 3887.3 3935.7 3937.7 3073.8 3465.6 3894.5 3906.3 3937.6 3046.7 3446.0 3447.7 3458.8 3471.0 4917.9 5043.7 5058.6 5157.4 5189.0 4190.4 4426.8 4480.8 4484.7 4487.0 4840.7 5219.8 5238.3 5372.6 5504.6 2980.4 3300.0 3787.9 3793.3 3816.3 5127.3 5476.9 5697.9 5717.9 5749.9 3426.4 3516.9 3664.2 3749.8 3828.7 3403.1 3874.4 3880.9 3884.4 3930.4 4131.4 4501.8 4528.7 4555.2 4573.8 5259.7 5493.4 5558.5 5626.8 5634.7 1029.2 1143.9 1263.1 1273.8 1279.5 775.6 796.4 847.7 862.5 870.3 4328.8 4432.2 4445.5 4696.4 4928.7 4667.4 4975.9 5065.6 5422.5 5476.3 3797.3 4390.3 4426.9 4859.0 4895.8 2683.7 2736.8 2792.3 2911.6 2924.0 4704.0 5081.3 5422.7 5661.9 5700.8 4915.2 5075.9 5189.7 5255.7 5732.3 4959.7 4987.9 5384.8 5457.8 5591.2 4647.7 4702.0 4809.4 5380.2 5486.3 4409.4 4527.5 4845.0 5391.8 5473.5 5521.9 5614.5 5674.0 5681.5 5702.8 3802.3 3803.0 3806.7 3811.3 3816.9 5700.1 5711.7 5725.5 5756.8 5760.6 4448.4 5360.5 5522.4 5537.6 5547.1 4458.8 4640.1 4713.6 5454.3 5571.6 4831.6 4856.8 5055.6 5060.6 5405.8 4801.7 4869.0 5466.3 5486.7 5699.9 5123.1 5251.0 5286.9 5293.4 5328.6 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - PROCESS | 1996 | [#5] yui.html Cycles:180 Average:18816.44 Median:47755.64 stddev:25664.23 (53.7%) stddev-sans-first:25699.76 04:55:17 INFO - PROCESS | 1996 | Values: 595.9 706.5 745.9 764.8 811.9 14417.5 15418.5 15419.5 15456.5 15471.4 13531.3 14097.9 14163.9 14301.1 14321.0 860.0 880.9 896.9 897.8 899.2 885.3 891.2 891.9 893.0 894.1 937.4 940.0 940.4 943.1 952.5 931.7 938.5 939.4 939.9 941.3 666.8 700.8 701.5 703.0 707.2 15090.9 15099.9 15362.4 15486.4 15654.5 14336.4 14484.7 14512.3 14521.6 14578.0 9604.7 10729.7 10977.7 11962.6 11985.5 3643.4 3652.3 3813.2 3845.3 3865.9 77953.0 95623.5 97120.5 97609.0 98233.5 9587.8 10522.5 10895.9 11071.7 11086.8 19556.6 21607.7 21721.5 22317.1 22388.7 7635.8 7689.2 7711.4 7803.6 7848.1 4199.8 4242.2 4256.2 4259.4 4392.2 3640.0 3749.9 3752.0 3752.9 3753.5 685.9 690.6 696.6 697.2 697.9 655.3 678.1 697.9 700.7 703.0 9836.8 9919.2 9933.6 10327.3 10352.9 554.7 570.8 582.3 590.5 602.0 4545.2 4638.5 4882.3 4956.4 4971.0 83862.0 85892.0 88815.0 96516.0 97616.0 73840.9 75796.6 75965.6 84539.0 86866.1 55472.0 59389.4 66054.3 67485.7 67596.7 9109.6 9284.7 9330.4 9348.3 9355.7 45232.5 47202.0 47410.8 47739.5 47771.8 59781.4 60502.7 60780.0 61198.0 61737.0 12521.7 12751.0 12789.4 12921.9 13109.6 14127.2 14161.6 14444.7 14512.3 14819.2 13172.5 13395.6 13534.3 13961.9 13983.2 12942.5 13562.5 14024.3 14039.8 14073.2 12598.2 13041.5 13365.2 13491.1 13491.3 10875.4 11142.6 11203.8 11554.7 11690.2 10797.0 10878.3 11015.7 11052.4 11068.4 04:55:17 INFO - PROCESS | 1996 | -------- Summary: end -------- 04:55:17 INFO - PROCESS | 1996 | 04:55:17 INFO - TEST-INFO | 1996: exit 0 04:55:17 INFO - TEST-OK | dromaeo_css | took 1115944ms 04:55:17 INFO - TEST-START | kraken 04:55:17 INFO - operating with platform_type : mac_ 04:55:17 INFO - Initialising browser for kraken test... 04:55:17 INFO - TEST-INFO | started process 2003 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpK9CGEr/profile http://localhost:49311/getInfo.html) 04:55:20 INFO - PROCESS | 2003 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:55:20 INFO - PROCESS | 2003 | 2017-02-09 04:55:20.601 plugin-container[2004:283857] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3f, name = 'com.apple.tsm.portname' 04:55:20 INFO - PROCESS | 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:20 INFO - PROCESS | 2003 | 2017-02-09 04:55:20.605 plugin-container[2004:283857] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4823, name = 'com.apple.CFPasteboardClient' 04:55:20 INFO - PROCESS | 2003 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:20 INFO - PROCESS | 2003 | 2017-02-09 04:55:20.605 plugin-container[2004:283857] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:55:20 INFO - PROCESS | 2003 | __metrics Screen width/height:1600/1200 04:55:20 INFO - PROCESS | 2003 | colorDepth:24 04:55:20 INFO - PROCESS | 2003 | Browser inner width/height: 1024/689 04:55:20 INFO - PROCESS | 2003 | __metrics 04:55:20 ERROR - PROCESS | 2003 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 04:55:21 INFO - TEST-INFO | 2003: exit 0 04:55:21 INFO - Browser initialized. 04:55:21 INFO - Running cycle 1/1 for kraken test... 04:55:21 INFO - TEST-INFO | started process 2005 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/T/tmpK9CGEr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:55:23 INFO - PROCESS | 2005 | 2017-02-09 04:55:23.928 plugin-container[2006:283978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:55:23 INFO - PROCESS | 2005 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:23 INFO - PROCESS | 2005 | 2017-02-09 04:55:23.929 plugin-container[2006:283978] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:55:23 INFO - PROCESS | 2005 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:55:23 INFO - PROCESS | 2005 | 2017-02-09 04:55:23.929 plugin-container[2006:283978] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:55:33 INFO - PROCESS | 2005 | RSS: Main: 232329216 04:55:33 INFO - PROCESS | 2005 | 04:55:37 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-beat-detection) 04:55:37 INFO - PROCESS | 2005 | RSS: Main: 247300096 04:55:37 INFO - PROCESS | 2005 | 04:55:40 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-dft) 04:55:41 INFO - PROCESS | 2005 | RSS: Main: 255217664 04:55:41 INFO - PROCESS | 2005 | 04:55:44 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-fft) 04:55:45 INFO - PROCESS | 2005 | RSS: Main: 257818624 04:55:45 INFO - PROCESS | 2005 | 04:55:47 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49311/tests/kraken/driver.html?testName=audio-oscillator) 04:55:47 INFO - PROCESS | 2005 | RSS: Main: 258994176 04:55:47 INFO - PROCESS | 2005 | 04:55:49 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:55:50 INFO - PROCESS | 2005 | RSS: Main: 259403776 04:55:50 INFO - PROCESS | 2005 | 04:55:53 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-darkroom) 04:55:54 INFO - PROCESS | 2005 | RSS: Main: 266420224 04:55:54 INFO - PROCESS | 2005 | 04:55:57 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49311/tests/kraken/driver.html?testName=imaging-desaturate) 04:55:57 INFO - PROCESS | 2005 | RSS: Main: 265580544 04:55:57 INFO - PROCESS | 2005 | 04:56:00 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49311/tests/kraken/driver.html?testName=json-parse-financial) 04:56:01 INFO - PROCESS | 2005 | RSS: Main: 265535488 04:56:01 INFO - PROCESS | 2005 | 04:56:03 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49311/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:03 INFO - PROCESS | 2005 | RSS: Main: 264896512 04:56:03 INFO - PROCESS | 2005 | 04:56:05 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:06 INFO - PROCESS | 2005 | RSS: Main: 264966144 04:56:06 INFO - PROCESS | 2005 | 04:56:08 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:09 INFO - PROCESS | 2005 | RSS: Main: 265068544 04:56:09 INFO - PROCESS | 2005 | 04:56:12 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:13 INFO - PROCESS | 2005 | RSS: Main: 265322496 04:56:13 INFO - PROCESS | 2005 | 04:56:16 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:16 INFO - PROCESS | 2005 | RSS: Main: 265117696 04:56:16 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | Cycle 1(1): loaded http://localhost:49311/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49311/tests/kraken/driver.html?testName=ai-astar) 04:56:18 INFO - PROCESS | 2005 | RSS: Main: 267075584 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | __start_tp_report 04:56:18 INFO - PROCESS | 2005 | _x_x_mozilla_page_load 04:56:18 INFO - PROCESS | 2005 | _x_x_mozilla_page_load_details 04:56:18 INFO - PROCESS | 2005 | |i|pagename|runs| 04:56:18 INFO - PROCESS | 2005 | |0;ai-astar;107;125;106;177;176;106;138;151;152;174 04:56:18 INFO - PROCESS | 2005 | |1;audio-beat-detection;153;113;114;152;120;123;116;116;135;118 04:56:18 INFO - PROCESS | 2005 | |2;audio-dft;204;261;263;287;276;225;197;195;194;197 04:56:18 INFO - PROCESS | 2005 | |3;audio-fft;83;60;62;86;62;60;61;60;74;61 04:56:18 INFO - PROCESS | 2005 | |4;audio-oscillator;87;72;84;72;71;71;84;93;57;98 04:56:18 INFO - PROCESS | 2005 | |5;imaging-gaussian-blur;119;89;90;91;91;90;89;93;90;76 04:56:18 INFO - PROCESS | 2005 | |6;imaging-darkroom;97;97;107;97;103;108;144;129;148;122 04:56:18 INFO - PROCESS | 2005 | |7;imaging-desaturate;92;91;91;134;144;93;94;91;96;95 04:56:18 INFO - PROCESS | 2005 | |8;json-parse-financial;64;66;64;66;66;66;67;67;67;66 04:56:18 INFO - PROCESS | 2005 | |9;json-stringify-tinderbox;88;112;73;73;68;88;101;105;91;72 04:56:18 INFO - PROCESS | 2005 | |10;stanford-crypto-aes;90;92;92;92;90;92;100;84;109;112 04:56:18 INFO - PROCESS | 2005 | |11;stanford-crypto-ccm;146;148;145;146;144;145;146;149;190;149 04:56:18 INFO - PROCESS | 2005 | |12;stanford-crypto-pbkdf2;179;179;174;231;179;175;176;176;175;176 04:56:18 INFO - PROCESS | 2005 | |13;stanford-crypto-sha256-iterative;69;67;70;67;69;68;68;69;70;66 04:56:18 INFO - PROCESS | 2005 | __end_tp_report 04:56:18 INFO - PROCESS | 2005 | __start_cc_report 04:56:18 INFO - PROCESS | 2005 | _x_x_mozilla_cycle_collect,1002 04:56:18 INFO - PROCESS | 2005 | __end_cc_report 04:56:18 INFO - PROCESS | 2005 | __startTimestamp1486644978769__endTimestamp 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | ------- Summary: start ------- 04:56:18 INFO - PROCESS | 2005 | Number of tests: 14 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#0] ai-astar Cycles:10 Average:141.20 Median:151.50 stddev:29.25 (19.3%) stddev-sans-first:28.29 04:56:18 INFO - PROCESS | 2005 | Values: 107.0 125.0 106.0 177.0 176.0 106.0 138.0 151.0 152.0 174.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:121.50 stddev:15.30 (12.6%) stddev-sans-first:12.74 04:56:18 INFO - PROCESS | 2005 | Values: 153.0 113.0 114.0 152.0 120.0 123.0 116.0 116.0 135.0 118.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#2] audio-dft Cycles:10 Average:229.90 Median:243.00 stddev:37.73 (15.5%) stddev-sans-first:38.84 04:56:18 INFO - PROCESS | 2005 | Values: 204.0 261.0 263.0 287.0 276.0 225.0 197.0 195.0 194.0 197.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#3] audio-fft Cycles:10 Average:66.90 Median:62.00 stddev:10.19 (16.4%) stddev-sans-first:8.99 04:56:18 INFO - PROCESS | 2005 | Values: 83.0 60.0 62.0 86.0 62.0 60.0 61.0 60.0 74.0 61.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:84.00 stddev:12.39 (14.7%) stddev-sans-first:12.79 04:56:18 INFO - PROCESS | 2005 | Values: 87.0 72.0 84.0 72.0 71.0 71.0 84.0 93.0 57.0 98.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#5] imaging-gaussian-blur Cycles:10 Average:91.80 Median:90.00 stddev:10.63 (11.8%) stddev-sans-first:4.94 04:56:18 INFO - PROCESS | 2005 | Values: 119.0 89.0 90.0 91.0 91.0 90.0 89.0 93.0 90.0 76.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#6] imaging-darkroom Cycles:10 Average:115.20 Median:146.00 stddev:19.45 (13.3%) stddev-sans-first:19.48 04:56:18 INFO - PROCESS | 2005 | Values: 97.0 97.0 107.0 97.0 103.0 108.0 144.0 129.0 148.0 122.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:92.50 stddev:19.67 (21.3%) stddev-sans-first:20.52 04:56:18 INFO - PROCESS | 2005 | Values: 92.0 91.0 91.0 134.0 144.0 93.0 94.0 91.0 96.0 95.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:0.93 04:56:18 INFO - PROCESS | 2005 | Values: 64.0 66.0 64.0 66.0 66.0 66.0 67.0 67.0 67.0 66.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#9] json-stringify-tinderbox Cycles:10 Average:87.10 Median:73.00 stddev:15.42 (21.1%) stddev-sans-first:16.36 04:56:18 INFO - PROCESS | 2005 | Values: 88.0 112.0 73.0 73.0 68.0 88.0 101.0 105.0 91.0 72.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#10] stanford-crypto-aes Cycles:10 Average:95.30 Median:91.00 stddev:8.92 (9.8%) stddev-sans-first:9.25 04:56:18 INFO - PROCESS | 2005 | Values: 90.0 92.0 92.0 92.0 90.0 92.0 100.0 84.0 109.0 112.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:147.00 stddev:13.88 (9.4%) stddev-sans-first:14.61 04:56:18 INFO - PROCESS | 2005 | Values: 146.0 148.0 145.0 146.0 144.0 145.0 146.0 149.0 190.0 149.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:177.50 stddev:17.31 (9.8%) stddev-sans-first:18.33 04:56:18 INFO - PROCESS | 2005 | Values: 179.0 179.0 174.0 231.0 179.0 175.0 176.0 176.0 175.0 176.0 04:56:18 INFO - PROCESS | 2005 | 04:56:18 INFO - PROCESS | 2005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:1.34 (1.9%) stddev-sans-first:1.39 04:56:18 INFO - PROCESS | 2005 | Values: 69.0 67.0 70.0 67.0 69.0 68.0 68.0 69.0 70.0 66.0 04:56:18 INFO - PROCESS | 2005 | -------- Summary: end -------- 04:56:18 INFO - PROCESS | 2005 | 04:56:19 INFO - TEST-INFO | 2005: exit 0 04:56:19 INFO - TEST-OK | kraken | took 62155ms 04:56:19 INFO - SUITE-END | took 1178s 04:56:19 INFO - Completed test suite (00:19:38) 04:56:19 INFO - javascript benchmark 04:56:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7064.1454547553, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2658.5746280595104, 2762.599423083652, 3314.055494184158, 3348.5312056312114, 3352.748543859211, 5501.889962200764, 5537.335519737632, 5560.193771903072, 5579.721013949302, 5594.664320140794, 5564.888702225953, 5566.666000040001, 5568.916466253009, 5593.328800543941, 5624.606277560572, 4999.700017998914, 5082.95799361132, 5153.665011774223, 5226.242194881759, 5233.633645644806, 5128.8974220515565, 5201.141811601081, 5247.449017853128, 5252.343457067866, 5290.92063619046, 4986.927810520756, 5058.392992840846, 5060.797568097271, 5131.717755523445, 5137.6660517066275, 5130.615203859726, 5139.177731562932, 5142.07442660321, 5165.199394093921, 5195.922061169085, 5089.160288552384, 5119.078565858144, 5125.256837758504, 5163.070647283487, 5207.817726379559, 4290.721103128318, 4925.990172014728, 5053.292539044537, 5520.475554822286, 5611.915821262684, 6039.214902062748, 6114.875284800388, 6127.220070483952, 6134.589663226396, 6139.614800607363, 6126.466494332852, 6129.448349648508, 6171.074338849164, 6175.536834737412, 6184.81445556634, 5506.752196151183, 5563.5271001964475, 5741.8564535886935, 5742.2247996520355, 5764.682942438164, 5098.872528186751, 6118.694065296718, 6145.784897528565, 6181.84545386369, 6202.658853762996, 5734.741936612862, 5830.533557315404, 5888.499477544457, 6029.969850150721, 6037.184980027728, 6125.540584456184, 6142.907856382158, 6144.77104579086, 6148.661823599745, 6168.753249869955, 5829.970850145807, 6123.28262147438, 6125.635385022116, 6132.324915438508, 6133.028644417026, 5906.0, 6084.574079814371, 6096.268447786205, 6118.265808102967, 6164.568480206342, 4915.238138088602, 4915.680480768739, 4919.852404427873, 4940.530649588283, 4959.950400495949, 4425.889352766142, 4436.401085853433, 4441.156180325728, 4442.555744425532, 4471.195184866755, 5419.972900135474, 5479.986202552541, 5506.64206826555, 5633.971830140905, 5648.435156484319, 5141.0, 6124.838682352462, 6167.753289868445, 6168.568200226031, 6214.8135555933395, 5620.57845661577, 5673.602847800615, 5682.516986056232, 5684.516816070598, 5684.54523638108, 5217.895642087213, 5250.553702935294, 5301.363836339664, 5337.306150200449, 5418.864528386743, 6108.888502348253, 6189.566730329014, 6202.844928876633, 6217.285012223471, 6228.283747369111, 6164.445199932027, 6170.167027451416, 6183.536234782319, 6191.226096737908, 6198.194234749634, 5210.426853046086, 6044.032954727222, 6129.8784197560135, 6188.288346840171, 6230.127782110599, 4622.0, 6008.849778755566, 6023.247094113236, 6048.395160483917, 6131.233595800525, 5943.632964418294, 5964.522838172849, 6109.877802444015, 6114.48026917717, 6119.663418511846, 5766.740496677743, 5834.533237341087, 5902.321233058254, 5934.851628709317, 5959.986802243716, 6000.5799594028, 6007.098935159761, 6009.0, 6027.789027384196, 6047.274327080779, 5720.39935806751, 5799.014167591604, 5863.442972917566, 5864.794732184353, 5879.412058794257, 5682.14767784819, 5747.1379293106365, 5804.622699524517, 5841.240638716939, 6023.608465449732, 5539.695316757617, 5541.33503979525, 5546.528545073714, 5550.139728342114, 5579.386267510489], "value": 5540.065092231614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.5721700210304, 457.70706747681487, 512.7180050971964, 521.0178812937614, 534.989300213996, 32206.516902246454, 32272.838635806816, 39159.0210244744, 39174.60825391745, 39309.01727456815, 40504.79747601258, 41271.793641031756, 41282.38076428856, 41369.37945930806, 41424.58575414245, 9003.324750643695, 10633.202509811756, 11000.944995275053, 11030.834537481944, 11159.27464714791, 9505.52472376382, 10724.892751072468, 10819.891801081967, 10945.398003109825, 10953.780924381548, 9505.952470237638, 9827.312088153833, 10439.478026098703, 10929.56281748733, 10966.122710183206, 10803.513841877095, 10868.510917008754, 10868.67393978178, 10874.836877446845, 10910.727231819188, 10643.893561064368, 10678.733031674192, 10728.195385346053, 10787.83818242727, 10818.837717434166, 35951.64048359509, 36371.4544281836, 36377.81811090954, 36394.0, 36453.81773091144, 3731.2350968051483, 3785.318642644323, 3793.6016718244464, 3806.200697853454, 3809.847606095753, 23040.539189216288, 27004.459910801674, 27304.726952730416, 27488.862555687294, 27538.586921196198, 3045.4061458015694, 3101.2246938265434, 3111.471049921519, 3137.278425962019, 3193.8562764675644, 446572.0, 446911.765441174, 447638.0, 448929.0, 452260.0, 35696.821515892254, 44892.77553612276, 53842.19236711453, 54926.72536637291, 55102.0, 49858.0, 52355.0, 54671.0, 56986.0, 57299.84301412809, 14114.364853581408, 14720.043197192148, 14722.337494812758, 14731.0, 14773.113613183243, 11325.433728313552, 11376.317420954769, 11408.94295528517, 11430.142739294586, 11440.370779607036, 14797.778033329509, 16478.505644830435, 16991.98048117117, 17161.056141912064, 17308.567285817702, 7434.739784107638, 7514.774556763306, 7522.736704215326, 7619.65679562644, 7651.655675494616, 816.4856140631364, 826.9297109745739, 831.8045259364045, 839.2530647723531, 848.5375470368664, 25842.483150336888, 26088.73911260901, 28119.57820632692, 29155.0, 29641.25896852596, 995.5669283861544, 1004.924630652704, 1031.1235449867552, 1053.7365658585354, 1196.2355525599844, 15319.693606127816, 15453.150076745887, 15535.223238838013, 15560.766588501181, 15631.983921045095, 528133.0, 530198.0, 530420.0, 530954.0, 534542.0, 56732.149017764765, 56947.43052569504, 57018.574535636944, 57473.425265747646, 57709.0, 1291.367230057284, 1351.1420248142501, 1352.932353382327, 1357.2942070123481, 1363.8022486739367, 24863.87568062148, 25554.74445255524, 28035.859820700767, 29018.12945611635, 29800.850995744884, 48595.0, 48732.025359493324, 49928.51072339178, 50032.0, 52879.678008050105, 396938.0, 476479.0, 476996.0, 485859.0, 486597.0, 21749.891250543646, 22260.77739222587, 24210.87894560516, 24554.0, 24912.875435622707, 41268.587314126475, 41365.58634413738, 41493.962650933965, 42028.0, 42427.575724242364, 30791.538126927666, 32875.342493149525, 34256.62973481132, 34299.314013719086, 35081.0, 33407.0, 34143.0, 35003.82498087493, 35006.47490287699, 35620.0, 34349.14127146841, 34527.30945381028, 34597.30805383828, 34754.82622586972, 34895.0, 29579.852100739357, 30784.230394240323, 30819.38361232718, 30845.845770771004, 31077.067687969397, 19715.507112322306, 23243.0702771894, 23458.061677532707, 23841.0, 24020.39949001289], "value": 18819.820761222963, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.712938166993, 380.89642848400297, 386.1658816955376, 395.18788888833444, 415.96009975062344, 13669.65825854354, 19431.222751089957, 19675.901620491877, 20332.390028299156, 20609.175632974682, 20110.893900835486, 20285.0871710773, 21070.367888963316, 21225.893870530665, 21240.681389779125, 5422.810201642934, 5742.368339482654, 5851.79518716845, 5926.436988486109, 5945.019071853139, 5593.636413633121, 5728.22668939692, 5800.419958004208, 5822.1266809978415, 5835.854103647401, 5703.8574035649235, 5776.960147173507, 5782.884342313151, 5783.768649254025, 5783.768649254046, 5521.1442226454965, 5716.371199168088, 5770.249867517238, 5777.653340799545, 5778.50882674971, 5116.360454943132, 5116.641835071547, 5120.92318615221, 5129.204973229155, 5137.2037334213255, 20929.581408371898, 24653.63019554708, 25288.856129726308, 25311.0, 25328.240152795446, 2612.7779138773226, 2678.8392696438277, 2691.300261931912, 2710.2817753295394, 2710.5934109883674, 9500.90739564952, 10295.691129266059, 14978.0, 15402.845971540253, 15923.52229433119, 1551.2553974092386, 1761.4891681412375, 1834.5780470491727, 1840.0707642640514, 1855.2486243071578, 109322.0, 127537.0, 136821.0, 137550.0, 140242.0, 10050.798984020425, 10720.249582529148, 10984.395858227714, 11606.94196529012, 11750.059995200363, 12998.675033124247, 13031.47874085026, 13048.739025219442, 13189.538366157138, 14920.552383428514, 6407.487401007908, 6525.902111468332, 7758.95254140695, 8385.496870187808, 8452.915470845335, 7981.561014144278, 7985.281324680806, 7994.680212791423, 8064.0, 8144.389170812213, 4765.499622539653, 4777.498362671939, 4809.975950120297, 4839.249916262985, 4948.90102197954, 1660.800703915538, 1831.6336732653256, 1960.5686748915216, 2052.127845665586, 2071.2336435518955, 699.0632552379835, 746.302207436049, 769.2691942654388, 777.1412589089089, 784.6351446577255, 17996.820031799776, 21482.57034859294, 21724.43786804757, 22169.45288753792, 22297.10811567519, 759.5480688990042, 761.9447065813888, 818.0428898189133, 829.6808075160524, 830.8213734047209, 11058.834117488244, 11568.249988807715, 11694.94152529249, 11713.355765432983, 11716.004139648225, 682133.0, 687078.0, 688910.0, 694081.0, 702814.0, 97612.0, 142365.0, 144083.0, 147348.0, 150787.0, 1009.2934945538153, 1037.273908264218, 1056.3503445381189, 1057.0644979193469, 1058.142904247562, 18027.2789088435, 18710.719339210194, 19839.0, 19898.801011989694, 20255.59488810245, 53321.7333913328, 55990.0, 56454.1531877014, 56509.71745141412, 59663.0, 46738.0, 63862.0, 77359.0, 80825.0, 80987.19012810032, 7333.816654583678, 7633.351165151024, 7709.689352809924, 8172.101068882299, 8560.957195213985, 11583.942080289544, 12698.555550555686, 12755.426005829946, 13237.338133093113, 13330.200187988752, 11010.284331518425, 11243.156763242627, 11276.718082047686, 11364.318140911571, 11660.06719462458, 10717.464126793473, 10991.670249892515, 11069.667909962714, 11424.543018279175, 11465.0, 10921.781564368826, 11044.179708325404, 11701.239419437708, 11834.053275738093, 11881.5841445549, 7055.435565154878, 8406.243438090602, 8487.575621219037, 8496.575171241537, 8554.31565474773, 8219.630116644885, 9040.367174297737, 11368.488418021043, 11421.885781142082, 11498.08015358786], "value": 9551.276285647235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.4464857786857, 1320.4520124148478, 1386.8197134372533, 1412.7103943691545, 1425.0238586568203, 8076.71731489398, 8081.111077781439, 8388.748337549883, 8504.829903401936, 8532.70135545256, 8361.038480574736, 8453.87319190211, 8474.364422668294, 8488.151184881508, 8523.488590684563, 2129.9787002129974, 2249.8200143988524, 2251.8761468119246, 2255.0077965695123, 2264.6977987657083, 2235.1729859951843, 2247.6291411917014, 2264.003838311146, 2264.1622599638076, 2278.3392816083315, 2222.4554984028937, 2222.8999695013763, 2253.7746225377496, 2258.5369999150216, 2259.8531095478825, 2094.371688493446, 2230.2528652901296, 2245.1917309768633, 2252.51570912253, 2256.593813113639, 1902.7431296774896, 1932.8646994710375, 2025.767036790773, 2257.582347265745, 2270.943226419336, 8186.345092392594, 8376.371772117116, 8423.536705481196, 8462.78843028923, 8504.23461888433, 5030.094582975063, 5201.765920533585, 5205.297284866532, 5207.218917162418, 5213.426523082458, 3319.4854797506423, 3442.5180474733556, 3452.861885524576, 3466.2027733621157, 3523.3834079036324, 1184.8222766584995, 1185.7984142695761, 1221.584661215191, 1223.4127618743053, 1236.876312368765, 10828.566857325697, 10841.078508326802, 10853.51159197838, 10864.837027444595, 10933.343999360064, 4134.586541345841, 4364.279893817548, 4446.755428451466, 4447.266201076786, 4492.438445194351, 7231.16841563227, 8579.613917373734, 8641.049484556694, 8648.0, 8655.52394618302, 4157.563455837094, 4430.800613972379, 4955.677880937799, 5071.41678706946, 5091.465396133352, 4490.640748740093, 4578.908421831545, 4697.248440249544, 4761.381020467317, 4781.306710526954, 3425.9828700856337, 3433.1073920780777, 3473.913152171216, 3485.7908525488047, 3511.2801875615437, 974.9853752193723, 1124.814405623063, 1125.9887401125884, 1137.5108703257679, 1141.2695874640071, 807.3097501636134, 860.5525126933959, 880.700561808988, 914.0630853375211, 917.2295271971443, 5640.887182256414, 5682.801101961411, 5687.232223649754, 5761.452661997104, 6020.277566691937, 833.983320333602, 960.6589660670501, 960.711786464058, 964.4358050540372, 1007.5566750629699, 3583.6953858922284, 3607.603163651996, 3699.3711069118312, 3790.8673196437994, 3833.0609000794984, 9800.313978021613, 10130.898691013143, 10145.289829711997, 10150.695479135638, 10150.98490150979, 10002.599896004223, 10082.546285417175, 10084.445355505371, 10088.243381746252, 10094.899051009543, 6604.273529911706, 7911.97144371228, 7918.881216781753, 7940.444168908121, 7946.6424010919645, 5506.339239291311, 5531.336239651107, 5543.667379957215, 5590.44095590454, 5853.619514731528, 9062.864057039282, 9266.258699303904, 9278.164965152899, 9296.535173241176, 9325.533723313943, 8963.731088067369, 9222.769430764285, 9336.859947100935, 9352.485613291063, 9461.195798357217, 7016.543924644881, 7136.6788494518905, 7161.534500257467, 7167.928320716726, 7176.856462870818, 7819.648115834915, 7824.921750782647, 7894.1316455188735, 7909.52542847431, 7920.5247685139075, 7020.122484689414, 7085.078939737801, 7127.10911136108, 7160.319769622086, 7230.530015548972, 5741.971290143522, 6994.825129371807, 6995.965020174866, 7022.262662420577, 7142.428605711634, 6271.122042914087, 6359.87280254383, 6407.935920640734, 6422.389872962061, 6425.646589437439, 4082.4692789937117, 4108.897277567965, 4453.866384008485, 4543.659225558163, 4610.723356598614, 4489.506154323087, 4866.367372241586, 4985.255160693729, 5043.596512278936, 5157.0], "value": 4317.709718178984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2890232525654, 344.9758516903818, 352.11091992718383, 357.7406380374228, 362.98548058077677, 4315.0, 4720.5515476029805, 5209.453007434222, 5298.894022119555, 5394.7032913189805, 5204.817831375903, 5251.396089449714, 5264.499872512115, 5267.9990801747645, 5276.258834584587, 3238.805671659702, 3372.29181871806, 3878.45701601776, 4017.6785857131504, 4029.1594425929648, 3579.7673151245085, 3718.2749363874054, 3971.7021223408215, 4030.8186131624147, 4053.655439287649, 3576.3204991051616, 3861.3242682530586, 3887.2614203301423, 3935.724499285051, 3937.676770705283, 3073.830939298338, 3465.6014558325865, 3894.493715816954, 3906.277338692351, 3937.606239376068, 3046.664866864643, 3446.0351101691567, 3447.6554143883905, 3458.844352004166, 3470.9826450867836, 4917.926231106536, 5043.67216130954, 5058.645894787366, 5157.355330583677, 5188.9881473112755, 4190.371444283352, 4426.800793964279, 4480.753558554278, 4484.663650226246, 4487.0, 4840.733759643218, 5219.799446127374, 5238.266642670029, 5372.623916325859, 5504.559635229172, 2980.3890202508433, 3299.977007127774, 3787.9053023674355, 3793.3172029034763, 3816.255830113129, 5127.307813445174, 5476.863078423032, 5697.943020569741, 5717.8570535736935, 5749.9425005750245, 3426.3832510148413, 3516.894493165209, 3664.157243833933, 3749.8188070757624, 3828.73198876076, 3403.0811680846527, 3874.360730479439, 3880.9223815523533, 3884.378499440076, 3930.3514920037874, 4131.421600975866, 4501.77491125449, 4528.660350473728, 4555.248384016666, 4573.787946194261, 5259.737013149327, 5493.423190565013, 5558.527525160326, 5626.803061892814, 5634.7182640867795, 1029.156092004564, 1143.9199256051998, 1263.109507797001, 1273.7707212701803, 1279.5201799325253, 775.6393277126164, 796.3708670150633, 847.732639703647, 862.5385418800911, 870.2646263906988, 4328.783560821947, 4432.246518091933, 4445.4885338984905, 4696.430712658404, 4928.654994150446, 4667.439907211156, 4975.925361119586, 5065.6200784941275, 5422.457754224625, 5476.342838859283, 3797.3164830330807, 4390.253656878338, 4426.933595996063, 4858.951410485921, 4895.755212239374, 2683.6645419322585, 2736.8357898525755, 2792.3298408381843, 2911.5733290687413, 2923.9766081871176, 4703.988642441823, 5081.3140226069745, 5422.7017514036315, 5661.886762264731, 5700.781421747876, 4915.156816193928, 5075.949240507622, 5189.6886186828915, 5255.710935898486, 5732.34078081026, 4959.7272150032095, 4987.855222254538, 5384.784608615611, 5457.836264912059, 5591.189277554813, 4647.675412507554, 4702.0, 4809.44691360498, 5380.219868119179, 5486.31421072366, 4409.40473036136, 4527.524609916043, 4845.0067736114715, 5391.784328626811, 5473.480019398151, 5521.889562208814, 5614.45602459327, 5674.0494942628775, 5681.517071049007, 5702.800401985911, 3802.258559580855, 3803.0, 3806.657400833938, 3811.313963486599, 3816.94274585887, 5700.087985922399, 5711.7429715662065, 5725.484706376446, 5756.827295181151, 5760.567957403296, 4448.377227188261, 5360.525855389643, 5522.392536820867, 5537.640053396516, 5547.084731019498, 4458.84070141772, 4640.148676598483, 4713.599344055794, 5454.281901201109, 5571.637843540157, 4831.5651591355545, 4856.8300109495995, 5055.620828437955, 5060.569851562511, 5405.783768649368, 4801.719183388002, 4868.95131048685, 5466.316710411199, 5486.725663716718, 5699.914501282401, 5123.052235336475, 5251.002309561171, 5286.894262114659, 5293.364796224478, 5328.626996110235], "value": 3921.2278010718974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.886781511513, 706.5019161491145, 745.8993035940148, 764.7820371194207, 811.8701007838745, 14417.495387661435, 15418.460353887616, 15419.537413877588, 15456.45902393415, 15471.381144754196, 13531.323433828295, 14097.929510352435, 14163.92918035411, 14301.141931484119, 14321.0, 859.9957000215006, 880.8810810540559, 896.8923729152478, 897.8428774964387, 899.1817446124029, 885.2519620920312, 891.189017993626, 891.9152680495342, 893.0266010049078, 894.0969620683125, 937.409432057806, 939.9906000940006, 940.3887473142478, 943.1087622197026, 952.538019060755, 931.7204838548408, 938.4932136646203, 939.3847030195233, 939.8872135343734, 941.3175447800324, 666.8066260784367, 700.7652436433801, 701.4528667639249, 702.9789106326818, 707.1514182980444, 15090.924545377313, 15099.924500377538, 15362.385504579803, 15486.380544778196, 15654.452094176762, 14336.354864031144, 14484.710305793931, 14512.346944387527, 14521.636959076108, 14578.0, 9604.711858644252, 10729.658792650918, 10977.670669879917, 11962.58130965412, 11985.460654270579, 3643.417053271464, 3652.2695460907657, 3813.199228162089, 3845.3270677631303, 3865.942010869839, 77953.0, 95623.52188239084, 97120.51439742756, 97609.0239097607, 98233.5088324561, 9587.760305992266, 10522.473876306154, 10895.855935126856, 11071.72320691973, 11086.833697494543, 19556.608867822564, 21607.67588486174, 21721.456963576038, 22317.107315707515, 22388.664170037464, 7635.809104772314, 7689.154193038761, 7711.383089352838, 7803.648835802289, 7848.13670496245, 4199.832006719758, 4242.193983143255, 4256.233877901946, 4259.424977628042, 4392.2094023075515, 3640.0, 3749.9437508437395, 3752.0, 3752.887413377603, 3753.4557489163917, 685.85939882324, 690.5545922879814, 696.5681277607915, 697.2156324135348, 697.888337865939, 655.3021032600361, 678.0737938874083, 697.930206979298, 700.7477308169055, 702.9753958611424, 9836.803263934682, 9919.156871665846, 9933.602655893683, 10327.32872363294, 10352.896471035343, 554.6810583914265, 570.8201916396322, 582.2837909371412, 590.5364289033089, 602.0, 4545.204589196944, 4638.512956139624, 4882.292067650242, 4956.355673762388, 4970.950290497049, 83862.0, 85892.0, 88815.0, 96516.03483965211, 97616.0, 73840.89238661424, 75796.62101689457, 75965.6201718999, 84539.0, 86866.13133868708, 55472.0, 59389.406105939255, 66054.33945660578, 67485.66257168683, 67596.6620166896, 9109.635614575343, 9284.72145835626, 9330.393524420891, 9348.252139828934, 9355.719328420158, 45232.54767452284, 47202.0, 47410.762946185045, 47739.522604773505, 47771.761141194074, 59781.40218597758, 60502.69748651228, 60780.0, 61198.0, 61737.0, 12521.749565008467, 12751.0, 12789.424475898793, 12921.870781292442, 13109.557948625834, 14127.223002734949, 14161.645958850699, 14444.711105778037, 14512.274386280433, 14819.184944828137, 13172.538961136313, 13395.641743302756, 13534.323283835965, 13961.860381396056, 13983.230922299372, 12942.547010854574, 13562.525311614047, 14024.29878506091, 14039.789403159166, 14073.155610663393, 12598.244105353708, 13041.543545975845, 13365.198088114745, 13491.123076999964, 13491.32543372847, 10875.40185289785, 11142.554297827995, 11203.831942521032, 11554.711132221426, 11690.181687281809, 10797.0, 10878.292910960763, 11015.669529914116, 11052.447377630926, 11068.391238481961], "value": 7369.570942149109, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1601.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 125.0, 106.0, 177.0, 176.0, 106.0, 138.0, 151.0, 152.0, 174.0], "value": 141.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 113.0, 114.0, 152.0, 120.0, 123.0, 116.0, 116.0, 135.0, 118.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 261.0, 263.0, 287.0, 276.0, 225.0, 197.0, 195.0, 194.0, 197.0], "value": 229.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 62.0, 86.0, 62.0, 60.0, 61.0, 60.0, 74.0, 61.0], "value": 66.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 84.0, 72.0, 71.0, 71.0, 84.0, 93.0, 57.0, 98.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 89.0, 90.0, 91.0, 91.0, 90.0, 89.0, 93.0, 90.0, 76.0], "value": 91.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 107.0, 97.0, 103.0, 108.0, 144.0, 129.0, 148.0, 122.0], "value": 115.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 91.0, 134.0, 144.0, 93.0, 94.0, 91.0, 96.0, 95.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 112.0, 73.0, 73.0, 68.0, 88.0, 101.0, 105.0, 91.0, 72.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 92.0, 92.0, 90.0, 92.0, 100.0, 84.0, 109.0, 112.0], "value": 95.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 145.0, 146.0, 144.0, 145.0, 146.0, 149.0, 190.0, 149.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 174.0, 231.0, 179.0, 175.0, 176.0, 176.0, 175.0, 176.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 67.0, 69.0, 68.0, 68.0, 69.0, 70.0, 66.0], "value": 68.3, "unit": "score"}]}]} 04:56:20 INFO - Return code: 0 04:56:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:56:20 ERROR - # TBPL SUCCESS # 04:56:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:56:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:56:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:56:20 INFO - 2017-02-09 04:56:20.128 screenresolution[2010:284362] starting screenresolution argv=screenresolution get 04:56:20 INFO - 2017-02-09 04:56:20.131 screenresolution[2010:284362] Display 0: 1600x1200x32@60 04:56:20 INFO - 2017-02-09 04:56:20.137 screenresolution[2011:284365] starting screenresolution argv=screenresolution list 04:56:20 INFO - Available Modes on Display 0 04:56:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:56:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:56:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:56:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:56:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:56:20 INFO - Intel Iris: 04:56:20 INFO - Chipset Model: Intel Iris 04:56:20 INFO - Type: GPU 04:56:20 INFO - Bus: Built-In 04:56:20 INFO - VRAM (Dynamic, Max): 1536 MB 04:56:20 INFO - Vendor: Intel (0x8086) 04:56:20 INFO - Device ID: 0x0a2e 04:56:20 INFO - Revision ID: 0x0009 04:56:20 INFO - Displays: 04:56:20 INFO - Display: 04:56:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:56:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:56:20 INFO - Display Serial Number: 1600x1200 60 04:56:20 INFO - Main Display: Yes 04:56:20 INFO - Mirror: Off 04:56:20 INFO - Online: Yes 04:56:20 INFO - Rotation: Supported 04:56:20 INFO - Return code: 0 04:56:20 INFO - Running post-action listener: _resource_record_post_action 04:56:20 INFO - [mozharness: 2017-02-09 12:56:20.387476Z] Finished run-tests step (success) 04:56:20 INFO - Running post-run listener: _resource_record_post_run 04:56:20 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 3166720; Write bytes: 556836352; Read time: 25; Write time: 1756 04:56:20 INFO - TinderboxPrint: CPU usage
54.4% 04:56:20 INFO - TinderboxPrint: I/O read bytes / time
3,166,720 / 25 04:56:20 INFO - TinderboxPrint: I/O write bytes / time
556,836,352 / 1,756 04:56:20 INFO - TinderboxPrint: CPU idle
2,187.2 (45.5%) 04:56:20 INFO - TinderboxPrint: CPU system
962.8 (20.1%) 04:56:20 INFO - TinderboxPrint: CPU user
1,651.8 (34.4%) 04:56:20 INFO - TinderboxPrint: Swap in / out
271,101,952 / 0 04:56:20 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250542592; Write bytes: 244725760; Read time: 18071; Write time: 536 04:56:20 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 1765888; Write bytes: 300740096; Read time: 19; Write time: 1179 04:56:20 INFO - Running post-run listener: _upload_blobber_files 04:56:20 INFO - Blob upload gear active. 04:56:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:56:20 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 04:56:20 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:56:20 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:56:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:56:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:56:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:56:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:22 INFO - (blobuploader) - INFO - Done attempting. 04:56:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:56:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:56:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:23 INFO - (blobuploader) - INFO - Done attempting. 04:56:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:56:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:56:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:24 INFO - (blobuploader) - INFO - Done attempting. 04:56:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:56:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:56:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:56:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:56:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:56:26 INFO - (blobuploader) - INFO - Done attempting. 04:56:26 INFO - (blobuploader) - INFO - Iteration through files over. 04:56:26 INFO - Return code: 0 04:56:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:56:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:56:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4293796c347b215c9952f47fa4383b3d525cd5a462449db5d6bc1007f89f869d22a0500aba63becade80e4135a9862b9714ef83e0a9b8086adbc1a5ed72cadb7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7959be60c22bd3e8dc627b811e4729043ff281ad0df7c8c8179d972dc5006210f24b88e2e2a040918a0fa439eca2a4b1d482a62846576363ca35460e5630cd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da21899bc895882c759383b7dc69116d921333f2e45c3ebd373c3464d1ae0dc4d242e5c68396e2eab9d8eac9a1a9e4bfec9179276d2a94606a7bea1af3609b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9607ec76c15f34fabea402060f6b66a74fdb700c5b867c754627215c9b50d92e539a099b1c12920e3d0972ae6cc43d475dbf002c736a69570f4eea37cdb4cb14"} 04:56:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:56:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:56:26 INFO - Contents: 04:56:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4293796c347b215c9952f47fa4383b3d525cd5a462449db5d6bc1007f89f869d22a0500aba63becade80e4135a9862b9714ef83e0a9b8086adbc1a5ed72cadb7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7959be60c22bd3e8dc627b811e4729043ff281ad0df7c8c8179d972dc5006210f24b88e2e2a040918a0fa439eca2a4b1d482a62846576363ca35460e5630cd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da21899bc895882c759383b7dc69116d921333f2e45c3ebd373c3464d1ae0dc4d242e5c68396e2eab9d8eac9a1a9e4bfec9179276d2a94606a7bea1af3609b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9607ec76c15f34fabea402060f6b66a74fdb700c5b867c754627215c9b50d92e539a099b1c12920e3d0972ae6cc43d475dbf002c736a69570f4eea37cdb4cb14"} 04:56:26 INFO - Running post-run listener: copy_logs_to_upload_dir 04:56:26 INFO - Copying logs to upload dir... 04:56:26 INFO - mkdir: /builds/slave/test/build/upload/logs 04:56:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.134733 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-02-09 04:56:26.585625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:56:26.588925) ========= 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.wLXYS4k88z/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.3CybCgu9I1/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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/Firefox/sha512/4293796c347b215c9952f47fa4383b3d525cd5a462449db5d6bc1007f89f869d22a0500aba63becade80e4135a9862b9714ef83e0a9b8086adbc1a5ed72cadb7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7959be60c22bd3e8dc627b811e4729043ff281ad0df7c8c8179d972dc5006210f24b88e2e2a040918a0fa439eca2a4b1d482a62846576363ca35460e5630cd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da21899bc895882c759383b7dc69116d921333f2e45c3ebd373c3464d1ae0dc4d242e5c68396e2eab9d8eac9a1a9e4bfec9179276d2a94606a7bea1af3609b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9607ec76c15f34fabea402060f6b66a74fdb700c5b867c754627215c9b50d92e539a099b1c12920e3d0972ae6cc43d475dbf002c736a69570f4eea37cdb4cb14"} build_url:https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011416 build_url: 'https://queue.taskcluster.net/v1/task/Ny8FTxFNTe28h1Arcm2wjQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4293796c347b215c9952f47fa4383b3d525cd5a462449db5d6bc1007f89f869d22a0500aba63becade80e4135a9862b9714ef83e0a9b8086adbc1a5ed72cadb7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7959be60c22bd3e8dc627b811e4729043ff281ad0df7c8c8179d972dc5006210f24b88e2e2a040918a0fa439eca2a4b1d482a62846576363ca35460e5630cd5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7da21899bc895882c759383b7dc69116d921333f2e45c3ebd373c3464d1ae0dc4d242e5c68396e2eab9d8eac9a1a9e4bfec9179276d2a94606a7bea1af3609b9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9607ec76c15f34fabea402060f6b66a74fdb700c5b867c754627215c9b50d92e539a099b1c12920e3d0972ae6cc43d475dbf002c736a69570f4eea37cdb4cb14"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:56:26.627570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:56:26.627952) ========= 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.wLXYS4k88z/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.3CybCgu9I1/Listeners TMPDIR=/var/folders/hm/9qlv5fh54ms08d6djtv3wf9r00000w/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.005356 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:56:26.677386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:56:26.677741) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:56:26.678072) ========= ========= Total master_lag: 0.21 =========