builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0026 starttime: 1489250316.21 results: success (0) buildid: 20170311080236 builduid: 1bb80191d4884421a932b85c3c74944b revision: 3154da520af568d4da3de62bc26fbf97a1317f51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.213997) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.214461) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.214836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.243509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.243912) ========= 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.0QIvb7QODi/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.kvDWkrt5wR/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-03-11 08:38:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 47.0M=0s 2017-03-11 08:38:36 (47.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164906 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.432063) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.432422) ========= 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.0QIvb7QODi/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.kvDWkrt5wR/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.020885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:36.481393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-11 08:38:36.481772) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3154da520af568d4da3de62bc26fbf97a1317f51 --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 3154da520af568d4da3de62bc26fbf97a1317f51 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0QIvb7QODi/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.kvDWkrt5wR/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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-03-11 08:38:36,568 truncating revision to first 12 chars 2017-03-11 08:38:36,568 Setting DEBUG logging. 2017-03-11 08:38:36,568 attempt 1/10 2017-03-11 08:38:36,568 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3154da520af5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-11 08:38:37,334 unpacking tar archive at: mozilla-central-3154da520af5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.018139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-11 08:38:37.524290) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:37.524635) ========= script_repo_revision: 3154da520af568d4da3de62bc26fbf97a1317f51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:37.525024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:37.525290) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-11 08:38:37.545039) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-11 08:38:37.545362) ========= /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.0QIvb7QODi/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.kvDWkrt5wR/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:38:37 INFO - MultiFileLogger online at 20170311 08:38:37 in /builds/slave/test 08:38:37 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 08:38:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:38:37 INFO - {'append_to_log': False, 08:38:37 INFO - 'base_work_dir': '/builds/slave/test', 08:38:37 INFO - 'blob_upload_branch': 'Firefox', 08:38:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:38:37 INFO - 'branch': 'Firefox', 08:38:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:38:37 INFO - 'config_files': ('talos/mac_config.py',), 08:38:37 INFO - 'default_actions': ('clobber', 08:38:37 INFO - 'read-buildbot-config', 08:38:37 INFO - 'download-and-extract', 08:38:37 INFO - 'populate-webroot', 08:38:37 INFO - 'create-virtualenv', 08:38:37 INFO - 'install', 08:38:37 INFO - 'run-tests'), 08:38:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:38:37 INFO - 'download_minidump_stackwalk': True, 08:38:37 INFO - 'download_symbols': 'ondemand', 08:38:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:38:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:38:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:38:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:38:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:38:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:38:37 INFO - 'gecko_profile': False, 08:38:37 INFO - 'gecko_profile_interval': 0, 08:38:37 INFO - 'installer_path': 'installer.exe', 08:38:37 INFO - 'log_level': 'info', 08:38:37 INFO - 'log_name': 'talos', 08:38:37 INFO - 'log_to_console': True, 08:38:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:38:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:38:37 INFO - 'opt_config_files': (), 08:38:37 INFO - 'pip_index': False, 08:38:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:37 INFO - 'cmd': ('bash', 08:38:37 INFO - '-c', 08:38:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:37 INFO - 'enabled': True, 08:38:37 INFO - 'halt_on_failure': False, 08:38:37 INFO - 'name': 'check_screen_resolution'},), 08:38:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:38:37 INFO - 'cmd': ('bash', 08:38:37 INFO - '-c', 08:38:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:38:37 INFO - 'enabled': True, 08:38:37 INFO - 'halt_on_failure': False, 08:38:37 INFO - 'name': 'check_screen_resolution'},), 08:38:37 INFO - 'run_cmd_checks_enabled': True, 08:38:37 INFO - 'suite': 'dromaeojs-e10s', 08:38:37 INFO - 'system_bits': '32', 08:38:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:38:37 INFO - 'title': 't-yosemite-r7-0026', 08:38:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:38:37 INFO - 'use_talos_json': True, 08:38:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:38:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:38:37 INFO - 'work_dir': 'build'} 08:38:37 INFO - [mozharness: 2017-03-11 16:38:37.760321Z] Running clobber step. 08:38:37 INFO - Running pre-action listener: _resource_record_pre_action 08:38:37 INFO - Running main action method: clobber 08:38:37 INFO - rmtree: /builds/slave/test/build 08:38:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:38:40 INFO - Running post-action listener: _resource_record_post_action 08:38:40 INFO - [mozharness: 2017-03-11 16:38:40.953198Z] Finished clobber step (success) 08:38:40 INFO - [mozharness: 2017-03-11 16:38:40.953325Z] Running read-buildbot-config step. 08:38:40 INFO - Running pre-action listener: _resource_record_pre_action 08:38:40 INFO - Running main action method: read_buildbot_config 08:38:40 INFO - Using buildbot properties: 08:38:40 INFO - { 08:38:40 INFO - "project": "", 08:38:40 INFO - "product": "firefox", 08:38:40 INFO - "script_repo_revision": "production", 08:38:40 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 08:38:40 INFO - "repository": "", 08:38:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 08:38:40 INFO - "buildid": "20170311080236", 08:38:40 INFO - "pgo_build": "False", 08:38:40 INFO - "basedir": "/builds/slave/test", 08:38:40 INFO - "buildnumber": 168, 08:38:40 INFO - "slavename": "t-yosemite-r7-0026", 08:38:40 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:38:40 INFO - "platform": "yosemite_r7", 08:38:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:38:40 INFO - "branch": "mozilla-central", 08:38:40 INFO - "repo_path": "mozilla-central", 08:38:40 INFO - "revision": "3154da520af568d4da3de62bc26fbf97a1317f51", 08:38:40 INFO - "stage_platform": "macosx64", 08:38:40 INFO - "builduid": "1bb80191d4884421a932b85c3c74944b", 08:38:40 INFO - "slavebuilddir": "test" 08:38:40 INFO - } 08:38:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:38:40 INFO - Running post-action listener: _resource_record_post_action 08:38:40 INFO - [mozharness: 2017-03-11 16:38:40.956666Z] Finished read-buildbot-config step (success) 08:38:40 INFO - [mozharness: 2017-03-11 16:38:40.956797Z] Running download-and-extract step. 08:38:40 INFO - Running pre-action listener: _resource_record_pre_action 08:38:40 INFO - Running main action method: download_and_extract 08:38:40 INFO - mkdir: /builds/slave/test/build/tests 08:38:40 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')]} 08:38:40 INFO - trying https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:40 INFO - Downloading https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 08:38:42 INFO - Downloaded 1199 bytes. 08:38:42 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:38:42 INFO - Using the following test package requirements: 08:38:42 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:38:42 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:38:42 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:38:42 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'jsshell-mac.zip'], 08:38:42 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:38:42 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:38:42 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:38:42 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:38:42 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:38:42 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:38:42 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:38:42 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:38:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:38:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:38:42 INFO - Fetch https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:38:44 INFO - Expected file size: 51787241 08:38:44 INFO - Obtained file size: 51787241 08:39:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:39:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:39:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:39:00 INFO - Fetch https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:39:01 INFO - Expected file size: 51787241 08:39:01 INFO - Obtained file size: 51787241 08:39:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:39:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:39:17 INFO - Fetch https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:39:18 INFO - Expected file size: 14404438 08:39:18 INFO - Obtained file size: 14404438 08:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:18 INFO - trying https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:18 INFO - Downloading https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 08:39:20 INFO - Downloaded 74939199 bytes. 08:39:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:20 INFO - mkdir: /builds/slave/test/properties 08:39:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:39:20 INFO - Writing to file /builds/slave/test/properties/build_url 08:39:20 INFO - Contents: 08:39:20 INFO - build_url:https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:39:21 INFO - Running post-action listener: _resource_record_post_action 08:39:21 INFO - Running post-action listener: set_extra_try_arguments 08:39:21 INFO - [mozharness: 2017-03-11 16:39:21.736371Z] Finished download-and-extract step (success) 08:39:21 INFO - [mozharness: 2017-03-11 16:39:21.736527Z] Running populate-webroot step. 08:39:21 INFO - Running pre-action listener: _resource_record_pre_action 08:39:21 INFO - Running main action method: populate_webroot 08:39:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:39:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:39:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:39:21 INFO - '--tppagecycles', 08:39:21 INFO - '7'], 08:39:21 INFO - 'tests': ['tsvgm']}}, 08:39:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:39:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:39:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:39:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:39:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:39:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['damp', 'tps']}, 08:39:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'tests': ['damp', 'tps']}, 08:39:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['dromaeo_dom']}, 08:39:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:39:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['basic_compositor_video']}, 08:39:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:39:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['a11yr', 08:39:21 INFO - 'ts_paint', 08:39:21 INFO - 'tpaint', 08:39:21 INFO - 'sessionrestore', 08:39:21 INFO - 'sessionrestore_no_auto_restore', 08:39:21 INFO - 'tabpaint']}, 08:39:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:39:21 INFO - 'ts_paint', 08:39:21 INFO - 'tpaint', 08:39:21 INFO - 'sessionrestore', 08:39:21 INFO - 'sessionrestore_no_auto_restore', 08:39:21 INFO - 'tabpaint']}, 08:39:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:39:21 INFO - 'ts_paint', 08:39:21 INFO - 'tpaint', 08:39:21 INFO - 'sessionrestore', 08:39:21 INFO - 'sessionrestore_no_auto_restore', 08:39:21 INFO - 'tabpaint']}, 08:39:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:39:21 INFO - 'ts_paint', 08:39:21 INFO - 'tpaint', 08:39:21 INFO - 'sessionrestore', 08:39:21 INFO - 'sessionrestore_no_auto_restore', 08:39:21 INFO - 'tabpaint']}, 08:39:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['a11yr', 08:39:21 INFO - 'ts_paint', 08:39:21 INFO - 'tpaint', 08:39:21 INFO - 'sessionrestore', 08:39:21 INFO - 'sessionrestore_no_auto_restore', 08:39:21 INFO - 'tabpaint']}, 08:39:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['a11yr', 08:39:21 INFO - 'ts_paint', 08:39:21 INFO - 'tpaint', 08:39:21 INFO - 'sessionrestore', 08:39:21 INFO - 'sessionrestore_no_auto_restore', 08:39:21 INFO - 'tabpaint']}, 08:39:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['tsvgx', 08:39:21 INFO - 'tsvgr_opacity', 08:39:21 INFO - 'tart', 08:39:21 INFO - 'tscrollx', 08:39:21 INFO - 'cart', 08:39:21 INFO - 'tsvg_static']}, 08:39:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:39:21 INFO - 'tsvgr_opacity', 08:39:21 INFO - 'tart', 08:39:21 INFO - 'tscrollx', 08:39:21 INFO - 'cart', 08:39:21 INFO - 'tsvg_static']}, 08:39:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'talos_options': ['--disable-e10s'], 08:39:21 INFO - 'tests': ['tp5o']}, 08:39:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:39:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'talos_options': ['--disable-e10s', 08:39:21 INFO - '--xperf_path', 08:39:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:21 INFO - 'tests': ['tp5n']}, 08:39:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:39:21 INFO - 'talos_options': ['--xperf_path', 08:39:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:39:21 INFO - 'tests': ['tp5n']}}, 08:39:21 INFO - 'talos.zip': {'path': '', 08:39:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:39:21 INFO - Running post-action listener: _resource_record_post_action 08:39:21 INFO - [mozharness: 2017-03-11 16:39:21.754997Z] Finished populate-webroot step (success) 08:39:21 INFO - [mozharness: 2017-03-11 16:39:21.755130Z] Running create-virtualenv step. 08:39:21 INFO - Running pre-action listener: _resource_record_pre_action 08:39:21 INFO - Running main action method: create_virtualenv 08:39:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:39:21 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 08:39:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:39:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:39:21 INFO - Using real prefix '/tools/python27' 08:39:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:39:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:39:25 INFO - Installing pip.................done. 08:39:25 INFO - Return code: 0 08:39:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:39:25 INFO - Reading from file tmpfile_stdout 08:39:25 INFO - Output received: 08:39:25 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) 08:39:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:25 INFO - 'HOME': '/Users/cltbld', 08:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:25 INFO - 'LOGNAME': 'cltbld', 08:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:25 INFO - 'MOZ_NO_REMOTE': '1', 08:39:25 INFO - 'NO_EM_RESTART': '1', 08:39:25 INFO - 'PAGER': '/bin/cat', 08:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:25 INFO - 'PWD': '/builds/slave/test', 08:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:25 INFO - 'SHELL': '/bin/bash', 08:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:25 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:25 INFO - 'USER': 'cltbld', 08:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:25 INFO - 'XPC_FLAGS': '0x0', 08:39:25 INFO - 'XPC_SERVICE_NAME': '0', 08:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:39:25 INFO - Cleaning up... 08:39:26 INFO - Return code: 0 08:39:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:39:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:26 INFO - 'HOME': '/Users/cltbld', 08:39:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:26 INFO - 'LOGNAME': 'cltbld', 08:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:26 INFO - 'MOZ_NO_REMOTE': '1', 08:39:26 INFO - 'NO_EM_RESTART': '1', 08:39:26 INFO - 'PAGER': '/bin/cat', 08:39:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:26 INFO - 'PWD': '/builds/slave/test', 08:39:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:26 INFO - 'SHELL': '/bin/bash', 08:39:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:26 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:26 INFO - 'USER': 'cltbld', 08:39:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:26 INFO - 'XPC_FLAGS': '0x0', 08:39:26 INFO - 'XPC_SERVICE_NAME': '0', 08:39:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:26 INFO - Downloading/unpacking psutil>=3.1.1 08:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:39:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:29 INFO - Installing collected packages: psutil 08:39:29 INFO - Running setup.py install for psutil 08:39:30 INFO - building 'psutil._psutil_osx' extension 08:39:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:39:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:39:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:39:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:39:30 INFO - building 'psutil._psutil_posix' extension 08:39:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:39:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:39:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:39:30 INFO - ^ 08:39:30 INFO - 1 warning generated. 08:39:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:39:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:39:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:39:30 INFO - Successfully installed psutil 08:39:30 INFO - Cleaning up... 08:39:30 INFO - Return code: 0 08:39:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:30 INFO - 'HOME': '/Users/cltbld', 08:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:30 INFO - 'LOGNAME': 'cltbld', 08:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:30 INFO - 'MOZ_NO_REMOTE': '1', 08:39:30 INFO - 'NO_EM_RESTART': '1', 08:39:30 INFO - 'PAGER': '/bin/cat', 08:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:30 INFO - 'PWD': '/builds/slave/test', 08:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:30 INFO - 'SHELL': '/bin/bash', 08:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:30 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:30 INFO - 'USER': 'cltbld', 08:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:30 INFO - 'XPC_FLAGS': '0x0', 08:39:30 INFO - 'XPC_SERVICE_NAME': '0', 08:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39: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 08:39:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:39:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:39:33 INFO - Installing collected packages: mozsystemmonitor 08:39:33 INFO - Running setup.py install for mozsystemmonitor 08:39:33 INFO - Successfully installed mozsystemmonitor 08:39:33 INFO - Cleaning up... 08:39:34 INFO - Return code: 0 08:39:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:39:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:39:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:34 INFO - 'HOME': '/Users/cltbld', 08:39:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:34 INFO - 'LOGNAME': 'cltbld', 08:39:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:34 INFO - 'MOZ_NO_REMOTE': '1', 08:39:34 INFO - 'NO_EM_RESTART': '1', 08:39:34 INFO - 'PAGER': '/bin/cat', 08:39:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:34 INFO - 'PWD': '/builds/slave/test', 08:39:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:34 INFO - 'SHELL': '/bin/bash', 08:39:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:34 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:34 INFO - 'USER': 'cltbld', 08:39:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:34 INFO - 'XPC_FLAGS': '0x0', 08:39:34 INFO - 'XPC_SERVICE_NAME': '0', 08:39:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:34 INFO - Downloading/unpacking jsonschema==2.5.1 08:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:39:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:37 INFO - Downloading functools32-3.2.3-2.tar.gz 08:39:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:39:37 INFO - warning: no files found matching '*.txt' 08:39:37 INFO - no previously-included directories found matching 'build' 08:39:37 INFO - no previously-included directories found matching 'dist' 08:39:37 INFO - no previously-included directories found matching '.git*' 08:39:37 INFO - Installing collected packages: jsonschema, functools32 08:39:37 INFO - Running setup.py install for functools32 08:39:37 INFO - warning: no files found matching '*.txt' 08:39:37 INFO - no previously-included directories found matching 'build' 08:39:37 INFO - no previously-included directories found matching 'dist' 08:39:37 INFO - no previously-included directories found matching '.git*' 08:39:37 INFO - Successfully installed jsonschema functools32 08:39:37 INFO - Cleaning up... 08:39:37 INFO - Return code: 0 08:39:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:39:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:37 INFO - 'HOME': '/Users/cltbld', 08:39:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:37 INFO - 'LOGNAME': 'cltbld', 08:39:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:37 INFO - 'MOZ_NO_REMOTE': '1', 08:39:37 INFO - 'NO_EM_RESTART': '1', 08:39:37 INFO - 'PAGER': '/bin/cat', 08:39:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:37 INFO - 'PWD': '/builds/slave/test', 08:39:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:37 INFO - 'SHELL': '/bin/bash', 08:39:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:37 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:37 INFO - 'USER': 'cltbld', 08:39:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:37 INFO - 'XPC_FLAGS': '0x0', 08:39:37 INFO - 'XPC_SERVICE_NAME': '0', 08:39:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:39:38 INFO - Cleaning up... 08:39:38 INFO - Return code: 0 08:39:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:38 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 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:38 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 08:39:38 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 08:39:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:38 INFO - 'HOME': '/Users/cltbld', 08:39:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:38 INFO - 'LOGNAME': 'cltbld', 08:39:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:38 INFO - 'MOZ_NO_REMOTE': '1', 08:39:38 INFO - 'NO_EM_RESTART': '1', 08:39:38 INFO - 'PAGER': '/bin/cat', 08:39:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:38 INFO - 'PWD': '/builds/slave/test', 08:39:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:38 INFO - 'SHELL': '/bin/bash', 08:39:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:38 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:38 INFO - 'USER': 'cltbld', 08:39:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:38 INFO - 'XPC_FLAGS': '0x0', 08:39:38 INFO - 'XPC_SERVICE_NAME': '0', 08:39:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:39:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:39:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:39:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:39:42 INFO - Downloading docopt-0.6.1.tar.gz 08:39:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:39:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:39:42 INFO - Running setup.py install for blobuploader 08:39:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:39:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:39:42 INFO - Running setup.py install for requests 08:39:43 INFO - Running setup.py install for docopt 08:39:43 INFO - Successfully installed blobuploader requests docopt 08:39:43 INFO - Cleaning up... 08:39:43 INFO - Return code: 0 08:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39: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')]} 08:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39: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')]} 08:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:43 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 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:43 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 08:39:43 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 08:39:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:43 INFO - 'HOME': '/Users/cltbld', 08:39:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:43 INFO - 'LOGNAME': 'cltbld', 08:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:43 INFO - 'MOZ_NO_REMOTE': '1', 08:39:43 INFO - 'NO_EM_RESTART': '1', 08:39:43 INFO - 'PAGER': '/bin/cat', 08:39:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:43 INFO - 'PWD': '/builds/slave/test', 08:39:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:43 INFO - 'SHELL': '/bin/bash', 08:39:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:43 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:43 INFO - 'USER': 'cltbld', 08:39:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:43 INFO - 'XPC_FLAGS': '0x0', 08:39:43 INFO - 'XPC_SERVICE_NAME': '0', 08:39:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:43 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-wvLqu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:43 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-oNjFEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:43 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HyzGdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:43 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gjpQf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:43 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-5Wglh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-4LgIqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-cGbSiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-dFHX5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Jv_zcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-iEYLUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Obx5b_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Y8nRGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-gU4zTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-zCkS3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:44 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-EVNVHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:45 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-ikpSut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:45 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-IuqWn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:39:45 INFO - Running setup.py install for manifestparser 08:39:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Running setup.py install for mozcrash 08:39:45 INFO - Running setup.py install for mozdebug 08:39:45 INFO - Running setup.py install for mozdevice 08:39:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:39:45 INFO - Running setup.py install for mozfile 08:39:46 INFO - Running setup.py install for mozhttpd 08:39:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozinfo 08:39:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozInstall 08:39:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozleak 08:39:46 INFO - Running setup.py install for mozlog 08:39:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for moznetwork 08:39:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:39:46 INFO - Running setup.py install for mozprocess 08:39:47 INFO - Running setup.py install for mozprofile 08:39:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Running setup.py install for mozrunner 08:39:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Running setup.py install for mozscreenshot 08:39:47 INFO - Running setup.py install for moztest 08:39:47 INFO - Running setup.py install for mozversion 08:39:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:39:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:39:47 INFO - Cleaning up... 08:39:47 INFO - Return code: 0 08:39:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:39:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:47 INFO - 'HOME': '/Users/cltbld', 08:39:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:47 INFO - 'LOGNAME': 'cltbld', 08:39:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:47 INFO - 'MOZ_NO_REMOTE': '1', 08:39:47 INFO - 'NO_EM_RESTART': '1', 08:39:47 INFO - 'PAGER': '/bin/cat', 08:39:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:47 INFO - 'PWD': '/builds/slave/test', 08:39:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:47 INFO - 'SHELL': '/bin/bash', 08:39:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:47 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:47 INFO - 'USER': 'cltbld', 08:39:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:47 INFO - 'XPC_FLAGS': '0x0', 08:39:47 INFO - 'XPC_SERVICE_NAME': '0', 08:39:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-YZImBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:39:48 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)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-CFMITT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:39:48 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)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-9xOrgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-bEGYws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-3rongH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-uj06Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-FjUf0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:39:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:39:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:39:48 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-3o862l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:39:49 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)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-jWMTXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:39:49 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)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Fy_DuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:39:49 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)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-UIxQIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:39:49 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)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-Wv4k6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-JMZwXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-HJSda2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-6PjsUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-12JMBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:39:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:39:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:39:49 INFO - Running setup.py (path:/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/pip-mTx1Eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:39:50 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)) 08:39:50 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)) 08:39:50 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)) 08:39:50 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)) 08:39:50 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)) 08:39:50 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)) 08:39:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:50 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 08:39:52 INFO - Downloading blessings-1.6.tar.gz 08:39:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:39:52 INFO - Installing collected packages: blessings 08:39:52 INFO - Running setup.py install for blessings 08:39:52 INFO - Successfully installed blessings 08:39:52 INFO - Cleaning up... 08:39:53 INFO - Return code: 0 08:39:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:53 INFO - Reading from file tmpfile_stdout 08:39:53 INFO - Current package versions: 08:39:53 INFO - blessings == 1.6 08:39:53 INFO - blobuploader == 1.2.4 08:39:53 INFO - docopt == 0.6.1 08:39:53 INFO - functools32 == 3.2.3-2 08:39:53 INFO - jsonschema == 2.5.1 08:39:53 INFO - manifestparser == 1.1 08:39:53 INFO - mozInstall == 1.12 08:39:53 INFO - mozcrash == 1.0 08:39:53 INFO - mozdebug == 0.1 08:39:53 INFO - mozdevice == 0.49 08:39:53 INFO - mozfile == 1.2 08:39:53 INFO - mozhttpd == 0.7 08:39:53 INFO - mozinfo == 0.9 08:39:53 INFO - mozleak == 0.1 08:39:53 INFO - mozlog == 3.4 08:39:53 INFO - moznetwork == 0.27 08:39:53 INFO - mozprocess == 0.25 08:39:53 INFO - mozprofile == 0.28 08:39:53 INFO - mozrunner == 6.13 08:39:53 INFO - mozscreenshot == 0.1 08:39:53 INFO - mozsystemmonitor == 0.3 08:39:53 INFO - moztest == 0.8 08:39:53 INFO - mozversion == 1.4 08:39:53 INFO - psutil == 3.1.1 08:39:53 INFO - requests == 1.2.3 08:39:53 INFO - wsgiref == 0.1.2 08:39:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:53 INFO - 'HOME': '/Users/cltbld', 08:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:53 INFO - 'LOGNAME': 'cltbld', 08:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:53 INFO - 'MOZ_NO_REMOTE': '1', 08:39:53 INFO - 'NO_EM_RESTART': '1', 08:39:53 INFO - 'PAGER': '/bin/cat', 08:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:53 INFO - 'PWD': '/builds/slave/test', 08:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:53 INFO - 'SHELL': '/bin/bash', 08:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:53 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:53 INFO - 'USER': 'cltbld', 08:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:53 INFO - 'XPC_FLAGS': '0x0', 08:39:53 INFO - 'XPC_SERVICE_NAME': '0', 08:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:39:53 INFO - Cleaning up... 08:39:53 INFO - Return code: 0 08:39:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:39:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:39:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:39:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5c9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb11b565930>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, '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.0QIvb7QODi/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.kvDWkrt5wR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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 08:39:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:39:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:39:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:39:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:39:53 INFO - 'HOME': '/Users/cltbld', 08:39:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:39:53 INFO - 'LOGNAME': 'cltbld', 08:39:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:39:53 INFO - 'MOZ_NO_REMOTE': '1', 08:39:53 INFO - 'NO_EM_RESTART': '1', 08:39:53 INFO - 'PAGER': '/bin/cat', 08:39:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:39:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:39:53 INFO - 'PWD': '/builds/slave/test', 08:39:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:39:53 INFO - 'SHELL': '/bin/bash', 08:39:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:39:53 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:39:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:39:53 INFO - 'USER': 'cltbld', 08:39:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:39:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:39:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:39:53 INFO - 'XPC_FLAGS': '0x0', 08:39:53 INFO - 'XPC_SERVICE_NAME': '0', 08:39:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:39:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:39:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:39:53 INFO - Cleaning up... 08:39:53 INFO - Return code: 0 08:39:53 INFO - Running post-action listener: _resource_record_post_action 08:39:53 INFO - Running post-action listener: _start_resource_monitoring 08:39:53 INFO - Starting resource monitoring. 08:39:53 INFO - [mozharness: 2017-03-11 16:39:53.848952Z] Finished create-virtualenv step (success) 08:39:53 INFO - [mozharness: 2017-03-11 16:39:53.850018Z] Running install step. 08:39:53 INFO - Running pre-action listener: _resource_record_pre_action 08:39:53 INFO - Running main action method: install 08:39:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:39:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:39:54 INFO - Reading from file tmpfile_stdout 08:39:54 INFO - Detecting whether we're running mozinstall >=1.0... 08:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:39:54 INFO - Reading from file tmpfile_stdout 08:39:54 INFO - Output received: 08:39:54 INFO - Usage: mozinstall [options] installer 08:39:54 INFO - Options: 08:39:54 INFO - -h, --help show this help message and exit 08:39:54 INFO - -d DEST, --destination=DEST 08:39:54 INFO - Directory to install application into. [default: 08:39:54 INFO - "/builds/slave/test"] 08:39:54 INFO - --app=APP Application being installed. [default: firefox] 08:39:54 INFO - mkdir: /builds/slave/test/build/application 08:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:40:14 INFO - Reading from file tmpfile_stdout 08:40:14 INFO - Output received: 08:40:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:40:14 INFO - Running post-action listener: _resource_record_post_action 08:40:14 INFO - [mozharness: 2017-03-11 16:40:14.259607Z] Finished install step (success) 08:40:14 INFO - [mozharness: 2017-03-11 16:40:14.259743Z] Running run-tests step. 08:40:14 INFO - Running pre-action listener: _resource_record_pre_action 08:40:14 INFO - Running main action method: run_tests 08:40:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:40:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:40:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:40:14 INFO - 2017-03-11 08:40:14.274 screenresolution[2237:23355] starting screenresolution argv=screenresolution get 08:40:14 INFO - 2017-03-11 08:40:14.276 screenresolution[2237:23355] Display 0: 1600x1200x32@60 08:40:14 INFO - 2017-03-11 08:40:14.282 screenresolution[2238:23358] starting screenresolution argv=screenresolution list 08:40:14 INFO - Available Modes on Display 0 08:40:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:40:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:40:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:40:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:40:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:40:14 INFO - Intel Iris: 08:40:14 INFO - Chipset Model: Intel Iris 08:40:14 INFO - Type: GPU 08:40:14 INFO - Bus: Built-In 08:40:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:40:14 INFO - Vendor: Intel (0x8086) 08:40:14 INFO - Device ID: 0x0a2e 08:40:14 INFO - Revision ID: 0x0009 08:40:14 INFO - Displays: 08:40:14 INFO - Display: 08:40:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:40:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:40:14 INFO - Display Serial Number: 1600x1200 60 08:40:14 INFO - Main Display: Yes 08:40:14 INFO - Mirror: Off 08:40:14 INFO - Online: Yes 08:40:14 INFO - Rotation: Supported 08:40:14 INFO - Return code: 0 08:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:40:14 INFO - Python 2.7.3 08:40:14 INFO - Return code: 0 08:40:14 INFO - grabbing minidump binary from tooltool 08:40:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:14 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f3a4d30>, '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 0x10f2cbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f399be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:40:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:40:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:40:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:40:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:40:14 INFO - Return code: 0 08:40:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:40:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:40:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:40:14 INFO - ENV: RUST_BACKTRACE is now 1 08:40:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:40:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:40:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 08:40:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0026 --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 08:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0QIvb7QODi/Render', 08:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:14 INFO - 'HOME': '/Users/cltbld', 08:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:14 INFO - 'LOGNAME': 'cltbld', 08:40:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:40:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:14 INFO - 'MOZ_NO_REMOTE': '1', 08:40:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:40:14 INFO - 'NO_EM_RESTART': '1', 08:40:14 INFO - 'PAGER': '/bin/cat', 08:40:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:14 INFO - 'PWD': '/builds/slave/test', 08:40:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:14 INFO - 'RUST_BACKTRACE': '1', 08:40:14 INFO - 'SHELL': '/bin/bash', 08:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kvDWkrt5wR/Listeners', 08:40:14 INFO - 'TMPDIR': '/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/', 08:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:14 INFO - 'USER': 'cltbld', 08:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:14 INFO - 'XPC_FLAGS': '0x0', 08:40:14 INFO - 'XPC_SERVICE_NAME': '0', 08:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0026', '--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 08:40:14 INFO - mozversion application_buildid: 20170311080236 08:40:14 INFO - mozversion application_changeset: 3154da520af568d4da3de62bc26fbf97a1317f51 08:40:14 INFO - mozversion application_display_name: Nightly 08:40:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:40:14 INFO - mozversion application_name: Firefox 08:40:14 INFO - mozversion application_remotingname: firefox 08:40:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:40:14 INFO - mozversion application_vendor: Mozilla 08:40:14 INFO - mozversion application_version: 55.0a1 08:40:14 INFO - mozversion platform_buildid: 20170311080236 08:40:14 INFO - mozversion platform_changeset: 3154da520af568d4da3de62bc26fbf97a1317f51 08:40:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:40:14 INFO - mozversion platform_version: 55.0a1 08:40:14 INFO - using testdate: 1489250414 08:40:14 INFO - actual date: 1489250414 08:40:14 INFO - starting webserver on 'localhost:57168' 08:40:14 INFO - SUITE-START | Running 2 tests 08:40:14 INFO - TEST-START | dromaeo_css 08:40:14 INFO - operating with platform_type : mac_ 08:40:14 INFO - Initialising browser for dromaeo_css test... 08:40:14 INFO - TEST-INFO | started process 2248 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpFYIiCL/profile http://localhost:57168/getInfo.html) 08:40:17 INFO - PROCESS | 2248 | 2017-03-11 08:40:17.855 plugin-container[2250:23533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 08:40:17 INFO - PROCESS | 2248 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:17 INFO - PROCESS | 2248 | 2017-03-11 08:40:17.858 plugin-container[2250:23533] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.CFPasteboardClient' 08:40:17 INFO - PROCESS | 2248 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:17 INFO - PROCESS | 2248 | 2017-03-11 08:40:17.858 plugin-container[2250:23533] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:17 INFO - PROCESS | 2248 | __metrics Screen width/height:1600/1200 08:40:17 INFO - PROCESS | 2248 | colorDepth:24 08:40:17 INFO - PROCESS | 2248 | Browser inner width/height: 1024/689 08:40:17 INFO - PROCESS | 2248 | __metrics 08:40:18 ERROR - PROCESS | 2248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:40:18 INFO - TEST-INFO | 2248: exit 0 08:40:18 INFO - Browser initialized. 08:40:18 INFO - Running cycle 1/1 for dromaeo_css test... 08:40:18 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpFYIiCL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:40:21 INFO - PROCESS | 2251 | 2017-03-11 08:40:21.332 plugin-container[2252:23662] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893b, name = 'com.apple.tsm.portname' 08:40:21 INFO - PROCESS | 2251 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:21 INFO - PROCESS | 2251 | 2017-03-11 08:40:21.333 plugin-container[2252:23662] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 08:40:21 INFO - PROCESS | 2251 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:40:21 INFO - PROCESS | 2251 | 2017-03-11 08:40:21.333 plugin-container[2252:23662] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:40:31 INFO - PROCESS | 2251 | RSS: Main: 227360768 08:40:31 INFO - PROCESS | 2251 | 08:43:34 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57168/tests/dromaeo/cssquery-ext.html) 08:43:36 INFO - PROCESS | 2251 | RSS: Main: 250462208 08:43:36 INFO - PROCESS | 2251 | 08:45:19 INFO - PROCESS | 2251 | ************************* 08:45:19 INFO - PROCESS | 2251 | A coding exception was thrown and uncaught in a Task. 08:45:19 INFO - PROCESS | 2251 | 08:45:19 ERROR - PROCESS | 2251 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:45:19 INFO - PROCESS | 2251 | Full stack: 08:45:19 INFO - PROCESS | 2251 | ************************* 08:46:38 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-ext.html (next: http://localhost:57168/tests/dromaeo/cssquery-jquery.html) 08:46:39 INFO - PROCESS | 2251 | RSS: Main: 257269760 08:46:39 INFO - PROCESS | 2251 | 08:49:41 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57168/tests/dromaeo/cssquery-mootools.html) 08:49:41 INFO - PROCESS | 2251 | RSS: Main: 268378112 08:49:41 INFO - PROCESS | 2251 | 08:52:43 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57168/tests/dromaeo/cssquery-prototype.html) 08:52:44 INFO - PROCESS | 2251 | RSS: Main: 262082560 08:52:44 INFO - PROCESS | 2251 | 08:55:47 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57168/tests/dromaeo/cssquery-yui.html) 08:55:48 INFO - PROCESS | 2251 | RSS: Main: 270913536 08:55:48 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:57168/tests/dromaeo/cssquery-yui.html (next: http://localhost:57168/tests/dromaeo/cssquery-dojo.html) 08:58:51 INFO - PROCESS | 2251 | RSS: Main: 266977280 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | __start_tp_report 08:58:51 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 08:58:51 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 08:58:51 INFO - PROCESS | 2251 | |i|pagename|runs| 08:58:51 INFO - PROCESS | 2251 | |0;dojo.html;3350.9497357539635;3430.3825311443948;3445.5693038370205;3463.5151078848958;3485.5120283160363;5906;6017.8495537611525;6020.638761674297;6046.727897244624;6096.847578810521;5989.610675306102;6049.2136022317145;6051.2133422655;6079.05774604937;6091.512678985681;5383.650062745928;5402.459754024605;5445.401005889349;5471.562275017999;5494.203340515623;4594.448666160049;5361.383440904287;5462.672239665632;5502.532284755801;5544.722763861811;5472.5621950243885;5480.780768769245;5514.448555144493;5563.833085007456;5569.443055694439;4293.8711838644895;5337.519623233928;5415.783368665248;5461.535769459561;5481;5320.095583750772;5402.432744561804;5404.864878378033;5444.537214336786;5451.318585176853;5843.678597677126;5846.21076154718;5899.882002359929;6041.154238406627;6129.570930034899;6234.470070044052;6268.435840774352;6284.434400903895;6396.328385519547;6405.103285540028;6493.70778314977;6493.740250389978;6508.0563318319055;6516.77191298307;6519.152510173647;6179.969100154471;6211.65835879031;6216.2540495140875;6223.906641400383;6229.4393504584805;6287.874242515124;6336.556441049174;6488.870222595521;6497.610143391412;6503.967480162569;5459.727013649381;6097.827165393427;6314.336994615591;6319.115323854664;6354.983202687547;6233.283172435137;6346.492280617539;6354.904676429857;6363.236411630634;6366.331535188739;6351.68241587928;6357.205349331333;6358.8410289742205;6379.776707815204;6383.4574061204385;6182.876342473125;6257.2491301044165;6353.585637457736;6369.140166077613;6380.649064301508;5144.717040562805;5150.587952963754;5158.716270605078;5179.093658609729;5238.842834714965;4652.488226295105;4652.837150699777;4676.041411510632;4709.434867815884;4712.081144176921;6132.816015519542;6146.815595532141;6150.938490615036;6178.443940045418;6182.350853160354;6215.9378406216265;6231.781887633911;6335.714892829834;6356.713947872357;6457.225132984072;6130.7650488535955;6135.385782596134;6148.323684394713;6168.290646575611;6171.475424588871;5702.7433765480655;5712.371639119777;5722.54219662426;5725.713714314351;5842.831433713274;6348.492120630246;6371.331010243857;6521.739130434919;6647.567908086153;6682.231543372477;6362.586431881913;6430.324815894263;6453.128827608213;6470.48236141117;6483;6647.966760166361;6669.333066693486;6672.199336079701;6672.332766723289;6675.198976122896;6234.625922444668;6281.309056003927;6297.905531416941;6301.684915754102;6341.365863413622;6268.076667549122;6299.590526615755;6411.198600174978;6431.614103153825;6452.12896258999;6261.092141639528;6264.906026409699;6274.6548939808745;6275.435210831047;6296.811095666954;5211.9478805212975;6180.258368995749;6217.751289948352;6230.470410015199;6264.5301602379095;5252.7898884045735;5673.007223735913;6174.44430001302;6312.558120931674;6319.842003949938;5266.631335806457;6248.4064013918605;6287.2769631492965;6305.243370795534;6311.873762524816;6059.212302400836;6131.448169664752;6131.478824299806;6298.275698294755;6303.747850085945 08:58:51 INFO - PROCESS | 2251 | |1;ext.html;709.6097146569389;780.0911937592705;801.5951944268144;873.4366333714751;933.6965486216977;38025;38650.80674596626;40078.59921400785;40175.397369039485;40176.59823401765;38093.619063809354;38419;38499.615003849955;38587.84236472903;38741.932097129815;7726.806829829257;7894.6447409866405;10876.02115809577;11039.944800275987;11143.442827858575;10878.129749620051;10951.945240273828;10967.177461690366;10975.176861735363;11017.614383496579;10919.344839309666;11007.889921100767;11009;11019.063379612702;11025.338479691203;11149.777004459906;11180.267058605928;11211.831822522669;11216.439178041066;11269.83095253576;9410.62357505699;10922.29005114665;10935.234533582652;11003;11014.953579409943;38523.036924077125;38619.806900965596;38771.224575508335;38806;38871;3675.732875447356;3720.8325625346924;3752.7185461090253;3755.7746535207975;3892.026993251687;27427.90288388462;27779.44441111187;28718.856405717837;28723.712762872314;28744;3163.8734450621946;3267.836608169606;3292.901212963615;3293.1931676739114;3317.568716066896;305230.9999999978;325354;325521;326062;332010;49992;50126.74936625294;50210;50249;50253;52093;52259.47740522546;52625.7368713154;52637.47362526326;52896;14378.784318235235;14492.202928839015;14516.637084072772;14664.560063198121;14676.412943482355;11699.941500292614;11773.117016223818;11903;11907.404629768476;11913.404329783476;13819.723605527834;13850.515231966832;13882.861171388156;13900.51348202808;13966.58100256994;5096.311997880312;6026.306974697878;6076.574639775174;6079.331273559905;6084.543659225487;919.4161707315902;921.3826736086704;936.8079543693526;960.2558017536326;966.2704657983318;21089;25679;26727;27903.16290511288;28375.858120709265;912.8493798523302;1012.372329155928;1039.0700323210835;1045.243990096645;1049.2393015064017;13977.231252281223;14395;14495.855041449662;14697.485588004369;14751.409943602135;399650;403000;403529;403761;404466;44693.32960005602;53433.93132137413;53513;53931.460685392645;54128.45871541313;1397.7903314502905;1444.0397135904507;1444.1768192130385;1445.0534899640961;1448.2686243446992;21777.12891484323;23000.539989199788;27612.58581121325;27875.303117422227;28400.43199136047;46495.30257046079;46619.06761864676;46659.53340466688;46719.065618686756;47637.04725905393;304943;365489;366505;366927;366930;33094.33811323712;33829.154271143416;34482.482762758074;35155.296894062485;36594.81702591576;37335.43996840104;44812.77593612011;45046.324305136106;45493;45763.54236457593;34898.47652285269;34967.95096147119;36638;37875;37899;29116.12651620455;36144.45783313305;36504.81747591245;37718.811405943896;37934.810325948194;36554.634453655126;36701.63298366982;37037.44443833291;37424.62575374211;37470.812645936596;30997.845010774803;32279.63890471737;32608;32792.0162395119;33194;24148.39629009289;24576.402533835244;24598.385040374134;24963.500729985662;24992.000959884204 08:58:51 INFO - PROCESS | 2251 | |2;jquery.html;340.65253441489676;396.3816446343702;400.7875825812321;409.3900088867587;440.47803353026666;20658.793412065876;21227.787722122775;22059.558808823815;22097.447563810874;22143.224987125435;20175.697364539545;20959.47601309968;21263.893680531615;21306.254281100166;22451.877406129668;6328.683565821713;6698.263191048981;6698.83252918676;6698.966505167467;6716.966415167917;5514.724263786815;6502.252240992299;6569.737210511574;6789.9815027745735;6848.965755171217;6776.288489708583;6828.556143850634;6842.144731908512;6842.863142737142;6847.144106986627;6415.230172379298;6571.244306904696;6641.269460359356;6650.50121240904;6660.8667826643195;6296.96851515744;6482;6505.219373675142;6623.4038936495945;6660.2340730816095;25937.481250375076;26304;26562.86718566395;26567.468650627074;26619.33451663724;2795.4409118176445;2869.483343545902;2900.7389334959953;2931.7361437470518;2958.8224706517462;15685.607859803482;15907.806914481345;16290.266937987819;16491.422800201934;16732.916335418366;2024.7873973232745;2029.6853987631941;2086.405374468269;2095.371388583434;2099.422658768851;89553.55223223842;128107.35946320208;157239;157838;158475.41524584722;17875.553111172325;18067.82559133652;20975.265865694626;22085.122764564872;22717.43206419853;29851.10446686603;35491.4676279856;35808.925732228076;35893.64106358903;36048.09879753027;10348.327358721659;10616.946915265375;10695;10806.243562950518;10927.617533386294;7922.445428820042;8632.179942905414;8635.6977505787;8845.51349675774;8886;10438.321509102036;10454.895451045544;10514.894851051544;10700.678979630624;10903.563857445613;4312.956870431318;4368.301071828492;4373.906523369158;4379.430674012358;4400.427944367212;856.6316483911853;863.313665635821;957.4016239850093;1033.204432586904;1096.366414043086;21427.67858482124;21527.67708484374;22008;23543.529129417315;23757.16849910245;908.1871724806393;981.4896253947907;992.0971915556809;1093.3002878157986;1125.4147843121532;11493.482793274323;11569.826452603218;11672.941635291769;11673.416329183678;11870.347130907883;624158;708073;710513;729462;732264;139037;140365;140516;149913.25043374932;152913.9999999978;1284.6659868434274;1293.792993121115;1310.3251825309974;1326.2440408966988;1331.1480652382484;18977.90511047436;19700.901495493003;19779.70330445016;19801.801981979996;19864.21222090019;44513.777431112634;53894;58117;59703;61613;87841.12158878586;89016;89713;90891.09108908827;90909.54545227232;9499.857502137611;11089.445527723743;11945.641630751092;11962.521499140285;12280.877191227974;13574.524891628746;13594.592162235149;13652.385642645906;13910.956678249375;13971.231582263074;11340;11395.461612682182;11676.591319303783;11805.76388472243;11881.287122772661;11479.827802583135;11554.306741595532;11635.941820290844;11816.350100744541;11966.162368634112;11817.82273265919;11893.524259029542;11935;12028.458719357825;12057.095717821023;11960.342181180118;12032.639020829389;12246.203996740183;12280.631581052583;12548.498060077494;11306;11502.712432188928;11685;11715.882841171479;11719.88280117188 08:58:51 INFO - PROCESS | 2251 | |3;mootools.html;1513.3643869574778;1527.8472152784716;1568.2707540993435;1572.0960447742543;1574.858262756352;9021.548922553862;10528.736781580465;11097.889021109797;11157.609483668073;11252.93097155771;10896.237263391566;11074.778504429907;11088.611898583551;11100.4449777511;11160.665180044612;1893.4035778729724;2139.4009677290383;2161.659770942018;2347.0963678983544;2361.681173041635;1844.2622950819646;1881.5108071901336;1886.1323791056132;1887.2168050259127;1887.59416725404;2273.954520909589;2288.336382449088;2304.3893368257427;2305.2853615379204;2306.1813056365;2276.237460450751;2280.1563421533974;2283.668868014137;2285.714285714286;2287.2337766848127;2198.5822693688147;2305.5734689082406;2307.9538409231723;2311.56080344734;2312.629979203319;10860.67417977462;10958.835617465744;10959.397233152173;10964.890351096547;10979.945100274528;5735.311762588516;5907.409259074101;5910.763569457216;5914.201582786355;5931.851703707399;2565.9358516037064;3226.56441380413;3282;3662.505561749183;3662.8901132966053;1049.7638031442864;1131.5926266544038;1172.3879665459992;1173.3370645585217;1222.1811386371153;12962;13252.271125088117;13567.253801040939;15023.549293521211;15028.774568381483;4628.560286772751;4746.644001699887;4764.332993380929;4788.018456216468;4805.879853003703;11813.054955603531;11837.704057398634;11846;11874.168808183344;11932.343721095249;5491.121420572689;5806.970965145148;5814.825555233349;5826.592138550261;5876.7649294028615;5201.297824793604;5257.4742525747115;5263.473652634706;5267.26258323835;5274.525292723673;3802;3830.8467661293794;3905.6484916357663;3908.472356231929;3915.4909861717792;975.0882924465648;993.6869885985891;1018.7147598672384;1023.3910823060268;1032.9896701033044;845.7166849105496;862.5040601653949;897.7665806890255;972.1639390124628;982.5873133284038;6532.510061745293;6562.901556476657;6659.933400666028;6727.697253623599;6798.456123510107;964.6623681711345;988.0958922585897;997.9950100249597;1001.594801246042;1006.3509036671306;4100.200460910153;4287.013986782995;4449.733016018984;4502.594766471033;4693.530646935279;13172.341382930816;13503;13514.864851351558;13514.986376021838;13549.119307245195;13012.544560940321;13412.12821166621;13439.992000599994;13484.39320230592;13808;9758;10039.397636141855;10052.095311422006;10053.999999999854;10080.3951762893;5810.593258471867;6560.475161987125;6763.154605674291;6995.650217489207;7019.29807019294;8751.431156974777;10780.083692886192;11061.723456913642;11471.311721296748;11656;11442.885571144181;11599.8260026098;11778;11778.705532361759;11976.28142311464;8986.595603198002;9220.953895230481;9287.953560232427;9368.203702685349;9424;8465.703700370457;10117.949410252902;10257.076863082359;10303.845442318221;10362.5336859843;8380.329573633973;8504.957475212585;9101.135392137736;9180.954095229481;9247.630094796134;8730.69442569507;8859.335549833917;8905;8912.86630700527;8913.242374398249;7539.283768042027;7783.221677832172;7805.297523222937;7838.098618658927;8054.3556515479795;5771.307443106854;5814.970925145347;5899.52511872032;5913.2608423947;6162.784302549389;5806.303243610793;5848.56135789826;5970.402959703995;6050.092486127116;6193.659348735682 08:58:51 INFO - PROCESS | 2251 | |4;prototype.html;369.9889003329901;375.8383894925181;385.967192788613;393.75587135975684;393.90546268895463;4845.279925626404;4931.260310953355;4956.876078098049;5071.822486212984;5404;4270.786460676969;5240.475952404758;5257.581512504243;5283.365996080466;5324.787008519665;3718.8326525306293;3878.650921417072;4369.781510924457;4395.186890425265;4396.846110386137;3934.3114954882926;4070.6743460523235;4215.199112168693;4269;4339.522652508222;3812.989557767194;4126.2148050066235;4340.502526628308;4369;4377.6935614507;4105.545483150785;4326.524082350938;4352.194843953878;4360.23695853226;4375.484096644426;3267.134209434478;3775.4903088083306;3790.943135852937;3928.135810121769;4038.3846461415374;4172.165566886635;4362.149380870732;4508.481524624677;4934.654574179773;5181.476595914776;4598.517155698671;5061.924071138899;5069.518395752434;5076.44159142494;5095.286659867585;4816.563605112889;5403.5136837684795;5679.290088738908;5691.573132015115;5727.570432217601;3716.888493345177;4317.445719540963;4469.240229161051;4471.262241730111;4489.955100448987;5128.743562821844;5716.542676585822;5802.243934131296;6042.486388656969;6061.727222275008;3934.960650393459;4327.5239723630375;4471.28459446487;4542.977285113553;4580.725156490621;4341.565843415633;4666.06358361283;4683.634764443934;4691.114964297001;4701.623870090384;4211.925958880466;4403.361512580658;4715.95284047162;5008.949910500921;5021.648484606116;4582.725036497821;5511.382093505633;5549.500544950974;5579.69311687861;5588.882223555305;1478.9926050369895;1499.7626957759892;1520.8707259883033;1544.4980381376097;1588.9364425423084;1095.5343978809133;1120.3222050659233;1173.7887180307628;1194.4445832687843;1215.9756804863853;4521.683482156283;4842.467328593852;5147.922781158286;5203.661761985459;5257.553107985787;5180.430152683201;5364.195370694427;5475.890482190334;5806;5849.473547380756;4069.7761623111014;4590.42619672541;5155.860317968001;5296.708681022504;5350.38470575881;2804.551271796503;2869.7991140620375;2879.510483217858;2901.7968742187845;3081.2604974805886;5137.948620513747;5172.27588137661;5660.839283126898;5711.029125048752;5769.067362433548;5448.194179997305;5465.9180112298345;5702.6863522506665;5901.822945311647;5974.970125149346;5237.188235823453;5304.38999515053;5559.610827242054;5743.655380677173;6114.370820547208;4209.831606735696;5176.498815343508;5858.129516536951;5873.823785286449;5899.587028907935;5420.593455490775;5480.671159730429;5813.15709222152;5832.475077243069;5844.503217226584;5501.404592668081;5788.6396696777065;5979.325788779149;6121.785737499166;6126.295476020315;3986.9202615948097;4278.65770738334;4608.4930657626965;4645.326427668037;4657.5575320344515;5038.899222015612;5405.270288511001;5558;5590.860228494157;5780.450857168562;5267.73661316925;5310.4154695579555;5329.653572517774;5684.886302274014;5705.088795253637;5593.440655934374;5609.559841468974;5701.4298570142655;5726.599138060295;5798.59409841307;4670.416197975253;4948.193909223036;5287.793281958316;5499.807506737245;5532.893421315834;4687.531246875285;4978.352814134139;5355.812546560852;5372.919406208832;5405.378381486022;4754.381930349033;4817.807287708452;5123.487651234846;5220.817271395483;5512.3385193777 08:58:51 INFO - PROCESS | 2251 | |5;yui.html;639.2999665366425;646.224530563324;741.1032650492904;797.9640916158772;808.4260175275554;15057.247137643115;15834.524964251063;15845.207739613032;15877.206139693013;15928.203589820507;14205.502807401743;14630.97583169176;14809.407623695066;15111.848881511181;15150.54548363551;915.455304094063;920.0247737398379;938.3572253006678;938.9859152112724;941.0307383395113;933.0809152984305;936.5270538378144;944.36255527519;971.1647982734843;975.6682727872521;1005.9798804023915;1016.2885979814159;1019.6380284998793;1019.6788011776267;1020.9744756381076;991.9206463482905;1008.8890222075565;1011.3325205364424;1012.2610494339137;1014.279861298479;731.4806487393956;744.57559191261;749.9437542184359;751.7331347371659;752.8870669399579;13770.311484425738;15641.530754077396;15813.05121692702;16081.597960050975;16354.591135221715;14008.22954737489;14315.856841431556;14385.71228575433;14511.709765804624;14546.927265363605;10169.389836609827;11118.66576010884;11527.942360288229;11598.536058557647;11879.881201187964;4467.977660111678;4511.142882852248;4513.7066090704;4520.932186017212;4699.130660827758;77999;107024;108229;108234;109513.80972380508;11285.661430156944;11302.830457543143;11318.490667919963;11339.546418143182;11637.47631356591;22791.658125128135;23148.421289467897;23164.18925337605;23248.302550923498;23282.185123520594;7280.817979550554;7281.381082607932;7358.963205184047;7370.48406611532;7463.328300452877;4080.612341827581;4154.937675934863;4172.144710334374;4213.094184750294;4214.262504061777;3352.379809735207;3424.9143771405916;3425.691687748065;3435.2957643682985;3439.9312013759586;537.7176982084437;629.8708764703225;633.9711135732446;638.5306799502362;648.9675516224264;527.6306585390242;539.3743257820909;542.6174546944395;549.409384911222;550.5788072124827;8163.224493673091;9233.746898263027;9502.477363744922;9669.016395072591;9937.453440060866;568.5196009372074;587.5916238214486;604.7753299568409;651.3486513486514;655.8655475627485;4615.676902616851;4645.883852903705;4690.95309046912;4698.201305778026;4699.224627936421;88823;92659;101679.44121955696;102737.48631256945;103961.96038039675;90595.54702226447;91837.08162918419;91913;92086.61870071954;92718.53640731753;77673.45591984877;78858.21141788624;80869.19130808617;81357.18642813615;83675.16324836796;8018.679252829821;8243.670253190045;8715.91284087151;8971.788808510768;9318.580663870007;36832.631673683994;41124.794376029124;52818.679533011986;53861.73069134629;54025.72987135039;61108.38891611027;62070.68964655148;62172;62184.44538886383;62818;11180.776384472427;11254.606088786853;11384.54461821551;11807.586734464252;12008.279503229835;11771.23486973344;11863.940680296544;11995.340256285639;12072.75854482888;12248.755024899274;10353.896461035294;10876.347419154876;11462.369569673749;11469.31184128955;11792.587259445878;9610.759731006781;10127.64553240633;10625.734356641145;10680.092192163753;11128.109751219721;10119.79760404773;10670;10839.295445796313;11041.668749937515;11448.771024579295;8839.718240855169;9360.297977651839;9416.387934784218;9422.387544809566;9627.277954153607;7414.8887766682465;8078.474899131537;8124.309433697966;9593.986007736097;9799.902000979899 08:58:51 INFO - PROCESS | 2251 | __end_tp_report 08:58:51 INFO - PROCESS | 2251 | __start_cc_report 08:58:51 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,430 08:58:51 INFO - PROCESS | 2251 | __end_cc_report 08:58:51 INFO - PROCESS | 2251 | __startTimestamp1489251531466__endTimestamp 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | ------- Summary: start ------- 08:58:51 INFO - PROCESS | 2251 | Number of tests: 6 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | [#0] dojo.html Cycles:165 Average:5936.66 Median:6182.88 stddev:661.79 (10.7%) stddev-sans-first:631.97 08:58:51 INFO - PROCESS | 2251 | Values: 3350.9 3430.4 3445.6 3463.5 3485.5 5906.0 6017.8 6020.6 6046.7 6096.8 5989.6 6049.2 6051.2 6079.1 6091.5 5383.7 5402.5 5445.4 5471.6 5494.2 4594.4 5361.4 5462.7 5502.5 5544.7 5472.6 5480.8 5514.4 5563.8 5569.4 4293.9 5337.5 5415.8 5461.5 5481.0 5320.1 5402.4 5404.9 5444.5 5451.3 5843.7 5846.2 5899.9 6041.2 6129.6 6234.5 6268.4 6284.4 6396.3 6405.1 6493.7 6493.7 6508.1 6516.8 6519.2 6180.0 6211.7 6216.3 6223.9 6229.4 6287.9 6336.6 6488.9 6497.6 6504.0 5459.7 6097.8 6314.3 6319.1 6355.0 6233.3 6346.5 6354.9 6363.2 6366.3 6351.7 6357.2 6358.8 6379.8 6383.5 6182.9 6257.2 6353.6 6369.1 6380.6 5144.7 5150.6 5158.7 5179.1 5238.8 4652.5 4652.8 4676.0 4709.4 4712.1 6132.8 6146.8 6150.9 6178.4 6182.4 6215.9 6231.8 6335.7 6356.7 6457.2 6130.8 6135.4 6148.3 6168.3 6171.5 5702.7 5712.4 5722.5 5725.7 5842.8 6348.5 6371.3 6521.7 6647.6 6682.2 6362.6 6430.3 6453.1 6470.5 6483.0 6648.0 6669.3 6672.2 6672.3 6675.2 6234.6 6281.3 6297.9 6301.7 6341.4 6268.1 6299.6 6411.2 6431.6 6452.1 6261.1 6264.9 6274.7 6275.4 6296.8 5211.9 6180.3 6217.8 6230.5 6264.5 5252.8 5673.0 6174.4 6312.6 6319.8 5266.6 6248.4 6287.3 6305.2 6311.9 6059.2 6131.4 6131.5 6298.3 6303.7 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | [#1] ext.html Cycles:180 Average:51322.40 Median:34690.48 stddev:95256.05 (274.6%) stddev-sans-first:95447.47 08:58:51 INFO - PROCESS | 2251 | Values: 709.6 780.1 801.6 873.4 933.7 38025.0 38650.8 40078.6 40175.4 40176.6 38093.6 38419.0 38499.6 38587.8 38741.9 7726.8 7894.6 10876.0 11039.9 11143.4 10878.1 10951.9 10967.2 10975.2 11017.6 10919.3 11007.9 11009.0 11019.1 11025.3 11149.8 11180.3 11211.8 11216.4 11269.8 9410.6 10922.3 10935.2 11003.0 11015.0 38523.0 38619.8 38771.2 38806.0 38871.0 3675.7 3720.8 3752.7 3755.8 3892.0 27427.9 27779.4 28718.9 28723.7 28744.0 3163.9 3267.8 3292.9 3293.2 3317.6 305231.0 325354.0 325521.0 326062.0 332010.0 49992.0 50126.7 50210.0 50249.0 50253.0 52093.0 52259.5 52625.7 52637.5 52896.0 14378.8 14492.2 14516.6 14664.6 14676.4 11699.9 11773.1 11903.0 11907.4 11913.4 13819.7 13850.5 13882.9 13900.5 13966.6 5096.3 6026.3 6076.6 6079.3 6084.5 919.4 921.4 936.8 960.3 966.3 21089.0 25679.0 26727.0 27903.2 28375.9 912.8 1012.4 1039.1 1045.2 1049.2 13977.2 14395.0 14495.9 14697.5 14751.4 399650.0 403000.0 403529.0 403761.0 404466.0 44693.3 53433.9 53513.0 53931.5 54128.5 1397.8 1444.0 1444.2 1445.1 1448.3 21777.1 23000.5 27612.6 27875.3 28400.4 46495.3 46619.1 46659.5 46719.1 47637.0 304943.0 365489.0 366505.0 366927.0 366930.0 33094.3 33829.2 34482.5 35155.3 36594.8 37335.4 44812.8 45046.3 45493.0 45763.5 34898.5 34968.0 36638.0 37875.0 37899.0 29116.1 36144.5 36504.8 37718.8 37934.8 36554.6 36701.6 37037.4 37424.6 37470.8 30997.8 32279.6 32608.0 32792.0 33194.0 24148.4 24576.4 24598.4 24963.5 24992.0 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | [#2] jquery.html Cycles:180 Average:41198.54 Median:21366.97 stddev:116961.76 (547.4%) stddev-sans-first:117249.64 08:58:51 INFO - PROCESS | 2251 | Values: 340.7 396.4 400.8 409.4 440.5 20658.8 21227.8 22059.6 22097.4 22143.2 20175.7 20959.5 21263.9 21306.3 22451.9 6328.7 6698.3 6698.8 6699.0 6717.0 5514.7 6502.3 6569.7 6790.0 6849.0 6776.3 6828.6 6842.1 6842.9 6847.1 6415.2 6571.2 6641.3 6650.5 6660.9 6297.0 6482.0 6505.2 6623.4 6660.2 25937.5 26304.0 26562.9 26567.5 26619.3 2795.4 2869.5 2900.7 2931.7 2958.8 15685.6 15907.8 16290.3 16491.4 16732.9 2024.8 2029.7 2086.4 2095.4 2099.4 89553.6 128107.4 157239.0 157838.0 158475.4 17875.6 18067.8 20975.3 22085.1 22717.4 29851.1 35491.5 35808.9 35893.6 36048.1 10348.3 10616.9 10695.0 10806.2 10927.6 7922.4 8632.2 8635.7 8845.5 8886.0 10438.3 10454.9 10514.9 10700.7 10903.6 4313.0 4368.3 4373.9 4379.4 4400.4 856.6 863.3 957.4 1033.2 1096.4 21427.7 21527.7 22008.0 23543.5 23757.2 908.2 981.5 992.1 1093.3 1125.4 11493.5 11569.8 11672.9 11673.4 11870.3 624158.0 708073.0 710513.0 729462.0 732264.0 139037.0 140365.0 140516.0 149913.3 152914.0 1284.7 1293.8 1310.3 1326.2 1331.1 18977.9 19700.9 19779.7 19801.8 19864.2 44513.8 53894.0 58117.0 59703.0 61613.0 87841.1 89016.0 89713.0 90891.1 90909.5 9499.9 11089.4 11945.6 11962.5 12280.9 13574.5 13594.6 13652.4 13911.0 13971.2 11340.0 11395.5 11676.6 11805.8 11881.3 11479.8 11554.3 11635.9 11816.4 11966.2 11817.8 11893.5 11935.0 12028.5 12057.1 11960.3 12032.6 12246.2 12280.6 12548.5 11306.0 11502.7 11685.0 11715.9 11719.9 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | [#3] mootools.html Cycles:180 Average:6594.67 Median:2463.81 stddev:4085.26 (165.8%) stddev-sans-first:4078.88 08:58:51 INFO - PROCESS | 2251 | Values: 1513.4 1527.8 1568.3 1572.1 1574.9 9021.5 10528.7 11097.9 11157.6 11252.9 10896.2 11074.8 11088.6 11100.4 11160.7 1893.4 2139.4 2161.7 2347.1 2361.7 1844.3 1881.5 1886.1 1887.2 1887.6 2274.0 2288.3 2304.4 2305.3 2306.2 2276.2 2280.2 2283.7 2285.7 2287.2 2198.6 2305.6 2308.0 2311.6 2312.6 10860.7 10958.8 10959.4 10964.9 10979.9 5735.3 5907.4 5910.8 5914.2 5931.9 2565.9 3226.6 3282.0 3662.5 3662.9 1049.8 1131.6 1172.4 1173.3 1222.2 12962.0 13252.3 13567.3 15023.5 15028.8 4628.6 4746.6 4764.3 4788.0 4805.9 11813.1 11837.7 11846.0 11874.2 11932.3 5491.1 5807.0 5814.8 5826.6 5876.8 5201.3 5257.5 5263.5 5267.3 5274.5 3802.0 3830.8 3905.6 3908.5 3915.5 975.1 993.7 1018.7 1023.4 1033.0 845.7 862.5 897.8 972.2 982.6 6532.5 6562.9 6659.9 6727.7 6798.5 964.7 988.1 998.0 1001.6 1006.4 4100.2 4287.0 4449.7 4502.6 4693.5 13172.3 13503.0 13514.9 13515.0 13549.1 13012.5 13412.1 13440.0 13484.4 13808.0 9758.0 10039.4 10052.1 10054.0 10080.4 5810.6 6560.5 6763.2 6995.7 7019.3 8751.4 10780.1 11061.7 11471.3 11656.0 11442.9 11599.8 11778.0 11778.7 11976.3 8986.6 9221.0 9288.0 9368.2 9424.0 8465.7 10117.9 10257.1 10303.8 10362.5 8380.3 8505.0 9101.1 9181.0 9247.6 8730.7 8859.3 8905.0 8912.9 8913.2 7539.3 7783.2 7805.3 7838.1 8054.4 5771.3 5815.0 5899.5 5913.3 6162.8 5806.3 5848.6 5970.4 6050.1 6193.7 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | [#4] prototype.html Cycles:180 Average:4625.06 Median:5015.30 stddev:1301.71 (26.0%) stddev-sans-first:1265.58 08:58:51 INFO - PROCESS | 2251 | Values: 370.0 375.8 386.0 393.8 393.9 4845.3 4931.3 4956.9 5071.8 5404.0 4270.8 5240.5 5257.6 5283.4 5324.8 3718.8 3878.7 4369.8 4395.2 4396.8 3934.3 4070.7 4215.2 4269.0 4339.5 3813.0 4126.2 4340.5 4369.0 4377.7 4105.5 4326.5 4352.2 4360.2 4375.5 3267.1 3775.5 3790.9 3928.1 4038.4 4172.2 4362.1 4508.5 4934.7 5181.5 4598.5 5061.9 5069.5 5076.4 5095.3 4816.6 5403.5 5679.3 5691.6 5727.6 3716.9 4317.4 4469.2 4471.3 4490.0 5128.7 5716.5 5802.2 6042.5 6061.7 3935.0 4327.5 4471.3 4543.0 4580.7 4341.6 4666.1 4683.6 4691.1 4701.6 4211.9 4403.4 4716.0 5008.9 5021.6 4582.7 5511.4 5549.5 5579.7 5588.9 1479.0 1499.8 1520.9 1544.5 1588.9 1095.5 1120.3 1173.8 1194.4 1216.0 4521.7 4842.5 5147.9 5203.7 5257.6 5180.4 5364.2 5475.9 5806.0 5849.5 4069.8 4590.4 5155.9 5296.7 5350.4 2804.6 2869.8 2879.5 2901.8 3081.3 5137.9 5172.3 5660.8 5711.0 5769.1 5448.2 5465.9 5702.7 5901.8 5975.0 5237.2 5304.4 5559.6 5743.7 6114.4 4209.8 5176.5 5858.1 5873.8 5899.6 5420.6 5480.7 5813.2 5832.5 5844.5 5501.4 5788.6 5979.3 6121.8 6126.3 3986.9 4278.7 4608.5 4645.3 4657.6 5038.9 5405.3 5558.0 5590.9 5780.5 5267.7 5310.4 5329.7 5684.9 5705.1 5593.4 5609.6 5701.4 5726.6 5798.6 4670.4 4948.2 5287.8 5499.8 5532.9 4687.5 4978.4 5355.8 5372.9 5405.4 4754.4 4817.8 5123.5 5220.8 5512.3 08:58:51 INFO - PROCESS | 2251 | 08:58:51 INFO - PROCESS | 2251 | [#5] yui.html Cycles:180 Average:19766.33 Median:4568.30 stddev:28972.85 (634.2%) stddev-sans-first:29018.54 08:58:51 INFO - PROCESS | 2251 | Values: 639.3 646.2 741.1 798.0 808.4 15057.2 15834.5 15845.2 15877.2 15928.2 14205.5 14631.0 14809.4 15111.8 15150.5 915.5 920.0 938.4 939.0 941.0 933.1 936.5 944.4 971.2 975.7 1006.0 1016.3 1019.6 1019.7 1021.0 991.9 1008.9 1011.3 1012.3 1014.3 731.5 744.6 749.9 751.7 752.9 13770.3 15641.5 15813.1 16081.6 16354.6 14008.2 14315.9 14385.7 14511.7 14546.9 10169.4 11118.7 11527.9 11598.5 11879.9 4468.0 4511.1 4513.7 4520.9 4699.1 77999.0 107024.0 108229.0 108234.0 109513.8 11285.7 11302.8 11318.5 11339.5 11637.5 22791.7 23148.4 23164.2 23248.3 23282.2 7280.8 7281.4 7359.0 7370.5 7463.3 4080.6 4154.9 4172.1 4213.1 4214.3 3352.4 3424.9 3425.7 3435.3 3439.9 537.7 629.9 634.0 638.5 649.0 527.6 539.4 542.6 549.4 550.6 8163.2 9233.7 9502.5 9669.0 9937.5 568.5 587.6 604.8 651.3 655.9 4615.7 4645.9 4691.0 4698.2 4699.2 88823.0 92659.0 101679.4 102737.5 103962.0 90595.5 91837.1 91913.0 92086.6 92718.5 77673.5 78858.2 80869.2 81357.2 83675.2 8018.7 8243.7 8715.9 8971.8 9318.6 36832.6 41124.8 52818.7 53861.7 54025.7 61108.4 62070.7 62172.0 62184.4 62818.0 11180.8 11254.6 11384.5 11807.6 12008.3 11771.2 11863.9 11995.3 12072.8 12248.8 10353.9 10876.3 11462.4 11469.3 11792.6 9610.8 10127.6 10625.7 10680.1 11128.1 10119.8 10670.0 10839.3 11041.7 11448.8 8839.7 9360.3 9416.4 9422.4 9627.3 7414.9 8078.5 8124.3 9594.0 9799.9 08:58:51 INFO - PROCESS | 2251 | -------- Summary: end -------- 08:58:51 INFO - PROCESS | 2251 | 08:58:52 INFO - TEST-INFO | 2251: exit 0 08:58:52 INFO - TEST-OK | dromaeo_css | took 1117271ms 08:58:52 INFO - TEST-START | kraken 08:58:52 INFO - operating with platform_type : mac_ 08:58:52 INFO - Initialising browser for kraken test... 08:58:52 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpVgFMeF/profile http://localhost:57168/getInfo.html) 08:58:55 INFO - PROCESS | 2256 | 2017-03-11 08:58:55.089 plugin-container[2257:25895] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 08:58:55 INFO - PROCESS | 2256 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:55 INFO - PROCESS | 2256 | 2017-03-11 08:58:55.092 plugin-container[2257:25895] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 08:58:55 INFO - PROCESS | 2256 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:55 INFO - PROCESS | 2256 | 2017-03-11 08:58:55.092 plugin-container[2257:25895] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:58:55 INFO - PROCESS | 2256 | __metrics Screen width/height:1600/1200 08:58:55 INFO - PROCESS | 2256 | colorDepth:24 08:58:55 INFO - PROCESS | 2256 | Browser inner width/height: 1024/689 08:58:55 INFO - PROCESS | 2256 | __metrics 08:58:55 ERROR - PROCESS | 2256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 08:58:56 INFO - TEST-INFO | 2256: exit 0 08:58:56 INFO - Browser initialized. 08:58:56 INFO - Running cycle 1/1 for kraken test... 08:58:56 INFO - TEST-INFO | started process 2258 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/T/tmpVgFMeF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:58 INFO - PROCESS | 2258 | 2017-03-11 08:58:58.420 plugin-container[2259:26028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.tsm.portname' 08:58:58 INFO - PROCESS | 2258 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:58 INFO - PROCESS | 2258 | 2017-03-11 08:58:58.420 plugin-container[2259:26028] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9017, name = 'com.apple.CFPasteboardClient' 08:58:58 INFO - PROCESS | 2258 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:58:58 INFO - PROCESS | 2258 | 2017-03-11 08:58:58.420 plugin-container[2259:26028] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:59:08 INFO - PROCESS | 2258 | RSS: Main: 227721216 08:59:08 INFO - PROCESS | 2258 | 08:59:10 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-beat-detection) 08:59:11 INFO - PROCESS | 2258 | RSS: Main: 241827840 08:59:11 INFO - PROCESS | 2258 | 08:59:14 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-dft) 08:59:15 INFO - PROCESS | 2258 | RSS: Main: 250286080 08:59:15 INFO - PROCESS | 2258 | 08:59:18 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-fft) 08:59:19 INFO - PROCESS | 2258 | RSS: Main: 253149184 08:59:19 INFO - PROCESS | 2258 | 08:59:21 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57168/tests/kraken/driver.html?testName=audio-oscillator) 08:59:22 INFO - PROCESS | 2258 | RSS: Main: 255283200 08:59:22 INFO - PROCESS | 2258 | 08:59:24 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57168/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:59:24 INFO - PROCESS | 2258 | RSS: Main: 255610880 08:59:24 INFO - PROCESS | 2258 | 08:59:27 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57168/tests/kraken/driver.html?testName=imaging-darkroom) 08:59:28 INFO - PROCESS | 2258 | RSS: Main: 261873664 08:59:28 INFO - PROCESS | 2258 | 08:59:31 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57168/tests/kraken/driver.html?testName=imaging-desaturate) 08:59:32 INFO - PROCESS | 2258 | RSS: Main: 262430720 08:59:32 INFO - PROCESS | 2258 | 08:59:35 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57168/tests/kraken/driver.html?testName=json-parse-financial) 08:59:36 INFO - PROCESS | 2258 | RSS: Main: 262303744 08:59:36 INFO - PROCESS | 2258 | 08:59:38 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57168/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:59:38 INFO - PROCESS | 2258 | RSS: Main: 262062080 08:59:38 INFO - PROCESS | 2258 | 08:59:40 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:59:41 INFO - PROCESS | 2258 | RSS: Main: 261971968 08:59:41 INFO - PROCESS | 2258 | 08:59:43 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:59:44 INFO - PROCESS | 2258 | RSS: Main: 262021120 08:59:44 INFO - PROCESS | 2258 | 08:59:46 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:59:47 INFO - PROCESS | 2258 | RSS: Main: 262389760 08:59:47 INFO - PROCESS | 2258 | 08:59:50 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:59:51 INFO - PROCESS | 2258 | RSS: Main: 262397952 08:59:51 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | Cycle 1(1): loaded http://localhost:57168/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57168/tests/kraken/driver.html?testName=ai-astar) 08:59:53 INFO - PROCESS | 2258 | RSS: Main: 265433088 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | __start_tp_report 08:59:53 INFO - PROCESS | 2258 | _x_x_mozilla_page_load 08:59:53 INFO - PROCESS | 2258 | _x_x_mozilla_page_load_details 08:59:53 INFO - PROCESS | 2258 | |i|pagename|runs| 08:59:53 INFO - PROCESS | 2258 | |0;ai-astar;110;125;120;119;121;120;120;120;121;120 08:59:53 INFO - PROCESS | 2258 | |1;audio-beat-detection;147;132;144;162;115;131;130;147;135;123 08:59:53 INFO - PROCESS | 2258 | |2;audio-dft;197;207;217;238;274;204;235;223;196;205 08:59:53 INFO - PROCESS | 2258 | |3;audio-fft;82;64;76;100;77;74;53;56;100;69 08:59:53 INFO - PROCESS | 2258 | |4;audio-oscillator;92;72;88;74;72;73;86;57;85;114 08:59:53 INFO - PROCESS | 2258 | |5;imaging-gaussian-blur;89;103;108;91;89;93;119;90;89;89 08:59:53 INFO - PROCESS | 2258 | |6;imaging-darkroom;97;100;94;133;134;153;120;97;97;98 08:59:53 INFO - PROCESS | 2258 | |7;imaging-desaturate;118;148;93;94;91;91;119;83;139;147 08:59:53 INFO - PROCESS | 2258 | |8;json-parse-financial;73;65;67;66;68;68;73;67;67;67 08:59:53 INFO - PROCESS | 2258 | |9;json-stringify-tinderbox;61;62;68;71;63;60;52;84;53;56 08:59:53 INFO - PROCESS | 2258 | |10;stanford-crypto-aes;88;89;88;93;87;89;87;88;87;88 08:59:53 INFO - PROCESS | 2258 | |11;stanford-crypto-ccm;148;140;145;149;150;152;156;142;213;136 08:59:53 INFO - PROCESS | 2258 | |12;stanford-crypto-pbkdf2;214;239;174;172;172;169;186;170;170;175 08:59:53 INFO - PROCESS | 2258 | |13;stanford-crypto-sha256-iterative;68;76;79;84;67;86;86;86;86;77 08:59:53 INFO - PROCESS | 2258 | __end_tp_report 08:59:53 INFO - PROCESS | 2258 | __start_cc_report 08:59:53 INFO - PROCESS | 2258 | _x_x_mozilla_cycle_collect,1016 08:59:53 INFO - PROCESS | 2258 | __end_cc_report 08:59:53 INFO - PROCESS | 2258 | __startTimestamp1489251593615__endTimestamp 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | ------- Summary: start ------- 08:59:53 INFO - PROCESS | 2258 | Number of tests: 14 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#0] ai-astar Cycles:10 Average:119.60 Median:120.00 stddev:3.75 (3.1%) stddev-sans-first:1.73 08:59:53 INFO - PROCESS | 2258 | Values: 110.0 125.0 120.0 119.0 121.0 120.0 120.0 120.0 121.0 120.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:139.50 stddev:13.61 (9.8%) stddev-sans-first:13.90 08:59:53 INFO - PROCESS | 2258 | Values: 147.0 132.0 144.0 162.0 115.0 131.0 130.0 147.0 135.0 123.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#2] audio-dft Cycles:10 Average:219.60 Median:220.00 stddev:24.12 (11.0%) stddev-sans-first:24.16 08:59:53 INFO - PROCESS | 2258 | Values: 197.0 207.0 217.0 238.0 274.0 204.0 235.0 223.0 196.0 205.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#3] audio-fft Cycles:10 Average:75.10 Median:71.50 stddev:16.01 (22.4%) stddev-sans-first:16.79 08:59:53 INFO - PROCESS | 2258 | Values: 82.0 64.0 76.0 100.0 77.0 74.0 53.0 56.0 100.0 69.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:79.50 stddev:15.46 (19.4%) stddev-sans-first:15.90 08:59:53 INFO - PROCESS | 2258 | Values: 92.0 72.0 88.0 74.0 72.0 73.0 86.0 57.0 85.0 114.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:89.00 stddev:10.48 (11.8%) stddev-sans-first:10.80 08:59:53 INFO - PROCESS | 2258 | Values: 89.0 103.0 108.0 91.0 89.0 93.0 119.0 90.0 89.0 89.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#6] imaging-darkroom Cycles:10 Average:112.30 Median:95.50 stddev:21.10 (22.1%) stddev-sans-first:21.64 08:59:53 INFO - PROCESS | 2258 | Values: 97.0 100.0 94.0 133.0 134.0 153.0 120.0 97.0 97.0 98.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#7] imaging-desaturate Cycles:10 Average:112.30 Median:87.00 stddev:25.26 (29.0%) stddev-sans-first:26.71 08:59:53 INFO - PROCESS | 2258 | Values: 118.0 148.0 93.0 94.0 91.0 91.0 119.0 83.0 139.0 147.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:67.50 stddev:2.73 (4.0%) stddev-sans-first:2.24 08:59:53 INFO - PROCESS | 2258 | Values: 73.0 65.0 67.0 66.0 68.0 68.0 73.0 67.0 67.0 67.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:62.50 stddev:9.51 (15.2%) stddev-sans-first:10.06 08:59:53 INFO - PROCESS | 2258 | Values: 61.0 62.0 68.0 71.0 63.0 60.0 52.0 84.0 53.0 56.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:88.00 stddev:1.78 (2.0%) stddev-sans-first:1.88 08:59:53 INFO - PROCESS | 2258 | Values: 88.0 89.0 88.0 93.0 87.0 89.0 87.0 88.0 87.0 88.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#11] stanford-crypto-ccm Cycles:10 Average:153.10 Median:149.50 stddev:21.87 (14.6%) stddev-sans-first:23.11 08:59:53 INFO - PROCESS | 2258 | Values: 148.0 140.0 145.0 149.0 150.0 152.0 156.0 142.0 213.0 136.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.10 Median:174.50 stddev:23.61 (13.5%) stddev-sans-first:22.42 08:59:53 INFO - PROCESS | 2258 | Values: 214.0 239.0 174.0 172.0 172.0 169.0 186.0 170.0 170.0 175.0 08:59:53 INFO - PROCESS | 2258 | 08:59:53 INFO - PROCESS | 2258 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.50 Median:85.00 stddev:7.43 (8.7%) stddev-sans-first:6.61 08:59:53 INFO - PROCESS | 2258 | Values: 68.0 76.0 79.0 84.0 67.0 86.0 86.0 86.0 86.0 77.0 08:59:53 INFO - PROCESS | 2258 | -------- Summary: end -------- 08:59:53 INFO - PROCESS | 2258 | 08:59:54 INFO - TEST-INFO | 2258: exit 0 08:59:54 INFO - TEST-OK | kraken | took 62412ms 08:59:54 INFO - SUITE-END | took 1179s 08:59:54 INFO - Completed test suite (00:19:39) 08:59:54 INFO - javascript benchmark 08:59:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7646.797343855421, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.9497357539635, 3430.3825311443948, 3445.5693038370205, 3463.5151078848958, 3485.5120283160363, 5906.0, 6017.8495537611525, 6020.638761674297, 6046.727897244624, 6096.847578810521, 5989.610675306102, 6049.2136022317145, 6051.2133422655, 6079.05774604937, 6091.512678985681, 5383.650062745928, 5402.459754024605, 5445.401005889349, 5471.562275017999, 5494.203340515623, 4594.448666160049, 5361.383440904287, 5462.672239665632, 5502.532284755801, 5544.722763861811, 5472.5621950243885, 5480.780768769245, 5514.448555144493, 5563.833085007456, 5569.443055694439, 4293.8711838644895, 5337.519623233928, 5415.783368665248, 5461.535769459561, 5481.0, 5320.095583750772, 5402.432744561804, 5404.864878378033, 5444.537214336786, 5451.318585176853, 5843.678597677126, 5846.21076154718, 5899.882002359929, 6041.154238406627, 6129.570930034899, 6234.470070044052, 6268.435840774352, 6284.434400903895, 6396.328385519547, 6405.103285540028, 6493.70778314977, 6493.740250389978, 6508.0563318319055, 6516.77191298307, 6519.152510173647, 6179.969100154471, 6211.65835879031, 6216.2540495140875, 6223.906641400383, 6229.4393504584805, 6287.874242515124, 6336.556441049174, 6488.870222595521, 6497.610143391412, 6503.967480162569, 5459.727013649381, 6097.827165393427, 6314.336994615591, 6319.115323854664, 6354.983202687547, 6233.283172435137, 6346.492280617539, 6354.904676429857, 6363.236411630634, 6366.331535188739, 6351.68241587928, 6357.205349331333, 6358.8410289742205, 6379.776707815204, 6383.4574061204385, 6182.876342473125, 6257.2491301044165, 6353.585637457736, 6369.140166077613, 6380.649064301508, 5144.717040562805, 5150.587952963754, 5158.716270605078, 5179.093658609729, 5238.842834714965, 4652.488226295105, 4652.837150699777, 4676.041411510632, 4709.434867815884, 4712.081144176921, 6132.816015519542, 6146.815595532141, 6150.938490615036, 6178.443940045418, 6182.350853160354, 6215.9378406216265, 6231.781887633911, 6335.714892829834, 6356.713947872357, 6457.225132984072, 6130.7650488535955, 6135.385782596134, 6148.323684394713, 6168.290646575611, 6171.475424588871, 5702.7433765480655, 5712.371639119777, 5722.54219662426, 5725.713714314351, 5842.831433713274, 6348.492120630246, 6371.331010243857, 6521.739130434919, 6647.567908086153, 6682.231543372477, 6362.586431881913, 6430.324815894263, 6453.128827608213, 6470.48236141117, 6483.0, 6647.966760166361, 6669.333066693486, 6672.199336079701, 6672.332766723289, 6675.198976122896, 6234.625922444668, 6281.309056003927, 6297.905531416941, 6301.684915754102, 6341.365863413622, 6268.076667549122, 6299.590526615755, 6411.198600174978, 6431.614103153825, 6452.12896258999, 6261.092141639528, 6264.906026409699, 6274.6548939808745, 6275.435210831047, 6296.811095666954, 5211.9478805212975, 6180.258368995749, 6217.751289948352, 6230.470410015199, 6264.5301602379095, 5252.7898884045735, 5673.007223735913, 6174.44430001302, 6312.558120931674, 6319.842003949938, 5266.631335806457, 6248.4064013918605, 6287.2769631492965, 6305.243370795534, 6311.873762524816, 6059.212302400836, 6131.448169664752, 6131.478824299806, 6298.275698294755, 6303.747850085945], "value": 5895.468946548261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.6097146569389, 780.0911937592705, 801.5951944268144, 873.4366333714751, 933.6965486216977, 38025.0, 38650.80674596626, 40078.59921400785, 40175.397369039485, 40176.59823401765, 38093.619063809354, 38419.0, 38499.615003849955, 38587.84236472903, 38741.932097129815, 7726.806829829257, 7894.6447409866405, 10876.02115809577, 11039.944800275987, 11143.442827858575, 10878.129749620051, 10951.945240273828, 10967.177461690366, 10975.176861735363, 11017.614383496579, 10919.344839309666, 11007.889921100767, 11009.0, 11019.063379612702, 11025.338479691203, 11149.777004459906, 11180.267058605928, 11211.831822522669, 11216.439178041066, 11269.83095253576, 9410.62357505699, 10922.29005114665, 10935.234533582652, 11003.0, 11014.953579409943, 38523.036924077125, 38619.806900965596, 38771.224575508335, 38806.0, 38871.0, 3675.732875447356, 3720.8325625346924, 3752.7185461090253, 3755.7746535207975, 3892.026993251687, 27427.90288388462, 27779.44441111187, 28718.856405717837, 28723.712762872314, 28744.0, 3163.8734450621946, 3267.836608169606, 3292.901212963615, 3293.1931676739114, 3317.568716066896, 305230.9999999978, 325354.0, 325521.0, 326062.0, 332010.0, 49992.0, 50126.74936625294, 50210.0, 50249.0, 50253.0, 52093.0, 52259.47740522546, 52625.7368713154, 52637.47362526326, 52896.0, 14378.784318235235, 14492.202928839015, 14516.637084072772, 14664.560063198121, 14676.412943482355, 11699.941500292614, 11773.117016223818, 11903.0, 11907.404629768476, 11913.404329783476, 13819.723605527834, 13850.515231966832, 13882.861171388156, 13900.51348202808, 13966.58100256994, 5096.311997880312, 6026.306974697878, 6076.574639775174, 6079.331273559905, 6084.543659225487, 919.4161707315902, 921.3826736086704, 936.8079543693526, 960.2558017536326, 966.2704657983318, 21089.0, 25679.0, 26727.0, 27903.16290511288, 28375.858120709265, 912.8493798523302, 1012.372329155928, 1039.0700323210835, 1045.243990096645, 1049.2393015064017, 13977.231252281223, 14395.0, 14495.855041449662, 14697.485588004369, 14751.409943602135, 399650.0, 403000.0, 403529.0, 403761.0, 404466.0, 44693.32960005602, 53433.93132137413, 53513.0, 53931.460685392645, 54128.45871541313, 1397.7903314502905, 1444.0397135904507, 1444.1768192130385, 1445.0534899640961, 1448.2686243446992, 21777.12891484323, 23000.539989199788, 27612.58581121325, 27875.303117422227, 28400.43199136047, 46495.30257046079, 46619.06761864676, 46659.53340466688, 46719.065618686756, 47637.04725905393, 304943.0, 365489.0, 366505.0, 366927.0, 366930.0, 33094.33811323712, 33829.154271143416, 34482.482762758074, 35155.296894062485, 36594.81702591576, 37335.43996840104, 44812.77593612011, 45046.324305136106, 45493.0, 45763.54236457593, 34898.47652285269, 34967.95096147119, 36638.0, 37875.0, 37899.0, 29116.12651620455, 36144.45783313305, 36504.81747591245, 37718.811405943896, 37934.810325948194, 36554.634453655126, 36701.63298366982, 37037.44443833291, 37424.62575374211, 37470.812645936596, 30997.845010774803, 32279.63890471737, 32608.0, 32792.0162395119, 33194.0, 24148.39629009289, 24576.402533835244, 24598.385040374134, 24963.500729985662, 24992.000959884204], "value": 18802.510667164468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.65253441489676, 396.3816446343702, 400.7875825812321, 409.3900088867587, 440.47803353026666, 20658.793412065876, 21227.787722122775, 22059.558808823815, 22097.447563810874, 22143.224987125435, 20175.697364539545, 20959.47601309968, 21263.893680531615, 21306.254281100166, 22451.877406129668, 6328.683565821713, 6698.263191048981, 6698.83252918676, 6698.966505167467, 6716.966415167917, 5514.724263786815, 6502.252240992299, 6569.737210511574, 6789.9815027745735, 6848.965755171217, 6776.288489708583, 6828.556143850634, 6842.144731908512, 6842.863142737142, 6847.144106986627, 6415.230172379298, 6571.244306904696, 6641.269460359356, 6650.50121240904, 6660.8667826643195, 6296.96851515744, 6482.0, 6505.219373675142, 6623.4038936495945, 6660.2340730816095, 25937.481250375076, 26304.0, 26562.86718566395, 26567.468650627074, 26619.33451663724, 2795.4409118176445, 2869.483343545902, 2900.7389334959953, 2931.7361437470518, 2958.8224706517462, 15685.607859803482, 15907.806914481345, 16290.266937987819, 16491.422800201934, 16732.916335418366, 2024.7873973232745, 2029.6853987631941, 2086.405374468269, 2095.371388583434, 2099.422658768851, 89553.55223223842, 128107.35946320208, 157239.0, 157838.0, 158475.41524584722, 17875.553111172325, 18067.82559133652, 20975.265865694626, 22085.122764564872, 22717.43206419853, 29851.10446686603, 35491.4676279856, 35808.925732228076, 35893.64106358903, 36048.09879753027, 10348.327358721659, 10616.946915265375, 10695.0, 10806.243562950518, 10927.617533386294, 7922.445428820042, 8632.179942905414, 8635.6977505787, 8845.51349675774, 8886.0, 10438.321509102036, 10454.895451045544, 10514.894851051544, 10700.678979630624, 10903.563857445613, 4312.956870431318, 4368.301071828492, 4373.906523369158, 4379.430674012358, 4400.427944367212, 856.6316483911853, 863.313665635821, 957.4016239850093, 1033.204432586904, 1096.366414043086, 21427.67858482124, 21527.67708484374, 22008.0, 23543.529129417315, 23757.16849910245, 908.1871724806393, 981.4896253947907, 992.0971915556809, 1093.3002878157986, 1125.4147843121532, 11493.482793274323, 11569.826452603218, 11672.941635291769, 11673.416329183678, 11870.347130907883, 624158.0, 708073.0, 710513.0, 729462.0, 732264.0, 139037.0, 140365.0, 140516.0, 149913.25043374932, 152913.9999999978, 1284.6659868434274, 1293.792993121115, 1310.3251825309974, 1326.2440408966988, 1331.1480652382484, 18977.90511047436, 19700.901495493003, 19779.70330445016, 19801.801981979996, 19864.21222090019, 44513.777431112634, 53894.0, 58117.0, 59703.0, 61613.0, 87841.12158878586, 89016.0, 89713.0, 90891.09108908827, 90909.54545227232, 9499.857502137611, 11089.445527723743, 11945.641630751092, 11962.521499140285, 12280.877191227974, 13574.524891628746, 13594.592162235149, 13652.385642645906, 13910.956678249375, 13971.231582263074, 11340.0, 11395.461612682182, 11676.591319303783, 11805.76388472243, 11881.287122772661, 11479.827802583135, 11554.306741595532, 11635.941820290844, 11816.350100744541, 11966.162368634112, 11817.82273265919, 11893.524259029542, 11935.0, 12028.458719357825, 12057.095717821023, 11960.342181180118, 12032.639020829389, 12246.203996740183, 12280.631581052583, 12548.498060077494, 11306.0, 11502.712432188928, 11685.0, 11715.882841171479, 11719.88280117188], "value": 11705.711152795497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.3643869574778, 1527.8472152784716, 1568.2707540993435, 1572.0960447742543, 1574.858262756352, 9021.548922553862, 10528.736781580465, 11097.889021109797, 11157.609483668073, 11252.93097155771, 10896.237263391566, 11074.778504429907, 11088.611898583551, 11100.4449777511, 11160.665180044612, 1893.4035778729724, 2139.4009677290383, 2161.659770942018, 2347.0963678983544, 2361.681173041635, 1844.2622950819646, 1881.5108071901336, 1886.1323791056132, 1887.2168050259127, 1887.59416725404, 2273.954520909589, 2288.336382449088, 2304.3893368257427, 2305.2853615379204, 2306.1813056365, 2276.237460450751, 2280.1563421533974, 2283.668868014137, 2285.714285714286, 2287.2337766848127, 2198.5822693688147, 2305.5734689082406, 2307.9538409231723, 2311.56080344734, 2312.629979203319, 10860.67417977462, 10958.835617465744, 10959.397233152173, 10964.890351096547, 10979.945100274528, 5735.311762588516, 5907.409259074101, 5910.763569457216, 5914.201582786355, 5931.851703707399, 2565.9358516037064, 3226.56441380413, 3282.0, 3662.505561749183, 3662.8901132966053, 1049.7638031442864, 1131.5926266544038, 1172.3879665459992, 1173.3370645585217, 1222.1811386371153, 12962.0, 13252.271125088117, 13567.253801040939, 15023.549293521211, 15028.774568381483, 4628.560286772751, 4746.644001699887, 4764.332993380929, 4788.018456216468, 4805.879853003703, 11813.054955603531, 11837.704057398634, 11846.0, 11874.168808183344, 11932.343721095249, 5491.121420572689, 5806.970965145148, 5814.825555233349, 5826.592138550261, 5876.7649294028615, 5201.297824793604, 5257.4742525747115, 5263.473652634706, 5267.26258323835, 5274.525292723673, 3802.0, 3830.8467661293794, 3905.6484916357663, 3908.472356231929, 3915.4909861717792, 975.0882924465648, 993.6869885985891, 1018.7147598672384, 1023.3910823060268, 1032.9896701033044, 845.7166849105496, 862.5040601653949, 897.7665806890255, 972.1639390124628, 982.5873133284038, 6532.510061745293, 6562.901556476657, 6659.933400666028, 6727.697253623599, 6798.456123510107, 964.6623681711345, 988.0958922585897, 997.9950100249597, 1001.594801246042, 1006.3509036671306, 4100.200460910153, 4287.013986782995, 4449.733016018984, 4502.594766471033, 4693.530646935279, 13172.341382930816, 13503.0, 13514.864851351558, 13514.986376021838, 13549.119307245195, 13012.544560940321, 13412.12821166621, 13439.992000599994, 13484.39320230592, 13808.0, 9758.0, 10039.397636141855, 10052.095311422006, 10053.999999999854, 10080.3951762893, 5810.593258471867, 6560.475161987125, 6763.154605674291, 6995.650217489207, 7019.29807019294, 8751.431156974777, 10780.083692886192, 11061.723456913642, 11471.311721296748, 11656.0, 11442.885571144181, 11599.8260026098, 11778.0, 11778.705532361759, 11976.28142311464, 8986.595603198002, 9220.953895230481, 9287.953560232427, 9368.203702685349, 9424.0, 8465.703700370457, 10117.949410252902, 10257.076863082359, 10303.845442318221, 10362.5336859843, 8380.329573633973, 8504.957475212585, 9101.135392137736, 9180.954095229481, 9247.630094796134, 8730.69442569507, 8859.335549833917, 8905.0, 8912.86630700527, 8913.242374398249, 7539.283768042027, 7783.221677832172, 7805.297523222937, 7838.098618658927, 8054.3556515479795, 5771.307443106854, 5814.970925145347, 5899.52511872032, 5913.2608423947, 6162.784302549389, 5806.303243610793, 5848.56135789826, 5970.402959703995, 6050.092486127116, 6193.659348735682], "value": 5014.060897057582, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9889003329901, 375.8383894925181, 385.967192788613, 393.75587135975684, 393.90546268895463, 4845.279925626404, 4931.260310953355, 4956.876078098049, 5071.822486212984, 5404.0, 4270.786460676969, 5240.475952404758, 5257.581512504243, 5283.365996080466, 5324.787008519665, 3718.8326525306293, 3878.650921417072, 4369.781510924457, 4395.186890425265, 4396.846110386137, 3934.3114954882926, 4070.6743460523235, 4215.199112168693, 4269.0, 4339.522652508222, 3812.989557767194, 4126.2148050066235, 4340.502526628308, 4369.0, 4377.6935614507, 4105.545483150785, 4326.524082350938, 4352.194843953878, 4360.23695853226, 4375.484096644426, 3267.134209434478, 3775.4903088083306, 3790.943135852937, 3928.135810121769, 4038.3846461415374, 4172.165566886635, 4362.149380870732, 4508.481524624677, 4934.654574179773, 5181.476595914776, 4598.517155698671, 5061.924071138899, 5069.518395752434, 5076.44159142494, 5095.286659867585, 4816.563605112889, 5403.5136837684795, 5679.290088738908, 5691.573132015115, 5727.570432217601, 3716.888493345177, 4317.445719540963, 4469.240229161051, 4471.262241730111, 4489.955100448987, 5128.743562821844, 5716.542676585822, 5802.243934131296, 6042.486388656969, 6061.727222275008, 3934.960650393459, 4327.5239723630375, 4471.28459446487, 4542.977285113553, 4580.725156490621, 4341.565843415633, 4666.06358361283, 4683.634764443934, 4691.114964297001, 4701.623870090384, 4211.925958880466, 4403.361512580658, 4715.95284047162, 5008.949910500921, 5021.648484606116, 4582.725036497821, 5511.382093505633, 5549.500544950974, 5579.69311687861, 5588.882223555305, 1478.9926050369895, 1499.7626957759892, 1520.8707259883033, 1544.4980381376097, 1588.9364425423084, 1095.5343978809133, 1120.3222050659233, 1173.7887180307628, 1194.4445832687843, 1215.9756804863853, 4521.683482156283, 4842.467328593852, 5147.922781158286, 5203.661761985459, 5257.553107985787, 5180.430152683201, 5364.195370694427, 5475.890482190334, 5806.0, 5849.473547380756, 4069.7761623111014, 4590.42619672541, 5155.860317968001, 5296.708681022504, 5350.38470575881, 2804.551271796503, 2869.7991140620375, 2879.510483217858, 2901.7968742187845, 3081.2604974805886, 5137.948620513747, 5172.27588137661, 5660.839283126898, 5711.029125048752, 5769.067362433548, 5448.194179997305, 5465.9180112298345, 5702.6863522506665, 5901.822945311647, 5974.970125149346, 5237.188235823453, 5304.38999515053, 5559.610827242054, 5743.655380677173, 6114.370820547208, 4209.831606735696, 5176.498815343508, 5858.129516536951, 5873.823785286449, 5899.587028907935, 5420.593455490775, 5480.671159730429, 5813.15709222152, 5832.475077243069, 5844.503217226584, 5501.404592668081, 5788.6396696777065, 5979.325788779149, 6121.785737499166, 6126.295476020315, 3986.9202615948097, 4278.65770738334, 4608.4930657626965, 4645.326427668037, 4657.5575320344515, 5038.899222015612, 5405.270288511001, 5558.0, 5590.860228494157, 5780.450857168562, 5267.73661316925, 5310.4154695579555, 5329.653572517774, 5684.886302274014, 5705.088795253637, 5593.440655934374, 5609.559841468974, 5701.4298570142655, 5726.599138060295, 5798.59409841307, 4670.416197975253, 4948.193909223036, 5287.793281958316, 5499.807506737245, 5532.893421315834, 4687.531246875285, 4978.352814134139, 5355.812546560852, 5372.919406208832, 5405.378381486022, 4754.381930349033, 4817.807287708452, 5123.487651234846, 5220.817271395483, 5512.3385193777], "value": 4248.365656492678, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.2999665366425, 646.224530563324, 741.1032650492904, 797.9640916158772, 808.4260175275554, 15057.247137643115, 15834.524964251063, 15845.207739613032, 15877.206139693013, 15928.203589820507, 14205.502807401743, 14630.97583169176, 14809.407623695066, 15111.848881511181, 15150.54548363551, 915.455304094063, 920.0247737398379, 938.3572253006678, 938.9859152112724, 941.0307383395113, 933.0809152984305, 936.5270538378144, 944.36255527519, 971.1647982734843, 975.6682727872521, 1005.9798804023915, 1016.2885979814159, 1019.6380284998793, 1019.6788011776267, 1020.9744756381076, 991.9206463482905, 1008.8890222075565, 1011.3325205364424, 1012.2610494339137, 1014.279861298479, 731.4806487393956, 744.57559191261, 749.9437542184359, 751.7331347371659, 752.8870669399579, 13770.311484425738, 15641.530754077396, 15813.05121692702, 16081.597960050975, 16354.591135221715, 14008.22954737489, 14315.856841431556, 14385.71228575433, 14511.709765804624, 14546.927265363605, 10169.389836609827, 11118.66576010884, 11527.942360288229, 11598.536058557647, 11879.881201187964, 4467.977660111678, 4511.142882852248, 4513.7066090704, 4520.932186017212, 4699.130660827758, 77999.0, 107024.0, 108229.0, 108234.0, 109513.80972380508, 11285.661430156944, 11302.830457543143, 11318.490667919963, 11339.546418143182, 11637.47631356591, 22791.658125128135, 23148.421289467897, 23164.18925337605, 23248.302550923498, 23282.185123520594, 7280.817979550554, 7281.381082607932, 7358.963205184047, 7370.48406611532, 7463.328300452877, 4080.612341827581, 4154.937675934863, 4172.144710334374, 4213.094184750294, 4214.262504061777, 3352.379809735207, 3424.9143771405916, 3425.691687748065, 3435.2957643682985, 3439.9312013759586, 537.7176982084437, 629.8708764703225, 633.9711135732446, 638.5306799502362, 648.9675516224264, 527.6306585390242, 539.3743257820909, 542.6174546944395, 549.409384911222, 550.5788072124827, 8163.224493673091, 9233.746898263027, 9502.477363744922, 9669.016395072591, 9937.453440060866, 568.5196009372074, 587.5916238214486, 604.7753299568409, 651.3486513486514, 655.8655475627485, 4615.676902616851, 4645.883852903705, 4690.95309046912, 4698.201305778026, 4699.224627936421, 88823.0, 92659.0, 101679.44121955696, 102737.48631256945, 103961.96038039675, 90595.54702226447, 91837.08162918419, 91913.0, 92086.61870071954, 92718.53640731753, 77673.45591984877, 78858.21141788624, 80869.19130808617, 81357.18642813615, 83675.16324836796, 8018.679252829821, 8243.670253190045, 8715.91284087151, 8971.788808510768, 9318.580663870007, 36832.631673683994, 41124.794376029124, 52818.679533011986, 53861.73069134629, 54025.72987135039, 61108.38891611027, 62070.68964655148, 62172.0, 62184.44538886383, 62818.0, 11180.776384472427, 11254.606088786853, 11384.54461821551, 11807.586734464252, 12008.279503229835, 11771.23486973344, 11863.940680296544, 11995.340256285639, 12072.75854482888, 12248.755024899274, 10353.896461035294, 10876.347419154876, 11462.369569673749, 11469.31184128955, 11792.587259445878, 9610.759731006781, 10127.64553240633, 10625.734356641145, 10680.092192163753, 11128.109751219721, 10119.79760404773, 10670.0, 10839.295445796313, 11041.668749937515, 11448.771024579295, 8839.718240855169, 9360.297977651839, 9416.387934784218, 9422.387544809566, 9627.277954153607, 7414.8887766682465, 8078.474899131537, 8124.309433697966, 9593.986007736097, 9799.902000979899], "value": 7232.55942074145, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 125.0, 120.0, 119.0, 121.0, 120.0, 120.0, 120.0, 121.0, 120.0], "value": 119.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 132.0, 144.0, 162.0, 115.0, 131.0, 130.0, 147.0, 135.0, 123.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 207.0, 217.0, 238.0, 274.0, 204.0, 235.0, 223.0, 196.0, 205.0], "value": 219.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 64.0, 76.0, 100.0, 77.0, 74.0, 53.0, 56.0, 100.0, 69.0], "value": 75.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 72.0, 88.0, 74.0, 72.0, 73.0, 86.0, 57.0, 85.0, 114.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 103.0, 108.0, 91.0, 89.0, 93.0, 119.0, 90.0, 89.0, 89.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 94.0, 133.0, 134.0, 153.0, 120.0, 97.0, 97.0, 98.0], "value": 112.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 148.0, 93.0, 94.0, 91.0, 91.0, 119.0, 83.0, 139.0, 147.0], "value": 112.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 67.0, 66.0, 68.0, 68.0, 73.0, 67.0, 67.0, 67.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 68.0, 71.0, 63.0, 60.0, 52.0, 84.0, 53.0, 56.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 93.0, 87.0, 89.0, 87.0, 88.0, 87.0, 88.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 140.0, 145.0, 149.0, 150.0, 152.0, 156.0, 142.0, 213.0, 136.0], "value": 153.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 239.0, 174.0, 172.0, 172.0, 169.0, 186.0, 170.0, 170.0, 175.0], "value": 184.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 79.0, 84.0, 67.0, 86.0, 86.0, 86.0, 86.0, 77.0], "value": 79.5, "unit": "score"}]}]} 08:59:54 INFO - Return code: 0 08:59:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:59:54 ERROR - # TBPL SUCCESS # 08:59:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:59:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:59:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:59:54 INFO - 2017-03-11 08:59:54.955 screenresolution[2263:26418] starting screenresolution argv=screenresolution get 08:59:54 INFO - 2017-03-11 08:59:54.958 screenresolution[2263:26418] Display 0: 1600x1200x32@60 08:59:54 INFO - 2017-03-11 08:59:54.964 screenresolution[2264:26422] starting screenresolution argv=screenresolution list 08:59:54 INFO - Available Modes on Display 0 08:59:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:59:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:59:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:59:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:59:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:59:55 INFO - Intel Iris: 08:59:55 INFO - Chipset Model: Intel Iris 08:59:55 INFO - Type: GPU 08:59:55 INFO - Bus: Built-In 08:59:55 INFO - VRAM (Dynamic, Max): 1536 MB 08:59:55 INFO - Vendor: Intel (0x8086) 08:59:55 INFO - Device ID: 0x0a2e 08:59:55 INFO - Revision ID: 0x0009 08:59:55 INFO - Displays: 08:59:55 INFO - Display: 08:59:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:59:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:59:55 INFO - Display Serial Number: 1600x1200 60 08:59:55 INFO - Main Display: Yes 08:59:55 INFO - Mirror: Off 08:59:55 INFO - Online: Yes 08:59:55 INFO - Rotation: Supported 08:59:55 INFO - Return code: 0 08:59:55 INFO - Running post-action listener: _resource_record_post_action 08:59:55 INFO - [mozharness: 2017-03-11 16:59:55.210641Z] Finished run-tests step (success) 08:59:55 INFO - Running post-run listener: _resource_record_post_run 08:59:55 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 37376; Write bytes: 513380352; Read time: 2; Write time: 1610 08:59:55 INFO - TinderboxPrint: CPU usage
54.9% 08:59:55 INFO - TinderboxPrint: I/O read bytes / time
37,376 / 2 08:59:55 INFO - TinderboxPrint: I/O write bytes / time
513,380,352 / 1,610 08:59:55 INFO - TinderboxPrint: CPU idle
2,167.9 (45.1%) 08:59:55 INFO - TinderboxPrint: CPU system
971.0 (20.2%) 08:59:55 INFO - TinderboxPrint: CPU user
1,662.7 (34.6%) 08:59:55 INFO - TinderboxPrint: Swap in / out
209,256,448 / 0 08:59:55 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205187584; Write bytes: 200912896; Read time: 15515; Write time: 378 08:59:55 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 36864; Write bytes: 301445120; Read time: 2; Write time: 1158 08:59:55 INFO - Running post-run listener: _upload_blobber_files 08:59:55 INFO - Blob upload gear active. 08:59:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:59:55 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 08:59:55 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'] 08:59:55 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 08:59:56 INFO - (blobuploader) - INFO - Open directory for files ... 08:59:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:59:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:59:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:57 INFO - (blobuploader) - INFO - Done attempting. 08:59:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:59:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:58 INFO - (blobuploader) - INFO - Done attempting. 08:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:59:59 INFO - (blobuploader) - INFO - Done attempting. 08:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:00:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:00:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:00:01 INFO - (blobuploader) - INFO - Done attempting. 09:00:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:00:01 INFO - Return code: 0 09:00:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:00:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:00:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e50c770d97ee69af9c1097761f88df8e96d6da9084d3bbb9146081c4f188e00feba64a185bf93b935efea5e552c41419c6ba9c939bbd598dd4311439590f78", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da92fd7211415c4de71bd835630c548450cf240ced1b51dca9109d5c8985bb2cf2d7bbc9236da27e74166318a23877007793b8a29b5e1d28c73bbc628c2c8627", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b817ab33e61e1db4a57fbd95d3cf53e6b554958b23894c60e4392afc125ce8eab2f5f9ff00f715e6183d993efc58948c748194b59ecd14a8a99f2c1377fdee61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce17793b9f9e77bacfb778e4ac49593f2aec7ccea2e7019513a2db471d87bfb4528def50d25409acbafcf321a80f1dc0a58f229a12a4edeca416580c8f6c4588"} 09:00:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:00:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:00:01 INFO - Contents: 09:00:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e50c770d97ee69af9c1097761f88df8e96d6da9084d3bbb9146081c4f188e00feba64a185bf93b935efea5e552c41419c6ba9c939bbd598dd4311439590f78", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da92fd7211415c4de71bd835630c548450cf240ced1b51dca9109d5c8985bb2cf2d7bbc9236da27e74166318a23877007793b8a29b5e1d28c73bbc628c2c8627", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b817ab33e61e1db4a57fbd95d3cf53e6b554958b23894c60e4392afc125ce8eab2f5f9ff00f715e6183d993efc58948c748194b59ecd14a8a99f2c1377fdee61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce17793b9f9e77bacfb778e4ac49593f2aec7ccea2e7019513a2db471d87bfb4528def50d25409acbafcf321a80f1dc0a58f229a12a4edeca416580c8f6c4588"} 09:00:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:00:01 INFO - Copying logs to upload dir... 09:00:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:00:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.936626 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-11 09:00:01.525563) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:01.528138) ========= 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.0QIvb7QODi/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.kvDWkrt5wR/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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/90e50c770d97ee69af9c1097761f88df8e96d6da9084d3bbb9146081c4f188e00feba64a185bf93b935efea5e552c41419c6ba9c939bbd598dd4311439590f78", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da92fd7211415c4de71bd835630c548450cf240ced1b51dca9109d5c8985bb2cf2d7bbc9236da27e74166318a23877007793b8a29b5e1d28c73bbc628c2c8627", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b817ab33e61e1db4a57fbd95d3cf53e6b554958b23894c60e4392afc125ce8eab2f5f9ff00f715e6183d993efc58948c748194b59ecd14a8a99f2c1377fdee61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce17793b9f9e77bacfb778e4ac49593f2aec7ccea2e7019513a2db471d87bfb4528def50d25409acbafcf321a80f1dc0a58f229a12a4edeca416580c8f6c4588"} build_url:https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011433 build_url: 'https://queue.taskcluster.net/v1/task/ek9d67s6RSuQH2lrjjctpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90e50c770d97ee69af9c1097761f88df8e96d6da9084d3bbb9146081c4f188e00feba64a185bf93b935efea5e552c41419c6ba9c939bbd598dd4311439590f78", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da92fd7211415c4de71bd835630c548450cf240ced1b51dca9109d5c8985bb2cf2d7bbc9236da27e74166318a23877007793b8a29b5e1d28c73bbc628c2c8627", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b817ab33e61e1db4a57fbd95d3cf53e6b554958b23894c60e4392afc125ce8eab2f5f9ff00f715e6183d993efc58948c748194b59ecd14a8a99f2c1377fdee61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce17793b9f9e77bacfb778e4ac49593f2aec7ccea2e7019513a2db471d87bfb4528def50d25409acbafcf321a80f1dc0a58f229a12a4edeca416580c8f6c4588"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:01.599568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:01.599989) ========= 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.0QIvb7QODi/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.kvDWkrt5wR/Listeners TMPDIR=/var/folders/2_/5bvqc7_51034r2hmy_t0wjpm00000w/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.005090 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-11 09:00:01.656345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-11 09:00:01.658698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-11 09:00:01.659037) ========= ========= Total master_lag: 0.23 =========