builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0295 starttime: 1491155913.96 results: success (0) buildid: 20170402095323 builduid: ee4410c04856418b9be6bff0deaf64a0 revision: 38894655c89e68bcd8f45d31a0d3005f2c2b53db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:33.960583) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:33.960964) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:33.961247) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:34.113835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:34.114097) ========= 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.wbRVI5ahak/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.2b4uCl12U5/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-04-02 10:58:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.1M=0.001s 2017-04-02 10:58:34 (16.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.565849 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:34.713113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:34.713415) ========= 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.wbRVI5ahak/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.2b4uCl12U5/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.026628 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:34.764264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-02 10:58:34.764631) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 38894655c89e68bcd8f45d31a0d3005f2c2b53db --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 38894655c89e68bcd8f45d31a0d3005f2c2b53db --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wbRVI5ahak/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.2b4uCl12U5/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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-04-02 10:58:34,824 truncating revision to first 12 chars 2017-04-02 10:58:34,824 Setting DEBUG logging. 2017-04-02 10:58:34,825 attempt 1/10 2017-04-02 10:58:34,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/38894655c89e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 10:58:35,648 unpacking tar archive at: mozilla-central-38894655c89e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.095722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-02 10:58:35.884207) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:35.884583) ========= script_repo_revision: 38894655c89e68bcd8f45d31a0d3005f2c2b53db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:35.885012) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:35.885338) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 10:58:35.905596) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-02 10:58:35.905975) ========= /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.wbRVI5ahak/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.2b4uCl12U5/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:58:36 INFO - MultiFileLogger online at 20170402 10:58:36 in /builds/slave/test 10:58:36 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 10:58:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:36 INFO - {'append_to_log': False, 10:58:36 INFO - 'base_work_dir': '/builds/slave/test', 10:58:36 INFO - 'blob_upload_branch': 'Firefox', 10:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:36 INFO - 'branch': 'Firefox', 10:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:36 INFO - 'config_files': ('talos/mac_config.py',), 10:58:36 INFO - 'default_actions': ('clobber', 10:58:36 INFO - 'read-buildbot-config', 10:58:36 INFO - 'download-and-extract', 10:58:36 INFO - 'populate-webroot', 10:58:36 INFO - 'create-virtualenv', 10:58:36 INFO - 'install', 10:58:36 INFO - 'run-tests'), 10:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:36 INFO - 'download_minidump_stackwalk': True, 10:58:36 INFO - 'download_symbols': 'ondemand', 10:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:36 INFO - 'gecko_profile': False, 10:58:36 INFO - 'gecko_profile_interval': 0, 10:58:36 INFO - 'installer_path': 'installer.exe', 10:58:36 INFO - 'log_level': 'info', 10:58:36 INFO - 'log_name': 'talos', 10:58:36 INFO - 'log_to_console': True, 10:58:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:58:36 INFO - 'opt_config_files': (), 10:58:36 INFO - 'pip_index': False, 10:58:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:58:36 INFO - 'cmd': ('bash', 10:58:36 INFO - '-c', 10:58:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:58:36 INFO - 'enabled': True, 10:58:36 INFO - 'halt_on_failure': False, 10:58:36 INFO - 'name': 'check_screen_resolution'},), 10:58:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:58:36 INFO - 'cmd': ('bash', 10:58:36 INFO - '-c', 10:58:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:58:36 INFO - 'enabled': True, 10:58:36 INFO - 'halt_on_failure': False, 10:58:36 INFO - 'name': 'check_screen_resolution'},), 10:58:36 INFO - 'run_cmd_checks_enabled': True, 10:58:36 INFO - 'suite': 'dromaeojs-e10s', 10:58:36 INFO - 'system_bits': '32', 10:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:36 INFO - 'title': 't-yosemite-r7-0295', 10:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:36 INFO - 'use_talos_json': True, 10:58:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:36 INFO - 'work_dir': 'build'} 10:58:36 INFO - [mozharness: 2017-04-02 17:58:36.082970Z] Running clobber step. 10:58:36 INFO - Running pre-action listener: _resource_record_pre_action 10:58:36 INFO - Running main action method: clobber 10:58:36 INFO - rmtree: /builds/slave/test/build 10:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:38 INFO - Running post-action listener: _resource_record_post_action 10:58:38 INFO - [mozharness: 2017-04-02 17:58:38.672234Z] Finished clobber step (success) 10:58:38 INFO - [mozharness: 2017-04-02 17:58:38.672315Z] Running read-buildbot-config step. 10:58:38 INFO - Running pre-action listener: _resource_record_pre_action 10:58:38 INFO - Running main action method: read_buildbot_config 10:58:38 INFO - Using buildbot properties: 10:58:38 INFO - { 10:58:38 INFO - "project": "", 10:58:38 INFO - "product": "firefox", 10:58:38 INFO - "script_repo_revision": "production", 10:58:38 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:58:38 INFO - "repository": "", 10:58:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:58:38 INFO - "buildid": "20170402095323", 10:58:38 INFO - "pgo_build": "False", 10:58:38 INFO - "basedir": "/builds/slave/test", 10:58:38 INFO - "buildnumber": 34, 10:58:38 INFO - "slavename": "t-yosemite-r7-0295", 10:58:38 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 10:58:38 INFO - "platform": "yosemite_r7", 10:58:38 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:58:38 INFO - "branch": "mozilla-central", 10:58:38 INFO - "repo_path": "mozilla-central", 10:58:38 INFO - "revision": "38894655c89e68bcd8f45d31a0d3005f2c2b53db", 10:58:38 INFO - "stage_platform": "macosx64", 10:58:38 INFO - "builduid": "ee4410c04856418b9be6bff0deaf64a0", 10:58:38 INFO - "slavebuilddir": "test" 10:58:38 INFO - } 10:58:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 10:58:38 INFO - Running post-action listener: _resource_record_post_action 10:58:38 INFO - [mozharness: 2017-04-02 17:58:38.675728Z] Finished read-buildbot-config step (success) 10:58:38 INFO - [mozharness: 2017-04-02 17:58:38.675879Z] Running download-and-extract step. 10:58:38 INFO - Running pre-action listener: _resource_record_pre_action 10:58:38 INFO - Running main action method: download_and_extract 10:58:38 INFO - mkdir: /builds/slave/test/build/tests 10:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:38 INFO - trying https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:58:38 INFO - Downloading https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:58:39 INFO - Downloaded 1325 bytes. 10:58:39 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:58:39 INFO - Using the following test package requirements: 10:58:39 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:58:39 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:58:39 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:58:39 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:58:39 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'jsshell-mac.zip'], 10:58:39 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:58:39 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:58:39 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:58:39 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:58:39 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:58:39 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:58:39 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:58:39 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:58:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:58:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:58:39 INFO - Fetch https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:58:42 INFO - Expected file size: 52515633 10:58:42 INFO - Obtained file size: 52515633 10:58:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:58:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:58:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:58:59 INFO - Fetch https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:59:00 INFO - Expected file size: 52515633 10:59:00 INFO - Obtained file size: 52515633 10:59:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:59:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:59:16 INFO - Fetch https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:59:17 INFO - Expected file size: 14404152 10:59:17 INFO - Obtained file size: 14404152 10:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:18 INFO - trying https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:59:18 INFO - Downloading https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:59:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:59:20 INFO - Downloaded 75564319 bytes. 10:59:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:59:20 INFO - mkdir: /builds/slave/test/properties 10:59:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:20 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:20 INFO - Contents: 10:59:20 INFO - build_url:https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:59:20 INFO - Running post-action listener: _resource_record_post_action 10:59:20 INFO - Running post-action listener: set_extra_try_arguments 10:59:20 INFO - [mozharness: 2017-04-02 17:59:20.950865Z] Finished download-and-extract step (success) 10:59:20 INFO - [mozharness: 2017-04-02 17:59:20.950959Z] Running populate-webroot step. 10:59:20 INFO - Running pre-action listener: _resource_record_pre_action 10:59:20 INFO - Running main action method: populate_webroot 10:59:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:59:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:59:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:59:20 INFO - '--tppagecycles', 10:59:20 INFO - '7'], 10:59:20 INFO - 'tests': ['tsvgm']}}, 10:59:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:59:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:20 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:20 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:20 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['damp', 'tps']}, 10:59:20 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'tests': ['damp', 'tps']}, 10:59:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['dromaeo_dom']}, 10:59:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['basic_compositor_video']}, 10:59:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:59:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['a11yr', 10:59:20 INFO - 'ts_paint', 10:59:20 INFO - 'tpaint', 10:59:20 INFO - 'sessionrestore', 10:59:20 INFO - 'sessionrestore_no_auto_restore', 10:59:20 INFO - 'tabpaint']}, 10:59:20 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:20 INFO - 'ts_paint', 10:59:20 INFO - 'tpaint', 10:59:20 INFO - 'sessionrestore', 10:59:20 INFO - 'sessionrestore_no_auto_restore', 10:59:20 INFO - 'tabpaint']}, 10:59:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:59:20 INFO - 'ts_paint', 10:59:20 INFO - 'tpaint', 10:59:20 INFO - 'sessionrestore', 10:59:20 INFO - 'sessionrestore_no_auto_restore', 10:59:20 INFO - 'tabpaint']}, 10:59:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:59:20 INFO - 'ts_paint', 10:59:20 INFO - 'tpaint', 10:59:20 INFO - 'sessionrestore', 10:59:20 INFO - 'sessionrestore_no_auto_restore', 10:59:20 INFO - 'tabpaint']}, 10:59:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['a11yr', 10:59:20 INFO - 'ts_paint', 10:59:20 INFO - 'tpaint', 10:59:20 INFO - 'sessionrestore', 10:59:20 INFO - 'sessionrestore_no_auto_restore', 10:59:20 INFO - 'tabpaint']}, 10:59:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['a11yr', 10:59:20 INFO - 'ts_paint', 10:59:20 INFO - 'tpaint', 10:59:20 INFO - 'sessionrestore', 10:59:20 INFO - 'sessionrestore_no_auto_restore', 10:59:20 INFO - 'tabpaint']}, 10:59:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['tsvgx', 10:59:20 INFO - 'tsvgr_opacity', 10:59:20 INFO - 'tart', 10:59:20 INFO - 'tscrollx', 10:59:20 INFO - 'cart', 10:59:20 INFO - 'tsvg_static']}, 10:59:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:20 INFO - 'tsvgr_opacity', 10:59:20 INFO - 'tart', 10:59:20 INFO - 'tscrollx', 10:59:20 INFO - 'cart', 10:59:20 INFO - 'tsvg_static']}, 10:59:20 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'talos_options': ['--disable-e10s'], 10:59:20 INFO - 'tests': ['tp5o']}, 10:59:20 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:59:20 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'talos_options': ['--disable-e10s', 10:59:20 INFO - '--xperf_path', 10:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:20 INFO - 'tests': ['tp5n']}, 10:59:20 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:59:20 INFO - 'talos_options': ['--xperf_path', 10:59:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:20 INFO - 'tests': ['tp5n']}}, 10:59:20 INFO - 'talos.zip': {'path': '', 10:59:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:59:20 INFO - Running post-action listener: _resource_record_post_action 10:59:20 INFO - [mozharness: 2017-04-02 17:59:20.969696Z] Finished populate-webroot step (success) 10:59:20 INFO - [mozharness: 2017-04-02 17:59:20.969833Z] Running create-virtualenv step. 10:59:20 INFO - Running pre-action listener: _resource_record_pre_action 10:59:20 INFO - Running main action method: create_virtualenv 10:59:20 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:20 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:59:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:21 INFO - Using real prefix '/tools/python27' 10:59:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:21 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:24 INFO - Installing pip.................done. 10:59:24 INFO - Return code: 0 10:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:59:24 INFO - Reading from file tmpfile_stdout 10:59:24 INFO - Output received: 10:59:24 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) 10:59:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59: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')]} 10:59:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:24 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 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:24 INFO - 'HOME': '/Users/cltbld', 10:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:24 INFO - 'LOGNAME': 'cltbld', 10:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:24 INFO - 'MOZ_NO_REMOTE': '1', 10:59:24 INFO - 'NO_EM_RESTART': '1', 10:59:24 INFO - 'PAGER': '/bin/cat', 10:59:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:24 INFO - 'PWD': '/builds/slave/test', 10:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:24 INFO - 'SHELL': '/bin/bash', 10:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:24 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:24 INFO - 'USER': 'cltbld', 10:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:24 INFO - 'XPC_FLAGS': '0x0', 10:59:24 INFO - 'XPC_SERVICE_NAME': '0', 10:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:59:25 INFO - Cleaning up... 10:59:25 INFO - Return code: 0 10:59:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:25 INFO - 'HOME': '/Users/cltbld', 10:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:25 INFO - 'LOGNAME': 'cltbld', 10:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:25 INFO - 'MOZ_NO_REMOTE': '1', 10:59:25 INFO - 'NO_EM_RESTART': '1', 10:59:25 INFO - 'PAGER': '/bin/cat', 10:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:25 INFO - 'PWD': '/builds/slave/test', 10:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:25 INFO - 'SHELL': '/bin/bash', 10:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:25 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:25 INFO - 'USER': 'cltbld', 10:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:25 INFO - 'XPC_FLAGS': '0x0', 10:59:25 INFO - 'XPC_SERVICE_NAME': '0', 10:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:25 INFO - Downloading/unpacking psutil>=3.1.1 10:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:29 INFO - Installing collected packages: psutil 10:59:29 INFO - Running setup.py install for psutil 10:59:29 INFO - building 'psutil._psutil_osx' extension 10:59:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:59:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:59:30 INFO - building 'psutil._psutil_posix' extension 10:59:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:59:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:59:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:59:30 INFO - ^ 10:59:30 INFO - 1 warning generated. 10:59:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:59:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:30 INFO - Successfully installed psutil 10:59:30 INFO - Cleaning up... 10:59:30 INFO - Return code: 0 10:59:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:59:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:59:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:30 INFO - 'HOME': '/Users/cltbld', 10:59:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:30 INFO - 'LOGNAME': 'cltbld', 10:59:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:30 INFO - 'MOZ_NO_REMOTE': '1', 10:59:30 INFO - 'NO_EM_RESTART': '1', 10:59:30 INFO - 'PAGER': '/bin/cat', 10:59:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:30 INFO - 'PWD': '/builds/slave/test', 10:59:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:30 INFO - 'SHELL': '/bin/bash', 10:59:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:30 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:30 INFO - 'USER': 'cltbld', 10:59:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:30 INFO - 'XPC_FLAGS': '0x0', 10:59:30 INFO - 'XPC_SERVICE_NAME': '0', 10:59:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:33 INFO - Installing collected packages: mozsystemmonitor 10:59:33 INFO - Running setup.py install for mozsystemmonitor 10:59:33 INFO - Successfully installed mozsystemmonitor 10:59:33 INFO - Cleaning up... 10:59:33 INFO - Return code: 0 10:59:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:59:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:59:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:33 INFO - 'HOME': '/Users/cltbld', 10:59:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:33 INFO - 'LOGNAME': 'cltbld', 10:59:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:33 INFO - 'MOZ_NO_REMOTE': '1', 10:59:33 INFO - 'NO_EM_RESTART': '1', 10:59:33 INFO - 'PAGER': '/bin/cat', 10:59:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:33 INFO - 'PWD': '/builds/slave/test', 10:59:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:33 INFO - 'SHELL': '/bin/bash', 10:59:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:33 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:33 INFO - 'USER': 'cltbld', 10:59:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:33 INFO - 'XPC_FLAGS': '0x0', 10:59:33 INFO - 'XPC_SERVICE_NAME': '0', 10:59:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:34 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:37 INFO - warning: no files found matching '*.txt' 10:59:37 INFO - no previously-included directories found matching 'build' 10:59:37 INFO - no previously-included directories found matching 'dist' 10:59:37 INFO - no previously-included directories found matching '.git*' 10:59:37 INFO - Installing collected packages: jsonschema, functools32 10:59:37 INFO - Running setup.py install for functools32 10:59:37 INFO - warning: no files found matching '*.txt' 10:59:37 INFO - no previously-included directories found matching 'build' 10:59:37 INFO - no previously-included directories found matching 'dist' 10:59:37 INFO - no previously-included directories found matching '.git*' 10:59:37 INFO - Successfully installed jsonschema functools32 10:59:37 INFO - Cleaning up... 10:59:37 INFO - Return code: 0 10:59:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:37 INFO - 'HOME': '/Users/cltbld', 10:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:37 INFO - 'LOGNAME': 'cltbld', 10:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:37 INFO - 'MOZ_NO_REMOTE': '1', 10:59:37 INFO - 'NO_EM_RESTART': '1', 10:59:37 INFO - 'PAGER': '/bin/cat', 10:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:37 INFO - 'PWD': '/builds/slave/test', 10:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:37 INFO - 'SHELL': '/bin/bash', 10:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:37 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:37 INFO - 'USER': 'cltbld', 10:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:37 INFO - 'XPC_FLAGS': '0x0', 10:59:37 INFO - 'XPC_SERVICE_NAME': '0', 10:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:37 INFO - Cleaning up... 10:59:37 INFO - Return code: 0 10:59:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:59:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:37 INFO - 'HOME': '/Users/cltbld', 10:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:37 INFO - 'LOGNAME': 'cltbld', 10:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:37 INFO - 'MOZ_NO_REMOTE': '1', 10:59:37 INFO - 'NO_EM_RESTART': '1', 10:59:37 INFO - 'PAGER': '/bin/cat', 10:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:37 INFO - 'PWD': '/builds/slave/test', 10:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:37 INFO - 'SHELL': '/bin/bash', 10:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:37 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:37 INFO - 'USER': 'cltbld', 10:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:37 INFO - 'XPC_FLAGS': '0x0', 10:59:37 INFO - 'XPC_SERVICE_NAME': '0', 10:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:41 INFO - Downloading docopt-0.6.1.tar.gz 10:59:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:41 INFO - Running setup.py install for blobuploader 10:59:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:42 INFO - Running setup.py install for requests 10:59:42 INFO - Running setup.py install for docopt 10:59:42 INFO - Successfully installed blobuploader requests docopt 10:59:42 INFO - Cleaning up... 10:59:42 INFO - Return code: 0 10:59:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:42 INFO - 'HOME': '/Users/cltbld', 10:59:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:42 INFO - 'LOGNAME': 'cltbld', 10:59:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:42 INFO - 'MOZ_NO_REMOTE': '1', 10:59:42 INFO - 'NO_EM_RESTART': '1', 10:59:42 INFO - 'PAGER': '/bin/cat', 10:59:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:42 INFO - 'PWD': '/builds/slave/test', 10:59:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:42 INFO - 'SHELL': '/bin/bash', 10:59:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:42 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:42 INFO - 'USER': 'cltbld', 10:59:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:42 INFO - 'XPC_FLAGS': '0x0', 10:59:42 INFO - 'XPC_SERVICE_NAME': '0', 10:59:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ScmpSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-eQtjsF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-v8etAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-MZOum9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0nknIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-r4uvI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-JrdEU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-bbkWVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:43 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Ck46Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-vDelt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-nzlbPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-kFB_Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ux0Dfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ICEUp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5XOwhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-WRg45L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:44 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-SqLINH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:44 INFO - Running setup.py install for manifestparser 10:59:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:45 INFO - Running setup.py install for mozcrash 10:59:45 INFO - Running setup.py install for mozdebug 10:59:45 INFO - Running setup.py install for mozdevice 10:59:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:45 INFO - Running setup.py install for mozfile 10:59:45 INFO - Running setup.py install for mozhttpd 10:59:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:45 INFO - Running setup.py install for mozinfo 10:59:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:45 INFO - Running setup.py install for mozInstall 10:59:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Running setup.py install for mozleak 10:59:46 INFO - Running setup.py install for mozlog 10:59:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Running setup.py install for moznetwork 10:59:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Running setup.py install for mozprocess 10:59:46 INFO - Running setup.py install for mozprofile 10:59:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:46 INFO - Running setup.py install for mozrunner 10:59:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:47 INFO - Running setup.py install for mozscreenshot 10:59:47 INFO - Running setup.py install for moztest 10:59:47 INFO - Running setup.py install for mozversion 10:59:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:47 INFO - Cleaning up... 10:59:47 INFO - Return code: 0 10:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:47 INFO - 'HOME': '/Users/cltbld', 10:59:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:47 INFO - 'LOGNAME': 'cltbld', 10:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:47 INFO - 'MOZ_NO_REMOTE': '1', 10:59:47 INFO - 'NO_EM_RESTART': '1', 10:59:47 INFO - 'PAGER': '/bin/cat', 10:59:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:47 INFO - 'PWD': '/builds/slave/test', 10:59:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:47 INFO - 'SHELL': '/bin/bash', 10:59:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:47 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:47 INFO - 'USER': 'cltbld', 10:59:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:47 INFO - 'XPC_FLAGS': '0x0', 10:59:47 INFO - 'XPC_SERVICE_NAME': '0', 10:59:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Y9vhyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5feaOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:47 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)) 10:59:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Q7Bmwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-n_zsub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:48 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)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-pi29IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-tMVPfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-Aqr9hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-QGngfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-QSCY8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-k7UXEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-2bg3sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:59:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:48 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-FQGIWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:49 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-59lqMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:49 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-dS90Wz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:49 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)) 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:49 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-o7YrXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:49 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0tVU1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:49 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)) 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:49 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-sjAOu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:59:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:52 INFO - Downloading blessings-1.6.tar.gz 10:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:52 INFO - Installing collected packages: blessings 10:59:52 INFO - Running setup.py install for blessings 10:59:52 INFO - Successfully installed blessings 10:59:52 INFO - Cleaning up... 10:59:52 INFO - Return code: 0 10:59:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:52 INFO - Reading from file tmpfile_stdout 10:59:52 INFO - Current package versions: 10:59:52 INFO - blessings == 1.6 10:59:52 INFO - blobuploader == 1.2.4 10:59:52 INFO - docopt == 0.6.1 10:59:52 INFO - functools32 == 3.2.3-2 10:59:52 INFO - jsonschema == 2.5.1 10:59:52 INFO - manifestparser == 1.1 10:59:52 INFO - mozInstall == 1.12 10:59:52 INFO - mozcrash == 1.0 10:59:52 INFO - mozdebug == 0.1 10:59:52 INFO - mozdevice == 0.49 10:59:52 INFO - mozfile == 1.2 10:59:52 INFO - mozhttpd == 0.7 10:59:52 INFO - mozinfo == 0.9 10:59:52 INFO - mozleak == 0.1 10:59:52 INFO - mozlog == 3.4 10:59:52 INFO - moznetwork == 0.27 10:59:52 INFO - mozprocess == 0.25 10:59:52 INFO - mozprofile == 0.28 10:59:52 INFO - mozrunner == 6.13 10:59:52 INFO - mozscreenshot == 0.1 10:59:52 INFO - mozsystemmonitor == 0.3 10:59:52 INFO - moztest == 0.8 10:59:52 INFO - mozversion == 1.4 10:59:52 INFO - psutil == 3.1.1 10:59:52 INFO - requests == 1.2.3 10:59:52 INFO - wsgiref == 0.1.2 10:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:52 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 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:52 INFO - 'HOME': '/Users/cltbld', 10:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:52 INFO - 'LOGNAME': 'cltbld', 10:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:52 INFO - 'MOZ_NO_REMOTE': '1', 10:59:52 INFO - 'NO_EM_RESTART': '1', 10:59:52 INFO - 'PAGER': '/bin/cat', 10:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:52 INFO - 'PWD': '/builds/slave/test', 10:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:52 INFO - 'SHELL': '/bin/bash', 10:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:52 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:52 INFO - 'USER': 'cltbld', 10:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:52 INFO - 'XPC_FLAGS': '0x0', 10:59:52 INFO - 'XPC_SERVICE_NAME': '0', 10:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:59:53 INFO - Cleaning up... 10:59:53 INFO - Return code: 0 10:59:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:59:53 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 0x109f94b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f97768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2cb450380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, '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.wbRVI5ahak/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.2b4uCl12U5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:59:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:59:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 10:59:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:59:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:59:53 INFO - 'HOME': '/Users/cltbld', 10:59:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:59:53 INFO - 'LOGNAME': 'cltbld', 10:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:53 INFO - 'MOZ_NO_REMOTE': '1', 10:59:53 INFO - 'NO_EM_RESTART': '1', 10:59:53 INFO - 'PAGER': '/bin/cat', 10:59:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:53 INFO - 'PWD': '/builds/slave/test', 10:59:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:59:53 INFO - 'SHELL': '/bin/bash', 10:59:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 10:59:53 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 10:59:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:59:53 INFO - 'USER': 'cltbld', 10:59:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:59:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:53 INFO - 'XPC_FLAGS': '0x0', 10:59:53 INFO - 'XPC_SERVICE_NAME': '0', 10:59:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:53 INFO - Cleaning up... 10:59:53 INFO - Return code: 0 10:59:53 INFO - Running post-action listener: _resource_record_post_action 10:59:53 INFO - Running post-action listener: _start_resource_monitoring 10:59:53 INFO - Starting resource monitoring. 10:59:53 INFO - [mozharness: 2017-04-02 17:59:53.407780Z] Finished create-virtualenv step (success) 10:59:53 INFO - [mozharness: 2017-04-02 17:59:53.408745Z] Running install step. 10:59:53 INFO - Running pre-action listener: _resource_record_pre_action 10:59:53 INFO - Running main action method: install 10:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:53 INFO - Reading from file tmpfile_stdout 10:59:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:53 INFO - Reading from file tmpfile_stdout 10:59:53 INFO - Output received: 10:59:53 INFO - Usage: mozinstall [options] installer 10:59:53 INFO - Options: 10:59:53 INFO - -h, --help show this help message and exit 10:59:53 INFO - -d DEST, --destination=DEST 10:59:53 INFO - Directory to install application into. [default: 10:59:53 INFO - "/builds/slave/test"] 10:59:53 INFO - --app=APP Application being installed. [default: firefox] 10:59:53 INFO - mkdir: /builds/slave/test/build/application 10:59:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:59:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:00:14 INFO - Reading from file tmpfile_stdout 11:00:14 INFO - Output received: 11:00:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:00:14 INFO - Running post-action listener: _resource_record_post_action 11:00:14 INFO - [mozharness: 2017-04-02 18:00:14.449551Z] Finished install step (success) 11:00:14 INFO - [mozharness: 2017-04-02 18:00:14.449697Z] Running run-tests step. 11:00:14 INFO - Running pre-action listener: _resource_record_pre_action 11:00:14 INFO - Running main action method: run_tests 11:00:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:00:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:00:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:00:14 INFO - 2017-04-02 11:00:14.464 screenresolution[1636:8794] starting screenresolution argv=screenresolution get 11:00:14 INFO - 2017-04-02 11:00:14.467 screenresolution[1636:8794] Display 0: 1600x1200x32@60 11:00:14 INFO - 2017-04-02 11:00:14.473 screenresolution[1637:8796] starting screenresolution argv=screenresolution list 11:00:14 INFO - Available Modes on Display 0 11:00:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:00:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:00:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:00:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:00:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:00:14 INFO - Intel Iris: 11:00:14 INFO - Chipset Model: Intel Iris 11:00:14 INFO - Type: GPU 11:00:14 INFO - Bus: Built-In 11:00:14 INFO - VRAM (Dynamic, Max): 1536 MB 11:00:14 INFO - Vendor: Intel (0x8086) 11:00:14 INFO - Device ID: 0x0a2e 11:00:14 INFO - Revision ID: 0x0009 11:00:14 INFO - Displays: 11:00:14 INFO - Display: 11:00:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:00:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:00:14 INFO - Display Serial Number: 1600x1200 60 11:00:14 INFO - Main Display: Yes 11:00:14 INFO - Mirror: Off 11:00:14 INFO - Online: Yes 11:00:14 INFO - Rotation: Supported 11:00:14 INFO - Return code: 0 11:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:14 INFO - Python 2.7.3 11:00:14 INFO - Return code: 0 11:00:14 INFO - grabbing minidump binary from tooltool 11:00:14 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')]} 11:00:14 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 0x109d72d30>, '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 0x109c99db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d67be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:14 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 11:00:14 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 11:00:14 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 11:00:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:14 INFO - Return code: 0 11:00:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:00:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:14 INFO - ENV: RUST_BACKTRACE is now 1 11:00:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:00:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:14 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/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 11:00:14 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/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --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 11:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wbRVI5ahak/Render', 11:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:00:14 INFO - 'HOME': '/Users/cltbld', 11:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:00:14 INFO - 'LOGNAME': 'cltbld', 11:00:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:14 INFO - 'MOZ_NO_REMOTE': '1', 11:00:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:14 INFO - 'NO_EM_RESTART': '1', 11:00:14 INFO - 'PAGER': '/bin/cat', 11:00:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:14 INFO - 'PWD': '/builds/slave/test', 11:00:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:00:14 INFO - 'RUST_BACKTRACE': '1', 11:00:14 INFO - 'SHELL': '/bin/bash', 11:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2b4uCl12U5/Listeners', 11:00:14 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 11:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:00:14 INFO - 'USER': 'cltbld', 11:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:14 INFO - 'XPC_FLAGS': '0x0', 11:00:14 INFO - 'XPC_SERVICE_NAME': '0', 11:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:00:14 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/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 11:00:15 INFO - mozversion application_buildid: 20170402095323 11:00:15 INFO - mozversion application_changeset: 38894655c89e68bcd8f45d31a0d3005f2c2b53db 11:00:15 INFO - mozversion application_display_name: Nightly 11:00:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:15 INFO - mozversion application_name: Firefox 11:00:15 INFO - mozversion application_remotingname: firefox 11:00:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:00:15 INFO - mozversion application_vendor: Mozilla 11:00:15 INFO - mozversion application_version: 55.0a1 11:00:15 INFO - mozversion platform_buildid: 20170402095323 11:00:15 INFO - mozversion platform_changeset: 38894655c89e68bcd8f45d31a0d3005f2c2b53db 11:00:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:00:15 INFO - mozversion platform_version: 55.0a1 11:00:15 INFO - using testdate: 1491156015 11:00:15 INFO - actual date: 1491156015 11:00:15 INFO - starting webserver on 'localhost:49244' 11:00:15 INFO - SUITE-START | Running 2 tests 11:00:15 INFO - TEST-START | dromaeo_css 11:00:15 INFO - operating with platform_type : mac_ 11:00:15 INFO - Initialising browser for dromaeo_css test... 11:00:15 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpkQyBPG/profile http://localhost:49244/getInfo.html) 11:00:18 INFO - PID 1647 | 2017-04-02 11:00:18.093 plugin-container[1651:8999] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f37, name = 'com.apple.tsm.portname' 11:00:18 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:18 INFO - PID 1647 | 2017-04-02 11:00:18.097 plugin-container[1651:8999] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910f, name = 'com.apple.CFPasteboardClient' 11:00:18 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:18 INFO - PID 1647 | 2017-04-02 11:00:18.097 plugin-container[1651:8999] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:00:18 INFO - PID 1647 | __metrics Screen width/height:1600/1200 11:00:18 INFO - PID 1647 | colorDepth:24 11:00:18 INFO - PID 1647 | Browser inner width/height: 1024/689 11:00:18 INFO - PID 1647 | __metrics 11:00:18 ERROR - PID 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 11:00:18 INFO - TEST-INFO | 1647: exit 0 11:00:18 INFO - Browser initialized. 11:00:18 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:18 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpkQyBPG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:21 INFO - PID 1653 | 2017-04-02 11:00:21.584 plugin-container[1654:9238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8843, name = 'com.apple.tsm.portname' 11:00:21 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:21 INFO - PID 1653 | 2017-04-02 11:00:21.584 plugin-container[1654:9238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4323, name = 'com.apple.CFPasteboardClient' 11:00:21 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:00:21 INFO - PID 1653 | 2017-04-02 11:00:21.584 plugin-container[1654:9238] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:00:31 INFO - PID 1653 | RSS: Main: 228921344 11:00:31 INFO - PID 1653 | 11:03:35 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 11:03:37 INFO - PID 1653 | RSS: Main: 253628416 11:03:37 INFO - PID 1653 | 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 11:05:19 INFO - PID 1653 | 11:05:19 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:05:19 INFO - PID 1653 | Full stack: 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 11:05:19 INFO - PID 1653 | 11:05:19 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:05:19 INFO - PID 1653 | Full stack: 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 11:05:19 INFO - PID 1653 | 11:05:19 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:05:19 INFO - PID 1653 | Full stack: 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | ************************* 11:05:19 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 11:05:19 INFO - PID 1653 | 11:05:19 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:05:19 INFO - PID 1653 | Full stack: 11:05:19 INFO - PID 1653 | ************************* 11:06:39 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 11:06:40 INFO - PID 1653 | RSS: Main: 261263360 11:06:40 INFO - PID 1653 | 11:09:42 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 11:09:42 INFO - PID 1653 | RSS: Main: 272957440 11:09:42 INFO - PID 1653 | 11:12:44 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 11:12:45 INFO - PID 1653 | RSS: Main: 267190272 11:12:45 INFO - PID 1653 | 11:15:48 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 11:15:48 INFO - PID 1653 | RSS: Main: 277409792 11:15:48 INFO - PID 1653 | 11:18:51 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 11:18:52 INFO - PID 1653 | RSS: Main: 271032320 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | __start_tp_report 11:18:52 INFO - PID 1653 | _x_x_mozilla_page_load 11:18:52 INFO - PID 1653 | _x_x_mozilla_page_load_details 11:18:52 INFO - PID 1653 | |i|pagename|runs| 11:18:52 INFO - PID 1653 | |0;dojo.html;3598.046517672817;3601.747877648565;3627.927441451173;3643.672069513744;3644.653757893001;6117.357677443871;6224.968875155623;6240.09518619801;6245.968770156149;6247.156633854423;6181.134641150243;6183.598066125699;6206.7827626033095;6252.843678908018;6287.937120628792;4883.682560633548;5326.934613077381;5459;5521.337439507255;5635.6618602883955;5469.671819690811;5530.115181570949;5596.272484576999;5598;5622.522085622727;4513.210188217082;4634.9073018539775;4638.350630911641;5548.611597188198;5579.414161513023;4601.470830854428;5078.7460626968505;5531.170324451325;5546.639468434539;5605.5515558755205;4542.477615074243;5471.753771080271;5500.367457742371;5513.393526712059;5522.061249587579;4652.9996050848895;5588.469095435927;5898.085796701518;6213.130161777355;6323.683815809191;5758.62568933018;6547.148870646833;6713.295104014057;6808.489363297723;6817.352351526597;6835.213950395719;6860.5197636165485;6863.622500762456;6874.690638921261;6885;6322.114903913456;6347.460465860454;6355.809325720235;6360.77737279193;6384.872302554016;6663.633500157441;6870.965645171742;6902.551334163263;6957.965210174018;7025.437964962791;5835.94164058354;6140.416660417253;6389.488840892717;6468.708908099147;6641.136652235178;6231.937680623227;6502.674866256668;6748.055272261888;6764;6884.729753367211;6707.262201157869;6714.227863795629;6716.597004179765;6727.024581435762;6736.191657001191;6475.514336424787;6573.80278591643;6732.2931092235585;6752.966235168793;6771.593704377753;5312.787488500494;5418.106012507892;5418.783248670088;5449.727513624303;5487.42382049887;4787.0904528139545;4811.4707382187935;4817.9518204818205;4821.614270858323;4856.587190088811;6377.7448902044325;6408.551401401857;6410.423061924449;6453.386928241809;6460.095586617877;6612.735490580323;6692.364225398676;6732.225794033651;6755.18937727466;6831.965840170867;6405.391487808651;6413.7113829876835;6421.486281097595;6432.935670643234;6435.549511534241;6053.122297266872;6087.147799308101;6087.8478038048515;6100.48145907594;6104.694765261719;6756.155480564929;6884.380405763505;6944.236134025355;6970.860582788418;7017.754378596826;6773.864522709617;6836.111305530449;6859.314068593101;6874.896876546956;6886.655667216719;7026.754063607749;7027;7037.964810175917;7083.574985500681;7087.255838136922;6511.316311787384;6583.210014798255;6644.933550664625;6777.695003724745;6780.254172040973;6685.732570697312;6765.898511522233;6775.390214880685;6796.592204467748;6845.349691779273;6284.5600807943;6549.934500655123;6551.181102362205;6612.23959244693;6618.073469714148;6447.742090316335;6527.3472652734345;6544;6591.176102987127;6637.867242655023;6323.841903952438;6491.707873145814;6495.188101487314;6498.577592456475;6513.381228783258;6635.734570617315;6636.933630663824;6653.600783952978;6664.900026499509;6670.066190733398;6224.502039836711;6250.0937364082865;6381.329960354282;6450.774222902176;6483.935160648333 11:18:52 INFO - PID 1653 | |1;ext.html;652.9869402611948;691.7094820175525;838.4591938199861;1172.5368479450622;1278.5077745068152;28874.422511549757;39726.404103938425;39863.20273594526;39977.20045599086;40009.79995100024;39446.80276598613;39875.40186897199;39896.80051599745;39924.80037599808;40041.99895002627;7419.258074192591;8057.435979481454;8232.34141268697;8619.956900215522;8844.469331840079;8721.694740684077;8801.603927823231;8819.029906710257;8821.470711757283;8847.601857916408;8765.824683506326;8791.076936921627;8824.985126710415;8837.73486795394;8839.116088391174;8734;8755.605997730117;8781.034086250507;8822.47065176085;8822.602982865787;8691.348148888796;8693.913060869374;8727.38908276421;8731.60707768152;8740.8688869667;38457.423138652666;38692.61307386946;38764.41853372202;38769;39120.21759564821;2829.349249672566;2962.1113665900143;3054.57235986962;3075.7078077582596;3078.0919628709585;27173;27394.726052739417;27472;27558.86220568884;28514.429711405865;2807.6490438695164;2808.4242730240253;2817.3660926291627;2818.8449635270053;2842.9715702842914;280364;280533;281776.5911170431;283822;284009.6396144152;47017.529824702;47061.764691177006;47087.529124709;47125.528744712115;47190;49421.50578494241;49831.750841246285;49903.75048124809;49928.50071499311;50053.74973125111;14299.64250893736;14651.780223296659;14675.706485870436;14695.191764452844;14736.778948315783;11793.941030294794;11872;11894.107941904218;11894.88105118955;11921.284722916653;13267.402966866513;13704.10923289983;13734.862651373558;13749;13832.23922684242;5035.395752509722;5929.851753706192;5953.672548009901;5964.254468191476;5970.104484327298;955.7323949294208;964.9517524123906;973.1971123822874;993.5330394714473;1002.664107523973;23763.81180940946;24056.639150412757;24278.393040173785;28470.85764571164;30869.073927782203;1036.8185567525804;1039.6932904793105;1041.4792603698152;1067.8451624514403;1077.2889892670955;11798.705032374259;12108.576199832964;12222.449989750483;12278.201916875374;12346.691332716575;470469.942950856;488793;494333;497365;503525;40430;41191;53707.731461342446;53978.73010634922;54128.72935635297;1438.4102517967583;1444.83384410792;1448.0949406620862;1458.9927050364681;1466.7213229486363;28393.290167745145;28491;28683.569746453402;29363.85318073396;29897;37845.810770945965;37985.2402951945;38032.23935521329;38067.04832379213;38208.41499020024;358740;371389.42915855744;442665;442859;446478;26433;32301;32390.35219295648;32412.865549705646;32425.460435539517;41081.79459102685;41133.382999255635;42107;42587;42656.5734342665;28394.308739863685;29044.56433153547;29503.704962950094;29551.55672664955;30043.69956300409;25518.48963020692;26614;28937.855310724153;29969.250768730955;30112.84943575268;27249.727502725513;35131.824340878135;35156.472652910736;35888.74389396358;37363.62636373602;30446.128868392447;30591.136447590285;30599.694003060577;31066.689333107282;31278.843605781825;24649;24650.753492464846;24703.38241543976;24922.50154996926;25151.24546263615 11:18:52 INFO - PID 1653 | |2;jquery.html;391.26051762169493;406.78440426573906;427.4400535298761;439.96700247481436;456.15838777455605;17845.55386115348;19129.71305430418;20047.498812529677;22175.223867164652;22204.88897555514;22031.779682203174;22654.43363915903;23094.538109237805;23237;23310.18414355498;5526.171074338851;6016.187814645033;6402.071699603554;6404.103425520431;6411.5191360647905;5469.617126801106;6017.789377371793;6169.753209871622;6292.8741425171465;6340.873182536347;5388.757505912244;6221.0979407985815;6240.594361366497;6289.528285378592;6293.4650554702675;5604.439556044404;6047.425494578008;6111.572189946705;6250.031245157008;6286.528510361718;5058.2412638104215;5067.265246539231;5411.404745477994;5520.751566179531;5528.668279903219;23024.88487557568;26289.868550657124;27669.723302766917;27787.722122778716;28067.859660701564;1941.1361943934955;1978.980210197894;1989.1049027937486;2010.7888671689554;2015.5364266218705;16908.830911690973;17020.234089466005;17268.30926762928;17429.738553921576;17916.28334866604;1825.6257467219189;1917;1926.7206255093074;1963.9410817675493;1973.6842105263233;152376;159209.20395398064;159351;160394;161311;10497.842532362021;12627.179233349803;12738.770715124816;12893.61319160408;13002.024848136427;13257.734845303039;16658.833411665728;16666.50000499987;16686.83313166877;16724.91288066296;9007.234385077341;9223.308251881002;9240.214581760625;9340.673076442428;9392.29557783169;8861.025287218401;8879.24526415249;8890.97753758313;8901.287896968357;9059.275257979345;7095.858082838315;7992.920070799218;8158.143394943564;8164.591770411455;8245.13426090264;1843.8432733217826;2190.8466407351334;2197.890105494751;2204.7574766775642;2379.976610057657;794.6424109150905;926.578406824893;930.734740598926;933.4912472702393;971.3734641156556;17764.733528997076;18103.275868965356;18403.631927361377;19839.60320793576;20765.961701915145;851.9914800852036;959.7648576098901;971.3491960386558;995.2535598301274;995.9253056020827;9022.548872556477;9487;9825.066618671215;10401.323913945569;10868.782624347627;554702;589011;643754.5624543695;683147;719476;143217.28391357977;149087;159395;159924;160522;1172.809598257769;1178.0491467378445;1190.220405634311;1195.862475815275;1195.976080478403;15906.52280431589;17980.2807887683;18370.72443913369;18461.446156615322;18495.90752046231;51776;59950.50123746941;61262.69368653128;62710.37289627228;64765.14261430317;89114;89819.55090224507;90202.54898725727;90544.54727726319;90848.0915190866;7718.112417071884;8042.557659328793;8222.766585012057;8951.597178126869;8990.775230619287;14050.859491405365;14196.645083872985;14388.496402625859;14588.854111459174;14677.339519721425;11751.236169648946;11766.58816941403;11928.986036187021;11964.102692297938;11964.162508624313;11196.440177991231;11246;11338.943305283421;11393.772124557629;11424.257423267461;11753.353565553634;11996.64010079699;12091.153619246568;12207.877921220674;12383.504659813507;8863.911360886566;8869.512176830336;8948.060453652533;8964.731058068268;9044.41211321262;10039.849402259119;11662.950334469939;11837.940810295893;12038.638840834788;12110.910018098413 11:18:52 INFO - PID 1653 | |3;mootools.html;1080.5412692864631;1192.242925742154;1216.2033867816583;1233.1737735717072;1233.8710080276549;9579.137877591016;9840.360376575518;10666.946665266672;10999.23005389622;11120.833187502194;10615.893841061586;10939.726506837313;11035.227534072617;11037.83443248352;11055.834162487568;2439.3413778279855;2468.8518688878726;2477.7274499805008;2480.1567467061195;2484.1305543059875;2392.605220138675;2406.9759302407015;2449.8162637802147;2457.2382561405934;2502.8998840046374;2483.639872218527;2493.5262300163004;2509.836860604064;2513.6857892763405;2515.7295565739278;2397.3407312988893;2435.7807797298237;2447.278052974377;2449.546833835746;2449.7182823975295;2223.788740069691;2225.310153852311;2229.141780414536;2238.932832015042;2249.80876625487;10921.617743378943;11076.280041797338;11159.497822598003;11162.441877906072;11201.60794372193;5489.451054894518;6240.594361366497;6370.458511026568;6467.256265529477;6479.319671434526;3753.6434038766547;4015.217032678629;4064.593540645941;4098.856540021115;4107.527634322061;1123.7920984617872;1156.4333476596491;1160.628598848369;1194.677437091989;1208.6917835951776;12118.212316199508;14470;15360.385584576603;15394.307256173388;15477.226138693133;4451.955480445219;4530.79611417487;5391.757370918318;5437.9939711153565;5478.45215478457;9550.474723890253;11539.76920461586;11548.884511154949;11589;11602.18784685064;6158.753649854045;6183.288921774054;6262.373762623702;6273.247210334789;6297.27581328144;5611.579131565149;5824.155497452845;5911.733971971272;5975.910361344583;5992.370801065826;4176.853810116631;4230.957690423118;4252.234597772431;4285.678574106954;4343.087951530151;1101.2016288190998;1142.8514293141839;1145.1010956399352;1270.7776139175608;1280.9231446113263;766.2988365645483;768.047620950018;791.7347688524294;792.0970094092739;804.3002587748579;4882.9755851221225;5909.468147866627;5914.8817023659285;6083.8479038023515;6114.327423983358;883.1962913748587;884.6284560484612;885.8449771289999;921.3596550397409;937.1425145991478;3683.9631603684156;3707.9814600926825;3755.4366844973474;3787.6780473660046;3814.6376094271;13320.600381988555;13706.109102908278;13781.655458613615;13837.169769813843;13896.957728170226;13733.931330343485;13752.793708094387;13767.38046787897;13770.65573360654;13775.035747497579;7629.580373079423;9885.011498850201;9966.20270378368;10210.948945255375;10213.33613315132;6333.904991425225;6358.364163583605;6376.298607153117;6397.104405383343;6398.264199617103;12366.19619724715;12403;12494;12582.87417125817;12602.306873122066;11421.885781142415;12628.87371126277;12792.296423696785;12818.61544153677;12834.229946203257;8186.918130818615;8279.379046571652;8298.294644955246;8305.958470207852;8953.597088130919;10341.482925853828;10399.636012739518;10399.688009359732;10460.320079194827;10474.895251047392;6792.966035169792;8542.615582298688;8748;8752.21230089295;8794.42836215644;8539.103394143774;8574.056853745959;8607.397482176439;8618.655253789779;8630.395872289131;7664.965229694143;7672.61636918163;7709.80725481845;7779.299863012356;7791.454598178073;5544.1960915667805;5857.297124345106;5958.225430694156;6043.667598281961;6136.6011209271255;4731.716097034189;4930.013997200503;5131.717755523482;6093.146959425595;6188.3502232266765 11:18:52 INFO - PID 1653 | |4;prototype.html;345.48867675839773;360.5727213252296;392.5368065682495;400.62941778854554;411.1304590790478;5383.838484845451;5703.429657034295;5842.328132264791;6230.31466538681;6316.010351822067;5022.573081288095;6034.69826508675;6194.845128871781;6195.969020154904;6242.906356404646;3613.692836108934;4537.705049171794;4538.659600529957;4560.612347950429;4580.931286030712;4008.8196031178522;4354.129174165164;4501.504834468205;4564.771761411933;4579.656525760564;4512.548745125494;4523.570260825217;4548.135854187693;4550.749708766033;4554.7039442436135;4254.617084462413;4441.933370999438;4500.932486012713;4555.407796986404;4577.198990176722;3876.379779235337;3878.4957955465893;3884.5532763731967;3886.1644746379666;3889.8055097245306;6072.787452439187;6093.847653808646;6094.146819445281;6095.634261944253;6114.205153330083;4226.964393723527;5279.627296902833;5394.568434525228;5419.945800542023;5448.891022179574;5468.340267822784;6582.407583317477;6610.305917878602;6615.636140012298;6620.6827610335995;4407.933880991788;4410.29435290352;4416.53626369233;4433.733975961421;4466.419365482467;6014.48876845473;6734.3602357775935;6744.224414192382;7053.470989675743;7055.647217639097;4371.388005679208;4852.344933434012;4862.82980095695;4867.659263851568;4877.707337559757;4498.9652379952795;4818.349522814446;4940.2087820382085;4952.281919121707;4969.503049695001;5367.812126575551;5506.559475242051;5556.111022236423;5575.916361254584;5585.525230355384;5926.733297001645;6181.320054793969;6422.004589288667;6475.514336424787;6588.769393071219;1448.1238850495508;1495.6335697753902;1521.3078049487456;1699.8810083294052;1702.6339337042596;989.811935732223;1123.904468120219;1175.3359351966112;1179.8525184351956;1197.5269768441417;5415.864603384868;5850.882982340415;6371.5593579467495;6377.660691254889;6448.000559913221;6032.698365081728;6261.874762504815;6900.551464154914;6902;6930.896036559456;6253;6296.937030629727;6306.369363063749;6315;6334.547671519033;3165.208697825544;3528.7063408784497;3588.5334906462517;3589.2283159120916;3593.4969104325414;6051.577879198385;6208.099825525273;6350.301466838644;6771.45828333742;7097.699569700114;5743.483086522149;6994.202319072412;7031.859362812817;7035.155781306174;7078.787636370917;5900;7101.254368291358;7112.537685050455;7160.856782864314;7190;6808.251092379934;6823.078884350549;6843.692033858588;6867.107276054281;6877.828054298682;5465.371482279589;6398.360163983751;6735;6765.695543700644;6788.456923446014;6445.613263204035;6700.6984685688285;7123.323284288192;7141.321574450419;7144.1784194818265;4463.575960283768;4465.218586747371;4496.437945256843;4499.977500112478;4519.435070616173;6316.905246421215;6827.863442731018;6900.206476255295;6913.308669133247;6947.270536593584;5920.348761636303;6311.431971122621;6658.167729033871;6724.361185687352;6736.191657000995;6517.7067031984625;6606.4384527315715;6680.5991640501725;6691.76578819739;6692.063111164538;5694.088945768657;6554.934450655433;6558.672066396565;6561.212654481493;6565.671716414065;6533.248676402084;6674.43267322283;6716.899246511404;6717.429018533479;6722.210567326937;4988.6757360771435;5926.7925622603;6432.388923052303;6495.480361570969;6515.511336649675 11:18:52 INFO - PID 1653 | |5;yui.html;640.5964242527207;720.9927900720991;732.476279460186;740.974065907693;760.494271309579;12692.492300307988;12729.872701272985;16523.256453459595;16538.09040502772;16549.172541372944;15358.308876100602;15408.537743867673;15536.611584710388;15550.76673849893;15560.766588501181;975.7658162041113;987.9950600246989;1007.123802292007;1011.7672935224903;1017.7455636090978;1021.8978102189795;1030.042060883378;1036.6112707734599;1039.1790485516433;1041.5937784264106;1045.5190612318343;1063.0326402973296;1070.9196810239225;1071.7534966957605;1075.7310672331917;1022.616518805448;1050.6847945616323;1063.7819247054335;1076.2950267574752;1078.4338222433207;783.7844592737043;795.2405452792627;795.8209402884363;796.2594786848229;797.2466019611469;16760.41338553157;16977.236024378934;17023.91488042552;17393;17601.94388336704;15023.323950422147;15139.470118545798;15139.924300378538;15280.847191528053;16018.679626407524;10374.585016599327;11555.480003399867;11769.411529423494;11828.585999490062;11843.940780296129;2992.446397416485;3010.6236720409947;3072.4776787946103;3103.984480077585;3139.5133754268127;110098;110974.44512777466;111892;114642;115194;10267.435291058913;10659.09397701204;10660.608178958344;11489.613417307432;11589.82615260755;24530.14144504934;24862.875685621457;25136.497270054497;25161.496770064496;25173.87413062923;7885.763427097081;7918.574656561759;8056.718014869569;8058.919410805935;8073.354131669453;4195.160967806451;4212.831486740496;4215.810288537024;4220.6412454941055;4240.85157019509;4093.6111069448357;4196.139791342767;4198.6011328923705;4200.7479551227025;4206.47419072616;814.0922870998794;859.5616235719828;897.5243121145803;903.661127077346;906.7279816055157;523.6910222968467;546.551827501445;555.7110302642603;567.8381661226531;596.1326270276737;9644.517774111266;10281.948590257001;10611.84082238767;10691.946540267249;10794.514246858911;532.6902835908655;537.5108651127455;550.309361751;579.6377264209868;616.1466369078857;4218.6625069994325;4729.196036673774;4737.602407289858;4849.127157111683;5015.724135172528;109735;109931.70204893866;112307;113777.43111284556;115463;76854;94996;95371;98588;99284;86058.13941860502;86898.69651955226;87036;87565;89394.10605893988;9820.705378838646;9833.115019648267;9835.950820245853;9863.408195508293;9895.901040989498;33181.66818331786;40553;41412.792936035126;42020.369694454;42221;53781;53999.6500087501;54546;54596.45403546072;54742;9982.35114717541;11823.70440738954;12079.214851034654;12357;12562.497500099893;10768.456258754082;13177.934110329386;13190.60428187156;13289.401976910869;13410.745113257219;12294.262344259372;12296.446659900505;12380.566680166512;12414.255144691348;12874.935625322189;10841.891581084405;12196.085293602839;12413.93793031029;12509.061820363691;12692.36538173106;11448.713782155179;11783.234089784137;11943.104267179822;12337.321447320484;12646.114771966242;8024.317932975762;8208.384371172067;8388.66445342204;8513.446625969293;8771.429857059271;7975.521468711896;8216.137305582828;8345.29065029455;9118.22495087925;9137.77155571116 11:18:52 INFO - PID 1653 | __end_tp_report 11:18:52 INFO - PID 1653 | __start_cc_report 11:18:52 INFO - PID 1653 | _x_x_mozilla_cycle_collect,432 11:18:52 INFO - PID 1653 | __end_cc_report 11:18:52 INFO - PID 1653 | __startTimestamp1491157131998__endTimestamp 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | ------- Summary: start ------- 11:18:52 INFO - PID 1653 | Number of tests: 6 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | [#0] dojo.html Cycles:165 Average:6179.10 Median:6435.55 stddev:776.33 (12.1%) stddev-sans-first:751.85 11:18:52 INFO - PID 1653 | Values: 3598.0 3601.7 3627.9 3643.7 3644.7 6117.4 6225.0 6240.1 6246.0 6247.2 6181.1 6183.6 6206.8 6252.8 6287.9 4883.7 5326.9 5459.0 5521.3 5635.7 5469.7 5530.1 5596.3 5598.0 5622.5 4513.2 4634.9 4638.4 5548.6 5579.4 4601.5 5078.7 5531.2 5546.6 5605.6 4542.5 5471.8 5500.4 5513.4 5522.1 4653.0 5588.5 5898.1 6213.1 6323.7 5758.6 6547.1 6713.3 6808.5 6817.4 6835.2 6860.5 6863.6 6874.7 6885.0 6322.1 6347.5 6355.8 6360.8 6384.9 6663.6 6871.0 6902.6 6958.0 7025.4 5835.9 6140.4 6389.5 6468.7 6641.1 6231.9 6502.7 6748.1 6764.0 6884.7 6707.3 6714.2 6716.6 6727.0 6736.2 6475.5 6573.8 6732.3 6753.0 6771.6 5312.8 5418.1 5418.8 5449.7 5487.4 4787.1 4811.5 4818.0 4821.6 4856.6 6377.7 6408.6 6410.4 6453.4 6460.1 6612.7 6692.4 6732.2 6755.2 6832.0 6405.4 6413.7 6421.5 6432.9 6435.5 6053.1 6087.1 6087.8 6100.5 6104.7 6756.2 6884.4 6944.2 6970.9 7017.8 6773.9 6836.1 6859.3 6874.9 6886.7 7026.8 7027.0 7038.0 7083.6 7087.3 6511.3 6583.2 6644.9 6777.7 6780.3 6685.7 6765.9 6775.4 6796.6 6845.3 6284.6 6549.9 6551.2 6612.2 6618.1 6447.7 6527.3 6544.0 6591.2 6637.9 6323.8 6491.7 6495.2 6498.6 6513.4 6635.7 6636.9 6653.6 6664.9 6670.1 6224.5 6250.1 6381.3 6450.8 6483.9 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | [#1] ext.html Cycles:180 Average:52785.69 Median:35144.15 stddev:107750.14 (306.6%) stddev-sans-first:107981.32 11:18:52 INFO - PID 1653 | Values: 653.0 691.7 838.5 1172.5 1278.5 28874.4 39726.4 39863.2 39977.2 40009.8 39446.8 39875.4 39896.8 39924.8 40042.0 7419.3 8057.4 8232.3 8620.0 8844.5 8721.7 8801.6 8819.0 8821.5 8847.6 8765.8 8791.1 8825.0 8837.7 8839.1 8734.0 8755.6 8781.0 8822.5 8822.6 8691.3 8693.9 8727.4 8731.6 8740.9 38457.4 38692.6 38764.4 38769.0 39120.2 2829.3 2962.1 3054.6 3075.7 3078.1 27173.0 27394.7 27472.0 27558.9 28514.4 2807.6 2808.4 2817.4 2818.8 2843.0 280364.0 280533.0 281776.6 283822.0 284009.6 47017.5 47061.8 47087.5 47125.5 47190.0 49421.5 49831.8 49903.8 49928.5 50053.7 14299.6 14651.8 14675.7 14695.2 14736.8 11793.9 11872.0 11894.1 11894.9 11921.3 13267.4 13704.1 13734.9 13749.0 13832.2 5035.4 5929.9 5953.7 5964.3 5970.1 955.7 965.0 973.2 993.5 1002.7 23763.8 24056.6 24278.4 28470.9 30869.1 1036.8 1039.7 1041.5 1067.8 1077.3 11798.7 12108.6 12222.4 12278.2 12346.7 470469.9 488793.0 494333.0 497365.0 503525.0 40430.0 41191.0 53707.7 53978.7 54128.7 1438.4 1444.8 1448.1 1459.0 1466.7 28393.3 28491.0 28683.6 29363.9 29897.0 37845.8 37985.2 38032.2 38067.0 38208.4 358740.0 371389.4 442665.0 442859.0 446478.0 26433.0 32301.0 32390.4 32412.9 32425.5 41081.8 41133.4 42107.0 42587.0 42656.6 28394.3 29044.6 29503.7 29551.6 30043.7 25518.5 26614.0 28937.9 29969.3 30112.8 27249.7 35131.8 35156.5 35888.7 37363.6 30446.1 30591.1 30599.7 31066.7 31278.8 24649.0 24650.8 24703.4 24922.5 25151.2 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | [#2] jquery.html Cycles:180 Average:39086.78 Median:23273.59 stddev:108433.54 (465.9%) stddev-sans-first:108698.79 11:18:52 INFO - PID 1653 | Values: 391.3 406.8 427.4 440.0 456.2 17845.6 19129.7 20047.5 22175.2 22204.9 22031.8 22654.4 23094.5 23237.0 23310.2 5526.2 6016.2 6402.1 6404.1 6411.5 5469.6 6017.8 6169.8 6292.9 6340.9 5388.8 6221.1 6240.6 6289.5 6293.5 5604.4 6047.4 6111.6 6250.0 6286.5 5058.2 5067.3 5411.4 5520.8 5528.7 23024.9 26289.9 27669.7 27787.7 28067.9 1941.1 1979.0 1989.1 2010.8 2015.5 16908.8 17020.2 17268.3 17429.7 17916.3 1825.6 1917.0 1926.7 1963.9 1973.7 152376.0 159209.2 159351.0 160394.0 161311.0 10497.8 12627.2 12738.8 12893.6 13002.0 13257.7 16658.8 16666.5 16686.8 16724.9 9007.2 9223.3 9240.2 9340.7 9392.3 8861.0 8879.2 8891.0 8901.3 9059.3 7095.9 7992.9 8158.1 8164.6 8245.1 1843.8 2190.8 2197.9 2204.8 2380.0 794.6 926.6 930.7 933.5 971.4 17764.7 18103.3 18403.6 19839.6 20766.0 852.0 959.8 971.3 995.3 995.9 9022.5 9487.0 9825.1 10401.3 10868.8 554702.0 589011.0 643754.6 683147.0 719476.0 143217.3 149087.0 159395.0 159924.0 160522.0 1172.8 1178.0 1190.2 1195.9 1196.0 15906.5 17980.3 18370.7 18461.4 18495.9 51776.0 59950.5 61262.7 62710.4 64765.1 89114.0 89819.6 90202.5 90544.5 90848.1 7718.1 8042.6 8222.8 8951.6 8990.8 14050.9 14196.6 14388.5 14588.9 14677.3 11751.2 11766.6 11929.0 11964.1 11964.2 11196.4 11246.0 11338.9 11393.8 11424.3 11753.4 11996.6 12091.2 12207.9 12383.5 8863.9 8869.5 8948.1 8964.7 9044.4 10039.8 11663.0 11837.9 12038.6 12110.9 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | [#3] mootools.html Cycles:180 Average:6663.68 Median:3730.81 stddev:4154.52 (111.4%) stddev-sans-first:4144.99 11:18:52 INFO - PID 1653 | Values: 1080.5 1192.2 1216.2 1233.2 1233.9 9579.1 9840.4 10666.9 10999.2 11120.8 10615.9 10939.7 11035.2 11037.8 11055.8 2439.3 2468.9 2477.7 2480.2 2484.1 2392.6 2407.0 2449.8 2457.2 2502.9 2483.6 2493.5 2509.8 2513.7 2515.7 2397.3 2435.8 2447.3 2449.5 2449.7 2223.8 2225.3 2229.1 2238.9 2249.8 10921.6 11076.3 11159.5 11162.4 11201.6 5489.5 6240.6 6370.5 6467.3 6479.3 3753.6 4015.2 4064.6 4098.9 4107.5 1123.8 1156.4 1160.6 1194.7 1208.7 12118.2 14470.0 15360.4 15394.3 15477.2 4452.0 4530.8 5391.8 5438.0 5478.5 9550.5 11539.8 11548.9 11589.0 11602.2 6158.8 6183.3 6262.4 6273.2 6297.3 5611.6 5824.2 5911.7 5975.9 5992.4 4176.9 4231.0 4252.2 4285.7 4343.1 1101.2 1142.9 1145.1 1270.8 1280.9 766.3 768.0 791.7 792.1 804.3 4883.0 5909.5 5914.9 6083.8 6114.3 883.2 884.6 885.8 921.4 937.1 3684.0 3708.0 3755.4 3787.7 3814.6 13320.6 13706.1 13781.7 13837.2 13897.0 13733.9 13752.8 13767.4 13770.7 13775.0 7629.6 9885.0 9966.2 10210.9 10213.3 6333.9 6358.4 6376.3 6397.1 6398.3 12366.2 12403.0 12494.0 12582.9 12602.3 11421.9 12628.9 12792.3 12818.6 12834.2 8186.9 8279.4 8298.3 8306.0 8953.6 10341.5 10399.6 10399.7 10460.3 10474.9 6793.0 8542.6 8748.0 8752.2 8794.4 8539.1 8574.1 8607.4 8618.7 8630.4 7665.0 7672.6 7709.8 7779.3 7791.5 5544.2 5857.3 5958.2 6043.7 6136.6 4731.7 4930.0 5131.7 6093.1 6188.4 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | [#4] prototype.html Cycles:180 Average:5365.14 Median:6033.70 stddev:1663.61 (27.6%) stddev-sans-first:1625.06 11:18:52 INFO - PID 1653 | Values: 345.5 360.6 392.5 400.6 411.1 5383.8 5703.4 5842.3 6230.3 6316.0 5022.6 6034.7 6194.8 6196.0 6242.9 3613.7 4537.7 4538.7 4560.6 4580.9 4008.8 4354.1 4501.5 4564.8 4579.7 4512.5 4523.6 4548.1 4550.7 4554.7 4254.6 4441.9 4500.9 4555.4 4577.2 3876.4 3878.5 3884.6 3886.2 3889.8 6072.8 6093.8 6094.1 6095.6 6114.2 4227.0 5279.6 5394.6 5419.9 5448.9 5468.3 6582.4 6610.3 6615.6 6620.7 4407.9 4410.3 4416.5 4433.7 4466.4 6014.5 6734.4 6744.2 7053.5 7055.6 4371.4 4852.3 4862.8 4867.7 4877.7 4499.0 4818.3 4940.2 4952.3 4969.5 5367.8 5506.6 5556.1 5575.9 5585.5 5926.7 6181.3 6422.0 6475.5 6588.8 1448.1 1495.6 1521.3 1699.9 1702.6 989.8 1123.9 1175.3 1179.9 1197.5 5415.9 5850.9 6371.6 6377.7 6448.0 6032.7 6261.9 6900.6 6902.0 6930.9 6253.0 6296.9 6306.4 6315.0 6334.5 3165.2 3528.7 3588.5 3589.2 3593.5 6051.6 6208.1 6350.3 6771.5 7097.7 5743.5 6994.2 7031.9 7035.2 7078.8 5900.0 7101.3 7112.5 7160.9 7190.0 6808.3 6823.1 6843.7 6867.1 6877.8 5465.4 6398.4 6735.0 6765.7 6788.5 6445.6 6700.7 7123.3 7141.3 7144.2 4463.6 4465.2 4496.4 4500.0 4519.4 6316.9 6827.9 6900.2 6913.3 6947.3 5920.3 6311.4 6658.2 6724.4 6736.2 6517.7 6606.4 6680.6 6691.8 6692.1 5694.1 6554.9 6558.7 6561.2 6565.7 6533.2 6674.4 6716.9 6717.4 6722.2 4988.7 5926.8 6432.4 6495.5 6515.5 11:18:52 INFO - PID 1653 | 11:18:52 INFO - PID 1653 | [#5] yui.html Cycles:180 Average:20553.86 Median:14083.16 stddev:30859.38 (219.1%) stddev-sans-first:30909.73 11:18:52 INFO - PID 1653 | Values: 640.6 721.0 732.5 741.0 760.5 12692.5 12729.9 16523.3 16538.1 16549.2 15358.3 15408.5 15536.6 15550.8 15560.8 975.8 988.0 1007.1 1011.8 1017.7 1021.9 1030.0 1036.6 1039.2 1041.6 1045.5 1063.0 1070.9 1071.8 1075.7 1022.6 1050.7 1063.8 1076.3 1078.4 783.8 795.2 795.8 796.3 797.2 16760.4 16977.2 17023.9 17393.0 17601.9 15023.3 15139.5 15139.9 15280.8 16018.7 10374.6 11555.5 11769.4 11828.6 11843.9 2992.4 3010.6 3072.5 3104.0 3139.5 110098.0 110974.4 111892.0 114642.0 115194.0 10267.4 10659.1 10660.6 11489.6 11589.8 24530.1 24862.9 25136.5 25161.5 25173.9 7885.8 7918.6 8056.7 8058.9 8073.4 4195.2 4212.8 4215.8 4220.6 4240.9 4093.6 4196.1 4198.6 4200.7 4206.5 814.1 859.6 897.5 903.7 906.7 523.7 546.6 555.7 567.8 596.1 9644.5 10281.9 10611.8 10691.9 10794.5 532.7 537.5 550.3 579.6 616.1 4218.7 4729.2 4737.6 4849.1 5015.7 109735.0 109931.7 112307.0 113777.4 115463.0 76854.0 94996.0 95371.0 98588.0 99284.0 86058.1 86898.7 87036.0 87565.0 89394.1 9820.7 9833.1 9836.0 9863.4 9895.9 33181.7 40553.0 41412.8 42020.4 42221.0 53781.0 53999.7 54546.0 54596.5 54742.0 9982.4 11823.7 12079.2 12357.0 12562.5 10768.5 13177.9 13190.6 13289.4 13410.7 12294.3 12296.4 12380.6 12414.3 12874.9 10841.9 12196.1 12413.9 12509.1 12692.4 11448.7 11783.2 11943.1 12337.3 12646.1 8024.3 8208.4 8388.7 8513.4 8771.4 7975.5 8216.1 8345.3 9118.2 9137.8 11:18:52 INFO - PID 1653 | -------- Summary: end -------- 11:18:52 INFO - PID 1653 | 11:18:52 INFO - TEST-INFO | 1653: exit 0 11:18:52 INFO - TEST-OK | dromaeo_css | took 1117593ms 11:18:52 INFO - TEST-START | kraken 11:18:52 INFO - operating with platform_type : mac_ 11:18:52 INFO - Initialising browser for kraken test... 11:18:52 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpapXvae/profile http://localhost:49244/getInfo.html) 11:18:55 INFO - PID 1659 | 2017-04-02 11:18:55.482 plugin-container[1660:11425] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454f, name = 'com.apple.tsm.portname' 11:18:55 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:18:55 INFO - PID 1659 | 2017-04-02 11:18:55.486 plugin-container[1660:11425] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470b, name = 'com.apple.CFPasteboardClient' 11:18:55 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:18:55 INFO - PID 1659 | 2017-04-02 11:18:55.486 plugin-container[1660:11425] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:18:55 INFO - PID 1659 | __metrics Screen width/height:1600/1200 11:18:55 INFO - PID 1659 | colorDepth:24 11:18:55 INFO - PID 1659 | Browser inner width/height: 1024/689 11:18:55 INFO - PID 1659 | __metrics 11:18:55 ERROR - PID 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 11:18:56 INFO - TEST-INFO | 1659: exit 0 11:18:56 INFO - Browser initialized. 11:18:56 INFO - Running cycle 1/1 for kraken test... 11:18:56 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpapXvae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:59 INFO - PID 1661 | 2017-04-02 11:18:59.114 plugin-container[1662:11548] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 11:18:59 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:18:59 INFO - PID 1661 | 2017-04-02 11:18:59.117 plugin-container[1662:11548] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 11:18:59 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:18:59 INFO - PID 1661 | 2017-04-02 11:18:59.117 plugin-container[1662:11548] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:19:08 INFO - PID 1661 | RSS: Main: 228667392 11:19:08 INFO - PID 1661 | 11:19:11 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:12 INFO - PID 1661 | RSS: Main: 243367936 11:19:12 INFO - PID 1661 | 11:19:15 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 11:19:15 INFO - PID 1661 | RSS: Main: 251969536 11:19:15 INFO - PID 1661 | 11:19:19 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 11:19:20 INFO - PID 1661 | RSS: Main: 254148608 11:19:20 INFO - PID 1661 | 11:19:22 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 11:19:22 INFO - PID 1661 | RSS: Main: 256466944 11:19:22 INFO - PID 1661 | 11:19:24 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:25 INFO - PID 1661 | RSS: Main: 256720896 11:19:25 INFO - PID 1661 | 11:19:28 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:29 INFO - PID 1661 | RSS: Main: 262754304 11:19:29 INFO - PID 1661 | 11:19:32 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:33 INFO - PID 1661 | RSS: Main: 260210688 11:19:33 INFO - PID 1661 | 11:19:37 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 11:19:37 INFO - PID 1661 | RSS: Main: 261332992 11:19:37 INFO - PID 1661 | 11:19:39 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:19:39 INFO - PID 1661 | RSS: Main: 261476352 11:19:39 INFO - PID 1661 | 11:19:41 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:42 INFO - PID 1661 | RSS: Main: 261455872 11:19:42 INFO - PID 1661 | 11:19:44 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:45 INFO - PID 1661 | RSS: Main: 261525504 11:19:45 INFO - PID 1661 | 11:19:48 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:49 INFO - PID 1661 | RSS: Main: 262111232 11:19:49 INFO - PID 1661 | 11:19:52 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:53 INFO - PID 1661 | RSS: Main: 261627904 11:19:53 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 11:19:55 INFO - PID 1661 | RSS: Main: 264830976 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | __start_tp_report 11:19:55 INFO - PID 1661 | _x_x_mozilla_page_load 11:19:55 INFO - PID 1661 | _x_x_mozilla_page_load_details 11:19:55 INFO - PID 1661 | |i|pagename|runs| 11:19:55 INFO - PID 1661 | |0;ai-astar;108;121;120;124;122;129;123;121;123;123 11:19:55 INFO - PID 1661 | |1;audio-beat-detection;147;116;117;156;115;117;114;126;170;152 11:19:55 INFO - PID 1661 | |2;audio-dft;211;223;218;232;221;262;229;293;215;205 11:19:55 INFO - PID 1661 | |3;audio-fft;86;57;61;88;59;61;58;83;105;89 11:19:55 INFO - PID 1661 | |4;audio-oscillator;89;74;87;76;72;74;98;105;88;85 11:19:55 INFO - PID 1661 | |5;imaging-gaussian-blur;103;92;90;91;140;93;140;115;140;129 11:19:55 INFO - PID 1661 | |6;imaging-darkroom;102;101;130;140;163;159;156;161;103;121 11:19:55 INFO - PID 1661 | |7;imaging-desaturate;112;150;100;102;103;99;127;153;159;103 11:19:55 INFO - PID 1661 | |8;json-parse-financial;45;71;83;81;80;53;51;53;52;53 11:19:55 INFO - PID 1661 | |9;json-stringify-tinderbox;59;66;62;108;66;57;50;55;73;89 11:19:55 INFO - PID 1661 | |10;stanford-crypto-aes;92;89;89;102;83;114;110;112;86;88 11:19:55 INFO - PID 1661 | |11;stanford-crypto-ccm;147;155;168;148;157;198;153;147;194;163 11:19:55 INFO - PID 1661 | |12;stanford-crypto-pbkdf2;197;193;194;194;197;194;195;190;196;213 11:19:55 INFO - PID 1661 | |13;stanford-crypto-sha256-iterative;71;97;104;104;98;85;71;70;70;70 11:19:55 INFO - PID 1661 | __end_tp_report 11:19:55 INFO - PID 1661 | __start_cc_report 11:19:55 INFO - PID 1661 | _x_x_mozilla_cycle_collect,1013 11:19:55 INFO - PID 1661 | __end_cc_report 11:19:55 INFO - PID 1661 | __startTimestamp1491157195350__endTimestamp 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | ------- Summary: start ------- 11:19:55 INFO - PID 1661 | Number of tests: 14 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#0] ai-astar Cycles:10 Average:121.40 Median:123.00 stddev:5.32 (4.3%) stddev-sans-first:2.62 11:19:55 INFO - PID 1661 | Values: 108.0 121.0 120.0 124.0 122.0 129.0 123.0 121.0 123.0 123.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#1] audio-beat-detection Cycles:10 Average:133.00 Median:136.50 stddev:21.06 (15.4%) stddev-sans-first:21.71 11:19:55 INFO - PID 1661 | Values: 147.0 116.0 117.0 156.0 115.0 117.0 114.0 126.0 170.0 152.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#2] audio-dft Cycles:10 Average:230.90 Median:226.00 stddev:26.82 (11.9%) stddev-sans-first:27.47 11:19:55 INFO - PID 1661 | Values: 211.0 223.0 218.0 232.0 221.0 262.0 229.0 293.0 215.0 205.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#3] audio-fft Cycles:10 Average:74.70 Median:72.00 stddev:17.35 (24.1%) stddev-sans-first:17.92 11:19:55 INFO - PID 1661 | Values: 86.0 57.0 61.0 88.0 59.0 61.0 58.0 83.0 105.0 89.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#4] audio-oscillator Cycles:10 Average:84.80 Median:86.00 stddev:11.00 (12.8%) stddev-sans-first:11.57 11:19:55 INFO - PID 1661 | Values: 89.0 74.0 87.0 76.0 72.0 74.0 98.0 105.0 88.0 85.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:115.00 stddev:22.11 (19.2%) stddev-sans-first:23.14 11:19:55 INFO - PID 1661 | Values: 103.0 92.0 90.0 91.0 140.0 93.0 140.0 115.0 140.0 129.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#6] imaging-darkroom Cycles:10 Average:133.60 Median:148.00 stddev:25.76 (17.4%) stddev-sans-first:24.65 11:19:55 INFO - PID 1661 | Values: 102.0 101.0 130.0 140.0 163.0 159.0 156.0 161.0 103.0 121.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#7] imaging-desaturate Cycles:10 Average:120.80 Median:138.50 stddev:24.40 (17.6%) stddev-sans-first:25.67 11:19:55 INFO - PID 1661 | Values: 112.0 150.0 100.0 102.0 103.0 99.0 127.0 153.0 159.0 103.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:14.76 (23.8%) stddev-sans-first:14.28 11:19:55 INFO - PID 1661 | Values: 45.0 71.0 83.0 81.0 80.0 53.0 51.0 53.0 52.0 53.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:64.00 stddev:17.65 (27.6%) stddev-sans-first:18.38 11:19:55 INFO - PID 1661 | Values: 59.0 66.0 62.0 108.0 66.0 57.0 50.0 55.0 73.0 89.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#10] stanford-crypto-aes Cycles:10 Average:96.50 Median:87.00 stddev:11.82 (13.6%) stddev-sans-first:12.42 11:19:55 INFO - PID 1661 | Values: 92.0 89.0 89.0 102.0 83.0 114.0 110.0 112.0 86.0 88.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:163.00 Median:160.00 stddev:18.70 (11.7%) stddev-sans-first:18.92 11:19:55 INFO - PID 1661 | Values: 147.0 155.0 168.0 148.0 157.0 198.0 153.0 147.0 194.0 163.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:195.50 stddev:6.22 (3.2%) stddev-sans-first:6.59 11:19:55 INFO - PID 1661 | Values: 197.0 193.0 194.0 194.0 197.0 194.0 195.0 190.0 196.0 213.0 11:19:55 INFO - PID 1661 | 11:19:55 INFO - PID 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.00 Median:71.00 stddev:15.25 (21.5%) stddev-sans-first:15.43 11:19:55 INFO - PID 1661 | Values: 71.0 97.0 104.0 104.0 98.0 85.0 71.0 70.0 70.0 70.0 11:19:55 INFO - PID 1661 | -------- Summary: end -------- 11:19:55 INFO - PID 1661 | 11:19:56 INFO - TEST-INFO | 1661: exit 0 11:19:56 INFO - TEST-OK | kraken | took 63575ms 11:19:56 INFO - SUITE-END | took 1181s 11:19:56 INFO - Completed test suite (00:19:41) 11:19:56 INFO - javascript benchmark 11:19:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7696.3032022859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3598.046517672817, 3601.747877648565, 3627.927441451173, 3643.672069513744, 3644.653757893001, 6117.357677443871, 6224.968875155623, 6240.09518619801, 6245.968770156149, 6247.156633854423, 6181.134641150243, 6183.598066125699, 6206.7827626033095, 6252.843678908018, 6287.937120628792, 4883.682560633548, 5326.934613077381, 5459.0, 5521.337439507255, 5635.6618602883955, 5469.671819690811, 5530.115181570949, 5596.272484576999, 5598.0, 5622.522085622727, 4513.210188217082, 4634.9073018539775, 4638.350630911641, 5548.611597188198, 5579.414161513023, 4601.470830854428, 5078.7460626968505, 5531.170324451325, 5546.639468434539, 5605.5515558755205, 4542.477615074243, 5471.753771080271, 5500.367457742371, 5513.393526712059, 5522.061249587579, 4652.9996050848895, 5588.469095435927, 5898.085796701518, 6213.130161777355, 6323.683815809191, 5758.62568933018, 6547.148870646833, 6713.295104014057, 6808.489363297723, 6817.352351526597, 6835.213950395719, 6860.5197636165485, 6863.622500762456, 6874.690638921261, 6885.0, 6322.114903913456, 6347.460465860454, 6355.809325720235, 6360.77737279193, 6384.872302554016, 6663.633500157441, 6870.965645171742, 6902.551334163263, 6957.965210174018, 7025.437964962791, 5835.94164058354, 6140.416660417253, 6389.488840892717, 6468.708908099147, 6641.136652235178, 6231.937680623227, 6502.674866256668, 6748.055272261888, 6764.0, 6884.729753367211, 6707.262201157869, 6714.227863795629, 6716.597004179765, 6727.024581435762, 6736.191657001191, 6475.514336424787, 6573.80278591643, 6732.2931092235585, 6752.966235168793, 6771.593704377753, 5312.787488500494, 5418.106012507892, 5418.783248670088, 5449.727513624303, 5487.42382049887, 4787.0904528139545, 4811.4707382187935, 4817.9518204818205, 4821.614270858323, 4856.587190088811, 6377.7448902044325, 6408.551401401857, 6410.423061924449, 6453.386928241809, 6460.095586617877, 6612.735490580323, 6692.364225398676, 6732.225794033651, 6755.18937727466, 6831.965840170867, 6405.391487808651, 6413.7113829876835, 6421.486281097595, 6432.935670643234, 6435.549511534241, 6053.122297266872, 6087.147799308101, 6087.8478038048515, 6100.48145907594, 6104.694765261719, 6756.155480564929, 6884.380405763505, 6944.236134025355, 6970.860582788418, 7017.754378596826, 6773.864522709617, 6836.111305530449, 6859.314068593101, 6874.896876546956, 6886.655667216719, 7026.754063607749, 7027.0, 7037.964810175917, 7083.574985500681, 7087.255838136922, 6511.316311787384, 6583.210014798255, 6644.933550664625, 6777.695003724745, 6780.254172040973, 6685.732570697312, 6765.898511522233, 6775.390214880685, 6796.592204467748, 6845.349691779273, 6284.5600807943, 6549.934500655123, 6551.181102362205, 6612.23959244693, 6618.073469714148, 6447.742090316335, 6527.3472652734345, 6544.0, 6591.176102987127, 6637.867242655023, 6323.841903952438, 6491.707873145814, 6495.188101487314, 6498.577592456475, 6513.381228783258, 6635.734570617315, 6636.933630663824, 6653.600783952978, 6664.900026499509, 6670.066190733398, 6224.502039836711, 6250.0937364082865, 6381.329960354282, 6450.774222902176, 6483.935160648333], "value": 6126.34283673865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.9869402611948, 691.7094820175525, 838.4591938199861, 1172.5368479450622, 1278.5077745068152, 28874.422511549757, 39726.404103938425, 39863.20273594526, 39977.20045599086, 40009.79995100024, 39446.80276598613, 39875.40186897199, 39896.80051599745, 39924.80037599808, 40041.99895002627, 7419.258074192591, 8057.435979481454, 8232.34141268697, 8619.956900215522, 8844.469331840079, 8721.694740684077, 8801.603927823231, 8819.029906710257, 8821.470711757283, 8847.601857916408, 8765.824683506326, 8791.076936921627, 8824.985126710415, 8837.73486795394, 8839.116088391174, 8734.0, 8755.605997730117, 8781.034086250507, 8822.47065176085, 8822.602982865787, 8691.348148888796, 8693.913060869374, 8727.38908276421, 8731.60707768152, 8740.8688869667, 38457.423138652666, 38692.61307386946, 38764.41853372202, 38769.0, 39120.21759564821, 2829.349249672566, 2962.1113665900143, 3054.57235986962, 3075.7078077582596, 3078.0919628709585, 27173.0, 27394.726052739417, 27472.0, 27558.86220568884, 28514.429711405865, 2807.6490438695164, 2808.4242730240253, 2817.3660926291627, 2818.8449635270053, 2842.9715702842914, 280364.0, 280533.0, 281776.5911170431, 283822.0, 284009.6396144152, 47017.529824702, 47061.764691177006, 47087.529124709, 47125.528744712115, 47190.0, 49421.50578494241, 49831.750841246285, 49903.75048124809, 49928.50071499311, 50053.74973125111, 14299.64250893736, 14651.780223296659, 14675.706485870436, 14695.191764452844, 14736.778948315783, 11793.941030294794, 11872.0, 11894.107941904218, 11894.88105118955, 11921.284722916653, 13267.402966866513, 13704.10923289983, 13734.862651373558, 13749.0, 13832.23922684242, 5035.395752509722, 5929.851753706192, 5953.672548009901, 5964.254468191476, 5970.104484327298, 955.7323949294208, 964.9517524123906, 973.1971123822874, 993.5330394714473, 1002.664107523973, 23763.81180940946, 24056.639150412757, 24278.393040173785, 28470.85764571164, 30869.073927782203, 1036.8185567525804, 1039.6932904793105, 1041.4792603698152, 1067.8451624514403, 1077.2889892670955, 11798.705032374259, 12108.576199832964, 12222.449989750483, 12278.201916875374, 12346.691332716575, 470469.942950856, 488793.0, 494333.0, 497365.0, 503525.0, 40430.0, 41191.0, 53707.731461342446, 53978.73010634922, 54128.72935635297, 1438.4102517967583, 1444.83384410792, 1448.0949406620862, 1458.9927050364681, 1466.7213229486363, 28393.290167745145, 28491.0, 28683.569746453402, 29363.85318073396, 29897.0, 37845.810770945965, 37985.2402951945, 38032.23935521329, 38067.04832379213, 38208.41499020024, 358740.0, 371389.42915855744, 442665.0, 442859.0, 446478.0, 26433.0, 32301.0, 32390.35219295648, 32412.865549705646, 32425.460435539517, 41081.79459102685, 41133.382999255635, 42107.0, 42587.0, 42656.5734342665, 28394.308739863685, 29044.56433153547, 29503.704962950094, 29551.55672664955, 30043.69956300409, 25518.48963020692, 26614.0, 28937.855310724153, 29969.250768730955, 30112.84943575268, 27249.727502725513, 35131.824340878135, 35156.472652910736, 35888.74389396358, 37363.62636373602, 30446.128868392447, 30591.136447590285, 30599.694003060577, 31066.689333107282, 31278.843605781825, 24649.0, 24650.753492464846, 24703.38241543976, 24922.50154996926, 25151.24546263615], "value": 17684.764313349413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.26051762169493, 406.78440426573906, 427.4400535298761, 439.96700247481436, 456.15838777455605, 17845.55386115348, 19129.71305430418, 20047.498812529677, 22175.223867164652, 22204.88897555514, 22031.779682203174, 22654.43363915903, 23094.538109237805, 23237.0, 23310.18414355498, 5526.171074338851, 6016.187814645033, 6402.071699603554, 6404.103425520431, 6411.5191360647905, 5469.617126801106, 6017.789377371793, 6169.753209871622, 6292.8741425171465, 6340.873182536347, 5388.757505912244, 6221.0979407985815, 6240.594361366497, 6289.528285378592, 6293.4650554702675, 5604.439556044404, 6047.425494578008, 6111.572189946705, 6250.031245157008, 6286.528510361718, 5058.2412638104215, 5067.265246539231, 5411.404745477994, 5520.751566179531, 5528.668279903219, 23024.88487557568, 26289.868550657124, 27669.723302766917, 27787.722122778716, 28067.859660701564, 1941.1361943934955, 1978.980210197894, 1989.1049027937486, 2010.7888671689554, 2015.5364266218705, 16908.830911690973, 17020.234089466005, 17268.30926762928, 17429.738553921576, 17916.28334866604, 1825.6257467219189, 1917.0, 1926.7206255093074, 1963.9410817675493, 1973.6842105263233, 152376.0, 159209.20395398064, 159351.0, 160394.0, 161311.0, 10497.842532362021, 12627.179233349803, 12738.770715124816, 12893.61319160408, 13002.024848136427, 13257.734845303039, 16658.833411665728, 16666.50000499987, 16686.83313166877, 16724.91288066296, 9007.234385077341, 9223.308251881002, 9240.214581760625, 9340.673076442428, 9392.29557783169, 8861.025287218401, 8879.24526415249, 8890.97753758313, 8901.287896968357, 9059.275257979345, 7095.858082838315, 7992.920070799218, 8158.143394943564, 8164.591770411455, 8245.13426090264, 1843.8432733217826, 2190.8466407351334, 2197.890105494751, 2204.7574766775642, 2379.976610057657, 794.6424109150905, 926.578406824893, 930.734740598926, 933.4912472702393, 971.3734641156556, 17764.733528997076, 18103.275868965356, 18403.631927361377, 19839.60320793576, 20765.961701915145, 851.9914800852036, 959.7648576098901, 971.3491960386558, 995.2535598301274, 995.9253056020827, 9022.548872556477, 9487.0, 9825.066618671215, 10401.323913945569, 10868.782624347627, 554702.0, 589011.0, 643754.5624543695, 683147.0, 719476.0, 143217.28391357977, 149087.0, 159395.0, 159924.0, 160522.0, 1172.809598257769, 1178.0491467378445, 1190.220405634311, 1195.862475815275, 1195.976080478403, 15906.52280431589, 17980.2807887683, 18370.72443913369, 18461.446156615322, 18495.90752046231, 51776.0, 59950.50123746941, 61262.69368653128, 62710.37289627228, 64765.14261430317, 89114.0, 89819.55090224507, 90202.54898725727, 90544.54727726319, 90848.0915190866, 7718.112417071884, 8042.557659328793, 8222.766585012057, 8951.597178126869, 8990.775230619287, 14050.859491405365, 14196.645083872985, 14388.496402625859, 14588.854111459174, 14677.339519721425, 11751.236169648946, 11766.58816941403, 11928.986036187021, 11964.102692297938, 11964.162508624313, 11196.440177991231, 11246.0, 11338.943305283421, 11393.772124557629, 11424.257423267461, 11753.353565553634, 11996.64010079699, 12091.153619246568, 12207.877921220674, 12383.504659813507, 8863.911360886566, 8869.512176830336, 8948.060453652533, 8964.731058068268, 9044.41211321262, 10039.849402259119, 11662.950334469939, 11837.940810295893, 12038.638840834788, 12110.910018098413], "value": 10407.1666729069, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1080.5412692864631, 1192.242925742154, 1216.2033867816583, 1233.1737735717072, 1233.8710080276549, 9579.137877591016, 9840.360376575518, 10666.946665266672, 10999.23005389622, 11120.833187502194, 10615.893841061586, 10939.726506837313, 11035.227534072617, 11037.83443248352, 11055.834162487568, 2439.3413778279855, 2468.8518688878726, 2477.7274499805008, 2480.1567467061195, 2484.1305543059875, 2392.605220138675, 2406.9759302407015, 2449.8162637802147, 2457.2382561405934, 2502.8998840046374, 2483.639872218527, 2493.5262300163004, 2509.836860604064, 2513.6857892763405, 2515.7295565739278, 2397.3407312988893, 2435.7807797298237, 2447.278052974377, 2449.546833835746, 2449.7182823975295, 2223.788740069691, 2225.310153852311, 2229.141780414536, 2238.932832015042, 2249.80876625487, 10921.617743378943, 11076.280041797338, 11159.497822598003, 11162.441877906072, 11201.60794372193, 5489.451054894518, 6240.594361366497, 6370.458511026568, 6467.256265529477, 6479.319671434526, 3753.6434038766547, 4015.217032678629, 4064.593540645941, 4098.856540021115, 4107.527634322061, 1123.7920984617872, 1156.4333476596491, 1160.628598848369, 1194.677437091989, 1208.6917835951776, 12118.212316199508, 14470.0, 15360.385584576603, 15394.307256173388, 15477.226138693133, 4451.955480445219, 4530.79611417487, 5391.757370918318, 5437.9939711153565, 5478.45215478457, 9550.474723890253, 11539.76920461586, 11548.884511154949, 11589.0, 11602.18784685064, 6158.753649854045, 6183.288921774054, 6262.373762623702, 6273.247210334789, 6297.27581328144, 5611.579131565149, 5824.155497452845, 5911.733971971272, 5975.910361344583, 5992.370801065826, 4176.853810116631, 4230.957690423118, 4252.234597772431, 4285.678574106954, 4343.087951530151, 1101.2016288190998, 1142.8514293141839, 1145.1010956399352, 1270.7776139175608, 1280.9231446113263, 766.2988365645483, 768.047620950018, 791.7347688524294, 792.0970094092739, 804.3002587748579, 4882.9755851221225, 5909.468147866627, 5914.8817023659285, 6083.8479038023515, 6114.327423983358, 883.1962913748587, 884.6284560484612, 885.8449771289999, 921.3596550397409, 937.1425145991478, 3683.9631603684156, 3707.9814600926825, 3755.4366844973474, 3787.6780473660046, 3814.6376094271, 13320.600381988555, 13706.109102908278, 13781.655458613615, 13837.169769813843, 13896.957728170226, 13733.931330343485, 13752.793708094387, 13767.38046787897, 13770.65573360654, 13775.035747497579, 7629.580373079423, 9885.011498850201, 9966.20270378368, 10210.948945255375, 10213.33613315132, 6333.904991425225, 6358.364163583605, 6376.298607153117, 6397.104405383343, 6398.264199617103, 12366.19619724715, 12403.0, 12494.0, 12582.87417125817, 12602.306873122066, 11421.885781142415, 12628.87371126277, 12792.296423696785, 12818.61544153677, 12834.229946203257, 8186.918130818615, 8279.379046571652, 8298.294644955246, 8305.958470207852, 8953.597088130919, 10341.482925853828, 10399.636012739518, 10399.688009359732, 10460.320079194827, 10474.895251047392, 6792.966035169792, 8542.615582298688, 8748.0, 8752.21230089295, 8794.42836215644, 8539.103394143774, 8574.056853745959, 8607.397482176439, 8618.655253789779, 8630.395872289131, 7664.965229694143, 7672.61636918163, 7709.80725481845, 7779.299863012356, 7791.454598178073, 5544.1960915667805, 5857.297124345106, 5958.225430694156, 6043.667598281961, 6136.6011209271255, 4731.716097034189, 4930.013997200503, 5131.717755523482, 6093.146959425595, 6188.3502232266765], "value": 5067.195817676823, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.48867675839773, 360.5727213252296, 392.5368065682495, 400.62941778854554, 411.1304590790478, 5383.838484845451, 5703.429657034295, 5842.328132264791, 6230.31466538681, 6316.010351822067, 5022.573081288095, 6034.69826508675, 6194.845128871781, 6195.969020154904, 6242.906356404646, 3613.692836108934, 4537.705049171794, 4538.659600529957, 4560.612347950429, 4580.931286030712, 4008.8196031178522, 4354.129174165164, 4501.504834468205, 4564.771761411933, 4579.656525760564, 4512.548745125494, 4523.570260825217, 4548.135854187693, 4550.749708766033, 4554.7039442436135, 4254.617084462413, 4441.933370999438, 4500.932486012713, 4555.407796986404, 4577.198990176722, 3876.379779235337, 3878.4957955465893, 3884.5532763731967, 3886.1644746379666, 3889.8055097245306, 6072.787452439187, 6093.847653808646, 6094.146819445281, 6095.634261944253, 6114.205153330083, 4226.964393723527, 5279.627296902833, 5394.568434525228, 5419.945800542023, 5448.891022179574, 5468.340267822784, 6582.407583317477, 6610.305917878602, 6615.636140012298, 6620.6827610335995, 4407.933880991788, 4410.29435290352, 4416.53626369233, 4433.733975961421, 4466.419365482467, 6014.48876845473, 6734.3602357775935, 6744.224414192382, 7053.470989675743, 7055.647217639097, 4371.388005679208, 4852.344933434012, 4862.82980095695, 4867.659263851568, 4877.707337559757, 4498.9652379952795, 4818.349522814446, 4940.2087820382085, 4952.281919121707, 4969.503049695001, 5367.812126575551, 5506.559475242051, 5556.111022236423, 5575.916361254584, 5585.525230355384, 5926.733297001645, 6181.320054793969, 6422.004589288667, 6475.514336424787, 6588.769393071219, 1448.1238850495508, 1495.6335697753902, 1521.3078049487456, 1699.8810083294052, 1702.6339337042596, 989.811935732223, 1123.904468120219, 1175.3359351966112, 1179.8525184351956, 1197.5269768441417, 5415.864603384868, 5850.882982340415, 6371.5593579467495, 6377.660691254889, 6448.000559913221, 6032.698365081728, 6261.874762504815, 6900.551464154914, 6902.0, 6930.896036559456, 6253.0, 6296.937030629727, 6306.369363063749, 6315.0, 6334.547671519033, 3165.208697825544, 3528.7063408784497, 3588.5334906462517, 3589.2283159120916, 3593.4969104325414, 6051.577879198385, 6208.099825525273, 6350.301466838644, 6771.45828333742, 7097.699569700114, 5743.483086522149, 6994.202319072412, 7031.859362812817, 7035.155781306174, 7078.787636370917, 5900.0, 7101.254368291358, 7112.537685050455, 7160.856782864314, 7190.0, 6808.251092379934, 6823.078884350549, 6843.692033858588, 6867.107276054281, 6877.828054298682, 5465.371482279589, 6398.360163983751, 6735.0, 6765.695543700644, 6788.456923446014, 6445.613263204035, 6700.6984685688285, 7123.323284288192, 7141.321574450419, 7144.1784194818265, 4463.575960283768, 4465.218586747371, 4496.437945256843, 4499.977500112478, 4519.435070616173, 6316.905246421215, 6827.863442731018, 6900.206476255295, 6913.308669133247, 6947.270536593584, 5920.348761636303, 6311.431971122621, 6658.167729033871, 6724.361185687352, 6736.191657000995, 6517.7067031984625, 6606.4384527315715, 6680.5991640501725, 6691.76578819739, 6692.063111164538, 5694.088945768657, 6554.934450655433, 6558.672066396565, 6561.212654481493, 6565.671716414065, 6533.248676402084, 6674.43267322283, 6716.899246511404, 6717.429018533479, 6722.210567326937, 4988.6757360771435, 5926.7925622603, 6432.388923052303, 6495.480361570969, 6515.511336649675], "value": 4848.113310286368, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.5964242527207, 720.9927900720991, 732.476279460186, 740.974065907693, 760.494271309579, 12692.492300307988, 12729.872701272985, 16523.256453459595, 16538.09040502772, 16549.172541372944, 15358.308876100602, 15408.537743867673, 15536.611584710388, 15550.76673849893, 15560.766588501181, 975.7658162041113, 987.9950600246989, 1007.123802292007, 1011.7672935224903, 1017.7455636090978, 1021.8978102189795, 1030.042060883378, 1036.6112707734599, 1039.1790485516433, 1041.5937784264106, 1045.5190612318343, 1063.0326402973296, 1070.9196810239225, 1071.7534966957605, 1075.7310672331917, 1022.616518805448, 1050.6847945616323, 1063.7819247054335, 1076.2950267574752, 1078.4338222433207, 783.7844592737043, 795.2405452792627, 795.8209402884363, 796.2594786848229, 797.2466019611469, 16760.41338553157, 16977.236024378934, 17023.91488042552, 17393.0, 17601.94388336704, 15023.323950422147, 15139.470118545798, 15139.924300378538, 15280.847191528053, 16018.679626407524, 10374.585016599327, 11555.480003399867, 11769.411529423494, 11828.585999490062, 11843.940780296129, 2992.446397416485, 3010.6236720409947, 3072.4776787946103, 3103.984480077585, 3139.5133754268127, 110098.0, 110974.44512777466, 111892.0, 114642.0, 115194.0, 10267.435291058913, 10659.09397701204, 10660.608178958344, 11489.613417307432, 11589.82615260755, 24530.14144504934, 24862.875685621457, 25136.497270054497, 25161.496770064496, 25173.87413062923, 7885.763427097081, 7918.574656561759, 8056.718014869569, 8058.919410805935, 8073.354131669453, 4195.160967806451, 4212.831486740496, 4215.810288537024, 4220.6412454941055, 4240.85157019509, 4093.6111069448357, 4196.139791342767, 4198.6011328923705, 4200.7479551227025, 4206.47419072616, 814.0922870998794, 859.5616235719828, 897.5243121145803, 903.661127077346, 906.7279816055157, 523.6910222968467, 546.551827501445, 555.7110302642603, 567.8381661226531, 596.1326270276737, 9644.517774111266, 10281.948590257001, 10611.84082238767, 10691.946540267249, 10794.514246858911, 532.6902835908655, 537.5108651127455, 550.309361751, 579.6377264209868, 616.1466369078857, 4218.6625069994325, 4729.196036673774, 4737.602407289858, 4849.127157111683, 5015.724135172528, 109735.0, 109931.70204893866, 112307.0, 113777.43111284556, 115463.0, 76854.0, 94996.0, 95371.0, 98588.0, 99284.0, 86058.13941860502, 86898.69651955226, 87036.0, 87565.0, 89394.10605893988, 9820.705378838646, 9833.115019648267, 9835.950820245853, 9863.408195508293, 9895.901040989498, 33181.66818331786, 40553.0, 41412.792936035126, 42020.369694454, 42221.0, 53781.0, 53999.6500087501, 54546.0, 54596.45403546072, 54742.0, 9982.35114717541, 11823.70440738954, 12079.214851034654, 12357.0, 12562.497500099893, 10768.456258754082, 13177.934110329386, 13190.60428187156, 13289.401976910869, 13410.745113257219, 12294.262344259372, 12296.446659900505, 12380.566680166512, 12414.255144691348, 12874.935625322189, 10841.891581084405, 12196.085293602839, 12413.93793031029, 12509.061820363691, 12692.36538173106, 11448.713782155179, 11783.234089784137, 11943.104267179822, 12337.321447320484, 12646.114771966242, 8024.317932975762, 8208.384371172067, 8388.66445342204, 8513.446625969293, 8771.429857059271, 7975.521468711896, 8216.137305582828, 8345.29065029455, 9118.22495087925, 9137.77155571116], "value": 7502.183947051486, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1682.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 121.0, 120.0, 124.0, 122.0, 129.0, 123.0, 121.0, 123.0, 123.0], "value": 121.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 116.0, 117.0, 156.0, 115.0, 117.0, 114.0, 126.0, 170.0, 152.0], "value": 133.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [211.0, 223.0, 218.0, 232.0, 221.0, 262.0, 229.0, 293.0, 215.0, 205.0], "value": 230.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 57.0, 61.0, 88.0, 59.0, 61.0, 58.0, 83.0, 105.0, 89.0], "value": 74.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 74.0, 87.0, 76.0, 72.0, 74.0, 98.0, 105.0, 88.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 92.0, 90.0, 91.0, 140.0, 93.0, 140.0, 115.0, 140.0, 129.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 130.0, 140.0, 163.0, 159.0, 156.0, 161.0, 103.0, 121.0], "value": 133.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 150.0, 100.0, 102.0, 103.0, 99.0, 127.0, 153.0, 159.0, 103.0], "value": 120.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 71.0, 83.0, 81.0, 80.0, 53.0, 51.0, 53.0, 52.0, 53.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 66.0, 62.0, 108.0, 66.0, 57.0, 50.0, 55.0, 73.0, 89.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 89.0, 89.0, 102.0, 83.0, 114.0, 110.0, 112.0, 86.0, 88.0], "value": 96.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 155.0, 168.0, 148.0, 157.0, 198.0, 153.0, 147.0, 194.0, 163.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 193.0, 194.0, 194.0, 197.0, 194.0, 195.0, 190.0, 196.0, 213.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 97.0, 104.0, 104.0, 98.0, 85.0, 71.0, 70.0, 70.0, 70.0], "value": 84.0, "unit": "score"}]}]} 11:19:56 INFO - Return code: 0 11:19:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:56 ERROR - # TBPL SUCCESS # 11:19:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:19:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:19:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:19:56 INFO - 2017-04-02 11:19:56.693 screenresolution[1666:11963] starting screenresolution argv=screenresolution get 11:19:56 INFO - 2017-04-02 11:19:56.697 screenresolution[1666:11963] Display 0: 1600x1200x32@60 11:19:56 INFO - 2017-04-02 11:19:56.703 screenresolution[1667:11966] starting screenresolution argv=screenresolution list 11:19:56 INFO - Available Modes on Display 0 11:19:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:19:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:19:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:19:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:19:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:19:56 INFO - Intel Iris: 11:19:56 INFO - Chipset Model: Intel Iris 11:19:56 INFO - Type: GPU 11:19:56 INFO - Bus: Built-In 11:19:56 INFO - VRAM (Dynamic, Max): 1536 MB 11:19:56 INFO - Vendor: Intel (0x8086) 11:19:56 INFO - Device ID: 0x0a2e 11:19:56 INFO - Revision ID: 0x0009 11:19:56 INFO - Displays: 11:19:56 INFO - Display: 11:19:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:19:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:19:56 INFO - Display Serial Number: 1600x1200 60 11:19:56 INFO - Main Display: Yes 11:19:56 INFO - Mirror: Off 11:19:56 INFO - Online: Yes 11:19:56 INFO - Rotation: Supported 11:19:56 INFO - Return code: 0 11:19:56 INFO - Running post-action listener: _resource_record_post_action 11:19:56 INFO - [mozharness: 2017-04-02 18:19:56.944028Z] Finished run-tests step (success) 11:19:56 INFO - Running post-run listener: _resource_record_post_run 11:19:57 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 34148864; Write bytes: 520735744; Read time: 216; Write time: 1675 11:19:57 INFO - TinderboxPrint: CPU usage
54.2% 11:19:57 INFO - TinderboxPrint: I/O read bytes / time
34,148,864 / 216 11:19:57 INFO - TinderboxPrint: I/O write bytes / time
520,735,744 / 1,675 11:19:57 INFO - TinderboxPrint: CPU idle
2,203.8 (45.8%) 11:19:57 INFO - TinderboxPrint: CPU system
969.0 (20.1%) 11:19:57 INFO - TinderboxPrint: CPU user
1,640.9 (34.1%) 11:19:57 INFO - TinderboxPrint: Swap in / out
255,774,720 / 0 11:19:57 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 213336576; Write bytes: 215168512; Read time: 16404; Write time: 493 11:19:57 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 29897216; Write bytes: 301275136; Read time: 178; Write time: 1158 11:19:57 INFO - Running post-run listener: _upload_blobber_files 11:19:57 INFO - Blob upload gear active. 11:19:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:57 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 11:19:57 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'] 11:19:57 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 11:19:57 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:19:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:19:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:58 INFO - (blobuploader) - INFO - Done attempting. 11:19:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:19:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:19:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:59 INFO - (blobuploader) - INFO - Done attempting. 11:19:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:19:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:20:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:00 INFO - (blobuploader) - INFO - Done attempting. 11:20:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:20:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:02 INFO - (blobuploader) - INFO - Done attempting. 11:20:02 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:02 INFO - Return code: 0 11:20:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d44c04d264405c973305d502901fd2fbf0e7a2b87b54aa5d537a1dc3c22a1bc05074c5df898d987549f48e7e99ede0fc095245332b01550b3d1d2dd9271fd8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89f09141e61d39bc9e94dfb1d45f635296eff47dc94dc70478409a65c06839b5eec2678970ae1424dc048c1b6da124025b38edfdc87f175faa1766d98b3c55fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decc3aed1518c55f7675936ca5c598fc01e6c56148477955c3a59170f4b028376ea9a2e899329e9102d23197205817dbb1e179a3cb43ef35682842ede5b9d79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0f313efc6e02faf492ed70c1eecdb2635b594d8b5fb63744c9e0a99a07065e76617b76d959099498136429ece48a0d725541dff4f6a0e278b18ae26c40e18b6"} 11:20:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:02 INFO - Contents: 11:20:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d44c04d264405c973305d502901fd2fbf0e7a2b87b54aa5d537a1dc3c22a1bc05074c5df898d987549f48e7e99ede0fc095245332b01550b3d1d2dd9271fd8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89f09141e61d39bc9e94dfb1d45f635296eff47dc94dc70478409a65c06839b5eec2678970ae1424dc048c1b6da124025b38edfdc87f175faa1766d98b3c55fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decc3aed1518c55f7675936ca5c598fc01e6c56148477955c3a59170f4b028376ea9a2e899329e9102d23197205817dbb1e179a3cb43ef35682842ede5b9d79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0f313efc6e02faf492ed70c1eecdb2635b594d8b5fb63744c9e0a99a07065e76617b76d959099498136429ece48a0d725541dff4f6a0e278b18ae26c40e18b6"} 11:20:02 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:02 INFO - Copying logs to upload dir... 11:20:02 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.526289 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-02 11:20:02.478398) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 11:20:02.481698) ========= 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.wbRVI5ahak/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.2b4uCl12U5/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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/8d44c04d264405c973305d502901fd2fbf0e7a2b87b54aa5d537a1dc3c22a1bc05074c5df898d987549f48e7e99ede0fc095245332b01550b3d1d2dd9271fd8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89f09141e61d39bc9e94dfb1d45f635296eff47dc94dc70478409a65c06839b5eec2678970ae1424dc048c1b6da124025b38edfdc87f175faa1766d98b3c55fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decc3aed1518c55f7675936ca5c598fc01e6c56148477955c3a59170f4b028376ea9a2e899329e9102d23197205817dbb1e179a3cb43ef35682842ede5b9d79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0f313efc6e02faf492ed70c1eecdb2635b594d8b5fb63744c9e0a99a07065e76617b76d959099498136429ece48a0d725541dff4f6a0e278b18ae26c40e18b6"} build_url:https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/HNXSL0jOQZ-MNLYWE3Nefg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d44c04d264405c973305d502901fd2fbf0e7a2b87b54aa5d537a1dc3c22a1bc05074c5df898d987549f48e7e99ede0fc095245332b01550b3d1d2dd9271fd8f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89f09141e61d39bc9e94dfb1d45f635296eff47dc94dc70478409a65c06839b5eec2678970ae1424dc048c1b6da124025b38edfdc87f175faa1766d98b3c55fd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decc3aed1518c55f7675936ca5c598fc01e6c56148477955c3a59170f4b028376ea9a2e899329e9102d23197205817dbb1e179a3cb43ef35682842ede5b9d79a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0f313efc6e02faf492ed70c1eecdb2635b594d8b5fb63744c9e0a99a07065e76617b76d959099498136429ece48a0d725541dff4f6a0e278b18ae26c40e18b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 11:20:02.517406) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 11:20:02.517749) ========= 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.wbRVI5ahak/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.2b4uCl12U5/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.005202 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 11:20:02.565967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 11:20:02.566304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 11:20:02.566607) ========= ========= Total master_lag: 0.19 =========