builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0133 starttime: 1489147091.68 results: success (0) buildid: 20170310023722 builduid: b49eadd7111646f482e9fdc5bf197a02 revision: e18d3dd20e8d60bb21524e1b6ef4a87288369afe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.681568) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.682083) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.682388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.713604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.714038) ========= 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.rc0RMsK93l/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.T1iIWkbpH2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-10 03:58:11-- 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% 8.56M=0.001s 2017-03-10 03:58:11 (8.56 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.247320 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.984935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:11.985260) ========= 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.rc0RMsK93l/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.T1iIWkbpH2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.021978 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:12.037376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:12.040947) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e18d3dd20e8d60bb21524e1b6ef4a87288369afe --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 e18d3dd20e8d60bb21524e1b6ef4a87288369afe --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rc0RMsK93l/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.T1iIWkbpH2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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-10 03:58:12,123 truncating revision to first 12 chars 2017-03-10 03:58:12,124 Setting DEBUG logging. 2017-03-10 03:58:12,124 attempt 1/10 2017-03-10 03:58:12,124 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e18d3dd20e8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 03:58:12,818 unpacking tar archive at: mozilla-central-e18d3dd20e8d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942775 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:13.008083) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:13.008419) ========= script_repo_revision: e18d3dd20e8d60bb21524e1b6ef4a87288369afe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:13.014135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:13.014451) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 03:58:13.034780) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-10 03:58:13.035175) ========= /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.rc0RMsK93l/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.T1iIWkbpH2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:58:13 INFO - MultiFileLogger online at 20170310 03:58:13 in /builds/slave/test 03:58:13 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 03:58:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:58:13 INFO - {'append_to_log': False, 03:58:13 INFO - 'base_work_dir': '/builds/slave/test', 03:58:13 INFO - 'blob_upload_branch': 'Firefox', 03:58:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:58:13 INFO - 'branch': 'Firefox', 03:58:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:58:13 INFO - 'config_files': ('talos/mac_config.py',), 03:58:13 INFO - 'default_actions': ('clobber', 03:58:13 INFO - 'read-buildbot-config', 03:58:13 INFO - 'download-and-extract', 03:58:13 INFO - 'populate-webroot', 03:58:13 INFO - 'create-virtualenv', 03:58:13 INFO - 'install', 03:58:13 INFO - 'run-tests'), 03:58:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:58:13 INFO - 'download_minidump_stackwalk': True, 03:58:13 INFO - 'download_symbols': 'ondemand', 03:58:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:58:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:58:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:58:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:58:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:58:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:58:13 INFO - 'gecko_profile': False, 03:58:13 INFO - 'gecko_profile_interval': 0, 03:58:13 INFO - 'installer_path': 'installer.exe', 03:58:13 INFO - 'log_level': 'info', 03:58:13 INFO - 'log_name': 'talos', 03:58:13 INFO - 'log_to_console': True, 03:58:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:58:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:58:13 INFO - 'opt_config_files': (), 03:58:13 INFO - 'pip_index': False, 03:58:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:13 INFO - 'cmd': ('bash', 03:58:13 INFO - '-c', 03:58:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:13 INFO - 'enabled': True, 03:58:13 INFO - 'halt_on_failure': False, 03:58:13 INFO - 'name': 'check_screen_resolution'},), 03:58:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:58:13 INFO - 'cmd': ('bash', 03:58:13 INFO - '-c', 03:58:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:58:13 INFO - 'enabled': True, 03:58:13 INFO - 'halt_on_failure': False, 03:58:13 INFO - 'name': 'check_screen_resolution'},), 03:58:13 INFO - 'run_cmd_checks_enabled': True, 03:58:13 INFO - 'suite': 'dromaeojs-e10s', 03:58:13 INFO - 'system_bits': '32', 03:58:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:58:13 INFO - 'title': 't-yosemite-r7-0133', 03:58:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:58:13 INFO - 'use_talos_json': True, 03:58:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:58:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:58:13 INFO - 'work_dir': 'build'} 03:58:13 INFO - [mozharness: 2017-03-10 11:58:13.244059Z] Running clobber step. 03:58:13 INFO - Running pre-action listener: _resource_record_pre_action 03:58:13 INFO - Running main action method: clobber 03:58:13 INFO - rmtree: /builds/slave/test/build 03:58:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:58:13 INFO - Running post-action listener: _resource_record_post_action 03:58:13 INFO - [mozharness: 2017-03-10 11:58:13.445693Z] Finished clobber step (success) 03:58:13 INFO - [mozharness: 2017-03-10 11:58:13.445821Z] Running read-buildbot-config step. 03:58:13 INFO - Running pre-action listener: _resource_record_pre_action 03:58:13 INFO - Running main action method: read_buildbot_config 03:58:13 INFO - Using buildbot properties: 03:58:13 INFO - { 03:58:13 INFO - "project": "", 03:58:13 INFO - "product": "firefox", 03:58:13 INFO - "script_repo_revision": "production", 03:58:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:58:13 INFO - "repository": "", 03:58:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:58:13 INFO - "buildid": "20170310023722", 03:58:13 INFO - "pgo_build": "False", 03:58:13 INFO - "basedir": "/builds/slave/test", 03:58:13 INFO - "buildnumber": 5, 03:58:13 INFO - "slavename": "t-yosemite-r7-0133", 03:58:13 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:58:13 INFO - "platform": "yosemite_r7", 03:58:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:58:13 INFO - "branch": "mozilla-central", 03:58:13 INFO - "repo_path": "mozilla-central", 03:58:13 INFO - "revision": "e18d3dd20e8d60bb21524e1b6ef4a87288369afe", 03:58:13 INFO - "stage_platform": "macosx64", 03:58:13 INFO - "builduid": "b49eadd7111646f482e9fdc5bf197a02", 03:58:13 INFO - "slavebuilddir": "test" 03:58:13 INFO - } 03:58:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:58:13 INFO - Running post-action listener: _resource_record_post_action 03:58:13 INFO - [mozharness: 2017-03-10 11:58:13.449383Z] Finished read-buildbot-config step (success) 03:58:13 INFO - [mozharness: 2017-03-10 11:58:13.449486Z] Running download-and-extract step. 03:58:13 INFO - Running pre-action listener: _resource_record_pre_action 03:58:13 INFO - Running main action method: download_and_extract 03:58:13 INFO - mkdir: /builds/slave/test/build/tests 03:58:13 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')]} 03:58:13 INFO - trying https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:13 INFO - Downloading https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/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 03:58:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/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 03:58:14 INFO - Downloaded 1199 bytes. 03:58:14 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:58:14 INFO - Using the following test package requirements: 03:58:14 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:58:14 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:58:14 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:58:14 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'jsshell-mac.zip'], 03:58:14 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:58:14 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:58:14 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:58:14 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:58:14 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:58:14 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:58:14 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:58:14 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:58:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:58:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:58:14 INFO - Fetch https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:58:16 INFO - Expected file size: 51786216 03:58:16 INFO - Obtained file size: 51786216 03:58:32 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 03:58:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:58:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:58:32 INFO - Fetch https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:58:35 INFO - Expected file size: 51786216 03:58:35 INFO - Obtained file size: 51786216 03:58:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:58:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:58:50 INFO - Fetch https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:58:51 INFO - Expected file size: 14404424 03:58:51 INFO - Obtained file size: 14404424 03:58:51 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')]} 03:58:51 INFO - trying https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:51 INFO - Downloading https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/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 03:58:53 INFO - Downloaded 74864298 bytes. 03:58:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:53 INFO - mkdir: /builds/slave/test/properties 03:58:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:53 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:53 INFO - Contents: 03:58:53 INFO - build_url:https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:54 INFO - Running post-action listener: _resource_record_post_action 03:58:54 INFO - Running post-action listener: set_extra_try_arguments 03:58:54 INFO - [mozharness: 2017-03-10 11:58:54.109502Z] Finished download-and-extract step (success) 03:58:54 INFO - [mozharness: 2017-03-10 11:58:54.109670Z] Running populate-webroot step. 03:58:54 INFO - Running pre-action listener: _resource_record_pre_action 03:58:54 INFO - Running main action method: populate_webroot 03:58:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:54 INFO - '--tppagecycles', 03:58:54 INFO - '7'], 03:58:54 INFO - 'tests': ['tsvgm']}}, 03:58:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['damp', 'tps']}, 03:58:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'tests': ['damp', 'tps']}, 03:58:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['dromaeo_dom']}, 03:58:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['basic_compositor_video']}, 03:58:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['a11yr', 03:58:54 INFO - 'ts_paint', 03:58:54 INFO - 'tpaint', 03:58:54 INFO - 'sessionrestore', 03:58:54 INFO - 'sessionrestore_no_auto_restore', 03:58:54 INFO - 'tabpaint']}, 03:58:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:54 INFO - 'ts_paint', 03:58:54 INFO - 'tpaint', 03:58:54 INFO - 'sessionrestore', 03:58:54 INFO - 'sessionrestore_no_auto_restore', 03:58:54 INFO - 'tabpaint']}, 03:58:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:54 INFO - 'ts_paint', 03:58:54 INFO - 'tpaint', 03:58:54 INFO - 'sessionrestore', 03:58:54 INFO - 'sessionrestore_no_auto_restore', 03:58:54 INFO - 'tabpaint']}, 03:58:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:54 INFO - 'ts_paint', 03:58:54 INFO - 'tpaint', 03:58:54 INFO - 'sessionrestore', 03:58:54 INFO - 'sessionrestore_no_auto_restore', 03:58:54 INFO - 'tabpaint']}, 03:58:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['a11yr', 03:58:54 INFO - 'ts_paint', 03:58:54 INFO - 'tpaint', 03:58:54 INFO - 'sessionrestore', 03:58:54 INFO - 'sessionrestore_no_auto_restore', 03:58:54 INFO - 'tabpaint']}, 03:58:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['a11yr', 03:58:54 INFO - 'ts_paint', 03:58:54 INFO - 'tpaint', 03:58:54 INFO - 'sessionrestore', 03:58:54 INFO - 'sessionrestore_no_auto_restore', 03:58:54 INFO - 'tabpaint']}, 03:58:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['tsvgx', 03:58:54 INFO - 'tsvgr_opacity', 03:58:54 INFO - 'tart', 03:58:54 INFO - 'tscrollx', 03:58:54 INFO - 'cart', 03:58:54 INFO - 'tsvg_static']}, 03:58:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:54 INFO - 'tsvgr_opacity', 03:58:54 INFO - 'tart', 03:58:54 INFO - 'tscrollx', 03:58:54 INFO - 'cart', 03:58:54 INFO - 'tsvg_static']}, 03:58:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'talos_options': ['--disable-e10s'], 03:58:54 INFO - 'tests': ['tp5o']}, 03:58:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:58:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'talos_options': ['--disable-e10s', 03:58:54 INFO - '--xperf_path', 03:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:54 INFO - 'tests': ['tp5n']}, 03:58:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:58:54 INFO - 'talos_options': ['--xperf_path', 03:58:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:54 INFO - 'tests': ['tp5n']}}, 03:58:54 INFO - 'talos.zip': {'path': '', 03:58:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:54 INFO - Running post-action listener: _resource_record_post_action 03:58:54 INFO - [mozharness: 2017-03-10 11:58:54.128958Z] Finished populate-webroot step (success) 03:58:54 INFO - [mozharness: 2017-03-10 11:58:54.129092Z] Running create-virtualenv step. 03:58:54 INFO - Running pre-action listener: _resource_record_pre_action 03:58:54 INFO - Running main action method: create_virtualenv 03:58:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:54 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 03:58:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:54 INFO - Using real prefix '/tools/python27' 03:58:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:57 INFO - Installing pip.................done. 03:58:57 INFO - Return code: 0 03:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:58:58 INFO - Reading from file tmpfile_stdout 03:58:58 INFO - Output received: 03:58:58 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) 03:58:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:58 INFO - 'HOME': '/Users/cltbld', 03:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:58 INFO - 'LOGNAME': 'cltbld', 03:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:58 INFO - 'MOZ_NO_REMOTE': '1', 03:58:58 INFO - 'NO_EM_RESTART': '1', 03:58:58 INFO - 'PAGER': '/bin/cat', 03:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:58 INFO - 'PWD': '/builds/slave/test', 03:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:58 INFO - 'SHELL': '/bin/bash', 03:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:58:58 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:58 INFO - 'USER': 'cltbld', 03:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:58 INFO - 'XPC_FLAGS': '0x0', 03:58:58 INFO - 'XPC_SERVICE_NAME': '0', 03:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:58 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 03:58:58 INFO - Cleaning up... 03:58:58 INFO - Return code: 0 03:58:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:58:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:58:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:58:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:58 INFO - 'HOME': '/Users/cltbld', 03:58:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:58 INFO - 'LOGNAME': 'cltbld', 03:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:58 INFO - 'MOZ_NO_REMOTE': '1', 03:58:58 INFO - 'NO_EM_RESTART': '1', 03:58:58 INFO - 'PAGER': '/bin/cat', 03:58:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:58 INFO - 'PWD': '/builds/slave/test', 03:58:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:58 INFO - 'SHELL': '/bin/bash', 03:58:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:58:58 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:58:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:58 INFO - 'USER': 'cltbld', 03:58:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:58 INFO - 'XPC_FLAGS': '0x0', 03:58:58 INFO - 'XPC_SERVICE_NAME': '0', 03:58:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:58 INFO - Downloading/unpacking psutil>=3.1.1 03:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:02 INFO - Installing collected packages: psutil 03:59:02 INFO - Running setup.py install for psutil 03:59:02 INFO - building 'psutil._psutil_osx' extension 03:59:02 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 03:59:02 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 03:59:02 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 03:59:02 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 03:59:02 INFO - building 'psutil._psutil_posix' extension 03:59:02 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 03:59:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:59:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:59:02 INFO - ^ 03:59:02 INFO - 1 warning generated. 03:59:02 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 03:59:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:03 INFO - Successfully installed psutil 03:59:03 INFO - Cleaning up... 03:59:03 INFO - Return code: 0 03:59:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:03 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')]} 03:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:03 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')]} 03:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:03 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 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:03 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 03:59:03 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 03:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:03 INFO - 'HOME': '/Users/cltbld', 03:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:03 INFO - 'LOGNAME': 'cltbld', 03:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:03 INFO - 'MOZ_NO_REMOTE': '1', 03:59:03 INFO - 'NO_EM_RESTART': '1', 03:59:03 INFO - 'PAGER': '/bin/cat', 03:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:03 INFO - 'PWD': '/builds/slave/test', 03:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:03 INFO - 'SHELL': '/bin/bash', 03:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:03 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:03 INFO - 'USER': 'cltbld', 03:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:03 INFO - 'XPC_FLAGS': '0x0', 03:59:03 INFO - 'XPC_SERVICE_NAME': '0', 03:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59:03 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 03:59:03 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 03:59:03 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 03:59:03 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 03:59:03 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 03:59:03 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 03:59:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:59:06 INFO - Installing collected packages: mozsystemmonitor 03:59:06 INFO - Running setup.py install for mozsystemmonitor 03:59:06 INFO - Successfully installed mozsystemmonitor 03:59:06 INFO - Cleaning up... 03:59:06 INFO - Return code: 0 03:59:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:59:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:59:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:07 INFO - 'HOME': '/Users/cltbld', 03:59:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:07 INFO - 'LOGNAME': 'cltbld', 03:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:07 INFO - 'MOZ_NO_REMOTE': '1', 03:59:07 INFO - 'NO_EM_RESTART': '1', 03:59:07 INFO - 'PAGER': '/bin/cat', 03:59:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:07 INFO - 'PWD': '/builds/slave/test', 03:59:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:07 INFO - 'SHELL': '/bin/bash', 03:59:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:07 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:07 INFO - 'USER': 'cltbld', 03:59:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:07 INFO - 'XPC_FLAGS': '0x0', 03:59:07 INFO - 'XPC_SERVICE_NAME': '0', 03:59:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:07 INFO - Downloading/unpacking jsonschema==2.5.1 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:07 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 03:59:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:59:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:59:11 INFO - warning: no files found matching '*.txt' 03:59:11 INFO - no previously-included directories found matching 'build' 03:59:11 INFO - no previously-included directories found matching 'dist' 03:59:11 INFO - no previously-included directories found matching '.git*' 03:59:11 INFO - Installing collected packages: jsonschema, functools32 03:59:11 INFO - Running setup.py install for functools32 03:59:11 INFO - warning: no files found matching '*.txt' 03:59:11 INFO - no previously-included directories found matching 'build' 03:59:11 INFO - no previously-included directories found matching 'dist' 03:59:11 INFO - no previously-included directories found matching '.git*' 03:59:11 INFO - Successfully installed jsonschema functools32 03:59:11 INFO - Cleaning up... 03:59:11 INFO - Return code: 0 03:59:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:59:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:11 INFO - 'HOME': '/Users/cltbld', 03:59:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:11 INFO - 'LOGNAME': 'cltbld', 03:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:11 INFO - 'MOZ_NO_REMOTE': '1', 03:59:11 INFO - 'NO_EM_RESTART': '1', 03:59:11 INFO - 'PAGER': '/bin/cat', 03:59:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:11 INFO - 'PWD': '/builds/slave/test', 03:59:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:11 INFO - 'SHELL': '/bin/bash', 03:59:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:11 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:11 INFO - 'USER': 'cltbld', 03:59:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:11 INFO - 'XPC_FLAGS': '0x0', 03:59:11 INFO - 'XPC_SERVICE_NAME': '0', 03:59:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:59:11 INFO - Cleaning up... 03:59:11 INFO - Return code: 0 03:59:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:59:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:11 INFO - 'HOME': '/Users/cltbld', 03:59:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:11 INFO - 'LOGNAME': 'cltbld', 03:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:11 INFO - 'MOZ_NO_REMOTE': '1', 03:59:11 INFO - 'NO_EM_RESTART': '1', 03:59:11 INFO - 'PAGER': '/bin/cat', 03:59:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:11 INFO - 'PWD': '/builds/slave/test', 03:59:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:11 INFO - 'SHELL': '/bin/bash', 03:59:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:11 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:11 INFO - 'USER': 'cltbld', 03:59:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:11 INFO - 'XPC_FLAGS': '0x0', 03:59:11 INFO - 'XPC_SERVICE_NAME': '0', 03:59:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:59:12 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 03:59:12 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 03:59:12 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 03:59:12 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 03:59:12 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 03:59:12 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 03:59:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:59:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:59:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:15 INFO - Downloading docopt-0.6.1.tar.gz 03:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:59:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:59:16 INFO - Running setup.py install for blobuploader 03:59:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:59:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:59:16 INFO - Running setup.py install for requests 03:59:16 INFO - Running setup.py install for docopt 03:59:16 INFO - Successfully installed blobuploader requests docopt 03:59:16 INFO - Cleaning up... 03:59:16 INFO - Return code: 0 03:59:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:16 INFO - 'HOME': '/Users/cltbld', 03:59:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:16 INFO - 'LOGNAME': 'cltbld', 03:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:16 INFO - 'MOZ_NO_REMOTE': '1', 03:59:16 INFO - 'NO_EM_RESTART': '1', 03:59:16 INFO - 'PAGER': '/bin/cat', 03:59:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:16 INFO - 'PWD': '/builds/slave/test', 03:59:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:16 INFO - 'SHELL': '/bin/bash', 03:59:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:16 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:16 INFO - 'USER': 'cltbld', 03:59:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:16 INFO - 'XPC_FLAGS': '0x0', 03:59:16 INFO - 'XPC_SERVICE_NAME': '0', 03:59:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-FdfrUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-jvuORL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-D2pMkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-dorimG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-nriCWx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-NfZ5tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-5vBEys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-lPHb4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:17 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-v8LDUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-QavL3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-tbTAMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-QCGQER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-G_067V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-R3Nao0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-JvUzvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-sPiJ4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:18 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-mlE1QI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:59:18 INFO - Running setup.py install for manifestparser 03:59:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:59:19 INFO - Running setup.py install for mozcrash 03:59:19 INFO - Running setup.py install for mozdebug 03:59:19 INFO - Running setup.py install for mozdevice 03:59:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:59:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:59:19 INFO - Running setup.py install for mozfile 03:59:19 INFO - Running setup.py install for mozhttpd 03:59:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:59:19 INFO - Running setup.py install for mozinfo 03:59:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:59:19 INFO - Running setup.py install for mozInstall 03:59:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Running setup.py install for mozleak 03:59:20 INFO - Running setup.py install for mozlog 03:59:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Running setup.py install for moznetwork 03:59:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Running setup.py install for mozprocess 03:59:20 INFO - Running setup.py install for mozprofile 03:59:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:59:20 INFO - Running setup.py install for mozrunner 03:59:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:59:21 INFO - Running setup.py install for mozscreenshot 03:59:21 INFO - Running setup.py install for moztest 03:59:21 INFO - Running setup.py install for mozversion 03:59:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:59:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:59:21 INFO - Cleaning up... 03:59:21 INFO - Return code: 0 03:59:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:21 INFO - 'HOME': '/Users/cltbld', 03:59:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:21 INFO - 'LOGNAME': 'cltbld', 03:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:21 INFO - 'MOZ_NO_REMOTE': '1', 03:59:21 INFO - 'NO_EM_RESTART': '1', 03:59:21 INFO - 'PAGER': '/bin/cat', 03:59:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:21 INFO - 'PWD': '/builds/slave/test', 03:59:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:21 INFO - 'SHELL': '/bin/bash', 03:59:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:21 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:21 INFO - 'USER': 'cltbld', 03:59:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:21 INFO - 'XPC_FLAGS': '0x0', 03:59:21 INFO - 'XPC_SERVICE_NAME': '0', 03:59:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:59:21 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-SPWzmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:59:21 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-_C59Eh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:59:21 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)) 03:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:59:21 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-azhWRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:59:22 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)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-MP25_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:59:22 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)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-u6Hyg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:59:22 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)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-80k0gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-hxzbvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-FPNSaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-doUCzJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-6sENFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-VTzWZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:59:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:59:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:59:22 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-L79xTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:59:23 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)) 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:59:23 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-gZjo44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:59:23 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)) 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:59:23 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-G3pNO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:59:23 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)) 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:23 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-MhjiVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:59:23 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-iIUEuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:59:23 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)) 03:59:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:59:23 INFO - Running setup.py (path:/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/pip-jQTFQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:59:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:59:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:26 INFO - Downloading blessings-1.6.tar.gz 03:59:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:59:26 INFO - Installing collected packages: blessings 03:59:26 INFO - Running setup.py install for blessings 03:59:26 INFO - Successfully installed blessings 03:59:26 INFO - Cleaning up... 03:59:26 INFO - Return code: 0 03:59:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:26 INFO - Reading from file tmpfile_stdout 03:59:26 INFO - Current package versions: 03:59:26 INFO - blessings == 1.6 03:59:26 INFO - blobuploader == 1.2.4 03:59:26 INFO - docopt == 0.6.1 03:59:26 INFO - functools32 == 3.2.3-2 03:59:26 INFO - jsonschema == 2.5.1 03:59:26 INFO - manifestparser == 1.1 03:59:26 INFO - mozInstall == 1.12 03:59:26 INFO - mozcrash == 1.0 03:59:26 INFO - mozdebug == 0.1 03:59:26 INFO - mozdevice == 0.49 03:59:26 INFO - mozfile == 1.2 03:59:26 INFO - mozhttpd == 0.7 03:59:26 INFO - mozinfo == 0.9 03:59:26 INFO - mozleak == 0.1 03:59:26 INFO - mozlog == 3.4 03:59:26 INFO - moznetwork == 0.27 03:59:26 INFO - mozprocess == 0.25 03:59:26 INFO - mozprofile == 0.28 03:59:26 INFO - mozrunner == 6.13 03:59:26 INFO - mozscreenshot == 0.1 03:59:26 INFO - mozsystemmonitor == 0.3 03:59:26 INFO - moztest == 0.8 03:59:26 INFO - mozversion == 1.4 03:59:26 INFO - psutil == 3.1.1 03:59:26 INFO - requests == 1.2.3 03:59:26 INFO - wsgiref == 0.1.2 03:59:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:59: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')]} 03:59:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59: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')]} 03:59:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:59:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:26 INFO - 'HOME': '/Users/cltbld', 03:59:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:26 INFO - 'LOGNAME': 'cltbld', 03:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:26 INFO - 'MOZ_NO_REMOTE': '1', 03:59:26 INFO - 'NO_EM_RESTART': '1', 03:59:26 INFO - 'PAGER': '/bin/cat', 03:59:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:26 INFO - 'PWD': '/builds/slave/test', 03:59:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:26 INFO - 'SHELL': '/bin/bash', 03:59:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:26 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:26 INFO - 'USER': 'cltbld', 03:59:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:26 INFO - 'XPC_FLAGS': '0x0', 03:59:26 INFO - 'XPC_SERVICE_NAME': '0', 03:59:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 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)) 03:59:27 INFO - Cleaning up... 03:59:27 INFO - Return code: 0 03:59:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:59:27 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')]} 03:59:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:27 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')]} 03:59:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:59:27 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 0x10b6aab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ad768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97b1ca0680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, '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.rc0RMsK93l/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.T1iIWkbpH2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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 03:59:27 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 03:59:27 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 03:59:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:27 INFO - 'HOME': '/Users/cltbld', 03:59:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:27 INFO - 'LOGNAME': 'cltbld', 03:59:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:27 INFO - 'MOZ_NO_REMOTE': '1', 03:59:27 INFO - 'NO_EM_RESTART': '1', 03:59:27 INFO - 'PAGER': '/bin/cat', 03:59:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:27 INFO - 'PWD': '/builds/slave/test', 03:59:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:27 INFO - 'SHELL': '/bin/bash', 03:59:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:27 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:27 INFO - 'USER': 'cltbld', 03:59:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:27 INFO - 'XPC_FLAGS': '0x0', 03:59:27 INFO - 'XPC_SERVICE_NAME': '0', 03:59:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:59:27 INFO - Cleaning up... 03:59:27 INFO - Return code: 0 03:59:27 INFO - Running post-action listener: _resource_record_post_action 03:59:27 INFO - Running post-action listener: _start_resource_monitoring 03:59:27 INFO - Starting resource monitoring. 03:59:27 INFO - [mozharness: 2017-03-10 11:59:27.393918Z] Finished create-virtualenv step (success) 03:59:27 INFO - [mozharness: 2017-03-10 11:59:27.394912Z] Running install step. 03:59:27 INFO - Running pre-action listener: _resource_record_pre_action 03:59:27 INFO - Running main action method: install 03:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:59:27 INFO - Reading from file tmpfile_stdout 03:59:27 INFO - Detecting whether we're running mozinstall >=1.0... 03:59:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:59:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:59:27 INFO - Reading from file tmpfile_stdout 03:59:27 INFO - Output received: 03:59:27 INFO - Usage: mozinstall [options] installer 03:59:27 INFO - Options: 03:59:27 INFO - -h, --help show this help message and exit 03:59:27 INFO - -d DEST, --destination=DEST 03:59:27 INFO - Directory to install application into. [default: 03:59:27 INFO - "/builds/slave/test"] 03:59:27 INFO - --app=APP Application being installed. [default: firefox] 03:59:27 INFO - mkdir: /builds/slave/test/build/application 03:59:27 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'] 03:59:27 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 03:59:48 INFO - Reading from file tmpfile_stdout 03:59:48 INFO - Output received: 03:59:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:59:48 INFO - Running post-action listener: _resource_record_post_action 03:59:48 INFO - [mozharness: 2017-03-10 11:59:48.121855Z] Finished install step (success) 03:59:48 INFO - [mozharness: 2017-03-10 11:59:48.122018Z] Running run-tests step. 03:59:48 INFO - Running pre-action listener: _resource_record_pre_action 03:59:48 INFO - Running main action method: run_tests 03:59:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:48 INFO - 2017-03-10 03:59:48.134 screenresolution[2155:14457] starting screenresolution argv=screenresolution get 03:59:48 INFO - 2017-03-10 03:59:48.137 screenresolution[2155:14457] Display 0: 1600x1200x32@60 03:59:48 INFO - 2017-03-10 03:59:48.142 screenresolution[2156:14461] starting screenresolution argv=screenresolution list 03:59:48 INFO - Available Modes on Display 0 03:59:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:48 INFO - Intel Iris: 03:59:48 INFO - Chipset Model: Intel Iris 03:59:48 INFO - Type: GPU 03:59:48 INFO - Bus: Built-In 03:59:48 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:48 INFO - Vendor: Intel (0x8086) 03:59:48 INFO - Device ID: 0x0a2e 03:59:48 INFO - Revision ID: 0x0009 03:59:48 INFO - Displays: 03:59:48 INFO - Display: 03:59:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:48 INFO - Display Serial Number: 1600x1200 60 03:59:48 INFO - Main Display: Yes 03:59:48 INFO - Mirror: Off 03:59:48 INFO - Online: Yes 03:59:48 INFO - Rotation: Supported 03:59:48 INFO - Return code: 0 03:59:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:48 INFO - Python 2.7.3 03:59:48 INFO - Return code: 0 03:59:48 INFO - grabbing minidump binary from tooltool 03:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:48 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 0x10b488d30>, '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 0x10b3afdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b47dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:48 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 03:59:48 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 03:59:48 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 03:59:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:48 INFO - Return code: 0 03:59:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:59:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:48 INFO - ENV: RUST_BACKTRACE is now 1 03:59:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:59:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:48 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/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 03:59:48 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/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0133 --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 03:59:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rc0RMsK93l/Render', 03:59:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:48 INFO - 'HOME': '/Users/cltbld', 03:59:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:48 INFO - 'LOGNAME': 'cltbld', 03:59:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:59:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:48 INFO - 'MOZ_NO_REMOTE': '1', 03:59:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:48 INFO - 'NO_EM_RESTART': '1', 03:59:48 INFO - 'PAGER': '/bin/cat', 03:59:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:48 INFO - 'PWD': '/builds/slave/test', 03:59:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:48 INFO - 'RUST_BACKTRACE': '1', 03:59:48 INFO - 'SHELL': '/bin/bash', 03:59:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.T1iIWkbpH2/Listeners', 03:59:48 INFO - 'TMPDIR': '/var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/', 03:59:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:48 INFO - 'USER': 'cltbld', 03:59:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:48 INFO - 'XPC_FLAGS': '0x0', 03:59:48 INFO - 'XPC_SERVICE_NAME': '0', 03:59:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:48 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/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0133', '--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 03:59:48 INFO - mozversion application_buildid: 20170310023722 03:59:48 INFO - mozversion application_changeset: e18d3dd20e8d60bb21524e1b6ef4a87288369afe 03:59:48 INFO - mozversion application_display_name: Nightly 03:59:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:48 INFO - mozversion application_name: Firefox 03:59:48 INFO - mozversion application_remotingname: firefox 03:59:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:59:48 INFO - mozversion application_vendor: Mozilla 03:59:48 INFO - mozversion application_version: 55.0a1 03:59:48 INFO - mozversion platform_buildid: 20170310023722 03:59:48 INFO - mozversion platform_changeset: e18d3dd20e8d60bb21524e1b6ef4a87288369afe 03:59:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:59:48 INFO - mozversion platform_version: 55.0a1 03:59:48 INFO - using testdate: 1489147188 03:59:48 INFO - actual date: 1489147188 03:59:48 INFO - starting webserver on 'localhost:51706' 03:59:48 INFO - SUITE-START | Running 2 tests 03:59:48 INFO - TEST-START | dromaeo_css 03:59:48 INFO - operating with platform_type : mac_ 03:59:48 INFO - Initialising browser for dromaeo_css test... 03:59:48 INFO - TEST-INFO | started process 2166 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpe1WmkX/profile http://localhost:51706/getInfo.html) 03:59:51 INFO - PROCESS | 2166 | 2017-03-10 03:59:51.791 plugin-container[2168:14626] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494f, name = 'com.apple.tsm.portname' 03:59:51 INFO - PROCESS | 2166 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:51 INFO - PROCESS | 2166 | 2017-03-10 03:59:51.794 plugin-container[2168:14626] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 03:59:51 INFO - PROCESS | 2166 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:51 INFO - PROCESS | 2166 | 2017-03-10 03:59:51.794 plugin-container[2168:14626] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:59:51 INFO - PROCESS | 2166 | __metrics Screen width/height:1600/1200 03:59:51 INFO - PROCESS | 2166 | colorDepth:24 03:59:51 INFO - PROCESS | 2166 | Browser inner width/height: 1024/689 03:59:51 INFO - PROCESS | 2166 | __metrics 03:59:52 ERROR - PROCESS | 2166 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 03:59:52 INFO - TEST-INFO | 2166: exit 0 03:59:52 INFO - Browser initialized. 03:59:52 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:52 INFO - TEST-INFO | started process 2169 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmpe1WmkX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:55 INFO - PROCESS | 2169 | 2017-03-10 03:59:55.126 plugin-container[2170:14756] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 03:59:55 INFO - PROCESS | 2169 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:55 INFO - PROCESS | 2169 | 2017-03-10 03:59:55.127 plugin-container[2170:14756] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 03:59:55 INFO - PROCESS | 2169 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:59:55 INFO - PROCESS | 2169 | 2017-03-10 03:59:55.127 plugin-container[2170:14756] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:00:04 INFO - PROCESS | 2169 | RSS: Main: 227287040 04:00:04 INFO - PROCESS | 2169 | 04:03:08 INFO - PROCESS | 2169 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51706/tests/dromaeo/cssquery-ext.html) 04:03:09 INFO - PROCESS | 2169 | RSS: Main: 252502016 04:03:09 INFO - PROCESS | 2169 | 04:04:53 INFO - PROCESS | 2169 | ************************* 04:04:53 INFO - PROCESS | 2169 | A coding exception was thrown and uncaught in a Task. 04:04:53 INFO - PROCESS | 2169 | 04:04:53 ERROR - PROCESS | 2169 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:04:53 INFO - PROCESS | 2169 | Full stack: 04:04:53 INFO - PROCESS | 2169 | ************************* 04:06:12 INFO - PROCESS | 2169 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-ext.html (next: http://localhost:51706/tests/dromaeo/cssquery-jquery.html) 04:06:12 INFO - PROCESS | 2169 | RSS: Main: 260689920 04:06:12 INFO - PROCESS | 2169 | 04:09:14 INFO - PROCESS | 2169 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51706/tests/dromaeo/cssquery-mootools.html) 04:09:15 INFO - PROCESS | 2169 | RSS: Main: 272011264 04:09:15 INFO - PROCESS | 2169 | 04:12:17 INFO - PROCESS | 2169 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51706/tests/dromaeo/cssquery-prototype.html) 04:12:18 INFO - PROCESS | 2169 | RSS: Main: 266117120 04:12:18 INFO - PROCESS | 2169 | 04:15:21 INFO - PROCESS | 2169 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51706/tests/dromaeo/cssquery-yui.html) 04:15:21 INFO - PROCESS | 2169 | RSS: Main: 277209088 04:15:21 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | Cycle 1(1): loaded http://localhost:51706/tests/dromaeo/cssquery-yui.html (next: http://localhost:51706/tests/dromaeo/cssquery-dojo.html) 04:18:24 INFO - PROCESS | 2169 | RSS: Main: 271110144 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | __start_tp_report 04:18:24 INFO - PROCESS | 2169 | _x_x_mozilla_page_load 04:18:24 INFO - PROCESS | 2169 | _x_x_mozilla_page_load_details 04:18:24 INFO - PROCESS | 2169 | |i|pagename|runs| 04:18:24 INFO - PROCESS | 2169 | |0;dojo.html;3425.640307767684;3433.4163192257347;3437.45000799872;3450.171958729906;3473.166440054386;5783.36382997871;5925.407459254073;5981.371955944623;5993.10103484477;6034.758609655609;4745.549172828584;5813.62211456255;5864.882702345951;5961.821145365635;5971.910421343683;5401.405845357018;5421.620486565942;5439.265699130607;5449.4005659377635;5508.980838544862;5381.031414345416;5463.890722185554;5514.6139770216105;5545.3622833374075;5568.777248910059;4354.847580334705;5352.652077614982;5477.096279113942;5478.397376288605;5506.119020956668;5383.246345511631;5383.2732581101445;5434.8913021739345;5435.809746658888;5503.559715222773;5330.413654498002;5373.032854086263;5377.623566350357;5408.540274076709;5471.042567550702;4545.568171023748;5055.5702765265;5619.466150715716;5943.821685349447;5969.462748352669;6375.45808606269;6394.904076438857;6405.615663060231;6423.710933008026;6455.9677201613695;5115.309433226504;6499.51253655973;6513.0230465430095;6547.181602299713;6550.050242714779;5102.591792656615;5928.970355148283;5970.402959703995;6058.969705151446;6164.8767024659255;5508.586855985737;6383.265924418658;6457.160569125984;6519.250286217051;6578.572392794453;5287.23335116406;6163.753449861955;6170.197874276315;6313.116163737081;6350.4602108820345;6367.586106903036;6387.520935929824;6396.232452105777;6438.742450302029;6456.967715161394;6357.300696923335;6366.045093236052;6366.713497892606;6380.489560835122;6382.36176382358;6246.312905580383;6271.341509141565;6281.466075383643;6290.21372328459;6372.107904893319;5210.869728256824;5238.476152384731;5241.50205730455;5246.580273578181;5280.392754833167;4652.488226295105;4653.441587009581;4665.2302370108555;4668.39310889589;4683.297505374153;5652.671622168787;5813.88372232553;5875.706214689249;5882.147088672119;6128.571000029955;5559.138333558305;5812.215350927655;6146.569740118238;6273.368924079681;6368.777092801823;6125.2209693688765;6158.753649854045;6173.259208894961;6183.752649894044;6191.721372538156;5677.517411020027;5725.284339457485;5727.284089488814;5734.971325143348;5752.309722833287;5253.605979551626;6333.841653958596;6369.14016607752;6581.078648989241;6619.2056953164965;5472.781088756406;6464.612123272619;6474.967625161844;6494.447971922439;6502.707378167899;6591.143151390289;6672.966635166793;6679.966600167162;6695.363940425652;6734.158230221223;6244.281907580505;6288.151099601495;6308.589941653778;6392.264889537762;6407.423331900151;6321.810345689637;6370.90443643355;6443.065755465525;6455.4512866406885;6472.579282346633;6120.538559592075;6139.369480960641;6235.875282494234;6288.371162883858;6295.213098362705;6227.844303892439;6246.5002799775;6303.275123360689;6305.306416294296;6314.715837787218;5610.410906854721;5802.868440654032;6053.092036194606;6171.537134715004;6281.089242059968;6178.042403427476;6267.2479302484;6274.592151510137;6287.874242515216;6293.276273228637;6216.222972128484;6264.34224406449;6271.811845644638;6271.874562508633;6284.654344011124 04:18:24 INFO - PROCESS | 2169 | |1;ext.html;679.6092246957999;751.7556794041936;822.1408627983757;850.9574521273935;923.2060428031896;31995;36900.44649330259;37727.86816395509;37778.8111059445;39553.80223098888;37795.81102094492;38012.23975520495;38045.809770951106;38081;38084.04789880248;7708.306252437294;7839.960800195991;7855.764327070197;10997.285176463543;11260.943695281512;10975.859707357069;11054.336739795597;11058.944705276503;11070.557177712923;11078.612248571302;8564.929383827022;10858.022777949984;11063.391513466757;11088.168387370939;11094.334339939589;11029.227954043221;11038.558457661724;11050.668479945614;11075.280106793032;11075.72310692239;10991.560337586487;11002.779944401147;11072.778544429148;11083.667489975314;11091.667249982513;39230;39411.60588394137;39454.0136496587;39550.60449395498;39601.80199098986;3339.6493368196234;3831.3295173344554;3854.5181852268465;3894.55212650546;4027.7784721840285;28250.85874570614;28338.858305708545;28385.57421638677;28566.571501427494;29493.41013179746;3055.114016935086;3139.262273365757;3157.3685262947274;3163.4043020302697;3182.7772055956093;274749;319761.4011929925;348940;350497;350687;41039.384409233884;41762.1647567053;42453.36319955203;51813;51992.480075198764;54580.904482417034;54833;54919.72540137354;55152.72423637856;55309.72345138249;12143.939280303543;14973;14974.326155323037;14982.775258371134;14988.775168372484;11905.880941190477;12065.336406497727;12067.517299308105;12079.75840483203;12109.878901211052;14043.368048437846;14048.946329025159;14073.366698498592;14078.225697586731;14119.576412707635;5936.970315148396;5966.880662386728;6004.099385092271;6038.547108966845;6086.178365920633;1114.6321713834416;1117.2402766118955;1117.357519426317;1137.2835113878205;1159.1848057622362;22088.558228835656;26456.412615243145;26493;26719.93120275206;27085.864570677415;1223.4555622747969;1233.901287896966;1242.8570714367784;1280.9039322050883;1281.4425724809737;13648.317584120754;13758.793618095737;13870.791938120936;13947.442102315998;13951.302434878215;451384;453282;455877;456399;457728;49505.752471237414;56504.43495565074;56960.43039569634;57047;57157;1408.7534681430914;1442.6537630968492;1442.7114577084626;1450.332846890421;1451.252604908473;25048.874755626104;26263.86868065724;26303.868480657475;26318.86840565785;26413.867930660224;38527.807360964136;43343;43344.56655433532;43378.783106084265;43436.34845477383;441617;442890;443077;444878;444950;34139.4879076819;34241.14397140092;34785.304293913476;34966.825165874005;35042.824785875906;42829;43410.78294608507;43694.78152609216;44689.55310446854;44827.655170344944;31741.5238771414;34913.30173396467;35950.28099438049;36945.6305436953;37066.8146659265;29974.400511990076;35303.293934121684;35522.64477355193;36227.81886090553;36326.818365908;36129.91610251697;36149.91550253497;36687.78090519625;36746.448803267434;36797.26405471822;24948.251552453454;30257.848710756305;31746.523802142525;31895.202619934687;32186.678133218367;18323.54191145232;22023.11907523681;22970.655440168077;23302.252331075575;24274.02903883825 04:18:24 INFO - PROCESS | 2169 | |2;jquery.html;367.3791292715311;398.7029662901139;399.9860004899829;411.9526254480735;439.9230134726422;20891;21039.2636257731;21663.350099497;21730.674039889374;21962.231321903735;19931.804091754468;20683.896580517114;21379.57240855182;21600.89199554;21820.45448863779;5278.9208161877605;6699.1291132152755;6701.597904125743;6702.932970670279;6713.966430167842;6270.372962703739;6571.44142747867;6669.8332541686605;7097.89353159703;7588.27911348421;7510.436717246201;7521.210272921347;7544.924550754477;7565;7592.658330375147;6739.797806065826;7532.058492688441;7542.20806815282;7542.547447153188;7572.659230334621;6261.311255761862;7082.681279342391;7300.56196628204;7380.261973802631;7382.815429614249;26211.213663590122;26680.19959401221;27028.729712702818;27384.726152738614;27766.583501247496;2864.375697655875;3221.197170125999;3306.371789360038;3357.261402491448;3476.739244556643;15495.992760470534;15681.686366272725;16292.755608665879;16439.849210555265;16753.497395078044;1685.2837544043732;1900.3158862809516;1951.7072439134101;1963.0184907546227;2005.91976320947;115308.42345788218;138334.6166538332;154017;158087.2095639526;158990.41009589873;17117.743233851503;17136.742948855775;20505.48736281575;21821.890890545445;22089.558208835733;35412;35530;35786.28427431489;35788.21058947042;35812.82093589516;10202.081812636898;10401.739956500996;10595.417252051056;10662.626808061681;10869.184811139037;8489.151084891584;8577.78555536104;8596.097409771884;8752.8687069694;8799.692010779592;10342;10477.47612619366;10478;10573.471326433648;10614.150867930546;3651.689606383487;3874.651281384689;4278.871633850989;4341.5021817472925;4374.343848422762;886.9689560865339;1007.6120693533043;1051.574112484445;1082.3397727386289;1122.803509385854;16609.3356265748;17536.123193840256;21163.576728465345;22669.88665056664;24959.62560561593;988.9208863290919;995.6267787903695;1001.4792307999945;1024.3802499487704;1031.3811712972156;11338.485069628441;11496.540138394537;11678.24091434054;11739.88260117405;11758.412079395996;636431;643214;662463;662477;677202.613986927;124217;130766.38467230603;132345;149546.50453495324;155178;1296.572131196703;1331.740310639416;1340.7117469743857;1359.884409825176;1360.8979326550548;19886.303979361233;20877.89561052185;20881.26915557948;20974.790252097893;21107.683384748932;52000.219996700835;62781.68609156925;64147.35852641414;64255;65237;66695;82838;86839;87074;89088;9968.900310996798;11848.617611435933;11861.822072668745;11902.642920712393;12106.878931210575;13564.050516464147;13647;13895.513657021957;14015.229162396166;14126.081804682663;11549.595764148215;11766.352850593299;11776.646700598996;11845.76308473843;11947.984421324285;9742.95128524353;11184.496697648463;11359.54561817518;11389.145814063813;11728.41357932117;10588.841167382341;10944.686637603538;11727.706807329885;11987;12076.154669173073;10459.581616735246;11385.943070284595;11605.599464433835;11730.530778768754;11903.880961190624;11392.373419461677;11551.76896462083;11651;11699.707507312385;11702 04:18:24 INFO - PROCESS | 2169 | |3;mootools.html;1400.6148309214966;1549.7597872329793;1574.7244232259352;1597.9360825566978;1614.5075751895674;8531.701390451335;8747.91252087479;10194.592216311348;10744.247902646808;10766.192535559834;10285.177185825134;10623.84064239037;10627.681169564925;10644.201684873646;10654.520546575402;2248.325502349297;2304.5045315257216;2305.527366889792;2309.145616122029;2317.050009496107;2277.954440911181;2301.1945818963313;2316.918907838226;2319.5592837360846;2331.988340058297;2287.0623044551735;2298.069281940808;2301.42464383904;2302.297799171252;2303.8963246653857;2238.3396897915154;2253.785890340415;2259.1415262200258;2268.047420083569;2270.8069814065743;2192.2655910270078;2236.944076398087;2247.404437823978;2247.449374903143;2247.8538894971775;10912.50893709785;10978;10999.780004399947;11016.504257308441;11042.613508527164;5610.438956104398;5749.108888122306;5787.479126878559;5791.391903850077;5807.245058142456;2781.568856827195;3294.1105901406727;3527.488514165457;3587.9820600897087;3595.7123430125525;1187.329159025148;1206.0351718625066;1737.287712038071;1761.3042848075067;1897.4402551247415;14879.553613391616;15089.170095644735;15096.471623493235;15238.857085718615;15367.308471118826;4126.885740849953;4450.955490445119;4464.486584042812;4515.796789144496;4648.697834640738;11320.26418282809;11435.028022618171;11523;11525.020373268366;11542.01892839118;5526.778928842801;5574.275344205308;5608.887822243614;5616.747246373923;5626.071698169838;4421.579949904818;4681.204195286809;5123.948760512421;5192.8961420771375;5233.084210263189;3155.857986390618;3189.920251993672;3562.3587754203973;3796.5633952095864;3802.5056742623283;823.9835203295901;873.2795443758924;1009.1724785675675;1031.6698656430021;1031.7059638003134;807.3581502705364;919.6827094652334;952.6332362040664;954.5370495309769;977.3891317926297;5805.796797112081;6146.569740118149;6382;6699.698513566901;6761;966.4829316315878;986.2652324018509;1005.8642083318805;1028.6091285311684;1029.4008371931766;3607.6933460655614;3970.6029397060065;3977.2244412339314;4170.4995400551525;4247.6389506892265;12999.480020799252;13409;13416.329183540784;13420.328983550784;13455.663608409868;13225.074244802772;13309.534166304327;13380.665483362995;13383.799243011363;13385.263810490322;9461.858072128924;10010.399376037461;10095.697129086138;10101.646442374482;10135.442550659636;5493.862653433696;6553.475721942328;6610.570312929644;6897.7585784497305;6919.8962015568795;11910.583129590423;12167.209131406431;12248.510059597516;12288.955438787803;12314.507419703112;12454.43955022008;12536.937315313366;12545.435455404346;12569.560065397667;12581.559645412366;9062.275017998412;9198.67804626835;9251.953740231256;9371.34400591952;9376.57805398745;10132.594696212069;10141.645042423479;10175.084242418217;10257.487125643836;10282.537285822007;8820.2061814437;9002.009778924183;9053.321000924825;9179;9191.724248272563;7413.777586672409;8815.074417186359;8951.462912225288;9041.276697864023;9113.498757568397;7673.53958762476;7705.961470192613;7728.729494467667;7745.264199901;7783;5621.044422448275;5770.913436298375;5798.362180160095;5823.068309070529;6001.969990150022;5919.792807251725;6004.339522652592;6056.121862329849;6079;6089.512838972783 04:18:24 INFO - PROCESS | 2169 | |4;prototype.html;339.3721615012227;373.19203923505614;376.73063759412014;381.3497985933985;386.26802209812416;4963.379577552806;4993.600511959044;5353.839384818452;5385.380681221656;5396.595255355849;4281.464816897887;5207.297014902987;5251.317328747267;5269.235960785693;5323.60072994526;3479.8782042628513;3710.517632707751;4281.336392859096;4354.499232588246;4355.542668019844;4278.679099067567;4342.609165175134;4365.672574556905;4373.803178856959;4388.451443569554;4025.5571887092397;4235.661147108224;4384.4519435070615;4395.165118498567;4396.74692712577;3973.721839471238;4087.6321131098193;4272.46594175728;4347.760873151976;4374.387585737999;3406.2165701888703;3920.5295364556437;3970.2456533258587;3971;3976.701747368959;4362.323839804835;4937.481564435754;5110.540051395392;5161.5870730341485;5177.48225177483;4370.497392799837;4626.282926146453;4705.929411058837;4905.768811557435;5047.419546752134;4532.977335113336;4962.96518427443;5521.395783279974;5620.847726216157;5646.6894320812335;3756.7182461315238;3811.5235595550557;4472.396226509412;4486.259767138451;4496.685232033759;5297.284866543006;5319.388270348921;5394.62237643369;5549.472800083986;5954.97022514889;3591;3807.9809600951817;3920.2355540669296;4351.390805287262;4534.274516077412;4136.683457263942;4670.416197975253;4701.6003639690325;4717.575418212377;4745.437463769595;4448.621867141264;4612.976935115303;4824.517548245218;5088.185890257541;5093.701106217891;4963.061753555236;5536.75084621193;5674.070815922606;5680.744366503517;5688.260526131577;1484.9952564038463;1486.6917112940544;1507.9698406031819;1541.368039103962;1598.6003499125218;1065.142560239015;1086.940218287986;1181.1023622047135;1181.9645410637695;1187.685263405181;4654.790534425892;4814.470408255089;5212.843614691566;5259.447757985433;5311.362636483569;5220.172939471231;5314.840554783363;5764;5864.706764661835;5895.233619629421;4575.450945886515;4625.889786451295;4731.9589690268085;5240.501777795506;5299.947000529945;2540.872956352175;2613.353587240065;2649.390640152737;2785.818921770119;3049.8932537361084;5024.598032157419;5740.225069615632;5914.822555323261;6062.575619706667;6119.755209791648;5267.631265811433;5758.3799371286805;5802.1296805479515;5833.67914764692;6018.548608854353;4947.6289278304275;5396;5562.471565201299;5803.88392232153;5974.820755377345;4945.280095947287;4958.776855041459;5190.636655434083;5490.478404551721;5643.576731745054;5036.823711170092;5159.638825282194;5240.659357141773;5768.682722450306;5865.530757539302;5819.79630712923;5961.7345408744395;6096.817095487142;6115.84710382244;6154.230721159855;4459.866204013885;4501.15452664406;4681.485036645898;5007.943565711639;5047.318611987334;5012.5964729875695;5375.892482150257;5511;5704.971475142598;5791.378414044075;4826.638002149783;5246.658967167122;5439.37447193562;5461.044317244387;5700.315962084576;4967.552920237196;5013.385008790178;5072.771725272298;5558.138488534284;5657.040071949569;4344.652427805705;5188.143956247177;5402.568844020128;5450.700211488248;5497.945020549743;5158.535731784007;5238.633295669267;5298.97350513245;5637.548996080386;5717.656940583412;4568.79440425175;4732.408448943882;4757.928631070606;4957.975210123926;5520.681313848113 04:18:24 INFO - PROCESS | 2169 | |5;yui.html;719.2088702427334;732.2018999290772;771.0939645916047;798.8362385710928;826.087173673091;14765.630859228524;16060.437884674038;16079.83920160798;16085.034897906135;16090.034597924117;14332.856671433283;15358.69282614347;15472.303746331414;15474.767878481833;15479.14864682442;903.4985583001431;940.3464592108487;942.528735632184;944.2257348973844;945.1068740040664;897.4256475855458;924.3483344242293;927.0775578299601;940.4921342475055;949.8622699708573;926.1109335038371;931.0410277414275;970.4710932541782;975.9756006099833;977.5063592885618;966.0870477398861;969.8933117357085;972.4359871274714;972.4845831709206;973.7078876337141;719.7660760252938;728.9307515785991;730.393773168269;730.4193166432699;731;14472.92763536186;14655.706885862222;14665.706685866224;15119.848801511955;15651.843481565153;14486.782698259534;14715.779263311058;14740.336684849208;14775.55673329791;14832.25838708071;11555.422228888607;11686.941286559011;11697.70755731105;11840.348780817052;12122.02380952381;3243.383757086146;3702.5581673783818;3729.776213427176;3740.682042026431;3799.981000094982;84197.73703394516;103345.9330813387;105135;108011;108719;10051.04515071067;10883.945580272048;11445;11617.361045142598;11767.646970590897;22824.88587557085;24340.391490212885;24591.63112553313;24592.262232133064;24687.50624987526;7980.760577182577;7989.0413150421155;8101.270885620323;8114.8782768258525;8315;4201.411802347674;4231.259529582311;4272.5086615039045;4306.334724190945;4333.328334108218;3452.5166476693284;3489.180042689966;3530.3292374448774;3537.9032499925106;3540.1149712571855;637.6747858592058;639.1084437210159;643.9613623182624;644.8355669304298;660.3066779881106;603.728322254987;685.1812084558904;686.605202008847;698.8637215742983;708.7944496096178;9673.951630241803;10033.690415349713;10069.244806639532;10202.285839991278;10385;644.3749562923956;660.9801705948829;669.1635455680399;676.2831398717375;725.4305370284302;4040.878773636796;4512.187806194916;4913.729744863996;4914.164592019365;4916.631252656065;77649.61175194201;102021;102196.95606087836;102916;105190;82887.5855620718;91054;91594;91831.49011059357;92094;77995.98036176771;78674;79392;81215.18784812077;82520.58739706263;7780.688772449039;7971.362291016821;9139;9249.30630202751;9415.85876211871;42238.788806057004;42287.803760199524;51757.22364164616;53314.66713332198;53562.73218633882;52100.47899521108;65851.34148658453;67532.3246767526;67849;68003.11950087962;12415.93792031034;13327.975153923719;13652.180869147884;13714.314284285945;13857.03000789935;14227.928860355632;14632.853671463576;14822.332995015035;14900.85099149038;15070.368544986426;13490.730185396433;13672.248026358247;13763.449462021406;14014.229217392733;14299.499517516837;12253.835885590855;12649.620511384674;13657.658558536115;13724.107932984323;14368.568942931728;12074.834182207125;13232.13991090576;13246;13402.865971340161;13853.753162215045;10712.821589625291;10914.090034244135;10947.233693641369;10987.835182472429;11465.828012579652;6672.70231012586;8323.708670196515;10683;11269.098472122047;11295.37875416827 04:18:24 INFO - PROCESS | 2169 | __end_tp_report 04:18:24 INFO - PROCESS | 2169 | __start_cc_report 04:18:24 INFO - PROCESS | 2169 | _x_x_mozilla_cycle_collect,429 04:18:24 INFO - PROCESS | 2169 | __end_cc_report 04:18:24 INFO - PROCESS | 2169 | __startTimestamp1489148304811__endTimestamp 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | ------- Summary: start ------- 04:18:24 INFO - PROCESS | 2169 | Number of tests: 6 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | [#0] dojo.html Cycles:165 Average:5879.69 Median:6146.57 stddev:671.76 (10.9%) stddev-sans-first:645.64 04:18:24 INFO - PROCESS | 2169 | Values: 3425.6 3433.4 3437.5 3450.2 3473.2 5783.4 5925.4 5981.4 5993.1 6034.8 4745.5 5813.6 5864.9 5961.8 5971.9 5401.4 5421.6 5439.3 5449.4 5509.0 5381.0 5463.9 5514.6 5545.4 5568.8 4354.8 5352.7 5477.1 5478.4 5506.1 5383.2 5383.3 5434.9 5435.8 5503.6 5330.4 5373.0 5377.6 5408.5 5471.0 4545.6 5055.6 5619.5 5943.8 5969.5 6375.5 6394.9 6405.6 6423.7 6456.0 5115.3 6499.5 6513.0 6547.2 6550.1 5102.6 5929.0 5970.4 6059.0 6164.9 5508.6 6383.3 6457.2 6519.3 6578.6 5287.2 6163.8 6170.2 6313.1 6350.5 6367.6 6387.5 6396.2 6438.7 6457.0 6357.3 6366.0 6366.7 6380.5 6382.4 6246.3 6271.3 6281.5 6290.2 6372.1 5210.9 5238.5 5241.5 5246.6 5280.4 4652.5 4653.4 4665.2 4668.4 4683.3 5652.7 5813.9 5875.7 5882.1 6128.6 5559.1 5812.2 6146.6 6273.4 6368.8 6125.2 6158.8 6173.3 6183.8 6191.7 5677.5 5725.3 5727.3 5735.0 5752.3 5253.6 6333.8 6369.1 6581.1 6619.2 5472.8 6464.6 6475.0 6494.4 6502.7 6591.1 6673.0 6680.0 6695.4 6734.2 6244.3 6288.2 6308.6 6392.3 6407.4 6321.8 6370.9 6443.1 6455.5 6472.6 6120.5 6139.4 6235.9 6288.4 6295.2 6227.8 6246.5 6303.3 6305.3 6314.7 5610.4 5802.9 6053.1 6171.5 6281.1 6178.0 6267.2 6274.6 6287.9 6293.3 6216.2 6264.3 6271.8 6271.9 6284.7 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | [#1] ext.html Cycles:180 Average:55077.73 Median:17763.16 stddev:109565.94 (616.8%) stddev-sans-first:109797.17 04:18:24 INFO - PROCESS | 2169 | Values: 679.6 751.8 822.1 851.0 923.2 31995.0 36900.4 37727.9 37778.8 39553.8 37795.8 38012.2 38045.8 38081.0 38084.0 7708.3 7840.0 7855.8 10997.3 11260.9 10975.9 11054.3 11058.9 11070.6 11078.6 8564.9 10858.0 11063.4 11088.2 11094.3 11029.2 11038.6 11050.7 11075.3 11075.7 10991.6 11002.8 11072.8 11083.7 11091.7 39230.0 39411.6 39454.0 39550.6 39601.8 3339.6 3831.3 3854.5 3894.6 4027.8 28250.9 28338.9 28385.6 28566.6 29493.4 3055.1 3139.3 3157.4 3163.4 3182.8 274749.0 319761.4 348940.0 350497.0 350687.0 41039.4 41762.2 42453.4 51813.0 51992.5 54580.9 54833.0 54919.7 55152.7 55309.7 12143.9 14973.0 14974.3 14982.8 14988.8 11905.9 12065.3 12067.5 12079.8 12109.9 14043.4 14048.9 14073.4 14078.2 14119.6 5937.0 5966.9 6004.1 6038.5 6086.2 1114.6 1117.2 1117.4 1137.3 1159.2 22088.6 26456.4 26493.0 26719.9 27085.9 1223.5 1233.9 1242.9 1280.9 1281.4 13648.3 13758.8 13870.8 13947.4 13951.3 451384.0 453282.0 455877.0 456399.0 457728.0 49505.8 56504.4 56960.4 57047.0 57157.0 1408.8 1442.7 1442.7 1450.3 1451.3 25048.9 26263.9 26303.9 26318.9 26413.9 38527.8 43343.0 43344.6 43378.8 43436.3 441617.0 442890.0 443077.0 444878.0 444950.0 34139.5 34241.1 34785.3 34966.8 35042.8 42829.0 43410.8 43694.8 44689.6 44827.7 31741.5 34913.3 35950.3 36945.6 37066.8 29974.4 35303.3 35522.6 36227.8 36326.8 36129.9 36149.9 36687.8 36746.4 36797.3 24948.3 30257.8 31746.5 31895.2 32186.7 18323.5 22023.1 22970.7 23302.3 24274.0 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | [#2] jquery.html Cycles:180 Average:39962.42 Median:20932.90 stddev:109715.52 (524.1%) stddev-sans-first:109983.02 04:18:24 INFO - PROCESS | 2169 | Values: 367.4 398.7 400.0 412.0 439.9 20891.0 21039.3 21663.4 21730.7 21962.2 19931.8 20683.9 21379.6 21600.9 21820.5 5278.9 6699.1 6701.6 6702.9 6714.0 6270.4 6571.4 6669.8 7097.9 7588.3 7510.4 7521.2 7544.9 7565.0 7592.7 6739.8 7532.1 7542.2 7542.5 7572.7 6261.3 7082.7 7300.6 7380.3 7382.8 26211.2 26680.2 27028.7 27384.7 27766.6 2864.4 3221.2 3306.4 3357.3 3476.7 15496.0 15681.7 16292.8 16439.8 16753.5 1685.3 1900.3 1951.7 1963.0 2005.9 115308.4 138334.6 154017.0 158087.2 158990.4 17117.7 17136.7 20505.5 21821.9 22089.6 35412.0 35530.0 35786.3 35788.2 35812.8 10202.1 10401.7 10595.4 10662.6 10869.2 8489.2 8577.8 8596.1 8752.9 8799.7 10342.0 10477.5 10478.0 10573.5 10614.2 3651.7 3874.7 4278.9 4341.5 4374.3 887.0 1007.6 1051.6 1082.3 1122.8 16609.3 17536.1 21163.6 22669.9 24959.6 988.9 995.6 1001.5 1024.4 1031.4 11338.5 11496.5 11678.2 11739.9 11758.4 636431.0 643214.0 662463.0 662477.0 677202.6 124217.0 130766.4 132345.0 149546.5 155178.0 1296.6 1331.7 1340.7 1359.9 1360.9 19886.3 20877.9 20881.3 20974.8 21107.7 52000.2 62781.7 64147.4 64255.0 65237.0 66695.0 82838.0 86839.0 87074.0 89088.0 9968.9 11848.6 11861.8 11902.6 12106.9 13564.1 13647.0 13895.5 14015.2 14126.1 11549.6 11766.4 11776.6 11845.8 11948.0 9743.0 11184.5 11359.5 11389.1 11728.4 10588.8 10944.7 11727.7 11987.0 12076.2 10459.6 11385.9 11605.6 11730.5 11903.9 11392.4 11551.8 11651.0 11699.7 11702.0 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | [#3] mootools.html Cycles:180 Average:6606.86 Median:2318.30 stddev:4165.41 (179.7%) stddev-sans-first:4158.72 04:18:24 INFO - PROCESS | 2169 | Values: 1400.6 1549.8 1574.7 1597.9 1614.5 8531.7 8747.9 10194.6 10744.2 10766.2 10285.2 10623.8 10627.7 10644.2 10654.5 2248.3 2304.5 2305.5 2309.1 2317.1 2278.0 2301.2 2316.9 2319.6 2332.0 2287.1 2298.1 2301.4 2302.3 2303.9 2238.3 2253.8 2259.1 2268.0 2270.8 2192.3 2236.9 2247.4 2247.4 2247.9 10912.5 10978.0 10999.8 11016.5 11042.6 5610.4 5749.1 5787.5 5791.4 5807.2 2781.6 3294.1 3527.5 3588.0 3595.7 1187.3 1206.0 1737.3 1761.3 1897.4 14879.6 15089.2 15096.5 15238.9 15367.3 4126.9 4451.0 4464.5 4515.8 4648.7 11320.3 11435.0 11523.0 11525.0 11542.0 5526.8 5574.3 5608.9 5616.7 5626.1 4421.6 4681.2 5123.9 5192.9 5233.1 3155.9 3189.9 3562.4 3796.6 3802.5 824.0 873.3 1009.2 1031.7 1031.7 807.4 919.7 952.6 954.5 977.4 5805.8 6146.6 6382.0 6699.7 6761.0 966.5 986.3 1005.9 1028.6 1029.4 3607.7 3970.6 3977.2 4170.5 4247.6 12999.5 13409.0 13416.3 13420.3 13455.7 13225.1 13309.5 13380.7 13383.8 13385.3 9461.9 10010.4 10095.7 10101.6 10135.4 5493.9 6553.5 6610.6 6897.8 6919.9 11910.6 12167.2 12248.5 12289.0 12314.5 12454.4 12536.9 12545.4 12569.6 12581.6 9062.3 9198.7 9252.0 9371.3 9376.6 10132.6 10141.6 10175.1 10257.5 10282.5 8820.2 9002.0 9053.3 9179.0 9191.7 7413.8 8815.1 8951.5 9041.3 9113.5 7673.5 7706.0 7728.7 7745.3 7783.0 5621.0 5770.9 5798.4 5823.1 6002.0 5919.8 6004.3 6056.1 6079.0 6089.5 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | [#4] prototype.html Cycles:180 Average:4610.56 Median:4965.47 stddev:1304.37 (26.3%) stddev-sans-first:1268.02 04:18:24 INFO - PROCESS | 2169 | Values: 339.4 373.2 376.7 381.3 386.3 4963.4 4993.6 5353.8 5385.4 5396.6 4281.5 5207.3 5251.3 5269.2 5323.6 3479.9 3710.5 4281.3 4354.5 4355.5 4278.7 4342.6 4365.7 4373.8 4388.5 4025.6 4235.7 4384.5 4395.2 4396.7 3973.7 4087.6 4272.5 4347.8 4374.4 3406.2 3920.5 3970.2 3971.0 3976.7 4362.3 4937.5 5110.5 5161.6 5177.5 4370.5 4626.3 4705.9 4905.8 5047.4 4533.0 4963.0 5521.4 5620.8 5646.7 3756.7 3811.5 4472.4 4486.3 4496.7 5297.3 5319.4 5394.6 5549.5 5955.0 3591.0 3808.0 3920.2 4351.4 4534.3 4136.7 4670.4 4701.6 4717.6 4745.4 4448.6 4613.0 4824.5 5088.2 5093.7 4963.1 5536.8 5674.1 5680.7 5688.3 1485.0 1486.7 1508.0 1541.4 1598.6 1065.1 1086.9 1181.1 1182.0 1187.7 4654.8 4814.5 5212.8 5259.4 5311.4 5220.2 5314.8 5764.0 5864.7 5895.2 4575.5 4625.9 4732.0 5240.5 5299.9 2540.9 2613.4 2649.4 2785.8 3049.9 5024.6 5740.2 5914.8 6062.6 6119.8 5267.6 5758.4 5802.1 5833.7 6018.5 4947.6 5396.0 5562.5 5803.9 5974.8 4945.3 4958.8 5190.6 5490.5 5643.6 5036.8 5159.6 5240.7 5768.7 5865.5 5819.8 5961.7 6096.8 6115.8 6154.2 4459.9 4501.2 4681.5 5007.9 5047.3 5012.6 5375.9 5511.0 5705.0 5791.4 4826.6 5246.7 5439.4 5461.0 5700.3 4967.6 5013.4 5072.8 5558.1 5657.0 4344.7 5188.1 5402.6 5450.7 5497.9 5158.5 5238.6 5299.0 5637.5 5717.7 4568.8 4732.4 4757.9 4958.0 5520.7 04:18:24 INFO - PROCESS | 2169 | 04:18:24 INFO - PROCESS | 2169 | [#5] yui.html Cycles:180 Average:20272.27 Median:4121.15 stddev:28788.09 (698.5%) stddev-sans-first:28831.41 04:18:24 INFO - PROCESS | 2169 | Values: 719.2 732.2 771.1 798.8 826.1 14765.6 16060.4 16079.8 16085.0 16090.0 14332.9 15358.7 15472.3 15474.8 15479.1 903.5 940.3 942.5 944.2 945.1 897.4 924.3 927.1 940.5 949.9 926.1 931.0 970.5 976.0 977.5 966.1 969.9 972.4 972.5 973.7 719.8 728.9 730.4 730.4 731.0 14472.9 14655.7 14665.7 15119.8 15651.8 14486.8 14715.8 14740.3 14775.6 14832.3 11555.4 11686.9 11697.7 11840.3 12122.0 3243.4 3702.6 3729.8 3740.7 3800.0 84197.7 103345.9 105135.0 108011.0 108719.0 10051.0 10883.9 11445.0 11617.4 11767.6 22824.9 24340.4 24591.6 24592.3 24687.5 7980.8 7989.0 8101.3 8114.9 8315.0 4201.4 4231.3 4272.5 4306.3 4333.3 3452.5 3489.2 3530.3 3537.9 3540.1 637.7 639.1 644.0 644.8 660.3 603.7 685.2 686.6 698.9 708.8 9674.0 10033.7 10069.2 10202.3 10385.0 644.4 661.0 669.2 676.3 725.4 4040.9 4512.2 4913.7 4914.2 4916.6 77649.6 102021.0 102197.0 102916.0 105190.0 82887.6 91054.0 91594.0 91831.5 92094.0 77996.0 78674.0 79392.0 81215.2 82520.6 7780.7 7971.4 9139.0 9249.3 9415.9 42238.8 42287.8 51757.2 53314.7 53562.7 52100.5 65851.3 67532.3 67849.0 68003.1 12415.9 13328.0 13652.2 13714.3 13857.0 14227.9 14632.9 14822.3 14900.9 15070.4 13490.7 13672.2 13763.4 14014.2 14299.5 12253.8 12649.6 13657.7 13724.1 14368.6 12074.8 13232.1 13246.0 13402.9 13853.8 10712.8 10914.1 10947.2 10987.8 11465.8 6672.7 8323.7 10683.0 11269.1 11295.4 04:18:24 INFO - PROCESS | 2169 | -------- Summary: end -------- 04:18:24 INFO - PROCESS | 2169 | 04:18:25 INFO - TEST-INFO | 2169: exit 0 04:18:25 INFO - TEST-OK | dromaeo_css | took 1116737ms 04:18:25 INFO - TEST-START | kraken 04:18:25 INFO - operating with platform_type : mac_ 04:18:25 INFO - Initialising browser for kraken test... 04:18:25 INFO - TEST-INFO | started process 2175 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp95ccF_/profile http://localhost:51706/getInfo.html) 04:18:28 INFO - PROCESS | 2175 | 2017-03-10 04:18:28.479 plugin-container[2176:16963] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4f, name = 'com.apple.tsm.portname' 04:18:28 INFO - PROCESS | 2175 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:28 INFO - PROCESS | 2175 | 2017-03-10 04:18:28.484 plugin-container[2176:16963] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9113, name = 'com.apple.CFPasteboardClient' 04:18:28 INFO - PROCESS | 2175 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:28 INFO - PROCESS | 2175 | 2017-03-10 04:18:28.484 plugin-container[2176:16963] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:18:28 INFO - PROCESS | 2175 | __metrics Screen width/height:1600/1200 04:18:28 INFO - PROCESS | 2175 | colorDepth:24 04:18:28 INFO - PROCESS | 2175 | Browser inner width/height: 1024/689 04:18:28 INFO - PROCESS | 2175 | __metrics 04:18:28 ERROR - PROCESS | 2175 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 04:18:29 INFO - TEST-INFO | 2175: exit 0 04:18:29 INFO - Browser initialized. 04:18:29 INFO - Running cycle 1/1 for kraken test... 04:18:29 INFO - TEST-INFO | started process 2177 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b5/152b2m257t95w2vfwktssysw00000w/T/tmp95ccF_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:31 INFO - PROCESS | 2177 | 2017-03-10 04:18:31.925 plugin-container[2178:17098] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 04:18:31 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:31 INFO - PROCESS | 2177 | 2017-03-10 04:18:31.926 plugin-container[2178:17098] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 04:18:31 INFO - PROCESS | 2177 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:18:31 INFO - PROCESS | 2177 | 2017-03-10 04:18:31.926 plugin-container[2178:17098] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:18:41 INFO - PROCESS | 2177 | RSS: Main: 228274176 04:18:41 INFO - PROCESS | 2177 | 04:18:44 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:45 INFO - PROCESS | 2177 | RSS: Main: 241803264 04:18:45 INFO - PROCESS | 2177 | 04:18:48 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-dft) 04:18:48 INFO - PROCESS | 2177 | RSS: Main: 250081280 04:18:48 INFO - PROCESS | 2177 | 04:18:52 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-fft) 04:18:52 INFO - PROCESS | 2177 | RSS: Main: 252649472 04:18:52 INFO - PROCESS | 2177 | 04:18:54 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51706/tests/kraken/driver.html?testName=audio-oscillator) 04:18:55 INFO - PROCESS | 2177 | RSS: Main: 253853696 04:18:55 INFO - PROCESS | 2177 | 04:18:57 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51706/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:58 INFO - PROCESS | 2177 | RSS: Main: 255500288 04:18:58 INFO - PROCESS | 2177 | 04:19:01 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51706/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:02 INFO - PROCESS | 2177 | RSS: Main: 260796416 04:19:02 INFO - PROCESS | 2177 | 04:19:05 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51706/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:06 INFO - PROCESS | 2177 | RSS: Main: 259026944 04:19:06 INFO - PROCESS | 2177 | 04:19:09 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51706/tests/kraken/driver.html?testName=json-parse-financial) 04:19:10 INFO - PROCESS | 2177 | RSS: Main: 258846720 04:19:10 INFO - PROCESS | 2177 | 04:19:12 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51706/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:12 INFO - PROCESS | 2177 | RSS: Main: 259686400 04:19:12 INFO - PROCESS | 2177 | 04:19:14 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:15 INFO - PROCESS | 2177 | RSS: Main: 260042752 04:19:15 INFO - PROCESS | 2177 | 04:19:17 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:18 INFO - PROCESS | 2177 | RSS: Main: 260210688 04:19:18 INFO - PROCESS | 2177 | 04:19:21 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:22 INFO - PROCESS | 2177 | RSS: Main: 260747264 04:19:22 INFO - PROCESS | 2177 | 04:19:25 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:26 INFO - PROCESS | 2177 | RSS: Main: 260419584 04:19:26 INFO - PROCESS | 2177 | 04:19:27 INFO - PROCESS | 2177 | Cycle 1(1): loaded http://localhost:51706/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51706/tests/kraken/driver.html?testName=ai-astar) 04:19:28 INFO - PROCESS | 2177 | RSS: Main: 263761920 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | __start_tp_report 04:19:28 INFO - PROCESS | 2177 | _x_x_mozilla_page_load 04:19:28 INFO - PROCESS | 2177 | _x_x_mozilla_page_load_details 04:19:28 INFO - PROCESS | 2177 | |i|pagename|runs| 04:19:28 INFO - PROCESS | 2177 | |0;ai-astar;109;133;118;118;121;119;120;121;121;120 04:19:28 INFO - PROCESS | 2177 | |1;audio-beat-detection;141;114;115;153;117;113;124;150;166;112 04:19:28 INFO - PROCESS | 2177 | |2;audio-dft;194;202;224;235;229;270;263;199;198;199 04:19:28 INFO - PROCESS | 2177 | |3;audio-fft;87;83;88;99;62;70;87;87;100;53 04:19:28 INFO - PROCESS | 2177 | |4;audio-oscillator;88;75;121;103;103;72;83;72;69;82 04:19:28 INFO - PROCESS | 2177 | |5;imaging-gaussian-blur;107;81;138;137;89;89;89;88;89;107 04:19:28 INFO - PROCESS | 2177 | |6;imaging-darkroom;96;124;113;100;153;157;95;156;155;96 04:19:28 INFO - PROCESS | 2177 | |7;imaging-desaturate;105;121;89;149;146;91;90;92;132;147 04:19:28 INFO - PROCESS | 2177 | |8;json-parse-financial;67;68;71;69;68;69;68;72;83;102 04:19:28 INFO - PROCESS | 2177 | |9;json-stringify-tinderbox;62;64;59;65;68;58;59;59;59;62 04:19:28 INFO - PROCESS | 2177 | |10;stanford-crypto-aes;112;113;109;84;85;88;97;88;78;114 04:19:28 INFO - PROCESS | 2177 | |11;stanford-crypto-ccm;149;159;176;159;156;141;138;129;186;153 04:19:28 INFO - PROCESS | 2177 | |12;stanford-crypto-pbkdf2;169;175;175;185;203;228;234;178;174;172 04:19:28 INFO - PROCESS | 2177 | |13;stanford-crypto-sha256-iterative;68;67;73;69;76;79;71;76;89;92 04:19:28 INFO - PROCESS | 2177 | __end_tp_report 04:19:28 INFO - PROCESS | 2177 | __start_cc_report 04:19:28 INFO - PROCESS | 2177 | _x_x_mozilla_cycle_collect,997 04:19:28 INFO - PROCESS | 2177 | __end_cc_report 04:19:28 INFO - PROCESS | 2177 | __startTimestamp1489148368075__endTimestamp 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | ------- Summary: start ------- 04:19:28 INFO - PROCESS | 2177 | Number of tests: 14 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#0] ai-astar Cycles:10 Average:120.00 Median:120.50 stddev:5.79 (4.8%) stddev-sans-first:4.58 04:19:28 INFO - PROCESS | 2177 | Values: 109.0 133.0 118.0 118.0 121.0 119.0 120.0 121.0 121.0 120.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:132.50 stddev:20.12 (15.2%) stddev-sans-first:20.98 04:19:28 INFO - PROCESS | 2177 | Values: 141.0 114.0 115.0 153.0 117.0 113.0 124.0 150.0 166.0 112.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#2] audio-dft Cycles:10 Average:221.30 Median:226.50 stddev:27.93 (12.3%) stddev-sans-first:27.82 04:19:28 INFO - PROCESS | 2177 | Values: 194.0 202.0 224.0 235.0 229.0 270.0 263.0 199.0 198.0 199.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#3] audio-fft Cycles:10 Average:81.60 Median:87.00 stddev:15.31 (17.6%) stddev-sans-first:16.11 04:19:28 INFO - PROCESS | 2177 | Values: 87.0 83.0 88.0 99.0 62.0 70.0 87.0 87.0 100.0 53.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:73.50 stddev:17.09 (23.2%) stddev-sans-first:18.12 04:19:28 INFO - PROCESS | 2177 | Values: 88.0 75.0 121.0 103.0 103.0 72.0 83.0 72.0 69.0 82.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#5] imaging-gaussian-blur Cycles:10 Average:101.40 Median:88.50 stddev:20.76 (23.5%) stddev-sans-first:21.92 04:19:28 INFO - PROCESS | 2177 | Values: 107.0 81.0 138.0 137.0 89.0 89.0 89.0 88.0 89.0 107.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#6] imaging-darkroom Cycles:10 Average:124.50 Median:156.50 stddev:27.93 (17.8%) stddev-sans-first:27.65 04:19:28 INFO - PROCESS | 2177 | Values: 96.0 124.0 113.0 100.0 153.0 157.0 95.0 156.0 155.0 96.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:119.00 stddev:25.73 (21.6%) stddev-sans-first:26.97 04:19:28 INFO - PROCESS | 2177 | Values: 105.0 121.0 89.0 149.0 146.0 91.0 90.0 92.0 132.0 147.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#8] json-parse-financial Cycles:10 Average:73.70 Median:69.00 stddev:10.98 (15.9%) stddev-sans-first:11.37 04:19:28 INFO - PROCESS | 2177 | Values: 67.0 68.0 71.0 69.0 68.0 69.0 68.0 72.0 83.0 102.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:62.00 stddev:3.31 (5.3%) stddev-sans-first:3.50 04:19:28 INFO - PROCESS | 2177 | Values: 62.0 64.0 59.0 65.0 68.0 58.0 59.0 59.0 59.0 62.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:84.50 stddev:13.94 (16.5%) stddev-sans-first:13.66 04:19:28 INFO - PROCESS | 2177 | Values: 112.0 113.0 109.0 84.0 85.0 88.0 97.0 88.0 78.0 114.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:157.50 stddev:17.11 (10.9%) stddev-sans-first:18.03 04:19:28 INFO - PROCESS | 2177 | Values: 149.0 159.0 176.0 159.0 156.0 141.0 138.0 129.0 186.0 153.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:181.50 stddev:24.00 (13.2%) stddev-sans-first:24.31 04:19:28 INFO - PROCESS | 2177 | Values: 169.0 175.0 175.0 185.0 203.0 228.0 234.0 178.0 174.0 172.0 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - PROCESS | 2177 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.00 Median:76.00 stddev:8.58 (11.3%) stddev-sans-first:8.59 04:19:28 INFO - PROCESS | 2177 | Values: 68.0 67.0 73.0 69.0 76.0 79.0 71.0 76.0 89.0 92.0 04:19:28 INFO - PROCESS | 2177 | -------- Summary: end -------- 04:19:28 INFO - PROCESS | 2177 | 04:19:28 INFO - TEST-INFO | 2177: exit 0 04:19:29 INFO - TEST-OK | kraken | took 63528ms 04:19:29 INFO - SUITE-END | took 1180s 04:19:29 INFO - Completed test suite (00:19:40) 04:19:29 INFO - javascript benchmark 04:19:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7710.934901719147, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3425.640307767684, 3433.4163192257347, 3437.45000799872, 3450.171958729906, 3473.166440054386, 5783.36382997871, 5925.407459254073, 5981.371955944623, 5993.10103484477, 6034.758609655609, 4745.549172828584, 5813.62211456255, 5864.882702345951, 5961.821145365635, 5971.910421343683, 5401.405845357018, 5421.620486565942, 5439.265699130607, 5449.4005659377635, 5508.980838544862, 5381.031414345416, 5463.890722185554, 5514.6139770216105, 5545.3622833374075, 5568.777248910059, 4354.847580334705, 5352.652077614982, 5477.096279113942, 5478.397376288605, 5506.119020956668, 5383.246345511631, 5383.2732581101445, 5434.8913021739345, 5435.809746658888, 5503.559715222773, 5330.413654498002, 5373.032854086263, 5377.623566350357, 5408.540274076709, 5471.042567550702, 4545.568171023748, 5055.5702765265, 5619.466150715716, 5943.821685349447, 5969.462748352669, 6375.45808606269, 6394.904076438857, 6405.615663060231, 6423.710933008026, 6455.9677201613695, 5115.309433226504, 6499.51253655973, 6513.0230465430095, 6547.181602299713, 6550.050242714779, 5102.591792656615, 5928.970355148283, 5970.402959703995, 6058.969705151446, 6164.8767024659255, 5508.586855985737, 6383.265924418658, 6457.160569125984, 6519.250286217051, 6578.572392794453, 5287.23335116406, 6163.753449861955, 6170.197874276315, 6313.116163737081, 6350.4602108820345, 6367.586106903036, 6387.520935929824, 6396.232452105777, 6438.742450302029, 6456.967715161394, 6357.300696923335, 6366.045093236052, 6366.713497892606, 6380.489560835122, 6382.36176382358, 6246.312905580383, 6271.341509141565, 6281.466075383643, 6290.21372328459, 6372.107904893319, 5210.869728256824, 5238.476152384731, 5241.50205730455, 5246.580273578181, 5280.392754833167, 4652.488226295105, 4653.441587009581, 4665.2302370108555, 4668.39310889589, 4683.297505374153, 5652.671622168787, 5813.88372232553, 5875.706214689249, 5882.147088672119, 6128.571000029955, 5559.138333558305, 5812.215350927655, 6146.569740118238, 6273.368924079681, 6368.777092801823, 6125.2209693688765, 6158.753649854045, 6173.259208894961, 6183.752649894044, 6191.721372538156, 5677.517411020027, 5725.284339457485, 5727.284089488814, 5734.971325143348, 5752.309722833287, 5253.605979551626, 6333.841653958596, 6369.14016607752, 6581.078648989241, 6619.2056953164965, 5472.781088756406, 6464.612123272619, 6474.967625161844, 6494.447971922439, 6502.707378167899, 6591.143151390289, 6672.966635166793, 6679.966600167162, 6695.363940425652, 6734.158230221223, 6244.281907580505, 6288.151099601495, 6308.589941653778, 6392.264889537762, 6407.423331900151, 6321.810345689637, 6370.90443643355, 6443.065755465525, 6455.4512866406885, 6472.579282346633, 6120.538559592075, 6139.369480960641, 6235.875282494234, 6288.371162883858, 6295.213098362705, 6227.844303892439, 6246.5002799775, 6303.275123360689, 6305.306416294296, 6314.715837787218, 5610.410906854721, 5802.868440654032, 6053.092036194606, 6171.537134715004, 6281.089242059968, 6178.042403427476, 6267.2479302484, 6274.592151510137, 6287.874242515216, 6293.276273228637, 6216.222972128484, 6264.34224406449, 6271.811845644638, 6271.874562508633, 6284.654344011124], "value": 5840.4869328086, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.6092246957999, 751.7556794041936, 822.1408627983757, 850.9574521273935, 923.2060428031896, 31995.0, 36900.44649330259, 37727.86816395509, 37778.8111059445, 39553.80223098888, 37795.81102094492, 38012.23975520495, 38045.809770951106, 38081.0, 38084.04789880248, 7708.306252437294, 7839.960800195991, 7855.764327070197, 10997.285176463543, 11260.943695281512, 10975.859707357069, 11054.336739795597, 11058.944705276503, 11070.557177712923, 11078.612248571302, 8564.929383827022, 10858.022777949984, 11063.391513466757, 11088.168387370939, 11094.334339939589, 11029.227954043221, 11038.558457661724, 11050.668479945614, 11075.280106793032, 11075.72310692239, 10991.560337586487, 11002.779944401147, 11072.778544429148, 11083.667489975314, 11091.667249982513, 39230.0, 39411.60588394137, 39454.0136496587, 39550.60449395498, 39601.80199098986, 3339.6493368196234, 3831.3295173344554, 3854.5181852268465, 3894.55212650546, 4027.7784721840285, 28250.85874570614, 28338.858305708545, 28385.57421638677, 28566.571501427494, 29493.41013179746, 3055.114016935086, 3139.262273365757, 3157.3685262947274, 3163.4043020302697, 3182.7772055956093, 274749.0, 319761.4011929925, 348940.0, 350497.0, 350687.0, 41039.384409233884, 41762.1647567053, 42453.36319955203, 51813.0, 51992.480075198764, 54580.904482417034, 54833.0, 54919.72540137354, 55152.72423637856, 55309.72345138249, 12143.939280303543, 14973.0, 14974.326155323037, 14982.775258371134, 14988.775168372484, 11905.880941190477, 12065.336406497727, 12067.517299308105, 12079.75840483203, 12109.878901211052, 14043.368048437846, 14048.946329025159, 14073.366698498592, 14078.225697586731, 14119.576412707635, 5936.970315148396, 5966.880662386728, 6004.099385092271, 6038.547108966845, 6086.178365920633, 1114.6321713834416, 1117.2402766118955, 1117.357519426317, 1137.2835113878205, 1159.1848057622362, 22088.558228835656, 26456.412615243145, 26493.0, 26719.93120275206, 27085.864570677415, 1223.4555622747969, 1233.901287896966, 1242.8570714367784, 1280.9039322050883, 1281.4425724809737, 13648.317584120754, 13758.793618095737, 13870.791938120936, 13947.442102315998, 13951.302434878215, 451384.0, 453282.0, 455877.0, 456399.0, 457728.0, 49505.752471237414, 56504.43495565074, 56960.43039569634, 57047.0, 57157.0, 1408.7534681430914, 1442.6537630968492, 1442.7114577084626, 1450.332846890421, 1451.252604908473, 25048.874755626104, 26263.86868065724, 26303.868480657475, 26318.86840565785, 26413.867930660224, 38527.807360964136, 43343.0, 43344.56655433532, 43378.783106084265, 43436.34845477383, 441617.0, 442890.0, 443077.0, 444878.0, 444950.0, 34139.4879076819, 34241.14397140092, 34785.304293913476, 34966.825165874005, 35042.824785875906, 42829.0, 43410.78294608507, 43694.78152609216, 44689.55310446854, 44827.655170344944, 31741.5238771414, 34913.30173396467, 35950.28099438049, 36945.6305436953, 37066.8146659265, 29974.400511990076, 35303.293934121684, 35522.64477355193, 36227.81886090553, 36326.818365908, 36129.91610251697, 36149.91550253497, 36687.78090519625, 36746.448803267434, 36797.26405471822, 24948.251552453454, 30257.848710756305, 31746.523802142525, 31895.202619934687, 32186.678133218367, 18323.54191145232, 22023.11907523681, 22970.655440168077, 23302.252331075575, 24274.02903883825], "value": 18945.691027091627, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.3791292715311, 398.7029662901139, 399.9860004899829, 411.9526254480735, 439.9230134726422, 20891.0, 21039.2636257731, 21663.350099497, 21730.674039889374, 21962.231321903735, 19931.804091754468, 20683.896580517114, 21379.57240855182, 21600.89199554, 21820.45448863779, 5278.9208161877605, 6699.1291132152755, 6701.597904125743, 6702.932970670279, 6713.966430167842, 6270.372962703739, 6571.44142747867, 6669.8332541686605, 7097.89353159703, 7588.27911348421, 7510.436717246201, 7521.210272921347, 7544.924550754477, 7565.0, 7592.658330375147, 6739.797806065826, 7532.058492688441, 7542.20806815282, 7542.547447153188, 7572.659230334621, 6261.311255761862, 7082.681279342391, 7300.56196628204, 7380.261973802631, 7382.815429614249, 26211.213663590122, 26680.19959401221, 27028.729712702818, 27384.726152738614, 27766.583501247496, 2864.375697655875, 3221.197170125999, 3306.371789360038, 3357.261402491448, 3476.739244556643, 15495.992760470534, 15681.686366272725, 16292.755608665879, 16439.849210555265, 16753.497395078044, 1685.2837544043732, 1900.3158862809516, 1951.7072439134101, 1963.0184907546227, 2005.91976320947, 115308.42345788218, 138334.6166538332, 154017.0, 158087.2095639526, 158990.41009589873, 17117.743233851503, 17136.742948855775, 20505.48736281575, 21821.890890545445, 22089.558208835733, 35412.0, 35530.0, 35786.28427431489, 35788.21058947042, 35812.82093589516, 10202.081812636898, 10401.739956500996, 10595.417252051056, 10662.626808061681, 10869.184811139037, 8489.151084891584, 8577.78555536104, 8596.097409771884, 8752.8687069694, 8799.692010779592, 10342.0, 10477.47612619366, 10478.0, 10573.471326433648, 10614.150867930546, 3651.689606383487, 3874.651281384689, 4278.871633850989, 4341.5021817472925, 4374.343848422762, 886.9689560865339, 1007.6120693533043, 1051.574112484445, 1082.3397727386289, 1122.803509385854, 16609.3356265748, 17536.123193840256, 21163.576728465345, 22669.88665056664, 24959.62560561593, 988.9208863290919, 995.6267787903695, 1001.4792307999945, 1024.3802499487704, 1031.3811712972156, 11338.485069628441, 11496.540138394537, 11678.24091434054, 11739.88260117405, 11758.412079395996, 636431.0, 643214.0, 662463.0, 662477.0, 677202.613986927, 124217.0, 130766.38467230603, 132345.0, 149546.50453495324, 155178.0, 1296.572131196703, 1331.740310639416, 1340.7117469743857, 1359.884409825176, 1360.8979326550548, 19886.303979361233, 20877.89561052185, 20881.26915557948, 20974.790252097893, 21107.683384748932, 52000.219996700835, 62781.68609156925, 64147.35852641414, 64255.0, 65237.0, 66695.0, 82838.0, 86839.0, 87074.0, 89088.0, 9968.900310996798, 11848.617611435933, 11861.822072668745, 11902.642920712393, 12106.878931210575, 13564.050516464147, 13647.0, 13895.513657021957, 14015.229162396166, 14126.081804682663, 11549.595764148215, 11766.352850593299, 11776.646700598996, 11845.76308473843, 11947.984421324285, 9742.95128524353, 11184.496697648463, 11359.54561817518, 11389.145814063813, 11728.41357932117, 10588.841167382341, 10944.686637603538, 11727.706807329885, 11987.0, 12076.154669173073, 10459.581616735246, 11385.943070284595, 11605.599464433835, 11730.530778768754, 11903.880961190624, 11392.373419461677, 11551.76896462083, 11651.0, 11699.707507312385, 11702.0], "value": 11762.881321926754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.6148309214966, 1549.7597872329793, 1574.7244232259352, 1597.9360825566978, 1614.5075751895674, 8531.701390451335, 8747.91252087479, 10194.592216311348, 10744.247902646808, 10766.192535559834, 10285.177185825134, 10623.84064239037, 10627.681169564925, 10644.201684873646, 10654.520546575402, 2248.325502349297, 2304.5045315257216, 2305.527366889792, 2309.145616122029, 2317.050009496107, 2277.954440911181, 2301.1945818963313, 2316.918907838226, 2319.5592837360846, 2331.988340058297, 2287.0623044551735, 2298.069281940808, 2301.42464383904, 2302.297799171252, 2303.8963246653857, 2238.3396897915154, 2253.785890340415, 2259.1415262200258, 2268.047420083569, 2270.8069814065743, 2192.2655910270078, 2236.944076398087, 2247.404437823978, 2247.449374903143, 2247.8538894971775, 10912.50893709785, 10978.0, 10999.780004399947, 11016.504257308441, 11042.613508527164, 5610.438956104398, 5749.108888122306, 5787.479126878559, 5791.391903850077, 5807.245058142456, 2781.568856827195, 3294.1105901406727, 3527.488514165457, 3587.9820600897087, 3595.7123430125525, 1187.329159025148, 1206.0351718625066, 1737.287712038071, 1761.3042848075067, 1897.4402551247415, 14879.553613391616, 15089.170095644735, 15096.471623493235, 15238.857085718615, 15367.308471118826, 4126.885740849953, 4450.955490445119, 4464.486584042812, 4515.796789144496, 4648.697834640738, 11320.26418282809, 11435.028022618171, 11523.0, 11525.020373268366, 11542.01892839118, 5526.778928842801, 5574.275344205308, 5608.887822243614, 5616.747246373923, 5626.071698169838, 4421.579949904818, 4681.204195286809, 5123.948760512421, 5192.8961420771375, 5233.084210263189, 3155.857986390618, 3189.920251993672, 3562.3587754203973, 3796.5633952095864, 3802.5056742623283, 823.9835203295901, 873.2795443758924, 1009.1724785675675, 1031.6698656430021, 1031.7059638003134, 807.3581502705364, 919.6827094652334, 952.6332362040664, 954.5370495309769, 977.3891317926297, 5805.796797112081, 6146.569740118149, 6382.0, 6699.698513566901, 6761.0, 966.4829316315878, 986.2652324018509, 1005.8642083318805, 1028.6091285311684, 1029.4008371931766, 3607.6933460655614, 3970.6029397060065, 3977.2244412339314, 4170.4995400551525, 4247.6389506892265, 12999.480020799252, 13409.0, 13416.329183540784, 13420.328983550784, 13455.663608409868, 13225.074244802772, 13309.534166304327, 13380.665483362995, 13383.799243011363, 13385.263810490322, 9461.858072128924, 10010.399376037461, 10095.697129086138, 10101.646442374482, 10135.442550659636, 5493.862653433696, 6553.475721942328, 6610.570312929644, 6897.7585784497305, 6919.8962015568795, 11910.583129590423, 12167.209131406431, 12248.510059597516, 12288.955438787803, 12314.507419703112, 12454.43955022008, 12536.937315313366, 12545.435455404346, 12569.560065397667, 12581.559645412366, 9062.275017998412, 9198.67804626835, 9251.953740231256, 9371.34400591952, 9376.57805398745, 10132.594696212069, 10141.645042423479, 10175.084242418217, 10257.487125643836, 10282.537285822007, 8820.2061814437, 9002.009778924183, 9053.321000924825, 9179.0, 9191.724248272563, 7413.777586672409, 8815.074417186359, 8951.462912225288, 9041.276697864023, 9113.498757568397, 7673.53958762476, 7705.961470192613, 7728.729494467667, 7745.264199901, 7783.0, 5621.044422448275, 5770.913436298375, 5798.362180160095, 5823.068309070529, 6001.969990150022, 5919.792807251725, 6004.339522652592, 6056.121862329849, 6079.0, 6089.512838972783], "value": 5038.521130664229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3721615012227, 373.19203923505614, 376.73063759412014, 381.3497985933985, 386.26802209812416, 4963.379577552806, 4993.600511959044, 5353.839384818452, 5385.380681221656, 5396.595255355849, 4281.464816897887, 5207.297014902987, 5251.317328747267, 5269.235960785693, 5323.60072994526, 3479.8782042628513, 3710.517632707751, 4281.336392859096, 4354.499232588246, 4355.542668019844, 4278.679099067567, 4342.609165175134, 4365.672574556905, 4373.803178856959, 4388.451443569554, 4025.5571887092397, 4235.661147108224, 4384.4519435070615, 4395.165118498567, 4396.74692712577, 3973.721839471238, 4087.6321131098193, 4272.46594175728, 4347.760873151976, 4374.387585737999, 3406.2165701888703, 3920.5295364556437, 3970.2456533258587, 3971.0, 3976.701747368959, 4362.323839804835, 4937.481564435754, 5110.540051395392, 5161.5870730341485, 5177.48225177483, 4370.497392799837, 4626.282926146453, 4705.929411058837, 4905.768811557435, 5047.419546752134, 4532.977335113336, 4962.96518427443, 5521.395783279974, 5620.847726216157, 5646.6894320812335, 3756.7182461315238, 3811.5235595550557, 4472.396226509412, 4486.259767138451, 4496.685232033759, 5297.284866543006, 5319.388270348921, 5394.62237643369, 5549.472800083986, 5954.97022514889, 3591.0, 3807.9809600951817, 3920.2355540669296, 4351.390805287262, 4534.274516077412, 4136.683457263942, 4670.416197975253, 4701.6003639690325, 4717.575418212377, 4745.437463769595, 4448.621867141264, 4612.976935115303, 4824.517548245218, 5088.185890257541, 5093.701106217891, 4963.061753555236, 5536.75084621193, 5674.070815922606, 5680.744366503517, 5688.260526131577, 1484.9952564038463, 1486.6917112940544, 1507.9698406031819, 1541.368039103962, 1598.6003499125218, 1065.142560239015, 1086.940218287986, 1181.1023622047135, 1181.9645410637695, 1187.685263405181, 4654.790534425892, 4814.470408255089, 5212.843614691566, 5259.447757985433, 5311.362636483569, 5220.172939471231, 5314.840554783363, 5764.0, 5864.706764661835, 5895.233619629421, 4575.450945886515, 4625.889786451295, 4731.9589690268085, 5240.501777795506, 5299.947000529945, 2540.872956352175, 2613.353587240065, 2649.390640152737, 2785.818921770119, 3049.8932537361084, 5024.598032157419, 5740.225069615632, 5914.822555323261, 6062.575619706667, 6119.755209791648, 5267.631265811433, 5758.3799371286805, 5802.1296805479515, 5833.67914764692, 6018.548608854353, 4947.6289278304275, 5396.0, 5562.471565201299, 5803.88392232153, 5974.820755377345, 4945.280095947287, 4958.776855041459, 5190.636655434083, 5490.478404551721, 5643.576731745054, 5036.823711170092, 5159.638825282194, 5240.659357141773, 5768.682722450306, 5865.530757539302, 5819.79630712923, 5961.7345408744395, 6096.817095487142, 6115.84710382244, 6154.230721159855, 4459.866204013885, 4501.15452664406, 4681.485036645898, 5007.943565711639, 5047.318611987334, 5012.5964729875695, 5375.892482150257, 5511.0, 5704.971475142598, 5791.378414044075, 4826.638002149783, 5246.658967167122, 5439.37447193562, 5461.044317244387, 5700.315962084576, 4967.552920237196, 5013.385008790178, 5072.771725272298, 5558.138488534284, 5657.040071949569, 4344.652427805705, 5188.143956247177, 5402.568844020128, 5450.700211488248, 5497.945020549743, 5158.535731784007, 5238.633295669267, 5298.97350513245, 5637.548996080386, 5717.656940583412, 4568.79440425175, 4732.408448943882, 4757.928631070606, 4957.975210123926, 5520.681313848113], "value": 4228.208720865747, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.2088702427334, 732.2018999290772, 771.0939645916047, 798.8362385710928, 826.087173673091, 14765.630859228524, 16060.437884674038, 16079.83920160798, 16085.034897906135, 16090.034597924117, 14332.856671433283, 15358.69282614347, 15472.303746331414, 15474.767878481833, 15479.14864682442, 903.4985583001431, 940.3464592108487, 942.528735632184, 944.2257348973844, 945.1068740040664, 897.4256475855458, 924.3483344242293, 927.0775578299601, 940.4921342475055, 949.8622699708573, 926.1109335038371, 931.0410277414275, 970.4710932541782, 975.9756006099833, 977.5063592885618, 966.0870477398861, 969.8933117357085, 972.4359871274714, 972.4845831709206, 973.7078876337141, 719.7660760252938, 728.9307515785991, 730.393773168269, 730.4193166432699, 731.0, 14472.92763536186, 14655.706885862222, 14665.706685866224, 15119.848801511955, 15651.843481565153, 14486.782698259534, 14715.779263311058, 14740.336684849208, 14775.55673329791, 14832.25838708071, 11555.422228888607, 11686.941286559011, 11697.70755731105, 11840.348780817052, 12122.02380952381, 3243.383757086146, 3702.5581673783818, 3729.776213427176, 3740.682042026431, 3799.981000094982, 84197.73703394516, 103345.9330813387, 105135.0, 108011.0, 108719.0, 10051.04515071067, 10883.945580272048, 11445.0, 11617.361045142598, 11767.646970590897, 22824.88587557085, 24340.391490212885, 24591.63112553313, 24592.262232133064, 24687.50624987526, 7980.760577182577, 7989.0413150421155, 8101.270885620323, 8114.8782768258525, 8315.0, 4201.411802347674, 4231.259529582311, 4272.5086615039045, 4306.334724190945, 4333.328334108218, 3452.5166476693284, 3489.180042689966, 3530.3292374448774, 3537.9032499925106, 3540.1149712571855, 637.6747858592058, 639.1084437210159, 643.9613623182624, 644.8355669304298, 660.3066779881106, 603.728322254987, 685.1812084558904, 686.605202008847, 698.8637215742983, 708.7944496096178, 9673.951630241803, 10033.690415349713, 10069.244806639532, 10202.285839991278, 10385.0, 644.3749562923956, 660.9801705948829, 669.1635455680399, 676.2831398717375, 725.4305370284302, 4040.878773636796, 4512.187806194916, 4913.729744863996, 4914.164592019365, 4916.631252656065, 77649.61175194201, 102021.0, 102196.95606087836, 102916.0, 105190.0, 82887.5855620718, 91054.0, 91594.0, 91831.49011059357, 92094.0, 77995.98036176771, 78674.0, 79392.0, 81215.18784812077, 82520.58739706263, 7780.688772449039, 7971.362291016821, 9139.0, 9249.30630202751, 9415.85876211871, 42238.788806057004, 42287.803760199524, 51757.22364164616, 53314.66713332198, 53562.73218633882, 52100.47899521108, 65851.34148658453, 67532.3246767526, 67849.0, 68003.11950087962, 12415.93792031034, 13327.975153923719, 13652.180869147884, 13714.314284285945, 13857.03000789935, 14227.928860355632, 14632.853671463576, 14822.332995015035, 14900.85099149038, 15070.368544986426, 13490.730185396433, 13672.248026358247, 13763.449462021406, 14014.229217392733, 14299.499517516837, 12253.835885590855, 12649.620511384674, 13657.658558536115, 13724.107932984323, 14368.568942931728, 12074.834182207125, 13232.13991090576, 13246.0, 13402.865971340161, 13853.753162215045, 10712.821589625291, 10914.090034244135, 10947.233693641369, 10987.835182472429, 11465.828012579652, 6672.70231012586, 8323.708670196515, 10683.0, 11269.098472122047, 11295.37875416827], "value": 7579.96205644592, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1634.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 133.0, 118.0, 118.0, 121.0, 119.0, 120.0, 121.0, 121.0, 120.0], "value": 120.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 114.0, 115.0, 153.0, 117.0, 113.0, 124.0, 150.0, 166.0, 112.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 202.0, 224.0, 235.0, 229.0, 270.0, 263.0, 199.0, 198.0, 199.0], "value": 221.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 88.0, 99.0, 62.0, 70.0, 87.0, 87.0, 100.0, 53.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 75.0, 121.0, 103.0, 103.0, 72.0, 83.0, 72.0, 69.0, 82.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 81.0, 138.0, 137.0, 89.0, 89.0, 89.0, 88.0, 89.0, 107.0], "value": 101.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 124.0, 113.0, 100.0, 153.0, 157.0, 95.0, 156.0, 155.0, 96.0], "value": 124.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 121.0, 89.0, 149.0, 146.0, 91.0, 90.0, 92.0, 132.0, 147.0], "value": 116.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 71.0, 69.0, 68.0, 69.0, 68.0, 72.0, 83.0, 102.0], "value": 73.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 59.0, 65.0, 68.0, 58.0, 59.0, 59.0, 59.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 109.0, 84.0, 85.0, 88.0, 97.0, 88.0, 78.0, 114.0], "value": 96.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 159.0, 176.0, 159.0, 156.0, 141.0, 138.0, 129.0, 186.0, 153.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 175.0, 175.0, 185.0, 203.0, 228.0, 234.0, 178.0, 174.0, 172.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 73.0, 69.0, 76.0, 79.0, 71.0, 76.0, 89.0, 92.0], "value": 76.0, "unit": "score"}]}]} 04:19:29 INFO - Return code: 0 04:19:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:19:29 ERROR - # TBPL SUCCESS # 04:19:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:29 INFO - 2017-03-10 04:19:29.362 screenresolution[2182:17490] starting screenresolution argv=screenresolution get 04:19:29 INFO - 2017-03-10 04:19:29.366 screenresolution[2182:17490] Display 0: 1600x1200x32@60 04:19:29 INFO - 2017-03-10 04:19:29.373 screenresolution[2183:17493] starting screenresolution argv=screenresolution list 04:19:29 INFO - Available Modes on Display 0 04:19:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:29 INFO - Intel Iris: 04:19:29 INFO - Chipset Model: Intel Iris 04:19:29 INFO - Type: GPU 04:19:29 INFO - Bus: Built-In 04:19:29 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:29 INFO - Vendor: Intel (0x8086) 04:19:29 INFO - Device ID: 0x0a2e 04:19:29 INFO - Revision ID: 0x0009 04:19:29 INFO - Displays: 04:19:29 INFO - Display: 04:19:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:29 INFO - Display Serial Number: 1600x1200 60 04:19:29 INFO - Main Display: Yes 04:19:29 INFO - Mirror: Off 04:19:29 INFO - Online: Yes 04:19:29 INFO - Rotation: Supported 04:19:29 INFO - Return code: 0 04:19:29 INFO - Running post-action listener: _resource_record_post_action 04:19:29 INFO - [mozharness: 2017-03-10 12:19:29.611278Z] Finished run-tests step (success) 04:19:29 INFO - Running post-run listener: _resource_record_post_run 04:19:29 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 610816; Write bytes: 516569088; Read time: 13; Write time: 1853 04:19:29 INFO - TinderboxPrint: CPU usage
54.6% 04:19:29 INFO - TinderboxPrint: I/O read bytes / time
610,816 / 13 04:19:29 INFO - TinderboxPrint: I/O write bytes / time
516,569,088 / 1,853 04:19:29 INFO - TinderboxPrint: CPU idle
2,180.6 (45.4%) 04:19:29 INFO - TinderboxPrint: CPU system
964.7 (20.1%) 04:19:29 INFO - TinderboxPrint: CPU user
1,660.5 (34.6%) 04:19:29 INFO - TinderboxPrint: Swap in / out
210,804,736 / 0 04:19:29 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203143680; Write bytes: 200908800; Read time: 15915; Write time: 431 04:19:29 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 610304; Write bytes: 305752064; Read time: 10; Write time: 1389 04:19:30 INFO - Running post-run listener: _upload_blobber_files 04:19:30 INFO - Blob upload gear active. 04:19:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:19:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:32 INFO - (blobuploader) - INFO - Done attempting. 04:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:34 INFO - (blobuploader) - INFO - Done attempting. 04:19:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:19:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:19:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:35 INFO - (blobuploader) - INFO - Done attempting. 04:19:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:19:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:39 INFO - (blobuploader) - INFO - Done attempting. 04:19:39 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:39 INFO - Return code: 0 04:19:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fb664e77eb571fe28c8eaaa1750ad52e8c394444fd521ccf240f43acd1202995d22e52d83a2e55661f69d70e733b56ffed2344c58f236de8fd1a59b1789ea74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127d97bb48d7831acb941ba51fbfed86f6867eeb068dbe9491e578960178d30064138b7e1effe0ad1bb65d2368393af11594738e5c52d3034e019e55d3d8ca8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e89a1cc57ef646d5f1e0ad790cca3618bc15621735294ddccbee8229b780f7d2772807f088a351ba5bd32e8f8b2313bfde6bdb65f5e4eeecddd81d98826904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ce3beec4c30ba78b302f3c8bd38af6e6b5db4d24a4fb52e95628fdbb8ac655f69e09266050207ffe1baf4a726c4b42734eaeed1ef046bafd438c02156df99d"} 04:19:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:39 INFO - Contents: 04:19:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fb664e77eb571fe28c8eaaa1750ad52e8c394444fd521ccf240f43acd1202995d22e52d83a2e55661f69d70e733b56ffed2344c58f236de8fd1a59b1789ea74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127d97bb48d7831acb941ba51fbfed86f6867eeb068dbe9491e578960178d30064138b7e1effe0ad1bb65d2368393af11594738e5c52d3034e019e55d3d8ca8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e89a1cc57ef646d5f1e0ad790cca3618bc15621735294ddccbee8229b780f7d2772807f088a351ba5bd32e8f8b2313bfde6bdb65f5e4eeecddd81d98826904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ce3beec4c30ba78b302f3c8bd38af6e6b5db4d24a4fb52e95628fdbb8ac655f69e09266050207ffe1baf4a726c4b42734eaeed1ef046bafd438c02156df99d"} 04:19:39 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:39 INFO - Copying logs to upload dir... 04:19:39 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.781711 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-10 04:19:39.855889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:39.858925) ========= 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.rc0RMsK93l/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.T1iIWkbpH2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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/0fb664e77eb571fe28c8eaaa1750ad52e8c394444fd521ccf240f43acd1202995d22e52d83a2e55661f69d70e733b56ffed2344c58f236de8fd1a59b1789ea74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127d97bb48d7831acb941ba51fbfed86f6867eeb068dbe9491e578960178d30064138b7e1effe0ad1bb65d2368393af11594738e5c52d3034e019e55d3d8ca8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e89a1cc57ef646d5f1e0ad790cca3618bc15621735294ddccbee8229b780f7d2772807f088a351ba5bd32e8f8b2313bfde6bdb65f5e4eeecddd81d98826904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ce3beec4c30ba78b302f3c8bd38af6e6b5db4d24a4fb52e95628fdbb8ac655f69e09266050207ffe1baf4a726c4b42734eaeed1ef046bafd438c02156df99d"} build_url:https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011559 build_url: 'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/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/0fb664e77eb571fe28c8eaaa1750ad52e8c394444fd521ccf240f43acd1202995d22e52d83a2e55661f69d70e733b56ffed2344c58f236de8fd1a59b1789ea74", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5127d97bb48d7831acb941ba51fbfed86f6867eeb068dbe9491e578960178d30064138b7e1effe0ad1bb65d2368393af11594738e5c52d3034e019e55d3d8ca8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/76e89a1cc57ef646d5f1e0ad790cca3618bc15621735294ddccbee8229b780f7d2772807f088a351ba5bd32e8f8b2313bfde6bdb65f5e4eeecddd81d98826904", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8ce3beec4c30ba78b302f3c8bd38af6e6b5db4d24a4fb52e95628fdbb8ac655f69e09266050207ffe1baf4a726c4b42734eaeed1ef046bafd438c02156df99d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:39.897582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:39.897900) ========= 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.rc0RMsK93l/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.T1iIWkbpH2/Listeners TMPDIR=/var/folders/b5/152b2m257t95w2vfwktssysw00000w/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.005340 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:39.946383) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:19:39.946705) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:19:39.947012) ========= ========= Total master_lag: 0.19 =========