builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0332 starttime: 1487163981.41 results: success (0) buildid: 20170215030342 builduid: 859694a255a644058954b130160b0f21 revision: 0a7831d838f793a263456df62f95a615472a7f95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.413037) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.413636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.414008) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.441783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.442090) ========= 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.KALZc6bHSo/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.WhTm5csnhd/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-15 05:06:21-- 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% 171M=0s 2017-02-15 05:06:21 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084997 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.552193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.552501) ========= 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.KALZc6bHSo/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.WhTm5csnhd/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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.025825 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:21.600509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-15 05:06:21.600867) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a7831d838f793a263456df62f95a615472a7f95 --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 0a7831d838f793a263456df62f95a615472a7f95 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KALZc6bHSo/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.WhTm5csnhd/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-15 05:06:21,706 truncating revision to first 12 chars 2017-02-15 05:06:21,706 Setting DEBUG logging. 2017-02-15 05:06:21,706 attempt 1/10 2017-02-15 05:06:21,706 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a7831d838f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-15 05:06:23,429 unpacking tar archive at: mozilla-central-0a7831d838f7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.017258 ========= master_lag: 0.57 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-15 05:06:24.192752) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:24.193109) ========= script_repo_revision: 0a7831d838f793a263456df62f95a615472a7f95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:24.193526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:24.193805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-15 05:06:24.228194) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-02-15 05:06:24.228747) ========= /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.KALZc6bHSo/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.WhTm5csnhd/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:06:24 INFO - MultiFileLogger online at 20170215 05:06:24 in /builds/slave/test 05:06:24 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 05:06:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:24 INFO - {'append_to_log': False, 05:06:24 INFO - 'base_work_dir': '/builds/slave/test', 05:06:24 INFO - 'blob_upload_branch': 'Firefox', 05:06:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:24 INFO - 'branch': 'Firefox', 05:06:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:24 INFO - 'config_files': ('talos/mac_config.py',), 05:06:24 INFO - 'default_actions': ('clobber', 05:06:24 INFO - 'read-buildbot-config', 05:06:24 INFO - 'download-and-extract', 05:06:24 INFO - 'populate-webroot', 05:06:24 INFO - 'create-virtualenv', 05:06:24 INFO - 'install', 05:06:24 INFO - 'run-tests'), 05:06:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:24 INFO - 'download_minidump_stackwalk': True, 05:06:24 INFO - 'download_symbols': 'ondemand', 05:06:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:24 INFO - 'installer_path': 'installer.exe', 05:06:24 INFO - 'log_level': 'info', 05:06:24 INFO - 'log_name': 'talos', 05:06:24 INFO - 'log_to_console': True, 05:06:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:06:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:06:24 INFO - 'opt_config_files': (), 05:06:24 INFO - 'pip_index': False, 05:06:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:24 INFO - 'cmd': ('bash', 05:06:24 INFO - '-c', 05:06:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:24 INFO - 'enabled': True, 05:06:24 INFO - 'halt_on_failure': False, 05:06:24 INFO - 'name': 'check_screen_resolution'},), 05:06:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:24 INFO - 'cmd': ('bash', 05:06:24 INFO - '-c', 05:06:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:24 INFO - 'enabled': True, 05:06:24 INFO - 'halt_on_failure': False, 05:06:24 INFO - 'name': 'check_screen_resolution'},), 05:06:24 INFO - 'run_cmd_checks_enabled': True, 05:06:24 INFO - 'sps_profile': False, 05:06:24 INFO - 'sps_profile_interval': 0, 05:06:24 INFO - 'suite': 'dromaeojs-e10s', 05:06:24 INFO - 'system_bits': '32', 05:06:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:24 INFO - 'title': 't-yosemite-r7-0332', 05:06:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:24 INFO - 'use_talos_json': True, 05:06:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:24 INFO - 'work_dir': 'build'} 05:06:24 INFO - [mozharness: 2017-02-15 13:06:24.446316Z] Running clobber step. 05:06:24 INFO - Running pre-action listener: _resource_record_pre_action 05:06:24 INFO - Running main action method: clobber 05:06:24 INFO - rmtree: /builds/slave/test/build 05:06:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:28 INFO - Running post-action listener: _resource_record_post_action 05:06:28 INFO - [mozharness: 2017-02-15 13:06:28.966002Z] Finished clobber step (success) 05:06:28 INFO - [mozharness: 2017-02-15 13:06:28.966128Z] Running read-buildbot-config step. 05:06:28 INFO - Running pre-action listener: _resource_record_pre_action 05:06:28 INFO - Running main action method: read_buildbot_config 05:06:28 INFO - Using buildbot properties: 05:06:28 INFO - { 05:06:28 INFO - "project": "", 05:06:28 INFO - "product": "firefox", 05:06:28 INFO - "script_repo_revision": "production", 05:06:28 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:06:28 INFO - "repository": "", 05:06:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:06:28 INFO - "buildid": "20170215030342", 05:06:28 INFO - "stage_platform": "macosx64", 05:06:28 INFO - "basedir": "/builds/slave/test", 05:06:28 INFO - "nightly_build": "True", 05:06:28 INFO - "buildnumber": 90, 05:06:28 INFO - "slavename": "t-yosemite-r7-0332", 05:06:28 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:06:28 INFO - "platform": "yosemite_r7", 05:06:28 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:06:28 INFO - "branch": "mozilla-central", 05:06:28 INFO - "repo_path": "mozilla-central", 05:06:28 INFO - "revision": "0a7831d838f793a263456df62f95a615472a7f95", 05:06:28 INFO - "pgo_build": "False", 05:06:28 INFO - "builduid": "859694a255a644058954b130160b0f21", 05:06:28 INFO - "slavebuilddir": "test" 05:06:28 INFO - } 05:06:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 05:06:28 INFO - Running post-action listener: _resource_record_post_action 05:06:28 INFO - [mozharness: 2017-02-15 13:06:28.969535Z] Finished read-buildbot-config step (success) 05:06:28 INFO - [mozharness: 2017-02-15 13:06:28.969667Z] Running download-and-extract step. 05:06:28 INFO - Running pre-action listener: _resource_record_pre_action 05:06:28 INFO - Running main action method: download_and_extract 05:06:28 INFO - mkdir: /builds/slave/test/build/tests 05:06:28 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')]} 05:06:28 INFO - trying https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 05:06:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:06:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 05:06:30 INFO - Downloaded 1199 bytes. 05:06:30 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:06:30 INFO - Using the following test package requirements: 05:06:30 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:06:30 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 05:06:30 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 05:06:30 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'jsshell-mac.zip'], 05:06:30 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 05:06:30 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:06:30 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 05:06:30 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 05:06:30 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 05:06:30 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:06:30 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 05:06:30 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:06:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:06:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:06:30 INFO - Fetch https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:06:32 INFO - Expected file size: 51505713 05:06:32 INFO - Obtained file size: 51505713 05:06:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:06:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:06:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:06:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:06:49 INFO - Expected file size: 51505713 05:06:49 INFO - Obtained file size: 51505713 05:07:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 05:07:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:07:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 05:07:07 INFO - Expected file size: 14403647 05:07:07 INFO - Obtained file size: 14403647 05:07:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:07 INFO - trying https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:07:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 05:07:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 05:07:10 INFO - Downloaded 70649853 bytes. 05:07:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:07:10 INFO - mkdir: /builds/slave/test/properties 05:07:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:10 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:10 INFO - Contents: 05:07:10 INFO - build_url:https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:07:11 INFO - Running post-action listener: _resource_record_post_action 05:07:11 INFO - Running post-action listener: set_extra_try_arguments 05:07:11 INFO - [mozharness: 2017-02-15 13:07:11.027233Z] Finished download-and-extract step (success) 05:07:11 INFO - [mozharness: 2017-02-15 13:07:11.027390Z] Running populate-webroot step. 05:07:11 INFO - Running pre-action listener: _resource_record_pre_action 05:07:11 INFO - Running main action method: populate_webroot 05:07:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:11 INFO - '--tppagecycles', 05:07:11 INFO - '7'], 05:07:11 INFO - 'tests': ['tsvgm']}}, 05:07:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['damp', 'tps']}, 05:07:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'tests': ['damp', 'tps']}, 05:07:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['dromaeo_dom']}, 05:07:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['basic_compositor_video']}, 05:07:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:07:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['a11yr', 05:07:11 INFO - 'ts_paint', 05:07:11 INFO - 'tpaint', 05:07:11 INFO - 'sessionrestore', 05:07:11 INFO - 'sessionrestore_no_auto_restore', 05:07:11 INFO - 'tabpaint']}, 05:07:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:11 INFO - 'ts_paint', 05:07:11 INFO - 'tpaint', 05:07:11 INFO - 'sessionrestore', 05:07:11 INFO - 'sessionrestore_no_auto_restore', 05:07:11 INFO - 'tabpaint']}, 05:07:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:11 INFO - 'ts_paint', 05:07:11 INFO - 'tpaint', 05:07:11 INFO - 'sessionrestore', 05:07:11 INFO - 'sessionrestore_no_auto_restore', 05:07:11 INFO - 'tabpaint']}, 05:07:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:11 INFO - 'ts_paint', 05:07:11 INFO - 'tpaint', 05:07:11 INFO - 'sessionrestore', 05:07:11 INFO - 'sessionrestore_no_auto_restore', 05:07:11 INFO - 'tabpaint']}, 05:07:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['a11yr', 05:07:11 INFO - 'ts_paint', 05:07:11 INFO - 'tpaint', 05:07:11 INFO - 'sessionrestore', 05:07:11 INFO - 'sessionrestore_no_auto_restore', 05:07:11 INFO - 'tabpaint']}, 05:07:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['a11yr', 05:07:11 INFO - 'ts_paint', 05:07:11 INFO - 'tpaint', 05:07:11 INFO - 'sessionrestore', 05:07:11 INFO - 'sessionrestore_no_auto_restore', 05:07:11 INFO - 'tabpaint']}, 05:07:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['tsvgx', 05:07:11 INFO - 'tsvgr_opacity', 05:07:11 INFO - 'tart', 05:07:11 INFO - 'tscrollx', 05:07:11 INFO - 'cart', 05:07:11 INFO - 'tsvg_static']}, 05:07:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:11 INFO - 'tsvgr_opacity', 05:07:11 INFO - 'tart', 05:07:11 INFO - 'tscrollx', 05:07:11 INFO - 'cart', 05:07:11 INFO - 'tsvg_static']}, 05:07:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'talos_options': ['--disable-e10s'], 05:07:11 INFO - 'tests': ['tp5o']}, 05:07:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:07:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'talos_options': ['--disable-e10s', 05:07:11 INFO - '--xperf_path', 05:07:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:11 INFO - 'tests': ['tp5n']}, 05:07:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:07:11 INFO - 'talos_options': ['--xperf_path', 05:07:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:11 INFO - 'tests': ['tp5n']}}, 05:07:11 INFO - 'talos.zip': {'path': '', 05:07:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:11 INFO - Running post-action listener: _resource_record_post_action 05:07:11 INFO - [mozharness: 2017-02-15 13:07:11.045975Z] Finished populate-webroot step (success) 05:07:11 INFO - [mozharness: 2017-02-15 13:07:11.046103Z] Running create-virtualenv step. 05:07:11 INFO - Running pre-action listener: _resource_record_pre_action 05:07:11 INFO - Running main action method: create_virtualenv 05:07:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:11 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 05:07:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:11 INFO - Using real prefix '/tools/python27' 05:07:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:11 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:14 INFO - Installing pip.................done. 05:07:14 INFO - Return code: 0 05:07:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:07:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:07:15 INFO - Reading from file tmpfile_stdout 05:07:15 INFO - Output received: 05:07:15 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) 05:07:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07:15 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')]} 05:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:15 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')]} 05:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:15 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:15 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 05:07:15 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 05:07:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:15 INFO - 'HOME': '/Users/cltbld', 05:07:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:15 INFO - 'LOGNAME': 'cltbld', 05:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:15 INFO - 'MOZ_NO_REMOTE': '1', 05:07:15 INFO - 'NO_EM_RESTART': '1', 05:07:15 INFO - 'PAGER': '/bin/cat', 05:07:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:15 INFO - 'PWD': '/builds/slave/test', 05:07:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:15 INFO - 'SHELL': '/bin/bash', 05:07:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:15 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:15 INFO - 'USER': 'cltbld', 05:07:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:15 INFO - 'XPC_FLAGS': '0x0', 05:07:15 INFO - 'XPC_SERVICE_NAME': '0', 05:07:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:15 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 05:07:15 INFO - Cleaning up... 05:07:15 INFO - Return code: 0 05:07:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:07:15 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')]} 05:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:15 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')]} 05:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:15 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:15 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 05:07:15 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 05:07:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:15 INFO - 'HOME': '/Users/cltbld', 05:07:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:15 INFO - 'LOGNAME': 'cltbld', 05:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:15 INFO - 'MOZ_NO_REMOTE': '1', 05:07:15 INFO - 'NO_EM_RESTART': '1', 05:07:15 INFO - 'PAGER': '/bin/cat', 05:07:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:15 INFO - 'PWD': '/builds/slave/test', 05:07:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:15 INFO - 'SHELL': '/bin/bash', 05:07:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:15 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:15 INFO - 'USER': 'cltbld', 05:07:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:15 INFO - 'XPC_FLAGS': '0x0', 05:07:15 INFO - 'XPC_SERVICE_NAME': '0', 05:07:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:15 INFO - Downloading/unpacking psutil>=3.1.1 05:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:18 INFO - Installing collected packages: psutil 05:07:18 INFO - Running setup.py install for psutil 05:07:19 INFO - building 'psutil._psutil_osx' extension 05:07:19 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 05:07:19 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 05:07:19 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 05:07:19 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 05:07:19 INFO - building 'psutil._psutil_posix' extension 05:07:19 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 05:07:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:07:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:07:19 INFO - ^ 05:07:19 INFO - 1 warning generated. 05:07:19 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 05:07:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:20 INFO - Successfully installed psutil 05:07:20 INFO - Cleaning up... 05:07:20 INFO - Return code: 0 05:07:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:07:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:07:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:20 INFO - 'HOME': '/Users/cltbld', 05:07:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:20 INFO - 'LOGNAME': 'cltbld', 05:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:20 INFO - 'MOZ_NO_REMOTE': '1', 05:07:20 INFO - 'NO_EM_RESTART': '1', 05:07:20 INFO - 'PAGER': '/bin/cat', 05:07:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:20 INFO - 'PWD': '/builds/slave/test', 05:07:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:20 INFO - 'SHELL': '/bin/bash', 05:07:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:20 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:20 INFO - 'USER': 'cltbld', 05:07:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:20 INFO - 'XPC_FLAGS': '0x0', 05:07:20 INFO - 'XPC_SERVICE_NAME': '0', 05:07:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:07:21 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 05:07:21 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 05:07:21 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 05:07:21 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 05:07:21 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 05:07:21 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 05:07:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:07:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:07:24 INFO - Installing collected packages: mozsystemmonitor 05:07:24 INFO - Running setup.py install for mozsystemmonitor 05:07:24 INFO - Successfully installed mozsystemmonitor 05:07:24 INFO - Cleaning up... 05:07:24 INFO - Return code: 0 05:07:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', '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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:07: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 jsonschema==2.5.1 05:07:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:24 INFO - 'HOME': '/Users/cltbld', 05:07:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:24 INFO - 'LOGNAME': 'cltbld', 05:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:24 INFO - 'MOZ_NO_REMOTE': '1', 05:07:24 INFO - 'NO_EM_RESTART': '1', 05:07:24 INFO - 'PAGER': '/bin/cat', 05:07:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:24 INFO - 'PWD': '/builds/slave/test', 05:07:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:24 INFO - 'SHELL': '/bin/bash', 05:07:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:24 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:24 INFO - 'USER': 'cltbld', 05:07:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:24 INFO - 'XPC_FLAGS': '0x0', 05:07:24 INFO - 'XPC_SERVICE_NAME': '0', 05:07:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:24 INFO - Downloading/unpacking jsonschema==2.5.1 05:07:24 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 05:07:24 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 05:07:24 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 05:07:24 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 05:07:24 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 05:07:24 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 05:07:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:07:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 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 05:07:27 INFO - Downloading functools32-3.2.3-2.tar.gz 05:07:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:07:27 INFO - warning: no files found matching '*.txt' 05:07:27 INFO - no previously-included directories found matching 'build' 05:07:27 INFO - no previously-included directories found matching 'dist' 05:07:27 INFO - no previously-included directories found matching '.git*' 05:07:27 INFO - Installing collected packages: jsonschema, functools32 05:07:27 INFO - Running setup.py install for functools32 05:07:28 INFO - warning: no files found matching '*.txt' 05:07:28 INFO - no previously-included directories found matching 'build' 05:07:28 INFO - no previously-included directories found matching 'dist' 05:07:28 INFO - no previously-included directories found matching '.git*' 05:07:28 INFO - Successfully installed jsonschema functools32 05:07:28 INFO - Cleaning up... 05:07:28 INFO - Return code: 0 05:07:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:07:28 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')]} 05:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:28 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')]} 05:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:28 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:28 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 05:07:28 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 05:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:28 INFO - 'HOME': '/Users/cltbld', 05:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:28 INFO - 'LOGNAME': 'cltbld', 05:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:28 INFO - 'MOZ_NO_REMOTE': '1', 05:07:28 INFO - 'NO_EM_RESTART': '1', 05:07:28 INFO - 'PAGER': '/bin/cat', 05:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:28 INFO - 'PWD': '/builds/slave/test', 05:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:28 INFO - 'SHELL': '/bin/bash', 05:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:28 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:28 INFO - 'USER': 'cltbld', 05:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:28 INFO - 'XPC_FLAGS': '0x0', 05:07:28 INFO - 'XPC_SERVICE_NAME': '0', 05:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:07:28 INFO - Cleaning up... 05:07:28 INFO - Return code: 0 05:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:28 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')]} 05:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:28 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')]} 05:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:28 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:28 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 05:07:28 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 05:07:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:28 INFO - 'HOME': '/Users/cltbld', 05:07:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:28 INFO - 'LOGNAME': 'cltbld', 05:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:28 INFO - 'MOZ_NO_REMOTE': '1', 05:07:28 INFO - 'NO_EM_RESTART': '1', 05:07:28 INFO - 'PAGER': '/bin/cat', 05:07:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:28 INFO - 'PWD': '/builds/slave/test', 05:07:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:28 INFO - 'SHELL': '/bin/bash', 05:07:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:28 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:28 INFO - 'USER': 'cltbld', 05:07:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:28 INFO - 'XPC_FLAGS': '0x0', 05:07:28 INFO - 'XPC_SERVICE_NAME': '0', 05:07:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:28 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:28 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 05:07:28 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 05:07:28 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 05:07:28 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 05:07:28 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 05:07:28 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 05:07:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:32 INFO - Downloading docopt-0.6.1.tar.gz 05:07:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:32 INFO - Running setup.py install for blobuploader 05:07:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:32 INFO - Running setup.py install for requests 05:07:33 INFO - Running setup.py install for docopt 05:07:33 INFO - Successfully installed blobuploader requests docopt 05:07:33 INFO - Cleaning up... 05:07:33 INFO - Return code: 0 05:07:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:33 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:33 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 05:07:33 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 05:07:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:33 INFO - 'HOME': '/Users/cltbld', 05:07:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:33 INFO - 'LOGNAME': 'cltbld', 05:07:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:33 INFO - 'MOZ_NO_REMOTE': '1', 05:07:33 INFO - 'NO_EM_RESTART': '1', 05:07:33 INFO - 'PAGER': '/bin/cat', 05:07:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:33 INFO - 'PWD': '/builds/slave/test', 05:07:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:33 INFO - 'SHELL': '/bin/bash', 05:07:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:33 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:33 INFO - 'USER': 'cltbld', 05:07:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:33 INFO - 'XPC_FLAGS': '0x0', 05:07:33 INFO - 'XPC_SERVICE_NAME': '0', 05:07:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:33 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-T7w2tV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:33 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-FW7Ss7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ohws3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-bxFUlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-RNT35i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ldAyxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-e6E9nA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-iVbGJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-LY72xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-Ny3ct1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:34 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ekMB4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:35 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-sDRpBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:35 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-UqufZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:35 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-50U5AW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:35 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-RhLMex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:35 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-PzW0Vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:35 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-2RhQ6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:07:35 INFO - Running setup.py install for manifestparser 05:07:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:07:35 INFO - Running setup.py install for mozcrash 05:07:35 INFO - Running setup.py install for mozdebug 05:07:36 INFO - Running setup.py install for mozdevice 05:07:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Running setup.py install for mozfile 05:07:36 INFO - Running setup.py install for mozhttpd 05:07:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Running setup.py install for mozinfo 05:07:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Running setup.py install for mozInstall 05:07:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:07:36 INFO - Running setup.py install for mozleak 05:07:36 INFO - Running setup.py install for mozlog 05:07:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:07:37 INFO - Running setup.py install for moznetwork 05:07:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:07:37 INFO - Running setup.py install for mozprocess 05:07:37 INFO - Running setup.py install for mozprofile 05:07:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:07:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:07:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:07:37 INFO - Running setup.py install for mozrunner 05:07:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:07:37 INFO - Running setup.py install for mozscreenshot 05:07:37 INFO - Running setup.py install for moztest 05:07:38 INFO - Running setup.py install for mozversion 05:07:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:07:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:07:38 INFO - Cleaning up... 05:07:38 INFO - Return code: 0 05:07:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:38 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:38 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 05:07:38 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 05:07:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:38 INFO - 'HOME': '/Users/cltbld', 05:07:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:38 INFO - 'LOGNAME': 'cltbld', 05:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:38 INFO - 'MOZ_NO_REMOTE': '1', 05:07:38 INFO - 'NO_EM_RESTART': '1', 05:07:38 INFO - 'PAGER': '/bin/cat', 05:07:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:38 INFO - 'PWD': '/builds/slave/test', 05:07:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:38 INFO - 'SHELL': '/bin/bash', 05:07:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:38 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:38 INFO - 'USER': 'cltbld', 05:07:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:38 INFO - 'XPC_FLAGS': '0x0', 05:07:38 INFO - 'XPC_SERVICE_NAME': '0', 05:07:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:38 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-old09H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:38 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)) 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:38 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-drJTbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:38 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)) 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:38 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-MbUMlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:38 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)) 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:38 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-vziiP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:38 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)) 05:07:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:38 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-WPxaZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-dk2KEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-eBvhsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-jb3IUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-XX2nHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-7vfLGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-TGR2hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-zatJNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-AIzg_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:39 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)) 05:07:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:39 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-NxIkgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:40 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)) 05:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:40 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-ebLmpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:40 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)) 05:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:40 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-3ZvzCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:40 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)) 05:07:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:40 INFO - Running setup.py (path:/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/pip-HlIwH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 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)) 05:07:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:42 INFO - Downloading blessings-1.6.tar.gz 05:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:07:43 INFO - Installing collected packages: blessings 05:07:43 INFO - Running setup.py install for blessings 05:07:43 INFO - Successfully installed blessings 05:07:43 INFO - Cleaning up... 05:07:43 INFO - Return code: 0 05:07:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:07:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:43 INFO - Reading from file tmpfile_stdout 05:07:43 INFO - Current package versions: 05:07:43 INFO - blessings == 1.6 05:07:43 INFO - blobuploader == 1.2.4 05:07:43 INFO - docopt == 0.6.1 05:07:43 INFO - functools32 == 3.2.3-2 05:07:43 INFO - jsonschema == 2.5.1 05:07:43 INFO - manifestparser == 1.1 05:07:43 INFO - mozInstall == 1.12 05:07:43 INFO - mozcrash == 1.0 05:07:43 INFO - mozdebug == 0.1 05:07:43 INFO - mozdevice == 0.49 05:07:43 INFO - mozfile == 1.2 05:07:43 INFO - mozhttpd == 0.7 05:07:43 INFO - mozinfo == 0.9 05:07:43 INFO - mozleak == 0.1 05:07:43 INFO - mozlog == 3.4 05:07:43 INFO - moznetwork == 0.27 05:07:43 INFO - mozprocess == 0.24 05:07:43 INFO - mozprofile == 0.28 05:07:43 INFO - mozrunner == 6.13 05:07:43 INFO - mozscreenshot == 0.1 05:07:43 INFO - mozsystemmonitor == 0.3 05:07:43 INFO - moztest == 0.8 05:07:43 INFO - mozversion == 1.4 05:07:43 INFO - psutil == 3.1.1 05:07:43 INFO - requests == 1.2.3 05:07:43 INFO - wsgiref == 0.1.2 05:07:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:43 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')]} 05:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:43 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')]} 05:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:43 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:43 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 05:07:43 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 05:07:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:43 INFO - 'HOME': '/Users/cltbld', 05:07:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:43 INFO - 'LOGNAME': 'cltbld', 05:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:43 INFO - 'MOZ_NO_REMOTE': '1', 05:07:43 INFO - 'NO_EM_RESTART': '1', 05:07:43 INFO - 'PAGER': '/bin/cat', 05:07:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:43 INFO - 'PWD': '/builds/slave/test', 05:07:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:43 INFO - 'SHELL': '/bin/bash', 05:07:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:43 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:43 INFO - 'USER': 'cltbld', 05:07:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:43 INFO - 'XPC_FLAGS': '0x0', 05:07:43 INFO - 'XPC_SERVICE_NAME': '0', 05:07:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 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)) 05:07:43 INFO - Cleaning up... 05:07:43 INFO - Return code: 0 05:07:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:07:43 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')]} 05:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:43 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')]} 05:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:43 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 0x10284eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102851768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe9e9470d40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, '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.KALZc6bHSo/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.WhTm5csnhd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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 05:07:43 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 05:07:43 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 05:07:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:07:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:43 INFO - 'HOME': '/Users/cltbld', 05:07:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:43 INFO - 'LOGNAME': 'cltbld', 05:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:43 INFO - 'MOZ_NO_REMOTE': '1', 05:07:43 INFO - 'NO_EM_RESTART': '1', 05:07:43 INFO - 'PAGER': '/bin/cat', 05:07:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:43 INFO - 'PWD': '/builds/slave/test', 05:07:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:43 INFO - 'SHELL': '/bin/bash', 05:07:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:07:43 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:07:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:43 INFO - 'USER': 'cltbld', 05:07:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:43 INFO - 'XPC_FLAGS': '0x0', 05:07:43 INFO - 'XPC_SERVICE_NAME': '0', 05:07:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:07:44 INFO - Cleaning up... 05:07:44 INFO - Return code: 0 05:07:44 INFO - Running post-action listener: _resource_record_post_action 05:07:44 INFO - Running post-action listener: _start_resource_monitoring 05:07:44 INFO - Starting resource monitoring. 05:07:44 INFO - [mozharness: 2017-02-15 13:07:44.148144Z] Finished create-virtualenv step (success) 05:07:44 INFO - [mozharness: 2017-02-15 13:07:44.149101Z] Running install step. 05:07:44 INFO - Running pre-action listener: _resource_record_pre_action 05:07:44 INFO - Running main action method: install 05:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:07:44 INFO - Reading from file tmpfile_stdout 05:07:44 INFO - Detecting whether we're running mozinstall >=1.0... 05:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:07:44 INFO - Reading from file tmpfile_stdout 05:07:44 INFO - Output received: 05:07:44 INFO - Usage: mozinstall [options] installer 05:07:44 INFO - Options: 05:07:44 INFO - -h, --help show this help message and exit 05:07:44 INFO - -d DEST, --destination=DEST 05:07:44 INFO - Directory to install application into. [default: 05:07:44 INFO - "/builds/slave/test"] 05:07:44 INFO - --app=APP Application being installed. [default: firefox] 05:07:44 INFO - mkdir: /builds/slave/test/build/application 05:07:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:07:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:08:06 INFO - Reading from file tmpfile_stdout 05:08:06 INFO - Output received: 05:08:06 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:08:06 INFO - Running post-action listener: _resource_record_post_action 05:08:06 INFO - [mozharness: 2017-02-15 13:08:06.636405Z] Finished install step (success) 05:08:06 INFO - [mozharness: 2017-02-15 13:08:06.636573Z] Running run-tests step. 05:08:06 INFO - Running pre-action listener: _resource_record_pre_action 05:08:06 INFO - Running main action method: run_tests 05:08:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:08:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:08:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:08:06 INFO - 2017-02-15 05:08:06.651 screenresolution[1623:7804] starting screenresolution argv=screenresolution get 05:08:06 INFO - 2017-02-15 05:08:06.654 screenresolution[1623:7804] Display 0: 1600x1200x32@60 05:08:06 INFO - 2017-02-15 05:08:06.660 screenresolution[1624:7809] starting screenresolution argv=screenresolution list 05:08:06 INFO - Available Modes on Display 0 05:08:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:08:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:08:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:08:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:08:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:08:06 INFO - Intel Iris: 05:08:06 INFO - Chipset Model: Intel Iris 05:08:06 INFO - Type: GPU 05:08:06 INFO - Bus: Built-In 05:08:06 INFO - VRAM (Dynamic, Max): 1536 MB 05:08:06 INFO - Vendor: Intel (0x8086) 05:08:06 INFO - Device ID: 0x0a2e 05:08:06 INFO - Revision ID: 0x0009 05:08:06 INFO - Displays: 05:08:06 INFO - Display: 05:08:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:08:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:08:06 INFO - Display Serial Number: 1600x1200 60 05:08:06 INFO - Main Display: Yes 05:08:06 INFO - Mirror: Off 05:08:06 INFO - Online: Yes 05:08:06 INFO - Rotation: Supported 05:08:06 INFO - Return code: 0 05:08:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:06 INFO - Python 2.7.3 05:08:06 INFO - Return code: 0 05:08:06 INFO - grabbing minidump binary from tooltool 05:08:06 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')]} 05:08:06 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 0x10262cd30>, '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 0x102553db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102621be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:06 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 05:08:06 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 05:08:06 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 05:08:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:07 INFO - Return code: 0 05:08:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:08:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:07 INFO - ENV: RUST_BACKTRACE is now 1 05:08:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:08:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:07 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0332', '--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 05:08:07 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0332 --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 05:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KALZc6bHSo/Render', 05:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:07 INFO - 'HOME': '/Users/cltbld', 05:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:07 INFO - 'LOGNAME': 'cltbld', 05:08:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:07 INFO - 'MOZ_NO_REMOTE': '1', 05:08:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:07 INFO - 'NO_EM_RESTART': '1', 05:08:07 INFO - 'PAGER': '/bin/cat', 05:08:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:07 INFO - 'PWD': '/builds/slave/test', 05:08:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:07 INFO - 'RUST_BACKTRACE': '1', 05:08:07 INFO - 'SHELL': '/bin/bash', 05:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WhTm5csnhd/Listeners', 05:08:07 INFO - 'TMPDIR': '/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/', 05:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:07 INFO - 'USER': 'cltbld', 05:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:07 INFO - 'XPC_FLAGS': '0x0', 05:08:07 INFO - 'XPC_SERVICE_NAME': '0', 05:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:07 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0332', '--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 05:08:07 INFO - mozversion application_buildid: 20170215030342 05:08:07 INFO - mozversion application_changeset: 0a7831d838f793a263456df62f95a615472a7f95 05:08:07 INFO - mozversion application_display_name: Nightly 05:08:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:07 INFO - mozversion application_name: Firefox 05:08:07 INFO - mozversion application_remotingname: firefox 05:08:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:08:07 INFO - mozversion application_vendor: Mozilla 05:08:07 INFO - mozversion application_version: 54.0a1 05:08:07 INFO - mozversion platform_buildid: 20170215030342 05:08:07 INFO - mozversion platform_changeset: 0a7831d838f793a263456df62f95a615472a7f95 05:08:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:08:07 INFO - mozversion platform_version: 54.0a1 05:08:07 INFO - using testdate: 1487164087 05:08:07 INFO - actual date: 1487164087 05:08:07 INFO - starting webserver on 'localhost:49251' 05:08:07 INFO - SUITE-START | Running 2 tests 05:08:07 INFO - TEST-START | dromaeo_css 05:08:07 INFO - operating with platform_type : mac_ 05:08:07 INFO - Initialising browser for dromaeo_css test... 05:08:07 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpG3NY2F/profile http://localhost:49251/getInfo.html) 05:08:10 INFO - PROCESS | 1634 | 2017-02-15 05:08:10.328 plugin-container[1637:7980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f3f, name = 'com.apple.tsm.portname' 05:08:10 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:10 INFO - PROCESS | 1634 | 2017-02-15 05:08:10.328 plugin-container[1637:7980] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 05:08:10 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:10 INFO - PROCESS | 1634 | 2017-02-15 05:08:10.328 plugin-container[1637:7980] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:08:10 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 05:08:10 INFO - PROCESS | 1634 | colorDepth:24 05:08:10 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 05:08:10 INFO - PROCESS | 1634 | __metrics 05:08:10 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:08:11 INFO - TEST-INFO | 1634: exit 0 05:08:11 INFO - Browser initialized. 05:08:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:11 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpG3NY2F/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:13 INFO - PROCESS | 1638 | 2017-02-15 05:08:13.668 plugin-container[1639:8114] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 05:08:13 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:13 INFO - PROCESS | 1638 | 2017-02-15 05:08:13.669 plugin-container[1639:8114] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a27, name = 'com.apple.CFPasteboardClient' 05:08:13 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:08:13 INFO - PROCESS | 1638 | 2017-02-15 05:08:13.669 plugin-container[1639:8114] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:08:23 INFO - PROCESS | 1638 | RSS: Main: 234450944 05:08:23 INFO - PROCESS | 1638 | 05:11:26 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 05:11:28 INFO - PROCESS | 1638 | RSS: Main: 255737856 05:11:28 INFO - PROCESS | 1638 | 05:13:11 INFO - PROCESS | 1638 | ************************* 05:13:11 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 05:13:11 INFO - PROCESS | 1638 | 05:13:11 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:13:11 INFO - PROCESS | 1638 | Full stack: 05:13:11 INFO - PROCESS | 1638 | ************************* 05:14:30 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 05:14:31 INFO - PROCESS | 1638 | RSS: Main: 261361664 05:14:31 INFO - PROCESS | 1638 | 05:17:33 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 05:17:33 INFO - PROCESS | 1638 | RSS: Main: 272945152 05:17:33 INFO - PROCESS | 1638 | 05:20:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 05:20:36 INFO - PROCESS | 1638 | RSS: Main: 264929280 05:20:36 INFO - PROCESS | 1638 | 05:23:39 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 05:23:39 INFO - PROCESS | 1638 | RSS: Main: 269172736 05:23:39 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 05:26:42 INFO - PROCESS | 1638 | RSS: Main: 269828096 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | __start_tp_report 05:26:42 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 05:26:42 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 05:26:42 INFO - PROCESS | 1638 | |i|pagename|runs| 05:26:42 INFO - PROCESS | 1638 | |0;dojo.html;2830.1226619747877;3314.817685027324;3353.01086179577;3353.513740507628;3418.3334249821287;5024.417308547805;5442.863928401782;5573.442655734424;5694.743736531856;5708.971455142723;5591.8602034949145;5681.602287839853;5761.683107429089;5788.6816225107605;5863.912041319373;5188.948110518903;5193.974030129844;5274.287971123907;5286.894262114755;5358.892822143554;5232.6075544334135;5302.946970530304;5341.092014357569;5363.704996225206;5380.7309634518315;5103.132467480537;5329.360476742777;5332.120200166968;5367.838964831061;5378.757955891974;5113.539781419653;5138.486151384869;5178.352705911761;5239.895202095937;5293.814716484943;5184.792608295664;5219.138842091051;5224.9738751306;5253.264542963988;5272.4200337963175;4317.84887528935;5591.74837132326;5711.914321285184;5773.134029895507;5802.071668533014;6125.2659746757545;6126.142340072393;6202.472789812826;6251.4061164189325;6292.056191571255;6246.312905580383;6265.530085243579;6276.278228003793;6292.779752708633;6294.307626161119;5898.941010589882;5908.438698323738;5914.940850591525;5959.731812068424;5963.254593175853;6157.9384206158265;6198.504119670415;6245.843853903689;6285.465735412541;6286.308506064329;5121.129408000649;6119.99004232014;6188.350223226586;6203;6215.564910456224;6233.096201050913;6267;6268.341824108494;6276.152719382916;6281.466075383552;6077.969610151921;6091.08633704939;6129.05316799051;6186.319504854462;6262.655553944485;5197.22041693749;6281.152044473937;6282.434580887742;6293.77971770995;6314.273858506239;4998.475160108136;5002.1496345621335;5002.199648056294;5022.673526220784;5028.145215313405;4344.826206951687;4375.190589740844;4381.036172042146;4413.337999300131;4449.243628583149;5799.3040835100055;5872.647641141545;5904.498117659961;5922.111683247461;5935.584509084322;6221.129041934133;6254.2807577129215;6288.8427789304715;6305.8108256752375;6329.525285603599;5627.184058311522;5783.248177736868;5831.533477321889;5855.38518455556;5880.588358814927;5354.705491198021;5484.643498172606;5506.0089183947275;5524.502794748411;5584.134459158837;6285.057241413641;6316.2736285326855;6328.778492752732;6332.366763323631;6356.014817703263;5933.486960824962;6000.939990600038;6271.62370257786;6272.5922815016875;6279;6164.167837342081;6224.439800417984;6231.688415579112;6255.96872015637;6293.590916590407;6253.843653908689;6283.717232724447;6298.244210694746;6313.842153946188;6337.144485494399;5781;6275.52933529978;6284.057391391328;6290.24517057956;6290.748370065146;5388.919166212431;5673.177389278449;6088.786892458743;6132.630864714964;6281.811545653638;4987.451380348231;6131.835460087213;6133.671320645445;6220.564560480723;6245;5819.330776960704;5946.583739138218;6022.789202378071;6060.606060606046;6096.969515152396;6051.334353221054;6106.06632622643;6125.082842094376;6198.349173336735;6256.906146407899;6002.669853157943;6027.758889644365;6048.8349045563255;6107.572469927062;6151.415615516519 05:26:42 INFO - PROCESS | 1638 | |1;ext.html;438.65346376362675;489.44203607887005;515.646781954361;523.0950455711619;539.7921800106958;35427.93716188515;38691.41962870559;39775.80112099442;39881.601183988154;39907;32334.19164520888;42095;42120.15759684812;42245.366319505156;42287.57712422875;9234.353595248353;10904.781904361907;11373.431328433586;11457.312561246352;11568.016718578889;11138.721531961724;11203.551857925713;11256.324620522753;11262.155338349616;11268.985791278783;11303.208775385727;11313.151513636469;11329.150313726463;11360.715982100472;11394.772104557904;11225.943870280678;11251.212415130944;11285;11297.943510282477;11310.37792921389;9530.761730956712;11221.495032723547;11288.54845806175;11298.491567879382;11305.49125289364;35964.460533092024;36077.45883811745;36204.27591448183;36218;36327;3748.7563308385143;3804.771713697187;3809.561900381464;3812.656860882506;3821.6942644588366;27646.861765691243;27935.720642793516;27997.44005119886;28056.01803936873;28421.147365579065;2726.836389816617;3018.2303512604367;3082.475979083561;3120.89076882308;3121.453745594512;443627;446066;448260;448928;450362;40440.79779601142;43560.78219608945;45927.540724593;52671;52776.944461110565;48881.755591221816;55482.89034219293;58565.65737370458;58800.70599646975;59085.70457147687;14252.501162459472;14385.928070359581;14392.424303027761;14422.711545769025;14459.710805783825;11005.669829904955;11142.61000864982;11184.720381990515;11237;11271.718207044889;17616.823831761518;17625.383111591033;17640.823591764176;17645.558861028578;17713.911430442764;7613.314801667876;7726.652300646372;7783.275853451247;7786;7795.934077469475;831.966721331152;838.7357982235576;842.0905422144069;857.2627540315324;861.586438509519;21992;28428.71571284302;28942.855285723435;29071.12786616405;29598.704012959595;998.9051040151174;1012.099231683802;1043.546057465005;1052.484282701486;1180.7756526259984;13435.731285374237;14193.361298741582;14777.335019924129;14821.555353339418;14887.95784295089;586511;591967.0401647964;592228;592354;593715;57749.711251444314;58033.70983145057;58264.41735582675;58589.707051465324;58651.12023319654;1325.8939284857188;1333.7532556477083;1343.563341913882;1353.451851999922;1372.8146700195346;26124.73875261223;29072.461890357547;29241.222083901994;29418.558721618763;29501.96743113981;48409;48743.025139497724;49054.509454905;49213;49362.50637493723;433276;491193;491865;493542.53228733625;494013;25174.370640734127;26171.345716357242;26333.604995924692;26349.73650263473;26382.07662731795;44678.776606116764;44793.552064478936;45909.77045114753;46120.769396152806;46135.53864461312;36501.26997460089;36838.26323473462;37102.58833175835;37738.43392349172;37857.81071094737;34327.65672343245;36501.26997460089;37426.25147497089;37586.436203456426;37680.43479347757;35230;36163.81918090393;36177;36373;36892.81553592215;26559.07043253477;28673;31206;32935;33493.49759753557;24240.878795606615;24433.877830610734;24481.877590612647;24574.468612566703;24587.508249834544 05:26:42 INFO - PROCESS | 1638 | |2;jquery.html;385.0315335952196;386.6365616320658;390.5313623651618;398.20756694178584;417.36352063103783;16634.251458684357;17568.736468952942;19723.605527889435;20540.691889621667;21170.470738231554;20222.494437639067;21098.89450552749;21130.15479380827;21624;21900;5205.609579281569;5415.079436495796;5820.388859169769;6096.993995990679;6219.440250377465;6122.265328160627;6130.63216207029;6142.600730952474;6164.5376596755195;6314.7789827356055;6828.419584335337;6837.794866154023;6885.173779146509;6902.861942761167;6932.826679333007;5066.822661206877;6085.265699275686;6140.9385906140815;6887.7244910203535;6902.6203558804245;5012.323336349619;6024.427679370453;6033.09503574463;6067.817965461043;6080.087986801971;11064.889351106467;13387.464501419932;13464.5287414941;13709.725805483935;13729.038967272294;2458.704955405363;2539.9238022859345;2546.376137846221;2593.533164030474;2603.5834266517268;7933.365330773524;9781.510924453749;9991.250656200815;10286.897131028669;10411.843822342671;1794.605186858889;1807.268056437145;1807.6384723055442;1816.636672665459;1868.551547628573;108056.37915431274;134896;136663;138694;139301;8708.869366959501;10806.891931080745;11742.70643233926;11865.525378984745;12090.335031573348;15575;15615.141167235684;15660;15693.607659808597;16451.341946322013;8148.185181481923;8382.87425688615;8396.454230475;8495.74512764618;8512.872306915402;7852.646630901623;7976.880346794803;7992.600369981477;8010.3191228745045;8145.185481451807;4848.272759086165;4851.611871050378;4862.78117484714;4875.024995000943;4945.826896058693;1685.612309168898;2069.6481598128353;2078.6674132138787;2082.063071617748;2083.19796878203;967.7580604848788;1002.9147522460527;1003.2024540490328;1009.5709323537467;1037.9221558383151;20404.183832646824;22064.558708825734;22064.88967555152;22074.779252207594;22083;878.9759929681977;1011.2567263061644;1023.7952409518126;1039.3711804358254;1052.3633201912885;10740;10973.83539246912;11312.94343528277;11377.838517682363;11490.482928268248;616115;620337;654679;656637;668601;133536;135390.5226634146;136626;138252;138943;1009.6668099527138;1033.2818691009827;1053.1416895230516;1056.5298442193305;1059.06802014227;18363.816361836212;18788.906055469633;19705.70441443351;20109.798902010793;20903.237417265038;59490.40509594849;59640;59915;60439.69780151247;60520.39479605148;77900;78944.60527697325;81743;82726.58636706778;85302.57348713216;7422.851542969002;7743.4966727162555;8431.620577074169;8464.957675211585;8912.108789121296;12580;13142.934285328512;13382.13016153947;13449.865501345254;13655.361356637268;11138.3873886937;11338.14963877729;11523.769524609628;11527.538898444303;11765.823512647488;10395.428251446243;10548.419836909045;10697.465126743788;11197.888021119685;11206.83189752138;11477.311361318347;11599.536018559163;11783.646490605295;11889.048876089719;11921.403929803648;7149.785506434815;7711.151773305044;7721.806954826175;7794.738228613199;7982.321502672105;8361.540115293474;10279.794404112026;11316.660500185008;11523.711907202387;11671.941640291745 05:26:42 INFO - PROCESS | 1638 | |3;mootools.html;1257.1953949472338;1441.300969030021;1451.5935538049343;1454.1783892100962;1473.2780937340706;8158.4696994695305;8413.36899732521;8592.484450932941;8595.656173753057;8617.87073193901;8412.663493460253;8553;8566.614502347395;8601.225889669928;8623.568821558913;2217.4899773052207;2260.8643481391086;2270.738865030526;2271.818254539641;2272.988635056831;2215.401841502793;2248.5278091600785;2262.298687406901;2287.748347681754;2346.7887890089887;2253.8309626777977;2256.571251462217;2286.588414085464;2290.015293423827;2296.47181148336;2233.542123864604;2250.291158285143;2257.2663884237604;2270.8069814065743;2272.216085450517;1822.5534743987675;1932.391296741536;2097.3603051069417;2281.269993602048;2306.123673004264;8323.500589964622;8441.535715535643;8538.70114545988;8541.273991710712;8556.315494760403;5059.2916991621205;5196.662216955886;5225.268462415265;5226.398964119099;5227.660202086852;3421.2473255883665;3431.588209414886;3447.3105378924065;3488.284901595167;3501.459357882549;1220.9389530523526;1221.9511219551207;1258.874112588743;1271.9824140687413;1274.3882936190587;10737.731556711067;10826.188035897261;10857.565697372096;10944.507497162567;10975.451227438596;4308.46144231971;4624.28323609841;4705.529447055335;4707.340972263886;4725.8582242532775;9654.565544550513;9682.612695492242;9715.854262186072;9717.757056073655;9740.951295243478;5174.922376164361;5237.711925844039;5249.9237656280375;5252.212168174804;5261.158214685632;4524.23088075028;4723.102610503994;4732.929006064912;4767.332573439721;4802.615790736732;3795.525559305087;3828.636279553438;3902.31709450845;3918.706097042676;3938.5864484229314;1112.6439539347332;1233.3155098920186;1235.5922545559943;1258.1256027061104;1275.6364436135843;731.8975343451921;732.1360794262714;756.3759898084103;760.395485588947;793.1711361627114;5000.849804544975;5256.369235691742;5418.160185171305;5492.956338295711;5558.9715902558155;483.5188986957999;485.6988667026466;562.693332133988;566.2553741829481;576.5474102829343;3395.1172695099453;3586.6234045425376;3644.398674218777;3669.7064234861145;3715.145516531159;8519.23326900582;9667.27495437845;10016.248781341428;10019.649312274036;10050.195984321383;10011.149052330633;10021.79956400868;10026.799464010679;10029.04724051214;10039.749006274755;7603.771886843404;7746.457747957589;7909.960450197827;7937.563434011069;7944.086430060617;4562.58936695699;5126.6926933631685;5205.427402985744;5209.322788037531;5278.208268759717;8894.822103558023;9003.234725048444;9092.454452732858;9237.07629237071;9261.583228754856;7671.347935425551;9367.812643747224;9452.243820494481;9483.193928516153;9501.334906556474;6114.296855861455;7151.499395042505;7272.672729727069;7282.162551306667;7290.416766658548;7041.295870412918;7504.986826778533;7919.326857217201;7931.2068793120225;7934.047914250327;7002.964985175042;7095.716171353294;7118.074650295428;7160;7256.23809500016;6988.580685158907;7012.5792452453015;7043.496910178305;7055.400290975324;7100.644967751695;6210.689465526796;6299.212598425197;6340.809775706736;6346.2067241594805;6378.553501254868;4201.474815648044;4233.364995250614;4288.228118938497;4300.376445415334;4396.538363471917;3558.323918455485;4530.275155975029;4719.244920812654;4855.34452848875;4964.404271487445 05:26:42 INFO - PROCESS | 1638 | |4;prototype.html;299.2742599196948;302.7335944368955;366.88993302009425;367.746255083992;368.29839156407036;4792.9281060784115;5576.693281869496;5584.972075139629;5610.915836262454;5617.775288988436;5000.174971129759;5047.419546752125;5082.847514574569;5196.856691527858;5537.446255374471;3952.367621180612;4098.323776576861;4135;4200.243956087903;4206.221848957937;3353.830630054599;3716.754887112807;3907.199024200032;4159.9376009359885;4168.208040472316;3664.725145614076;3828.827702753369;4143.274926887798;4144.725666723285;4196.643285320752;3307.4212012897647;4016.6585840203616;4120.423140760296;4187.392828039932;4204.411382406465;3282.885099021523;3316.403047451458;3366.4781958796425;3377.3619794399697;3545.2732189901008;4435.933460998088;5122.334096567422;5288.576913846883;5329.653572517774;5358.27663265462;4007.2786898358286;4061.6953728470485;4220.050488640062;4537.275835182642;4917.262410638397;4894.706317620954;5178.922316165261;5750.194972703783;5786.334571524244;5789.2763404574425;3307.8842240521467;3573.535440392758;3586;3625.274945011008;3930.9779457341297;4734.366643508019;5285.947140528622;5771.797987070474;6103.551493406256;6129.785457508966;4080.6327430531396;4285.485741710952;4297.742135471819;4299.78501074945;4302.204092242945;3663.4871118043493;3680.2271522980473;4363.80362883671;4380.189664912002;4393.297072468454;4046.9190616188102;4252.702310838212;4996.400431948116;4999.500049995044;5025.296458495814;5247.003069416799;5331.733413329318;5419.918701219485;5787.71061446926;5891.672789248223;1352.6956434802287;1356.559118286541;1427.8429372768987;1431.4202747887123;1437.2238990944982;949.4967667136428;959.5106495687111;1000.7448100734266;1002.6991902429243;1012.9898701012895;5077.466865979093;5088.346287456591;5208.9739551302;5239.633225674166;5247.737613119329;5807.651540907559;5810.331811841608;5814.16853691086;5814.79648212319;5820.534357251409;4195.58044195578;4829.420469543677;5209.322788037531;5217.58259339252;5234.319538459976;2681.209043332222;2759.1998320487237;2926.5317549192027;2931.472334979724;3030.606021217228;5726.9713651431475;5869.501092407193;5985;6002.698515816283;6019.428154325332;4546.590806827401;5900.498457631149;5958.374370691102;5975.6694888993325;5994.201739478139;5160.561352285098;5291.629585928948;5672.262605861211;5741.770329186869;5993.3706960768495;4970.453250142554;5103.18349064148;5808.767649293981;6026.879462410815;6033.758649653964;5517.613767036269;5679.630823996427;5893.4952645124795;5924.377940316377;5930.466258036798;5504.53211477029;6178.876422471615;6184.288806787277;6201.635640159157;6201.961039090903;4208.885424785575;4252.362145678049;4252.7023108383355;4263.211305908417;4279.657627389864;4319.697621166614;5392.406835248198;5907.2911250650195;5974.372690867396;6035.646098021687;5292.41783403833;5582.441755824385;5814.395075053494;5854.297484301911;5866.794662186803;5295.993761185362;5423.62034657586;5794.942050579441;5804.920694392406;5811.883762324815;5455.881544283333;5643.7742490299925;5667.376588575171;5677.630953987978;5700.401457846866;4460.1971645104195;5031.396232452129;5109.591232701449;5441.972790136182;5817.941820581909;5377.9141957465845;5522.917156242579;5590.86022849432;5690;5697.803461273013 05:26:42 INFO - PROCESS | 1638 | |5;yui.html;692.2938602625319;701.3022043067152;748.1807420874144;771.8537971112896;771.969420823201;13530.797038044426;14315.856841431596;14516.693497585215;15266.847331526682;15371.615709607266;13560.728785424286;14308.785368219485;14348.641283967907;14387.280635968213;14420;743.438703778649;876.2332958661171;890.1676932068505;892.6027917576681;892.8660700894853;842.1157784326464;897.5915958238986;899.5951821680237;906.5557876640431;918.6371383303591;953.323140570196;957.3203025851653;958.314804914486;959.52023988006;959.8608201810733;940.7412961435591;951.46242373059;951.980960380792;952.4761381240324;952.5665822050951;704.4153352717284;709.737397163053;709.7728726807424;710.4813486155135;711.7793484019919;14519.70960580793;15154.772678409832;15196.46812361573;15248.466303679317;15250.3137358818;13627.04610677253;14035.929820350833;14043.297835108204;14059.226742529157;14095.859041409558;11431.942840285828;11493.367864767435;11647.35939523326;11940.223885447505;12223.75552488954;3313.2082205632973;3514.4728290756334;3662.10278481771;3699.223163135745;3805.82873770681;99365.50317248367;100177;100549.497252514;101093.4945325276;103399.44900826494;10589;10775.892241077489;10786.70634920635;10802.121526347915;11034.503447344889;22182.667259991114;22183;22281.331560053226;22365.888170559043;22402.775972240393;7508.962455187689;7521.0974683038385;7529.698812047566;7585.6965721371635;7713.537187768752;4061.614146656063;4161.771102589387;4207.179599977975;4208.684348673801;4209.305464598368;3603.5855876574005;3646.7082633389796;3702.148505843671;3727.366347720894;3765.8493660253284;597.7507010348306;657.8980258060009;672.1564436631995;687.4500399680236;695.8851789454784;616.3682225718675;623.8440389902524;636.5512313818747;662.68522451835;670.3196255800367;9386.90613093874;9750.756231094138;9974.40153590787;10021.997800220066;10217.591296348211;599.3946114424463;624.5128799536369;638.8498702804837;684.5584597934304;690.1283797893811;4833.009233107205;4898.54224223873;4936.913878946626;4938.345654205881;4939.407271127488;78727;94155;96959.51520242354;97489;99873;49114;78312.21687783049;80533.59733201413;86375;86961.13038869656;65727.34272657403;67096.6645166771;67176.66411667911;68001.65999169972;69752.65123674349;10565;10574.889636588356;10704.571817127227;10789.946050269698;10820.134389248684;44005.55994440143;44778.88052798706;45392.63822085343;45433.54566454293;45708.54291457176;42239.788801055794;55053.72473137609;55753.44246557482;56215.71892140513;57808;12904.548340808027;13116.672083197996;13221.801672974721;13955.651108722363;14145.787813182606;11566.248193867372;11628.825567616661;14018.859811401755;14025.29873506341;14130.929345353208;10742.3017503862;12933.159344642569;13157;13191.736165276832;13202.207867527979;12430.254184748945;13249.337533123498;13539.59381218565;13716.24560649134;13830.861691382957;12617.242965422103;12741.49034038628;12792.552260671204;13316.40076196554;13609.251491168081;10535.894641053492;10551.894481055399;10897.727556811144;10932.508037138188;11276.210665253682;8832.823343532964;9016.927245159257;10573.735656608646;10653;10701.518431670438 05:26:42 INFO - PROCESS | 1638 | __end_tp_report 05:26:42 INFO - PROCESS | 1638 | __start_cc_report 05:26:42 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,426 05:26:42 INFO - PROCESS | 1638 | __end_cc_report 05:26:42 INFO - PROCESS | 1638 | __startTimestamp1487165202871__endTimestamp 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | ------- Summary: start ------- 05:26:42 INFO - PROCESS | 1638 | Number of tests: 6 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5740.47 Median:5959.73 stddev:666.19 (11.2%) stddev-sans-first:627.89 05:26:42 INFO - PROCESS | 1638 | Values: 2830.1 3314.8 3353.0 3353.5 3418.3 5024.4 5442.9 5573.4 5694.7 5709.0 5591.9 5681.6 5761.7 5788.7 5863.9 5188.9 5194.0 5274.3 5286.9 5358.9 5232.6 5302.9 5341.1 5363.7 5380.7 5103.1 5329.4 5332.1 5367.8 5378.8 5113.5 5138.5 5178.4 5239.9 5293.8 5184.8 5219.1 5225.0 5253.3 5272.4 4317.8 5591.7 5711.9 5773.1 5802.1 6125.3 6126.1 6202.5 6251.4 6292.1 6246.3 6265.5 6276.3 6292.8 6294.3 5898.9 5908.4 5914.9 5959.7 5963.3 6157.9 6198.5 6245.8 6285.5 6286.3 5121.1 6120.0 6188.4 6203.0 6215.6 6233.1 6267.0 6268.3 6276.2 6281.5 6078.0 6091.1 6129.1 6186.3 6262.7 5197.2 6281.2 6282.4 6293.8 6314.3 4998.5 5002.1 5002.2 5022.7 5028.1 4344.8 4375.2 4381.0 4413.3 4449.2 5799.3 5872.6 5904.5 5922.1 5935.6 6221.1 6254.3 6288.8 6305.8 6329.5 5627.2 5783.2 5831.5 5855.4 5880.6 5354.7 5484.6 5506.0 5524.5 5584.1 6285.1 6316.3 6328.8 6332.4 6356.0 5933.5 6000.9 6271.6 6272.6 6279.0 6164.2 6224.4 6231.7 6256.0 6293.6 6253.8 6283.7 6298.2 6313.8 6337.1 5781.0 6275.5 6284.1 6290.2 6290.7 5388.9 5673.2 6088.8 6132.6 6281.8 4987.5 6131.8 6133.7 6220.6 6245.0 5819.3 5946.6 6022.8 6060.6 6097.0 6051.3 6106.1 6125.1 6198.3 6256.9 6002.7 6027.8 6048.8 6107.6 6151.4 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:63826.87 Median:35696.20 stddev:136075.77 (381.2%) stddev-sans-first:136374.27 05:26:42 INFO - PROCESS | 1638 | Values: 438.7 489.4 515.6 523.1 539.8 35427.9 38691.4 39775.8 39881.6 39907.0 32334.2 42095.0 42120.2 42245.4 42287.6 9234.4 10904.8 11373.4 11457.3 11568.0 11138.7 11203.6 11256.3 11262.2 11269.0 11303.2 11313.2 11329.2 11360.7 11394.8 11225.9 11251.2 11285.0 11297.9 11310.4 9530.8 11221.5 11288.5 11298.5 11305.5 35964.5 36077.5 36204.3 36218.0 36327.0 3748.8 3804.8 3809.6 3812.7 3821.7 27646.9 27935.7 27997.4 28056.0 28421.1 2726.8 3018.2 3082.5 3120.9 3121.5 443627.0 446066.0 448260.0 448928.0 450362.0 40440.8 43560.8 45927.5 52671.0 52776.9 48881.8 55482.9 58565.7 58800.7 59085.7 14252.5 14385.9 14392.4 14422.7 14459.7 11005.7 11142.6 11184.7 11237.0 11271.7 17616.8 17625.4 17640.8 17645.6 17713.9 7613.3 7726.7 7783.3 7786.0 7795.9 832.0 838.7 842.1 857.3 861.6 21992.0 28428.7 28942.9 29071.1 29598.7 998.9 1012.1 1043.5 1052.5 1180.8 13435.7 14193.4 14777.3 14821.6 14888.0 586511.0 591967.0 592228.0 592354.0 593715.0 57749.7 58033.7 58264.4 58589.7 58651.1 1325.9 1333.8 1343.6 1353.5 1372.8 26124.7 29072.5 29241.2 29418.6 29502.0 48409.0 48743.0 49054.5 49213.0 49362.5 433276.0 491193.0 491865.0 493542.5 494013.0 25174.4 26171.3 26333.6 26349.7 26382.1 44678.8 44793.6 45909.8 46120.8 46135.5 36501.3 36838.3 37102.6 37738.4 37857.8 34327.7 36501.3 37426.3 37586.4 37680.4 35230.0 36163.8 36177.0 36373.0 36892.8 26559.1 28673.0 31206.0 32935.0 33493.5 24240.9 24433.9 24481.9 24574.5 24587.5 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:36965.39 Median:21150.31 stddev:107663.15 (509.0%) stddev-sans-first:107930.14 05:26:42 INFO - PROCESS | 1638 | Values: 385.0 386.6 390.5 398.2 417.4 16634.3 17568.7 19723.6 20540.7 21170.5 20222.5 21098.9 21130.2 21624.0 21900.0 5205.6 5415.1 5820.4 6097.0 6219.4 6122.3 6130.6 6142.6 6164.5 6314.8 6828.4 6837.8 6885.2 6902.9 6932.8 5066.8 6085.3 6140.9 6887.7 6902.6 5012.3 6024.4 6033.1 6067.8 6080.1 11064.9 13387.5 13464.5 13709.7 13729.0 2458.7 2539.9 2546.4 2593.5 2603.6 7933.4 9781.5 9991.3 10286.9 10411.8 1794.6 1807.3 1807.6 1816.6 1868.6 108056.4 134896.0 136663.0 138694.0 139301.0 8708.9 10806.9 11742.7 11865.5 12090.3 15575.0 15615.1 15660.0 15693.6 16451.3 8148.2 8382.9 8396.5 8495.7 8512.9 7852.6 7976.9 7992.6 8010.3 8145.2 4848.3 4851.6 4862.8 4875.0 4945.8 1685.6 2069.6 2078.7 2082.1 2083.2 967.8 1002.9 1003.2 1009.6 1037.9 20404.2 22064.6 22064.9 22074.8 22083.0 879.0 1011.3 1023.8 1039.4 1052.4 10740.0 10973.8 11312.9 11377.8 11490.5 616115.0 620337.0 654679.0 656637.0 668601.0 133536.0 135390.5 136626.0 138252.0 138943.0 1009.7 1033.3 1053.1 1056.5 1059.1 18363.8 18788.9 19705.7 20109.8 20903.2 59490.4 59640.0 59915.0 60439.7 60520.4 77900.0 78944.6 81743.0 82726.6 85302.6 7422.9 7743.5 8431.6 8465.0 8912.1 12580.0 13142.9 13382.1 13449.9 13655.4 11138.4 11338.1 11523.8 11527.5 11765.8 10395.4 10548.4 10697.5 11197.9 11206.8 11477.3 11599.5 11783.6 11889.0 11921.4 7149.8 7711.2 7721.8 7794.7 7982.3 8361.5 10279.8 11316.7 11523.7 11671.9 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5366.53 Median:4982.63 stddev:3011.46 (60.4%) stddev-sans-first:3004.07 05:26:42 INFO - PROCESS | 1638 | Values: 1257.2 1441.3 1451.6 1454.2 1473.3 8158.5 8413.4 8592.5 8595.7 8617.9 8412.7 8553.0 8566.6 8601.2 8623.6 2217.5 2260.9 2270.7 2271.8 2273.0 2215.4 2248.5 2262.3 2287.7 2346.8 2253.8 2256.6 2286.6 2290.0 2296.5 2233.5 2250.3 2257.3 2270.8 2272.2 1822.6 1932.4 2097.4 2281.3 2306.1 8323.5 8441.5 8538.7 8541.3 8556.3 5059.3 5196.7 5225.3 5226.4 5227.7 3421.2 3431.6 3447.3 3488.3 3501.5 1220.9 1222.0 1258.9 1272.0 1274.4 10737.7 10826.2 10857.6 10944.5 10975.5 4308.5 4624.3 4705.5 4707.3 4725.9 9654.6 9682.6 9715.9 9717.8 9741.0 5174.9 5237.7 5249.9 5252.2 5261.2 4524.2 4723.1 4732.9 4767.3 4802.6 3795.5 3828.6 3902.3 3918.7 3938.6 1112.6 1233.3 1235.6 1258.1 1275.6 731.9 732.1 756.4 760.4 793.2 5000.8 5256.4 5418.2 5493.0 5559.0 483.5 485.7 562.7 566.3 576.5 3395.1 3586.6 3644.4 3669.7 3715.1 8519.2 9667.3 10016.2 10019.6 10050.2 10011.1 10021.8 10026.8 10029.0 10039.7 7603.8 7746.5 7910.0 7937.6 7944.1 4562.6 5126.7 5205.4 5209.3 5278.2 8894.8 9003.2 9092.5 9237.1 9261.6 7671.3 9367.8 9452.2 9483.2 9501.3 6114.3 7151.5 7272.7 7282.2 7290.4 7041.3 7505.0 7919.3 7931.2 7934.0 7003.0 7095.7 7118.1 7160.0 7256.2 6988.6 7012.6 7043.5 7055.4 7100.6 6210.7 6299.2 6340.8 6346.2 6378.6 4201.5 4233.4 4288.2 4300.4 4396.5 3558.3 4530.3 4719.2 4855.3 4964.4 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4616.75 Median:5115.96 stddev:1416.17 (27.7%) stddev-sans-first:1382.57 05:26:42 INFO - PROCESS | 1638 | Values: 299.3 302.7 366.9 367.7 368.3 4792.9 5576.7 5585.0 5610.9 5617.8 5000.2 5047.4 5082.8 5196.9 5537.4 3952.4 4098.3 4135.0 4200.2 4206.2 3353.8 3716.8 3907.2 4159.9 4168.2 3664.7 3828.8 4143.3 4144.7 4196.6 3307.4 4016.7 4120.4 4187.4 4204.4 3282.9 3316.4 3366.5 3377.4 3545.3 4435.9 5122.3 5288.6 5329.7 5358.3 4007.3 4061.7 4220.1 4537.3 4917.3 4894.7 5178.9 5750.2 5786.3 5789.3 3307.9 3573.5 3586.0 3625.3 3931.0 4734.4 5285.9 5771.8 6103.6 6129.8 4080.6 4285.5 4297.7 4299.8 4302.2 3663.5 3680.2 4363.8 4380.2 4393.3 4046.9 4252.7 4996.4 4999.5 5025.3 5247.0 5331.7 5419.9 5787.7 5891.7 1352.7 1356.6 1427.8 1431.4 1437.2 949.5 959.5 1000.7 1002.7 1013.0 5077.5 5088.3 5209.0 5239.6 5247.7 5807.7 5810.3 5814.2 5814.8 5820.5 4195.6 4829.4 5209.3 5217.6 5234.3 2681.2 2759.2 2926.5 2931.5 3030.6 5727.0 5869.5 5985.0 6002.7 6019.4 4546.6 5900.5 5958.4 5975.7 5994.2 5160.6 5291.6 5672.3 5741.8 5993.4 4970.5 5103.2 5808.8 6026.9 6033.8 5517.6 5679.6 5893.5 5924.4 5930.5 5504.5 6178.9 6184.3 6201.6 6202.0 4208.9 4252.4 4252.7 4263.2 4279.7 4319.7 5392.4 5907.3 5974.4 6035.6 5292.4 5582.4 5814.4 5854.3 5866.8 5296.0 5423.6 5794.9 5804.9 5811.9 5455.9 5643.8 5667.4 5677.6 5700.4 4460.2 5031.4 5109.6 5442.0 5817.9 5377.9 5522.9 5590.9 5690.0 5697.8 05:26:42 INFO - PROCESS | 1638 | 05:26:42 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:18812.07 Median:4184.48 stddev:26287.46 (628.2%) stddev-sans-first:26325.99 05:26:42 INFO - PROCESS | 1638 | Values: 692.3 701.3 748.2 771.9 772.0 13530.8 14315.9 14516.7 15266.8 15371.6 13560.7 14308.8 14348.6 14387.3 14420.0 743.4 876.2 890.2 892.6 892.9 842.1 897.6 899.6 906.6 918.6 953.3 957.3 958.3 959.5 959.9 940.7 951.5 952.0 952.5 952.6 704.4 709.7 709.8 710.5 711.8 14519.7 15154.8 15196.5 15248.5 15250.3 13627.0 14035.9 14043.3 14059.2 14095.9 11431.9 11493.4 11647.4 11940.2 12223.8 3313.2 3514.5 3662.1 3699.2 3805.8 99365.5 100177.0 100549.5 101093.5 103399.4 10589.0 10775.9 10786.7 10802.1 11034.5 22182.7 22183.0 22281.3 22365.9 22402.8 7509.0 7521.1 7529.7 7585.7 7713.5 4061.6 4161.8 4207.2 4208.7 4209.3 3603.6 3646.7 3702.1 3727.4 3765.8 597.8 657.9 672.2 687.5 695.9 616.4 623.8 636.6 662.7 670.3 9386.9 9750.8 9974.4 10022.0 10217.6 599.4 624.5 638.8 684.6 690.1 4833.0 4898.5 4936.9 4938.3 4939.4 78727.0 94155.0 96959.5 97489.0 99873.0 49114.0 78312.2 80533.6 86375.0 86961.1 65727.3 67096.7 67176.7 68001.7 69752.7 10565.0 10574.9 10704.6 10789.9 10820.1 44005.6 44778.9 45392.6 45433.5 45708.5 42239.8 55053.7 55753.4 56215.7 57808.0 12904.5 13116.7 13221.8 13955.7 14145.8 11566.2 11628.8 14018.9 14025.3 14130.9 10742.3 12933.2 13157.0 13191.7 13202.2 12430.3 13249.3 13539.6 13716.2 13830.9 12617.2 12741.5 12792.6 13316.4 13609.3 10535.9 10551.9 10897.7 10932.5 11276.2 8832.8 9016.9 10573.7 10653.0 10701.5 05:26:42 INFO - PROCESS | 1638 | -------- Summary: end -------- 05:26:42 INFO - PROCESS | 1638 | 05:26:43 INFO - TEST-INFO | 1638: exit 0 05:26:43 INFO - TEST-OK | dromaeo_css | took 1116314ms 05:26:43 INFO - TEST-START | kraken 05:26:43 INFO - operating with platform_type : mac_ 05:26:43 INFO - Initialising browser for kraken test... 05:26:43 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpySnXyl/profile http://localhost:49251/getInfo.html) 05:26:46 INFO - PROCESS | 1650 | 2017-02-15 05:26:46.374 plugin-container[1652:10542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a3b, name = 'com.apple.tsm.portname' 05:26:46 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:26:46 INFO - PROCESS | 1650 | 2017-02-15 05:26:46.375 plugin-container[1652:10542] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 05:26:46 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:26:46 INFO - PROCESS | 1650 | 2017-02-15 05:26:46.375 plugin-container[1652:10542] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:26:46 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 05:26:46 INFO - PROCESS | 1650 | colorDepth:24 05:26:46 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 05:26:46 INFO - PROCESS | 1650 | __metrics 05:26:46 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:26:47 INFO - TEST-INFO | 1650: exit 0 05:26:47 INFO - Browser initialized. 05:26:47 INFO - Running cycle 1/1 for kraken test... 05:26:47 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/T/tmpySnXyl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:49 INFO - PROCESS | 1653 | 2017-02-15 05:26:49.810 plugin-container[1654:10660] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 05:26:49 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:26:49 INFO - PROCESS | 1653 | 2017-02-15 05:26:49.811 plugin-container[1654:10660] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d1b, name = 'com.apple.CFPasteboardClient' 05:26:49 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:26:49 INFO - PROCESS | 1653 | 2017-02-15 05:26:49.811 plugin-container[1654:10660] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:26:59 INFO - PROCESS | 1653 | RSS: Main: 233754624 05:26:59 INFO - PROCESS | 1653 | 05:27:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:03 INFO - PROCESS | 1653 | RSS: Main: 248614912 05:27:03 INFO - PROCESS | 1653 | 05:27:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 05:27:06 INFO - PROCESS | 1653 | RSS: Main: 255979520 05:27:06 INFO - PROCESS | 1653 | 05:27:10 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 05:27:10 INFO - PROCESS | 1653 | RSS: Main: 258600960 05:27:10 INFO - PROCESS | 1653 | 05:27:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 05:27:13 INFO - PROCESS | 1653 | RSS: Main: 259796992 05:27:13 INFO - PROCESS | 1653 | 05:27:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:16 INFO - PROCESS | 1653 | RSS: Main: 260173824 05:27:16 INFO - PROCESS | 1653 | 05:27:19 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:19 INFO - PROCESS | 1653 | RSS: Main: 265011200 05:27:19 INFO - PROCESS | 1653 | 05:27:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 05:27:23 INFO - PROCESS | 1653 | RSS: Main: 264675328 05:27:23 INFO - PROCESS | 1653 | 05:27:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 05:27:27 INFO - PROCESS | 1653 | RSS: Main: 264597504 05:27:27 INFO - PROCESS | 1653 | 05:27:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:27:29 INFO - PROCESS | 1653 | RSS: Main: 265654272 05:27:29 INFO - PROCESS | 1653 | 05:27:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:27:31 INFO - PROCESS | 1653 | RSS: Main: 265580544 05:27:31 INFO - PROCESS | 1653 | 05:27:34 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:27:34 INFO - PROCESS | 1653 | RSS: Main: 265887744 05:27:34 INFO - PROCESS | 1653 | 05:27:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:27:38 INFO - PROCESS | 1653 | RSS: Main: 266039296 05:27:38 INFO - PROCESS | 1653 | 05:27:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:27:42 INFO - PROCESS | 1653 | RSS: Main: 265879552 05:27:42 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 05:27:44 INFO - PROCESS | 1653 | RSS: Main: 267780096 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | __start_tp_report 05:27:44 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 05:27:44 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 05:27:44 INFO - PROCESS | 1653 | |i|pagename|runs| 05:27:44 INFO - PROCESS | 1653 | |0;ai-astar;102;118;115;118;118;117;120;118;118;118 05:27:44 INFO - PROCESS | 1653 | |1;audio-beat-detection;144;118;115;150;115;118;113;136;163;116 05:27:44 INFO - PROCESS | 1653 | |2;audio-dft;200;204;206;206;251;285;267;199;193;199 05:27:44 INFO - PROCESS | 1653 | |3;audio-fft;83;64;63;90;62;60;60;67;95;83 05:27:44 INFO - PROCESS | 1653 | |4;audio-oscillator;92;71;87;72;73;72;83;93;103;114 05:27:44 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;89;92;90;90;102;104;91;117;82;134 05:27:44 INFO - PROCESS | 1653 | |6;imaging-darkroom;98;101;97;115;123;101;98;117;154;108 05:27:44 INFO - PROCESS | 1653 | |7;imaging-desaturate;117;108;92;107;93;93;94;94;94;93 05:27:44 INFO - PROCESS | 1653 | |8;json-parse-financial;62;63;64;62;64;64;64;63;63;62 05:27:44 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;68;74;82;78;74;69;69;69;68;71 05:27:44 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;90;89;91;102;101;121;110;111;86;91 05:27:44 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;145;148;158;183;161;153;146;147;191;183 05:27:44 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;177;181;177;213;242;173;176;211;253;198 05:27:44 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;70;78;87;94;69;74;74;62;86;59 05:27:44 INFO - PROCESS | 1653 | __end_tp_report 05:27:44 INFO - PROCESS | 1653 | __start_cc_report 05:27:44 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1006 05:27:44 INFO - PROCESS | 1653 | __end_cc_report 05:27:44 INFO - PROCESS | 1653 | __startTimestamp1487165264558__endTimestamp 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | ------- Summary: start ------- 05:27:44 INFO - PROCESS | 1653 | Number of tests: 14 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:116.20 Median:118.00 stddev:5.14 (4.4%) stddev-sans-first:1.30 05:27:44 INFO - PROCESS | 1653 | Values: 102.0 118.0 115.0 118.0 118.0 117.0 120.0 118.0 118.0 118.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:128.80 Median:127.00 stddev:18.04 (14.2%) stddev-sans-first:18.28 05:27:44 INFO - PROCESS | 1653 | Values: 144.0 118.0 115.0 150.0 115.0 118.0 113.0 136.0 163.0 116.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:221.00 Median:206.00 stddev:33.41 (16.2%) stddev-sans-first:34.56 05:27:44 INFO - PROCESS | 1653 | Values: 200.0 204.0 206.0 206.0 251.0 285.0 267.0 199.0 193.0 199.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:72.70 Median:75.00 stddev:13.53 (18.0%) stddev-sans-first:13.83 05:27:44 INFO - PROCESS | 1653 | Values: 83.0 64.0 63.0 90.0 62.0 60.0 60.0 67.0 95.0 83.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:78.00 stddev:14.73 (18.9%) stddev-sans-first:15.47 05:27:44 INFO - PROCESS | 1653 | Values: 92.0 71.0 87.0 72.0 73.0 72.0 83.0 93.0 103.0 114.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:99.10 Median:89.50 stddev:15.80 (17.7%) stddev-sans-first:16.33 05:27:44 INFO - PROCESS | 1653 | Values: 89.0 92.0 90.0 90.0 102.0 104.0 91.0 117.0 82.0 134.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:111.20 Median:138.50 stddev:17.60 (12.7%) stddev-sans-first:18.01 05:27:44 INFO - PROCESS | 1653 | Values: 98.0 101.0 97.0 115.0 123.0 101.0 98.0 117.0 154.0 108.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:98.50 Median:93.00 stddev:8.81 (9.5%) stddev-sans-first:6.31 05:27:44 INFO - PROCESS | 1653 | Values: 117.0 108.0 92.0 107.0 93.0 93.0 94.0 94.0 94.0 93.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.50 stddev:0.88 (1.4%) stddev-sans-first:0.83 05:27:44 INFO - PROCESS | 1653 | Values: 62.0 63.0 64.0 62.0 64.0 64.0 64.0 63.0 63.0 62.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:72.50 stddev:4.76 (6.6%) stddev-sans-first:4.80 05:27:44 INFO - PROCESS | 1653 | Values: 68.0 74.0 82.0 78.0 74.0 69.0 69.0 69.0 68.0 71.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:99.20 Median:87.50 stddev:11.74 (13.4%) stddev-sans-first:11.97 05:27:44 INFO - PROCESS | 1653 | Values: 90.0 89.0 91.0 102.0 101.0 121.0 110.0 111.0 86.0 91.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:161.50 Median:159.50 stddev:17.59 (11.0%) stddev-sans-first:17.61 05:27:44 INFO - PROCESS | 1653 | Values: 145.0 148.0 158.0 183.0 161.0 153.0 146.0 147.0 191.0 183.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.10 Median:204.50 stddev:29.04 (14.2%) stddev-sans-first:29.58 05:27:44 INFO - PROCESS | 1653 | Values: 177.0 181.0 177.0 213.0 242.0 173.0 176.0 211.0 253.0 198.0 05:27:44 INFO - PROCESS | 1653 | 05:27:44 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:76.00 stddev:11.17 (14.7%) stddev-sans-first:11.68 05:27:44 INFO - PROCESS | 1653 | Values: 70.0 78.0 87.0 94.0 69.0 74.0 74.0 62.0 86.0 59.0 05:27:44 INFO - PROCESS | 1653 | -------- Summary: end -------- 05:27:44 INFO - PROCESS | 1653 | 05:27:45 INFO - TEST-INFO | 1653: exit 0 05:27:45 INFO - TEST-OK | kraken | took 62085ms 05:27:45 INFO - SUITE-END | took 1178s 05:27:45 INFO - Completed test suite (00:19:38) 05:27:45 INFO - javascript benchmark 05:27:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7204.477089861143, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2830.1226619747877, 3314.817685027324, 3353.01086179577, 3353.513740507628, 3418.3334249821287, 5024.417308547805, 5442.863928401782, 5573.442655734424, 5694.743736531856, 5708.971455142723, 5591.8602034949145, 5681.602287839853, 5761.683107429089, 5788.6816225107605, 5863.912041319373, 5188.948110518903, 5193.974030129844, 5274.287971123907, 5286.894262114755, 5358.892822143554, 5232.6075544334135, 5302.946970530304, 5341.092014357569, 5363.704996225206, 5380.7309634518315, 5103.132467480537, 5329.360476742777, 5332.120200166968, 5367.838964831061, 5378.757955891974, 5113.539781419653, 5138.486151384869, 5178.352705911761, 5239.895202095937, 5293.814716484943, 5184.792608295664, 5219.138842091051, 5224.9738751306, 5253.264542963988, 5272.4200337963175, 4317.84887528935, 5591.74837132326, 5711.914321285184, 5773.134029895507, 5802.071668533014, 6125.2659746757545, 6126.142340072393, 6202.472789812826, 6251.4061164189325, 6292.056191571255, 6246.312905580383, 6265.530085243579, 6276.278228003793, 6292.779752708633, 6294.307626161119, 5898.941010589882, 5908.438698323738, 5914.940850591525, 5959.731812068424, 5963.254593175853, 6157.9384206158265, 6198.504119670415, 6245.843853903689, 6285.465735412541, 6286.308506064329, 5121.129408000649, 6119.99004232014, 6188.350223226586, 6203.0, 6215.564910456224, 6233.096201050913, 6267.0, 6268.341824108494, 6276.152719382916, 6281.466075383552, 6077.969610151921, 6091.08633704939, 6129.05316799051, 6186.319504854462, 6262.655553944485, 5197.22041693749, 6281.152044473937, 6282.434580887742, 6293.77971770995, 6314.273858506239, 4998.475160108136, 5002.1496345621335, 5002.199648056294, 5022.673526220784, 5028.145215313405, 4344.826206951687, 4375.190589740844, 4381.036172042146, 4413.337999300131, 4449.243628583149, 5799.3040835100055, 5872.647641141545, 5904.498117659961, 5922.111683247461, 5935.584509084322, 6221.129041934133, 6254.2807577129215, 6288.8427789304715, 6305.8108256752375, 6329.525285603599, 5627.184058311522, 5783.248177736868, 5831.533477321889, 5855.38518455556, 5880.588358814927, 5354.705491198021, 5484.643498172606, 5506.0089183947275, 5524.502794748411, 5584.134459158837, 6285.057241413641, 6316.2736285326855, 6328.778492752732, 6332.366763323631, 6356.014817703263, 5933.486960824962, 6000.939990600038, 6271.62370257786, 6272.5922815016875, 6279.0, 6164.167837342081, 6224.439800417984, 6231.688415579112, 6255.96872015637, 6293.590916590407, 6253.843653908689, 6283.717232724447, 6298.244210694746, 6313.842153946188, 6337.144485494399, 5781.0, 6275.52933529978, 6284.057391391328, 6290.24517057956, 6290.748370065146, 5388.919166212431, 5673.177389278449, 6088.786892458743, 6132.630864714964, 6281.811545653638, 4987.451380348231, 6131.835460087213, 6133.671320645445, 6220.564560480723, 6245.0, 5819.330776960704, 5946.583739138218, 6022.789202378071, 6060.606060606046, 6096.969515152396, 6051.334353221054, 6106.06632622643, 6125.082842094376, 6198.349173336735, 6256.906146407899, 6002.669853157943, 6027.758889644365, 6048.8349045563255, 6107.572469927062, 6151.415615516519], "value": 5697.751880939132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.65346376362675, 489.44203607887005, 515.646781954361, 523.0950455711619, 539.7921800106958, 35427.93716188515, 38691.41962870559, 39775.80112099442, 39881.601183988154, 39907.0, 32334.19164520888, 42095.0, 42120.15759684812, 42245.366319505156, 42287.57712422875, 9234.353595248353, 10904.781904361907, 11373.431328433586, 11457.312561246352, 11568.016718578889, 11138.721531961724, 11203.551857925713, 11256.324620522753, 11262.155338349616, 11268.985791278783, 11303.208775385727, 11313.151513636469, 11329.150313726463, 11360.715982100472, 11394.772104557904, 11225.943870280678, 11251.212415130944, 11285.0, 11297.943510282477, 11310.37792921389, 9530.761730956712, 11221.495032723547, 11288.54845806175, 11298.491567879382, 11305.49125289364, 35964.460533092024, 36077.45883811745, 36204.27591448183, 36218.0, 36327.0, 3748.7563308385143, 3804.771713697187, 3809.561900381464, 3812.656860882506, 3821.6942644588366, 27646.861765691243, 27935.720642793516, 27997.44005119886, 28056.01803936873, 28421.147365579065, 2726.836389816617, 3018.2303512604367, 3082.475979083561, 3120.89076882308, 3121.453745594512, 443627.0, 446066.0, 448260.0, 448928.0, 450362.0, 40440.79779601142, 43560.78219608945, 45927.540724593, 52671.0, 52776.944461110565, 48881.755591221816, 55482.89034219293, 58565.65737370458, 58800.70599646975, 59085.70457147687, 14252.501162459472, 14385.928070359581, 14392.424303027761, 14422.711545769025, 14459.710805783825, 11005.669829904955, 11142.61000864982, 11184.720381990515, 11237.0, 11271.718207044889, 17616.823831761518, 17625.383111591033, 17640.823591764176, 17645.558861028578, 17713.911430442764, 7613.314801667876, 7726.652300646372, 7783.275853451247, 7786.0, 7795.934077469475, 831.966721331152, 838.7357982235576, 842.0905422144069, 857.2627540315324, 861.586438509519, 21992.0, 28428.71571284302, 28942.855285723435, 29071.12786616405, 29598.704012959595, 998.9051040151174, 1012.099231683802, 1043.546057465005, 1052.484282701486, 1180.7756526259984, 13435.731285374237, 14193.361298741582, 14777.335019924129, 14821.555353339418, 14887.95784295089, 586511.0, 591967.0401647964, 592228.0, 592354.0, 593715.0, 57749.711251444314, 58033.70983145057, 58264.41735582675, 58589.707051465324, 58651.12023319654, 1325.8939284857188, 1333.7532556477083, 1343.563341913882, 1353.451851999922, 1372.8146700195346, 26124.73875261223, 29072.461890357547, 29241.222083901994, 29418.558721618763, 29501.96743113981, 48409.0, 48743.025139497724, 49054.509454905, 49213.0, 49362.50637493723, 433276.0, 491193.0, 491865.0, 493542.53228733625, 494013.0, 25174.370640734127, 26171.345716357242, 26333.604995924692, 26349.73650263473, 26382.07662731795, 44678.776606116764, 44793.552064478936, 45909.77045114753, 46120.769396152806, 46135.53864461312, 36501.26997460089, 36838.26323473462, 37102.58833175835, 37738.43392349172, 37857.81071094737, 34327.65672343245, 36501.26997460089, 37426.25147497089, 37586.436203456426, 37680.43479347757, 35230.0, 36163.81918090393, 36177.0, 36373.0, 36892.81553592215, 26559.07043253477, 28673.0, 31206.0, 32935.0, 33493.49759753557, 24240.878795606615, 24433.877830610734, 24481.877590612647, 24574.468612566703, 24587.508249834544], "value": 19319.995151334995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.0315335952196, 386.6365616320658, 390.5313623651618, 398.20756694178584, 417.36352063103783, 16634.251458684357, 17568.736468952942, 19723.605527889435, 20540.691889621667, 21170.470738231554, 20222.494437639067, 21098.89450552749, 21130.15479380827, 21624.0, 21900.0, 5205.609579281569, 5415.079436495796, 5820.388859169769, 6096.993995990679, 6219.440250377465, 6122.265328160627, 6130.63216207029, 6142.600730952474, 6164.5376596755195, 6314.7789827356055, 6828.419584335337, 6837.794866154023, 6885.173779146509, 6902.861942761167, 6932.826679333007, 5066.822661206877, 6085.265699275686, 6140.9385906140815, 6887.7244910203535, 6902.6203558804245, 5012.323336349619, 6024.427679370453, 6033.09503574463, 6067.817965461043, 6080.087986801971, 11064.889351106467, 13387.464501419932, 13464.5287414941, 13709.725805483935, 13729.038967272294, 2458.704955405363, 2539.9238022859345, 2546.376137846221, 2593.533164030474, 2603.5834266517268, 7933.365330773524, 9781.510924453749, 9991.250656200815, 10286.897131028669, 10411.843822342671, 1794.605186858889, 1807.268056437145, 1807.6384723055442, 1816.636672665459, 1868.551547628573, 108056.37915431274, 134896.0, 136663.0, 138694.0, 139301.0, 8708.869366959501, 10806.891931080745, 11742.70643233926, 11865.525378984745, 12090.335031573348, 15575.0, 15615.141167235684, 15660.0, 15693.607659808597, 16451.341946322013, 8148.185181481923, 8382.87425688615, 8396.454230475, 8495.74512764618, 8512.872306915402, 7852.646630901623, 7976.880346794803, 7992.600369981477, 8010.3191228745045, 8145.185481451807, 4848.272759086165, 4851.611871050378, 4862.78117484714, 4875.024995000943, 4945.826896058693, 1685.612309168898, 2069.6481598128353, 2078.6674132138787, 2082.063071617748, 2083.19796878203, 967.7580604848788, 1002.9147522460527, 1003.2024540490328, 1009.5709323537467, 1037.9221558383151, 20404.183832646824, 22064.558708825734, 22064.88967555152, 22074.779252207594, 22083.0, 878.9759929681977, 1011.2567263061644, 1023.7952409518126, 1039.3711804358254, 1052.3633201912885, 10740.0, 10973.83539246912, 11312.94343528277, 11377.838517682363, 11490.482928268248, 616115.0, 620337.0, 654679.0, 656637.0, 668601.0, 133536.0, 135390.5226634146, 136626.0, 138252.0, 138943.0, 1009.6668099527138, 1033.2818691009827, 1053.1416895230516, 1056.5298442193305, 1059.06802014227, 18363.816361836212, 18788.906055469633, 19705.70441443351, 20109.798902010793, 20903.237417265038, 59490.40509594849, 59640.0, 59915.0, 60439.69780151247, 60520.39479605148, 77900.0, 78944.60527697325, 81743.0, 82726.58636706778, 85302.57348713216, 7422.851542969002, 7743.4966727162555, 8431.620577074169, 8464.957675211585, 8912.108789121296, 12580.0, 13142.934285328512, 13382.13016153947, 13449.865501345254, 13655.361356637268, 11138.3873886937, 11338.14963877729, 11523.769524609628, 11527.538898444303, 11765.823512647488, 10395.428251446243, 10548.419836909045, 10697.465126743788, 11197.888021119685, 11206.83189752138, 11477.311361318347, 11599.536018559163, 11783.646490605295, 11889.048876089719, 11921.403929803648, 7149.785506434815, 7711.151773305044, 7721.806954826175, 7794.738228613199, 7982.321502672105, 8361.540115293474, 10279.794404112026, 11316.660500185008, 11523.711907202387, 11671.941640291745], "value": 9709.706999670752, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.1953949472338, 1441.300969030021, 1451.5935538049343, 1454.1783892100962, 1473.2780937340706, 8158.4696994695305, 8413.36899732521, 8592.484450932941, 8595.656173753057, 8617.87073193901, 8412.663493460253, 8553.0, 8566.614502347395, 8601.225889669928, 8623.568821558913, 2217.4899773052207, 2260.8643481391086, 2270.738865030526, 2271.818254539641, 2272.988635056831, 2215.401841502793, 2248.5278091600785, 2262.298687406901, 2287.748347681754, 2346.7887890089887, 2253.8309626777977, 2256.571251462217, 2286.588414085464, 2290.015293423827, 2296.47181148336, 2233.542123864604, 2250.291158285143, 2257.2663884237604, 2270.8069814065743, 2272.216085450517, 1822.5534743987675, 1932.391296741536, 2097.3603051069417, 2281.269993602048, 2306.123673004264, 8323.500589964622, 8441.535715535643, 8538.70114545988, 8541.273991710712, 8556.315494760403, 5059.2916991621205, 5196.662216955886, 5225.268462415265, 5226.398964119099, 5227.660202086852, 3421.2473255883665, 3431.588209414886, 3447.3105378924065, 3488.284901595167, 3501.459357882549, 1220.9389530523526, 1221.9511219551207, 1258.874112588743, 1271.9824140687413, 1274.3882936190587, 10737.731556711067, 10826.188035897261, 10857.565697372096, 10944.507497162567, 10975.451227438596, 4308.46144231971, 4624.28323609841, 4705.529447055335, 4707.340972263886, 4725.8582242532775, 9654.565544550513, 9682.612695492242, 9715.854262186072, 9717.757056073655, 9740.951295243478, 5174.922376164361, 5237.711925844039, 5249.9237656280375, 5252.212168174804, 5261.158214685632, 4524.23088075028, 4723.102610503994, 4732.929006064912, 4767.332573439721, 4802.615790736732, 3795.525559305087, 3828.636279553438, 3902.31709450845, 3918.706097042676, 3938.5864484229314, 1112.6439539347332, 1233.3155098920186, 1235.5922545559943, 1258.1256027061104, 1275.6364436135843, 731.8975343451921, 732.1360794262714, 756.3759898084103, 760.395485588947, 793.1711361627114, 5000.849804544975, 5256.369235691742, 5418.160185171305, 5492.956338295711, 5558.9715902558155, 483.5188986957999, 485.6988667026466, 562.693332133988, 566.2553741829481, 576.5474102829343, 3395.1172695099453, 3586.6234045425376, 3644.398674218777, 3669.7064234861145, 3715.145516531159, 8519.23326900582, 9667.27495437845, 10016.248781341428, 10019.649312274036, 10050.195984321383, 10011.149052330633, 10021.79956400868, 10026.799464010679, 10029.04724051214, 10039.749006274755, 7603.771886843404, 7746.457747957589, 7909.960450197827, 7937.563434011069, 7944.086430060617, 4562.58936695699, 5126.6926933631685, 5205.427402985744, 5209.322788037531, 5278.208268759717, 8894.822103558023, 9003.234725048444, 9092.454452732858, 9237.07629237071, 9261.583228754856, 7671.347935425551, 9367.812643747224, 9452.243820494481, 9483.193928516153, 9501.334906556474, 6114.296855861455, 7151.499395042505, 7272.672729727069, 7282.162551306667, 7290.416766658548, 7041.295870412918, 7504.986826778533, 7919.326857217201, 7931.2068793120225, 7934.047914250327, 7002.964985175042, 7095.716171353294, 7118.074650295428, 7160.0, 7256.23809500016, 6988.580685158907, 7012.5792452453015, 7043.496910178305, 7055.400290975324, 7100.644967751695, 6210.689465526796, 6299.212598425197, 6340.809775706736, 6346.2067241594805, 6378.553501254868, 4201.474815648044, 4233.364995250614, 4288.228118938497, 4300.376445415334, 4396.538363471917, 3558.323918455485, 4530.275155975029, 4719.244920812654, 4855.34452848875, 4964.404271487445], "value": 4271.365717539856, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2742599196948, 302.7335944368955, 366.88993302009425, 367.746255083992, 368.29839156407036, 4792.9281060784115, 5576.693281869496, 5584.972075139629, 5610.915836262454, 5617.775288988436, 5000.174971129759, 5047.419546752125, 5082.847514574569, 5196.856691527858, 5537.446255374471, 3952.367621180612, 4098.323776576861, 4135.0, 4200.243956087903, 4206.221848957937, 3353.830630054599, 3716.754887112807, 3907.199024200032, 4159.9376009359885, 4168.208040472316, 3664.725145614076, 3828.827702753369, 4143.274926887798, 4144.725666723285, 4196.643285320752, 3307.4212012897647, 4016.6585840203616, 4120.423140760296, 4187.392828039932, 4204.411382406465, 3282.885099021523, 3316.403047451458, 3366.4781958796425, 3377.3619794399697, 3545.2732189901008, 4435.933460998088, 5122.334096567422, 5288.576913846883, 5329.653572517774, 5358.27663265462, 4007.2786898358286, 4061.6953728470485, 4220.050488640062, 4537.275835182642, 4917.262410638397, 4894.706317620954, 5178.922316165261, 5750.194972703783, 5786.334571524244, 5789.2763404574425, 3307.8842240521467, 3573.535440392758, 3586.0, 3625.274945011008, 3930.9779457341297, 4734.366643508019, 5285.947140528622, 5771.797987070474, 6103.551493406256, 6129.785457508966, 4080.6327430531396, 4285.485741710952, 4297.742135471819, 4299.78501074945, 4302.204092242945, 3663.4871118043493, 3680.2271522980473, 4363.80362883671, 4380.189664912002, 4393.297072468454, 4046.9190616188102, 4252.702310838212, 4996.400431948116, 4999.500049995044, 5025.296458495814, 5247.003069416799, 5331.733413329318, 5419.918701219485, 5787.71061446926, 5891.672789248223, 1352.6956434802287, 1356.559118286541, 1427.8429372768987, 1431.4202747887123, 1437.2238990944982, 949.4967667136428, 959.5106495687111, 1000.7448100734266, 1002.6991902429243, 1012.9898701012895, 5077.466865979093, 5088.346287456591, 5208.9739551302, 5239.633225674166, 5247.737613119329, 5807.651540907559, 5810.331811841608, 5814.16853691086, 5814.79648212319, 5820.534357251409, 4195.58044195578, 4829.420469543677, 5209.322788037531, 5217.58259339252, 5234.319538459976, 2681.209043332222, 2759.1998320487237, 2926.5317549192027, 2931.472334979724, 3030.606021217228, 5726.9713651431475, 5869.501092407193, 5985.0, 6002.698515816283, 6019.428154325332, 4546.590806827401, 5900.498457631149, 5958.374370691102, 5975.6694888993325, 5994.201739478139, 5160.561352285098, 5291.629585928948, 5672.262605861211, 5741.770329186869, 5993.3706960768495, 4970.453250142554, 5103.18349064148, 5808.767649293981, 6026.879462410815, 6033.758649653964, 5517.613767036269, 5679.630823996427, 5893.4952645124795, 5924.377940316377, 5930.466258036798, 5504.53211477029, 6178.876422471615, 6184.288806787277, 6201.635640159157, 6201.961039090903, 4208.885424785575, 4252.362145678049, 4252.7023108383355, 4263.211305908417, 4279.657627389864, 4319.697621166614, 5392.406835248198, 5907.2911250650195, 5974.372690867396, 6035.646098021687, 5292.41783403833, 5582.441755824385, 5814.395075053494, 5854.297484301911, 5866.794662186803, 5295.993761185362, 5423.62034657586, 5794.942050579441, 5804.920694392406, 5811.883762324815, 5455.881544283333, 5643.7742490299925, 5667.376588575171, 5677.630953987978, 5700.401457846866, 4460.1971645104195, 5031.396232452129, 5109.591232701449, 5441.972790136182, 5817.941820581909, 5377.9141957465845, 5522.917156242579, 5590.86022849432, 5690.0, 5697.803461273013], "value": 4183.719472577696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [692.2938602625319, 701.3022043067152, 748.1807420874144, 771.8537971112896, 771.969420823201, 13530.797038044426, 14315.856841431596, 14516.693497585215, 15266.847331526682, 15371.615709607266, 13560.728785424286, 14308.785368219485, 14348.641283967907, 14387.280635968213, 14420.0, 743.438703778649, 876.2332958661171, 890.1676932068505, 892.6027917576681, 892.8660700894853, 842.1157784326464, 897.5915958238986, 899.5951821680237, 906.5557876640431, 918.6371383303591, 953.323140570196, 957.3203025851653, 958.314804914486, 959.52023988006, 959.8608201810733, 940.7412961435591, 951.46242373059, 951.980960380792, 952.4761381240324, 952.5665822050951, 704.4153352717284, 709.737397163053, 709.7728726807424, 710.4813486155135, 711.7793484019919, 14519.70960580793, 15154.772678409832, 15196.46812361573, 15248.466303679317, 15250.3137358818, 13627.04610677253, 14035.929820350833, 14043.297835108204, 14059.226742529157, 14095.859041409558, 11431.942840285828, 11493.367864767435, 11647.35939523326, 11940.223885447505, 12223.75552488954, 3313.2082205632973, 3514.4728290756334, 3662.10278481771, 3699.223163135745, 3805.82873770681, 99365.50317248367, 100177.0, 100549.497252514, 101093.4945325276, 103399.44900826494, 10589.0, 10775.892241077489, 10786.70634920635, 10802.121526347915, 11034.503447344889, 22182.667259991114, 22183.0, 22281.331560053226, 22365.888170559043, 22402.775972240393, 7508.962455187689, 7521.0974683038385, 7529.698812047566, 7585.6965721371635, 7713.537187768752, 4061.614146656063, 4161.771102589387, 4207.179599977975, 4208.684348673801, 4209.305464598368, 3603.5855876574005, 3646.7082633389796, 3702.148505843671, 3727.366347720894, 3765.8493660253284, 597.7507010348306, 657.8980258060009, 672.1564436631995, 687.4500399680236, 695.8851789454784, 616.3682225718675, 623.8440389902524, 636.5512313818747, 662.68522451835, 670.3196255800367, 9386.90613093874, 9750.756231094138, 9974.40153590787, 10021.997800220066, 10217.591296348211, 599.3946114424463, 624.5128799536369, 638.8498702804837, 684.5584597934304, 690.1283797893811, 4833.009233107205, 4898.54224223873, 4936.913878946626, 4938.345654205881, 4939.407271127488, 78727.0, 94155.0, 96959.51520242354, 97489.0, 99873.0, 49114.0, 78312.21687783049, 80533.59733201413, 86375.0, 86961.13038869656, 65727.34272657403, 67096.6645166771, 67176.66411667911, 68001.65999169972, 69752.65123674349, 10565.0, 10574.889636588356, 10704.571817127227, 10789.946050269698, 10820.134389248684, 44005.55994440143, 44778.88052798706, 45392.63822085343, 45433.54566454293, 45708.54291457176, 42239.788801055794, 55053.72473137609, 55753.44246557482, 56215.71892140513, 57808.0, 12904.548340808027, 13116.672083197996, 13221.801672974721, 13955.651108722363, 14145.787813182606, 11566.248193867372, 11628.825567616661, 14018.859811401755, 14025.29873506341, 14130.929345353208, 10742.3017503862, 12933.159344642569, 13157.0, 13191.736165276832, 13202.207867527979, 12430.254184748945, 13249.337533123498, 13539.59381218565, 13716.24560649134, 13830.861691382957, 12617.242965422103, 12741.49034038628, 12792.552260671204, 13316.40076196554, 13609.251491168081, 10535.894641053492, 10551.894481055399, 10897.727556811144, 10932.508037138188, 11276.210665253682, 8832.823343532964, 9016.927245159257, 10573.735656608646, 10653.0, 10701.518431670438], "value": 7320.188486712057, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 118.0, 115.0, 118.0, 118.0, 117.0, 120.0, 118.0, 118.0, 118.0], "value": 116.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 118.0, 115.0, 150.0, 115.0, 118.0, 113.0, 136.0, 163.0, 116.0], "value": 128.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 204.0, 206.0, 206.0, 251.0, 285.0, 267.0, 199.0, 193.0, 199.0], "value": 221.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 64.0, 63.0, 90.0, 62.0, 60.0, 60.0, 67.0, 95.0, 83.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 71.0, 87.0, 72.0, 73.0, 72.0, 83.0, 93.0, 103.0, 114.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 90.0, 102.0, 104.0, 91.0, 117.0, 82.0, 134.0], "value": 99.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 101.0, 97.0, 115.0, 123.0, 101.0, 98.0, 117.0, 154.0, 108.0], "value": 111.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 92.0, 107.0, 93.0, 93.0, 94.0, 94.0, 94.0, 93.0], "value": 98.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 62.0, 64.0, 64.0, 64.0, 63.0, 63.0, 62.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 82.0, 78.0, 74.0, 69.0, 69.0, 69.0, 68.0, 71.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 91.0, 102.0, 101.0, 121.0, 110.0, 111.0, 86.0, 91.0], "value": 99.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 148.0, 158.0, 183.0, 161.0, 153.0, 146.0, 147.0, 191.0, 183.0], "value": 161.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 181.0, 177.0, 213.0, 242.0, 173.0, 176.0, 211.0, 253.0, 198.0], "value": 200.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 87.0, 94.0, 69.0, 74.0, 74.0, 62.0, 86.0, 59.0], "value": 75.3, "unit": "score"}]}]} 05:27:45 INFO - Return code: 0 05:27:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:27:45 ERROR - # TBPL SUCCESS # 05:27:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:27:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:27:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:27:45 INFO - 2017-02-15 05:27:45.887 screenresolution[1658:11046] starting screenresolution argv=screenresolution get 05:27:45 INFO - 2017-02-15 05:27:45.890 screenresolution[1658:11046] Display 0: 1600x1200x32@60 05:27:45 INFO - 2017-02-15 05:27:45.896 screenresolution[1659:11049] starting screenresolution argv=screenresolution list 05:27:45 INFO - Available Modes on Display 0 05:27:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:27:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:27:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:27:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:27:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:27:46 INFO - Intel Iris: 05:27:46 INFO - Chipset Model: Intel Iris 05:27:46 INFO - Type: GPU 05:27:46 INFO - Bus: Built-In 05:27:46 INFO - VRAM (Dynamic, Max): 1536 MB 05:27:46 INFO - Vendor: Intel (0x8086) 05:27:46 INFO - Device ID: 0x0a2e 05:27:46 INFO - Revision ID: 0x0009 05:27:46 INFO - Displays: 05:27:46 INFO - Display: 05:27:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:27:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:27:46 INFO - Display Serial Number: 1600x1200 60 05:27:46 INFO - Main Display: Yes 05:27:46 INFO - Mirror: Off 05:27:46 INFO - Online: Yes 05:27:46 INFO - Rotation: Supported 05:27:46 INFO - Return code: 0 05:27:46 INFO - Running post-action listener: _resource_record_post_action 05:27:46 INFO - [mozharness: 2017-02-15 13:27:46.141690Z] Finished run-tests step (success) 05:27:46 INFO - Running post-run listener: _resource_record_post_run 05:27:46 INFO - Total resource usage - Wall time: 1201s; CPU: 55.0%; Read bytes: 39389184; Write bytes: 557686784; Read time: 244; Write time: 1702 05:27:46 INFO - TinderboxPrint: CPU usage
54.6% 05:27:46 INFO - TinderboxPrint: I/O read bytes / time
39,389,184 / 244 05:27:46 INFO - TinderboxPrint: I/O write bytes / time
557,686,784 / 1,702 05:27:46 INFO - TinderboxPrint: CPU idle
2,179.4 (45.4%) 05:27:46 INFO - TinderboxPrint: CPU system
970.7 (20.2%) 05:27:46 INFO - TinderboxPrint: CPU user
1,655.6 (34.5%) 05:27:46 INFO - TinderboxPrint: Swap in / out
292,417,536 / 0 05:27:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 243124736; Write bytes: 237090816; Read time: 17643; Write time: 518 05:27:46 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 37386240; Write bytes: 301172736; Read time: 225; Write time: 1135 05:27:46 INFO - Running post-run listener: _upload_blobber_files 05:27:46 INFO - Blob upload gear active. 05:27:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:27:46 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 05:27:46 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'] 05:27:46 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 05:27:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:27:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:27:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:27:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:48 INFO - (blobuploader) - INFO - Done attempting. 05:27:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:27:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:27:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:49 INFO - (blobuploader) - INFO - Done attempting. 05:27:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:27:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:27:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:50 INFO - (blobuploader) - INFO - Done attempting. 05:27:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:27:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:27:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:27:52 INFO - (blobuploader) - INFO - Done attempting. 05:27:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:27:52 INFO - Return code: 0 05:27:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:27:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:27:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec57b8e762324fc4a49e1bf7bb13d9da9342f969cf0b71eef1b16979175c3330a5e3808e5633e733f1d0f6ca0585843f2149f777f24aaf807787a142ffa91dee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acd1992aca208887715a7f58c805b691a462ab494a7df01ba96190c35006ef0ce68b4dc1084da3e4ae277d99d824d96af4d7953efc4a775f991d790892d48e0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a48587a8ca5371c2ce39e4d7e2ca37fce203e76ccf28c393da47db61dd84fc4a4faa2d97306aa340d78eecd01ce5032c6788a38150c0ae26d3298569c09653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6b1e5d5c5901560a12441c8545f8f31cd16c631ea9e17fb9b745a375f43282209f901ad2bcc696a62f95425615f62302a8e44e0c6347c247ff315f183e67db"} 05:27:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:27:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:27:52 INFO - Contents: 05:27:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec57b8e762324fc4a49e1bf7bb13d9da9342f969cf0b71eef1b16979175c3330a5e3808e5633e733f1d0f6ca0585843f2149f777f24aaf807787a142ffa91dee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acd1992aca208887715a7f58c805b691a462ab494a7df01ba96190c35006ef0ce68b4dc1084da3e4ae277d99d824d96af4d7953efc4a775f991d790892d48e0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a48587a8ca5371c2ce39e4d7e2ca37fce203e76ccf28c393da47db61dd84fc4a4faa2d97306aa340d78eecd01ce5032c6788a38150c0ae26d3298569c09653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6b1e5d5c5901560a12441c8545f8f31cd16c631ea9e17fb9b745a375f43282209f901ad2bcc696a62f95425615f62302a8e44e0c6347c247ff315f183e67db"} 05:27:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:27:52 INFO - Copying logs to upload dir... 05:27:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:27:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.396774 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-02-15 05:27:52.665225) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 05:27:52.668983) ========= 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.KALZc6bHSo/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.WhTm5csnhd/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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/ec57b8e762324fc4a49e1bf7bb13d9da9342f969cf0b71eef1b16979175c3330a5e3808e5633e733f1d0f6ca0585843f2149f777f24aaf807787a142ffa91dee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acd1992aca208887715a7f58c805b691a462ab494a7df01ba96190c35006ef0ce68b4dc1084da3e4ae277d99d824d96af4d7953efc4a775f991d790892d48e0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a48587a8ca5371c2ce39e4d7e2ca37fce203e76ccf28c393da47db61dd84fc4a4faa2d97306aa340d78eecd01ce5032c6788a38150c0ae26d3298569c09653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6b1e5d5c5901560a12441c8545f8f31cd16c631ea9e17fb9b745a375f43282209f901ad2bcc696a62f95425615f62302a8e44e0c6347c247ff315f183e67db"} build_url:https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011303 build_url: 'https://queue.taskcluster.net/v1/task/ZlVYKox7TI2jAJP0BrY49g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec57b8e762324fc4a49e1bf7bb13d9da9342f969cf0b71eef1b16979175c3330a5e3808e5633e733f1d0f6ca0585843f2149f777f24aaf807787a142ffa91dee", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/acd1992aca208887715a7f58c805b691a462ab494a7df01ba96190c35006ef0ce68b4dc1084da3e4ae277d99d824d96af4d7953efc4a775f991d790892d48e0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12a48587a8ca5371c2ce39e4d7e2ca37fce203e76ccf28c393da47db61dd84fc4a4faa2d97306aa340d78eecd01ce5032c6788a38150c0ae26d3298569c09653", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce6b1e5d5c5901560a12441c8545f8f31cd16c631ea9e17fb9b745a375f43282209f901ad2bcc696a62f95425615f62302a8e44e0c6347c247ff315f183e67db"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-15 05:27:52.704027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:27:52.704367) ========= 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.KALZc6bHSo/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.WhTm5csnhd/Listeners TMPDIR=/var/folders/d7/7bqvmyhs3jdby27d06bbj7dh00000w/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.005241 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-15 05:27:52.752390) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 05:27:52.752705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-15 05:27:52.753021) ========= ========= Total master_lag: 0.73 =========