builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0240 starttime: 1490064631.4 results: success (0) buildid: 20170320182028 builduid: 00c98cb126f346e5a8fc793668fa3153 revision: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.402476) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.402945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.403229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.429707) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.430080) ========= 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.gy6dxQFRqA/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.eiAS6otnMc/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-20 19:50:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-03-20 19:50:31 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137622 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.592100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.592455) ========= 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.gy6dxQFRqA/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.eiAS6otnMc/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.030578 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:31.694414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 19:50:31.694802) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 --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 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gy6dxQFRqA/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.eiAS6otnMc/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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-20 19:50:31,804 truncating revision to first 12 chars 2017-03-20 19:50:31,804 Setting DEBUG logging. 2017-03-20 19:50:31,804 attempt 1/10 2017-03-20 19:50:31,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fe5dcf1c10a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 19:50:33,094 unpacking tar archive at: mozilla-central-5fe5dcf1c10a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.569281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 19:50:33.288009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:33.288341) ========= script_repo_revision: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:33.288762) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:33.289038) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 19:50:33.306341) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-20 19:50:33.306744) ========= /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.gy6dxQFRqA/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.eiAS6otnMc/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:50:33 INFO - MultiFileLogger online at 20170320 19:50:33 in /builds/slave/test 19:50:33 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 19:50:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:50:33 INFO - {'append_to_log': False, 19:50:33 INFO - 'base_work_dir': '/builds/slave/test', 19:50:33 INFO - 'blob_upload_branch': 'Firefox', 19:50:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:50:33 INFO - 'branch': 'Firefox', 19:50:33 INFO - 'buildbot_json_path': 'buildprops.json', 19:50:33 INFO - 'config_files': ('talos/mac_config.py',), 19:50:33 INFO - 'default_actions': ('clobber', 19:50:33 INFO - 'read-buildbot-config', 19:50:33 INFO - 'download-and-extract', 19:50:33 INFO - 'populate-webroot', 19:50:33 INFO - 'create-virtualenv', 19:50:33 INFO - 'install', 19:50:33 INFO - 'run-tests'), 19:50:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:50:33 INFO - 'download_minidump_stackwalk': True, 19:50:33 INFO - 'download_symbols': 'ondemand', 19:50:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:50:33 INFO - 'tooltool.py': '/tools/tooltool.py', 19:50:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:50:33 INFO - '/tools/misc-python/virtualenv.py')}, 19:50:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:50:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:50:33 INFO - 'gecko_profile': False, 19:50:33 INFO - 'gecko_profile_interval': 0, 19:50:33 INFO - 'installer_path': 'installer.exe', 19:50:33 INFO - 'log_level': 'info', 19:50:33 INFO - 'log_name': 'talos', 19:50:33 INFO - 'log_to_console': True, 19:50:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:50:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:50:33 INFO - 'opt_config_files': (), 19:50:33 INFO - 'pip_index': False, 19:50:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:50:33 INFO - 'cmd': ('bash', 19:50:33 INFO - '-c', 19:50:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:50:33 INFO - 'enabled': True, 19:50:33 INFO - 'halt_on_failure': False, 19:50:33 INFO - 'name': 'check_screen_resolution'},), 19:50:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:50:33 INFO - 'cmd': ('bash', 19:50:33 INFO - '-c', 19:50:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:50:33 INFO - 'enabled': True, 19:50:33 INFO - 'halt_on_failure': False, 19:50:33 INFO - 'name': 'check_screen_resolution'},), 19:50:33 INFO - 'run_cmd_checks_enabled': True, 19:50:33 INFO - 'suite': 'dromaeojs-e10s', 19:50:33 INFO - 'system_bits': '32', 19:50:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:50:33 INFO - 'title': 't-yosemite-r7-0240', 19:50:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:50:33 INFO - 'use_talos_json': True, 19:50:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:50:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:50:33 INFO - 'work_dir': 'build'} 19:50:33 INFO - [mozharness: 2017-03-21 02:50:33.520079Z] Running clobber step. 19:50:33 INFO - Running pre-action listener: _resource_record_pre_action 19:50:33 INFO - Running main action method: clobber 19:50:33 INFO - rmtree: /builds/slave/test/build 19:50:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:50:35 INFO - Running post-action listener: _resource_record_post_action 19:50:35 INFO - [mozharness: 2017-03-21 02:50:35.930931Z] Finished clobber step (success) 19:50:35 INFO - [mozharness: 2017-03-21 02:50:35.931063Z] Running read-buildbot-config step. 19:50:35 INFO - Running pre-action listener: _resource_record_pre_action 19:50:35 INFO - Running main action method: read_buildbot_config 19:50:35 INFO - Using buildbot properties: 19:50:35 INFO - { 19:50:35 INFO - "project": "", 19:50:35 INFO - "product": "firefox", 19:50:35 INFO - "script_repo_revision": "production", 19:50:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:50:35 INFO - "repository": "", 19:50:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:50:35 INFO - "buildid": "20170320182028", 19:50:35 INFO - "pgo_build": "False", 19:50:35 INFO - "basedir": "/builds/slave/test", 19:50:35 INFO - "buildnumber": 179, 19:50:35 INFO - "slavename": "t-yosemite-r7-0240", 19:50:35 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 19:50:35 INFO - "platform": "yosemite_r7", 19:50:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:50:35 INFO - "branch": "mozilla-central", 19:50:35 INFO - "repo_path": "mozilla-central", 19:50:35 INFO - "revision": "5fe5dcf1c10a4523ba3f0a20295551462c2dae11", 19:50:35 INFO - "stage_platform": "macosx64", 19:50:35 INFO - "builduid": "00c98cb126f346e5a8fc793668fa3153", 19:50:35 INFO - "slavebuilddir": "test" 19:50:35 INFO - } 19:50:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 19:50:35 INFO - Running post-action listener: _resource_record_post_action 19:50:35 INFO - [mozharness: 2017-03-21 02:50:35.934336Z] Finished read-buildbot-config step (success) 19:50:35 INFO - [mozharness: 2017-03-21 02:50:35.934472Z] Running download-and-extract step. 19:50:35 INFO - Running pre-action listener: _resource_record_pre_action 19:50:35 INFO - Running main action method: download_and_extract 19:50:35 INFO - mkdir: /builds/slave/test/build/tests 19:50:35 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')]} 19:50:35 INFO - trying https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 19:50:35 INFO - Downloading https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/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 19:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/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 19:50:36 INFO - Downloaded 1325 bytes. 19:50:36 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 19:50:36 INFO - Using the following test package requirements: 19:50:36 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 19:50:36 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:50:36 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 19:50:36 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 19:50:36 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'jsshell-mac.zip'], 19:50:36 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 19:50:36 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 19:50:36 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 19:50:36 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 19:50:36 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 19:50:36 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 19:50:36 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 19:50:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:50:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:50:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:50:36 INFO - Fetch https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:50:38 INFO - Expected file size: 52477902 19:50:38 INFO - Obtained file size: 52477902 19:50:54 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 19:50:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 19:50:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:50:54 INFO - Fetch https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 19:50:56 INFO - Expected file size: 52477902 19:50:56 INFO - Obtained file size: 52477902 19:51:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 19:51:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:51:12 INFO - Fetch https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 19:51:13 INFO - Expected file size: 14404171 19:51:13 INFO - Obtained file size: 14404171 19:51:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:14 INFO - trying https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:51:14 INFO - Downloading https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 19:51:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/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 19:51:16 INFO - Downloaded 75230329 bytes. 19:51:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:51:16 INFO - mkdir: /builds/slave/test/properties 19:51:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:51:16 INFO - Writing to file /builds/slave/test/properties/build_url 19:51:16 INFO - Contents: 19:51:16 INFO - build_url:https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 19:51:17 INFO - Running post-action listener: _resource_record_post_action 19:51:17 INFO - Running post-action listener: set_extra_try_arguments 19:51:17 INFO - [mozharness: 2017-03-21 02:51:17.116858Z] Finished download-and-extract step (success) 19:51:17 INFO - [mozharness: 2017-03-21 02:51:17.117010Z] Running populate-webroot step. 19:51:17 INFO - Running pre-action listener: _resource_record_pre_action 19:51:17 INFO - Running main action method: populate_webroot 19:51:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:51:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:51:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:51:17 INFO - '--tppagecycles', 19:51:17 INFO - '7'], 19:51:17 INFO - 'tests': ['tsvgm']}}, 19:51:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:51:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:51:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:51:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:51:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:51:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['damp', 'tps']}, 19:51:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'tests': ['damp', 'tps']}, 19:51:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['dromaeo_dom']}, 19:51:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:51:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['basic_compositor_video']}, 19:51:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:51:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['a11yr', 19:51:17 INFO - 'ts_paint', 19:51:17 INFO - 'tpaint', 19:51:17 INFO - 'sessionrestore', 19:51:17 INFO - 'sessionrestore_no_auto_restore', 19:51:17 INFO - 'tabpaint']}, 19:51:17 INFO - 'other-e10s': {'tests': ['a11yr', 19:51:17 INFO - 'ts_paint', 19:51:17 INFO - 'tpaint', 19:51:17 INFO - 'sessionrestore', 19:51:17 INFO - 'sessionrestore_no_auto_restore', 19:51:17 INFO - 'tabpaint']}, 19:51:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:51:17 INFO - 'ts_paint', 19:51:17 INFO - 'tpaint', 19:51:17 INFO - 'sessionrestore', 19:51:17 INFO - 'sessionrestore_no_auto_restore', 19:51:17 INFO - 'tabpaint']}, 19:51:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:51:17 INFO - 'ts_paint', 19:51:17 INFO - 'tpaint', 19:51:17 INFO - 'sessionrestore', 19:51:17 INFO - 'sessionrestore_no_auto_restore', 19:51:17 INFO - 'tabpaint']}, 19:51:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['a11yr', 19:51:17 INFO - 'ts_paint', 19:51:17 INFO - 'tpaint', 19:51:17 INFO - 'sessionrestore', 19:51:17 INFO - 'sessionrestore_no_auto_restore', 19:51:17 INFO - 'tabpaint']}, 19:51:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['a11yr', 19:51:17 INFO - 'ts_paint', 19:51:17 INFO - 'tpaint', 19:51:17 INFO - 'sessionrestore', 19:51:17 INFO - 'sessionrestore_no_auto_restore', 19:51:17 INFO - 'tabpaint']}, 19:51:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['tsvgx', 19:51:17 INFO - 'tsvgr_opacity', 19:51:17 INFO - 'tart', 19:51:17 INFO - 'tscrollx', 19:51:17 INFO - 'cart', 19:51:17 INFO - 'tsvg_static']}, 19:51:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:51:17 INFO - 'tsvgr_opacity', 19:51:17 INFO - 'tart', 19:51:17 INFO - 'tscrollx', 19:51:17 INFO - 'cart', 19:51:17 INFO - 'tsvg_static']}, 19:51:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'talos_options': ['--disable-e10s'], 19:51:17 INFO - 'tests': ['tp5o']}, 19:51:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:51:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'talos_options': ['--disable-e10s', 19:51:17 INFO - '--xperf_path', 19:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:17 INFO - 'tests': ['tp5n']}, 19:51:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:51:17 INFO - 'talos_options': ['--xperf_path', 19:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:51:17 INFO - 'tests': ['tp5n']}}, 19:51:17 INFO - 'talos.zip': {'path': '', 19:51:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:51:17 INFO - Running post-action listener: _resource_record_post_action 19:51:17 INFO - [mozharness: 2017-03-21 02:51:17.135053Z] Finished populate-webroot step (success) 19:51:17 INFO - [mozharness: 2017-03-21 02:51:17.135189Z] Running create-virtualenv step. 19:51:17 INFO - Running pre-action listener: _resource_record_pre_action 19:51:17 INFO - Running main action method: create_virtualenv 19:51:17 INFO - Creating virtualenv /builds/slave/test/build/venv 19:51:17 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 19:51:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:51:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:51:17 INFO - Using real prefix '/tools/python27' 19:51:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:51:17 INFO - Installing distribute.............................................................................................................................................................................................done. 19:51:20 INFO - Installing pip.................done. 19:51:20 INFO - Return code: 0 19:51:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:51:21 INFO - Reading from file tmpfile_stdout 19:51:21 INFO - Output received: 19:51:21 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) 19:51:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:21 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:21 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 19:51:21 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 19:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:21 INFO - 'HOME': '/Users/cltbld', 19:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:21 INFO - 'LOGNAME': 'cltbld', 19:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:21 INFO - 'MOZ_NO_REMOTE': '1', 19:51:21 INFO - 'NO_EM_RESTART': '1', 19:51:21 INFO - 'PAGER': '/bin/cat', 19:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:21 INFO - 'PWD': '/builds/slave/test', 19:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:21 INFO - 'SHELL': '/bin/bash', 19:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:21 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:21 INFO - 'USER': 'cltbld', 19:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:21 INFO - 'XPC_FLAGS': '0x0', 19:51:21 INFO - 'XPC_SERVICE_NAME': '0', 19:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:21 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 19:51:21 INFO - Cleaning up... 19:51:21 INFO - Return code: 0 19:51:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:21 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:21 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 19:51:21 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 19:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:21 INFO - 'HOME': '/Users/cltbld', 19:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:21 INFO - 'LOGNAME': 'cltbld', 19:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:21 INFO - 'MOZ_NO_REMOTE': '1', 19:51:21 INFO - 'NO_EM_RESTART': '1', 19:51:21 INFO - 'PAGER': '/bin/cat', 19:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:21 INFO - 'PWD': '/builds/slave/test', 19:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:21 INFO - 'SHELL': '/bin/bash', 19:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:21 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:21 INFO - 'USER': 'cltbld', 19:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:21 INFO - 'XPC_FLAGS': '0x0', 19:51:21 INFO - 'XPC_SERVICE_NAME': '0', 19:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:21 INFO - Downloading/unpacking psutil>=3.1.1 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:25 INFO - Installing collected packages: psutil 19:51:25 INFO - Running setup.py install for psutil 19:51:25 INFO - building 'psutil._psutil_osx' extension 19:51:25 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 19:51:25 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 19:51:25 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 19:51:25 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 19:51:26 INFO - building 'psutil._psutil_posix' extension 19:51:26 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 19:51:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:51:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:51:26 INFO - ^ 19:51:26 INFO - 1 warning generated. 19:51:26 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 19:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:51:26 INFO - Successfully installed psutil 19:51:26 INFO - Cleaning up... 19:51:26 INFO - Return code: 0 19:51:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:51: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')]} 19:51:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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')]} 19:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:51: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 mozsystemmonitor==0.3 19:51:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:27 INFO - 'HOME': '/Users/cltbld', 19:51:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:27 INFO - 'LOGNAME': 'cltbld', 19:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:27 INFO - 'MOZ_NO_REMOTE': '1', 19:51:27 INFO - 'NO_EM_RESTART': '1', 19:51:27 INFO - 'PAGER': '/bin/cat', 19:51:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:27 INFO - 'PWD': '/builds/slave/test', 19:51:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:27 INFO - 'SHELL': '/bin/bash', 19:51:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:27 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:27 INFO - 'USER': 'cltbld', 19:51:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:27 INFO - 'XPC_FLAGS': '0x0', 19:51:27 INFO - 'XPC_SERVICE_NAME': '0', 19:51:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:51:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:51:30 INFO - Installing collected packages: mozsystemmonitor 19:51:30 INFO - Running setup.py install for mozsystemmonitor 19:51:30 INFO - Successfully installed mozsystemmonitor 19:51:30 INFO - Cleaning up... 19:51:31 INFO - Return code: 0 19:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:51:31 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')]} 19:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:31 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')]} 19:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:31 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:31 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 19:51:31 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 19:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:31 INFO - 'HOME': '/Users/cltbld', 19:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:31 INFO - 'LOGNAME': 'cltbld', 19:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:31 INFO - 'MOZ_NO_REMOTE': '1', 19:51:31 INFO - 'NO_EM_RESTART': '1', 19:51:31 INFO - 'PAGER': '/bin/cat', 19:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:31 INFO - 'PWD': '/builds/slave/test', 19:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:31 INFO - 'SHELL': '/bin/bash', 19:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:31 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:31 INFO - 'USER': 'cltbld', 19:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:31 INFO - 'XPC_FLAGS': '0x0', 19:51:31 INFO - 'XPC_SERVICE_NAME': '0', 19:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:31 INFO - Downloading/unpacking jsonschema==2.5.1 19:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:51:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:51:33 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 19:51:33 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 19:51:33 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 19:51:33 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 19:51:33 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 19:51:33 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 19:51:34 INFO - Downloading functools32-3.2.3-2.tar.gz 19:51:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:51:34 INFO - warning: no files found matching '*.txt' 19:51:34 INFO - no previously-included directories found matching 'build' 19:51:34 INFO - no previously-included directories found matching 'dist' 19:51:34 INFO - no previously-included directories found matching '.git*' 19:51:34 INFO - Installing collected packages: jsonschema, functools32 19:51:34 INFO - Running setup.py install for functools32 19:51:34 INFO - warning: no files found matching '*.txt' 19:51:34 INFO - no previously-included directories found matching 'build' 19:51:34 INFO - no previously-included directories found matching 'dist' 19:51:34 INFO - no previously-included directories found matching '.git*' 19:51:34 INFO - Successfully installed jsonschema functools32 19:51:34 INFO - Cleaning up... 19:51:34 INFO - Return code: 0 19:51:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:34 INFO - 'HOME': '/Users/cltbld', 19:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:34 INFO - 'LOGNAME': 'cltbld', 19:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:34 INFO - 'MOZ_NO_REMOTE': '1', 19:51:34 INFO - 'NO_EM_RESTART': '1', 19:51:34 INFO - 'PAGER': '/bin/cat', 19:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:34 INFO - 'PWD': '/builds/slave/test', 19:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:34 INFO - 'SHELL': '/bin/bash', 19:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:34 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:34 INFO - 'USER': 'cltbld', 19:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:34 INFO - 'XPC_FLAGS': '0x0', 19:51:34 INFO - 'XPC_SERVICE_NAME': '0', 19:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:51:35 INFO - Cleaning up... 19:51:35 INFO - Return code: 0 19:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:51:35 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')]} 19:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:35 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')]} 19:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:35 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:35 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 19:51:35 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 19:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:35 INFO - 'HOME': '/Users/cltbld', 19:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:35 INFO - 'LOGNAME': 'cltbld', 19:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:35 INFO - 'MOZ_NO_REMOTE': '1', 19:51:35 INFO - 'NO_EM_RESTART': '1', 19:51:35 INFO - 'PAGER': '/bin/cat', 19:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:35 INFO - 'PWD': '/builds/slave/test', 19:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:35 INFO - 'SHELL': '/bin/bash', 19:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:35 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:35 INFO - 'USER': 'cltbld', 19:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:35 INFO - 'XPC_FLAGS': '0x0', 19:51:35 INFO - 'XPC_SERVICE_NAME': '0', 19:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 19:51:35 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 19:51:35 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 19:51:35 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 19:51:35 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 19:51:35 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 19:51:35 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 19:51:37 INFO - Downloading blobuploader-1.2.4.tar.gz 19:51:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:51:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:51:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:51:39 INFO - Downloading docopt-0.6.1.tar.gz 19:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 19:51:39 INFO - Running setup.py install for blobuploader 19:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:51:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:51:39 INFO - Running setup.py install for requests 19:51:39 INFO - Running setup.py install for docopt 19:51:39 INFO - Successfully installed blobuploader requests docopt 19:51:39 INFO - Cleaning up... 19:51:40 INFO - Return code: 0 19:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:40 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:40 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 19:51:40 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 19:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:40 INFO - 'HOME': '/Users/cltbld', 19:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:40 INFO - 'LOGNAME': 'cltbld', 19:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:40 INFO - 'MOZ_NO_REMOTE': '1', 19:51:40 INFO - 'NO_EM_RESTART': '1', 19:51:40 INFO - 'PAGER': '/bin/cat', 19:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:40 INFO - 'PWD': '/builds/slave/test', 19:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:40 INFO - 'SHELL': '/bin/bash', 19:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:40 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:40 INFO - 'USER': 'cltbld', 19:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:40 INFO - 'XPC_FLAGS': '0x0', 19:51:40 INFO - 'XPC_SERVICE_NAME': '0', 19:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-XP1GmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-7wJfli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-1ToutZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-PQbcBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-CCfhAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-pVHJgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:40 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-_1oURl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-kbgu3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-5oOgp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-iVmMsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-gsnuTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-QDHqPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Km5BZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4KcsuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ewRZRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-k7NFC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:41 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-34a4dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:51:42 INFO - Running setup.py install for manifestparser 19:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:51:42 INFO - Running setup.py install for mozcrash 19:51:42 INFO - Running setup.py install for mozdebug 19:51:42 INFO - Running setup.py install for mozdevice 19:51:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:51:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:51:42 INFO - Running setup.py install for mozfile 19:51:42 INFO - Running setup.py install for mozhttpd 19:51:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:51:42 INFO - Running setup.py install for mozinfo 19:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Running setup.py install for mozInstall 19:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Running setup.py install for mozleak 19:51:43 INFO - Running setup.py install for mozlog 19:51:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Running setup.py install for moznetwork 19:51:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:51:43 INFO - Running setup.py install for mozprocess 19:51:43 INFO - Running setup.py install for mozprofile 19:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:51:44 INFO - Running setup.py install for mozrunner 19:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:51:44 INFO - Running setup.py install for mozscreenshot 19:51:44 INFO - Running setup.py install for moztest 19:51:44 INFO - Running setup.py install for mozversion 19:51:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:51:44 INFO - Cleaning up... 19:51:44 INFO - Return code: 0 19:51:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:44 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')]} 19:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:44 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')]} 19:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:44 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:44 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 19:51:44 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 19:51:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:44 INFO - 'HOME': '/Users/cltbld', 19:51:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:44 INFO - 'LOGNAME': 'cltbld', 19:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:44 INFO - 'MOZ_NO_REMOTE': '1', 19:51:44 INFO - 'NO_EM_RESTART': '1', 19:51:44 INFO - 'PAGER': '/bin/cat', 19:51:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:44 INFO - 'PWD': '/builds/slave/test', 19:51:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:44 INFO - 'SHELL': '/bin/bash', 19:51:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:44 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:44 INFO - 'USER': 'cltbld', 19:51:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:44 INFO - 'XPC_FLAGS': '0x0', 19:51:44 INFO - 'XPC_SERVICE_NAME': '0', 19:51:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:51:44 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-jYFgyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-KHsN88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-mBoqfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ZU7XMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-TWx2LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-9uwNYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ZqBGuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-9gW2ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-EWV2El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-A7ezTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:51:45 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)) 19:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:51:45 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-tmMdzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:51:46 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-0IsiL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:51:46 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-sKv_Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:51:46 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-VW41u4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:46 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ZLaQNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:51:46 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-cqZ0Rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:51:46 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)) 19:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:51:46 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-W3mpRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:51:46 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)) 19:51:46 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)) 19:51:46 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)) 19:51:46 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)) 19:51:46 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)) 19:51:46 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)) 19:51:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:51:46 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 19:51:46 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 19:51:46 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 19:51:46 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 19:51:46 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 19:51:46 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 19:51:49 INFO - Downloading blessings-1.6.tar.gz 19:51:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:51:49 INFO - Installing collected packages: blessings 19:51:49 INFO - Running setup.py install for blessings 19:51:49 INFO - Successfully installed blessings 19:51:49 INFO - Cleaning up... 19:51:49 INFO - Return code: 0 19:51:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:51:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:50 INFO - Reading from file tmpfile_stdout 19:51:50 INFO - Current package versions: 19:51:50 INFO - blessings == 1.6 19:51:50 INFO - blobuploader == 1.2.4 19:51:50 INFO - docopt == 0.6.1 19:51:50 INFO - functools32 == 3.2.3-2 19:51:50 INFO - jsonschema == 2.5.1 19:51:50 INFO - manifestparser == 1.1 19:51:50 INFO - mozInstall == 1.12 19:51:50 INFO - mozcrash == 1.0 19:51:50 INFO - mozdebug == 0.1 19:51:50 INFO - mozdevice == 0.49 19:51:50 INFO - mozfile == 1.2 19:51:50 INFO - mozhttpd == 0.7 19:51:50 INFO - mozinfo == 0.9 19:51:50 INFO - mozleak == 0.1 19:51:50 INFO - mozlog == 3.4 19:51:50 INFO - moznetwork == 0.27 19:51:50 INFO - mozprocess == 0.25 19:51:50 INFO - mozprofile == 0.28 19:51:50 INFO - mozrunner == 6.13 19:51:50 INFO - mozscreenshot == 0.1 19:51:50 INFO - mozsystemmonitor == 0.3 19:51:50 INFO - moztest == 0.8 19:51:50 INFO - mozversion == 1.4 19:51:50 INFO - psutil == 3.1.1 19:51:50 INFO - requests == 1.2.3 19:51:50 INFO - wsgiref == 0.1.2 19:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:51:50 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')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:50 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 19:51:50 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 19:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:50 INFO - 'HOME': '/Users/cltbld', 19:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PAGER': '/bin/cat', 19:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test', 19:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:50 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - 'XPC_FLAGS': '0x0', 19:51:50 INFO - 'XPC_SERVICE_NAME': '0', 19:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 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)) 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:51:50 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')]} 19:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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')]} 19:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:51:50 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 0x106d49b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d4c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb49357a700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, '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.gy6dxQFRqA/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.eiAS6otnMc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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 19:51:50 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 19:51:50 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 19:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:51:50 INFO - 'HOME': '/Users/cltbld', 19:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:51:50 INFO - 'LOGNAME': 'cltbld', 19:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:51:50 INFO - 'MOZ_NO_REMOTE': '1', 19:51:50 INFO - 'NO_EM_RESTART': '1', 19:51:50 INFO - 'PAGER': '/bin/cat', 19:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:51:50 INFO - 'PWD': '/builds/slave/test', 19:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:51:50 INFO - 'SHELL': '/bin/bash', 19:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:51:50 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:51:50 INFO - 'USER': 'cltbld', 19:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:51:50 INFO - 'XPC_FLAGS': '0x0', 19:51:50 INFO - 'XPC_SERVICE_NAME': '0', 19:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:51:50 INFO - Cleaning up... 19:51:50 INFO - Return code: 0 19:51:50 INFO - Running post-action listener: _resource_record_post_action 19:51:50 INFO - Running post-action listener: _start_resource_monitoring 19:51:50 INFO - Starting resource monitoring. 19:51:50 INFO - [mozharness: 2017-03-21 02:51:50.589856Z] Finished create-virtualenv step (success) 19:51:50 INFO - [mozharness: 2017-03-21 02:51:50.590832Z] Running install step. 19:51:50 INFO - Running pre-action listener: _resource_record_pre_action 19:51:50 INFO - Running main action method: install 19:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:51:50 INFO - Reading from file tmpfile_stdout 19:51:50 INFO - Detecting whether we're running mozinstall >=1.0... 19:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:51:50 INFO - Reading from file tmpfile_stdout 19:51:50 INFO - Output received: 19:51:50 INFO - Usage: mozinstall [options] installer 19:51:50 INFO - Options: 19:51:50 INFO - -h, --help show this help message and exit 19:51:50 INFO - -d DEST, --destination=DEST 19:51:50 INFO - Directory to install application into. [default: 19:51:50 INFO - "/builds/slave/test"] 19:51:50 INFO - --app=APP Application being installed. [default: firefox] 19:51:50 INFO - mkdir: /builds/slave/test/build/application 19:51:50 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'] 19:51:50 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 19:52:11 INFO - Reading from file tmpfile_stdout 19:52:11 INFO - Output received: 19:52:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:52:11 INFO - Running post-action listener: _resource_record_post_action 19:52:11 INFO - [mozharness: 2017-03-21 02:52:11.656236Z] Finished install step (success) 19:52:11 INFO - [mozharness: 2017-03-21 02:52:11.656398Z] Running run-tests step. 19:52:11 INFO - Running pre-action listener: _resource_record_pre_action 19:52:11 INFO - Running main action method: run_tests 19:52:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:52:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:52:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:52:11 INFO - 2017-03-20 19:52:11.670 screenresolution[1626:7296] starting screenresolution argv=screenresolution get 19:52:11 INFO - 2017-03-20 19:52:11.673 screenresolution[1626:7296] Display 0: 1600x1200x32@60 19:52:11 INFO - 2017-03-20 19:52:11.679 screenresolution[1627:7298] starting screenresolution argv=screenresolution list 19:52:11 INFO - Available Modes on Display 0 19:52:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:52:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:52:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:52:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:52:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:52:11 INFO - Intel Iris: 19:52:11 INFO - Chipset Model: Intel Iris 19:52:11 INFO - Type: GPU 19:52:11 INFO - Bus: Built-In 19:52:11 INFO - VRAM (Dynamic, Max): 1536 MB 19:52:11 INFO - Vendor: Intel (0x8086) 19:52:11 INFO - Device ID: 0x0a2e 19:52:11 INFO - Revision ID: 0x0009 19:52:11 INFO - Displays: 19:52:11 INFO - Display: 19:52:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:52:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:52:11 INFO - Display Serial Number: 1600x1200 60 19:52:11 INFO - Main Display: Yes 19:52:11 INFO - Mirror: Off 19:52:11 INFO - Online: Yes 19:52:11 INFO - Rotation: Supported 19:52:11 INFO - Return code: 0 19:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:52:11 INFO - Python 2.7.3 19:52:11 INFO - Return code: 0 19:52:11 INFO - grabbing minidump binary from tooltool 19:52: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')]} 19:52:11 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 0x106b27d30>, '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 0x106a4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106b1cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:52:11 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 19:52:11 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 19:52:11 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 19:52:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:52:12 INFO - Return code: 0 19:52:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:52:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:52:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:52:12 INFO - ENV: RUST_BACKTRACE is now 1 19:52:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:52:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:52:12 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/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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 19:52:12 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/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0240 --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 19:52:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gy6dxQFRqA/Render', 19:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:52:12 INFO - 'HOME': '/Users/cltbld', 19:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:52:12 INFO - 'LOGNAME': 'cltbld', 19:52:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:52:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:52:12 INFO - 'MOZ_NO_REMOTE': '1', 19:52:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:52:12 INFO - 'NO_EM_RESTART': '1', 19:52:12 INFO - 'PAGER': '/bin/cat', 19:52:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:52:12 INFO - 'PWD': '/builds/slave/test', 19:52:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:52:12 INFO - 'RUST_BACKTRACE': '1', 19:52:12 INFO - 'SHELL': '/bin/bash', 19:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eiAS6otnMc/Listeners', 19:52:12 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 19:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:52:12 INFO - 'USER': 'cltbld', 19:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:52:12 INFO - 'XPC_FLAGS': '0x0', 19:52:12 INFO - 'XPC_SERVICE_NAME': '0', 19:52:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:52:12 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/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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 19:52:12 INFO - mozversion application_buildid: 20170320182028 19:52:12 INFO - mozversion application_changeset: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 19:52:12 INFO - mozversion application_display_name: Nightly 19:52:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:52:12 INFO - mozversion application_name: Firefox 19:52:12 INFO - mozversion application_remotingname: firefox 19:52:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:52:12 INFO - mozversion application_vendor: Mozilla 19:52:12 INFO - mozversion application_version: 55.0a1 19:52:12 INFO - mozversion platform_buildid: 20170320182028 19:52:12 INFO - mozversion platform_changeset: 5fe5dcf1c10a4523ba3f0a20295551462c2dae11 19:52:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:52:12 INFO - mozversion platform_version: 55.0a1 19:52:12 INFO - using testdate: 1490064732 19:52:12 INFO - actual date: 1490064732 19:52:12 INFO - starting webserver on 'localhost:49242' 19:52:12 INFO - SUITE-START | Running 2 tests 19:52:12 INFO - TEST-START | dromaeo_css 19:52:12 INFO - operating with platform_type : mac_ 19:52:12 INFO - Initialising browser for dromaeo_css test... 19:52:12 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpi4dAwW/profile http://localhost:49242/getInfo.html) 19:52:15 INFO - PID 1637 | 2017-03-20 19:52:15.249 plugin-container[1639:7471] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 19:52:15 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:52:15 INFO - PID 1637 | 2017-03-20 19:52:15.253 plugin-container[1639:7471] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9317, name = 'com.apple.CFPasteboardClient' 19:52:15 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:52:15 INFO - PID 1637 | 2017-03-20 19:52:15.253 plugin-container[1639:7471] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:52:15 INFO - PID 1637 | __metrics Screen width/height:1600/1200 19:52:15 INFO - PID 1637 | colorDepth:24 19:52:15 INFO - PID 1637 | Browser inner width/height: 1024/689 19:52:15 INFO - PID 1637 | __metrics 19:52:15 ERROR - PID 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 19:52:16 INFO - TEST-INFO | 1637: exit 0 19:52:16 INFO - Browser initialized. 19:52:16 INFO - Running cycle 1/1 for dromaeo_css test... 19:52:16 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpi4dAwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:18 INFO - PID 1640 | 2017-03-20 19:52:18.732 plugin-container[1641:7604] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 19:52:18 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:52:18 INFO - PID 1640 | 2017-03-20 19:52:18.733 plugin-container[1641:7604] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 19:52:18 INFO - PID 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:52:18 INFO - PID 1640 | 2017-03-20 19:52:18.733 plugin-container[1641:7604] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:52:28 INFO - PID 1640 | RSS: Main: 227516416 19:52:28 INFO - PID 1640 | 19:55:32 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 19:55:34 INFO - PID 1640 | RSS: Main: 250757120 19:55:34 INFO - PID 1640 | 19:57:16 INFO - PID 1640 | ************************* 19:57:16 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 19:57:16 INFO - PID 1640 | 19:57:16 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:57:16 INFO - PID 1640 | Full stack: 19:57:16 INFO - PID 1640 | ************************* 19:58:36 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 19:58:37 INFO - PID 1640 | RSS: Main: 260030464 19:58:37 INFO - PID 1640 | 20:01:39 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 20:01:39 INFO - PID 1640 | RSS: Main: 271536128 20:01:39 INFO - PID 1640 | 20:04:41 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 20:04:42 INFO - PID 1640 | RSS: Main: 263520256 20:04:42 INFO - PID 1640 | 20:07:45 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 20:07:45 INFO - PID 1640 | RSS: Main: 273825792 20:07:45 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 20:10:49 INFO - PID 1640 | RSS: Main: 268460032 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | __start_tp_report 20:10:49 INFO - PID 1640 | _x_x_mozilla_page_load 20:10:49 INFO - PID 1640 | _x_x_mozilla_page_load_details 20:10:49 INFO - PID 1640 | |i|pagename|runs| 20:10:49 INFO - PID 1640 | |0;dojo.html;3506.5266189064473;3507.5615548056494;3542.911427214318;3548.042028652264;3587.3184095021943;4855.660103792736;6011.128386383972;6021.638701677897;6147.8770424591485;6165.260168779752;6069.969650151743;6105.43571699886;6123.173371594833;6139.171211886394;6141.608749743932;5476.4249753775875;5518.613697041199;5571.331440227178;5584.134459158837;5650.51970582501;5494.230807686927;5649.350324712669;5653.123765816305;5662.773489060432;5671.092625179972;5143.794248230066;5545.417731138233;5629.211910332536;5670.461306175906;5671.347795003566;5391.919121213185;5436.700981446019;5456.809011684572;5550.111982082847;5550.72246387679;5389.568834493231;5399.352077750656;5459.3994660587305;5466.043442397565;5478.178273259004;4475.48531918827;5251.711155886463;6068.271807383142;6129.509639228895;6151.077338399231;6525.4779617630475;6531.412172904414;6534.281229064799;6535.052417399498;6544.345565443417;6387.489000879918;6455.419012288869;6574.967125164391;6642.903920853053;6651.966740166316;6135.293912123373;6167.506599472032;6173.783917562864;6191.19514463117;6193.59741616798;6692.196936367667;6819.113515242987;6835.897461538081;6837.863242735118;6858.245592984767;6241.812745617639;6292;6392.808215753535;6443.0335449682925;6470.611763294123;6617.867642647217;6639.236487803964;6655.933440665532;6686.5653732507235;6687.130673012477;6445.1621289233035;6521.836954076186;6530.706118224596;6533.575317604341;6543.051257567626;5707.885842283131;6326.6520341381665;6389.904151437732;6417.6149431033355;6559.048937903977;5305.946940530545;5313.707746074003;5320.068987927098;5329.973350133225;5362.839114826562;4704.694194877322;4712.081144176853;4713.528647135327;4725.220338644154;4752.95247047532;6132.816015519542;6220.813375598739;6226.034964580497;6232.563720539519;6268.937310626835;5648.5481161507805;6560.081588577603;6586.176727909012;6619.106420633249;6622.2715501294815;6223.751049958041;6234.345393733593;6242.812715618448;6266.655333956676;6278.780242691484;5760.510356619734;5902.4097590240635;5919.260092488439;5923.703814809242;5930.584859059824;6730.764423245163;6888.862222755617;6909.136357955255;6946.722131114901;6973.407260382722;6625.900611490928;6679.499037572299;6690.866182676416;6702.597844129368;6706.631135287606;6208.130861679459;6546.967265163644;6713.697883595348;6802.489813263926;6959.304069593203;5924.874273887947;6289.40250676185;6424.164858568543;6448.677566121769;6488.318726533646;5268.947310526845;6486.805395838132;6570.47436205112;6573.04690819838;6593.538452308292;6175.289841668266;6216.44052035319;6383.96808015957;6387.936120638734;6398.584092034189;6371.936280637135;6438.098666186644;6449.935500644933;6451.4516266116025;6463.612183269019;5415.945840541544;6191.411815877665;6255.906161407674;6361.109444677656;6365.745370185141;6139.798803208702;6407.679616019087;6472.449841763503;6479.254885688206;6480.384363485461;6132.20254427538;6223.564350495421;6260.342664020394;6281.528885333527;6284.214473190851 20:10:49 INFO - PID 1640 | |1;ext.html;708.1183926012116;785.83104632504;798.1858504325592;799.9720009799654;805.37583372886;36685.63314366856;37502.62497375025;37508.812455937754;37526.81236593813;37543;37177.88466346007;39011.41482877759;39443;39449.40825887614;39473;2706.499297629935;2771.9584206236923;2823.9717602824016;2910.9126726198247;2919.226405002676;2869;2872.095289983659;2908.7527560157305;2909.810862293944;2915.562665600156;2910.3306239564913;2914.8979785707506;2925.634295713036;2934.237098354422;2940.7206315400003;2908.2729317670583;2911.228524441014;2915.271182204449;2929.6630887448005;2930.3846192299643;2904.7385735283924;2921.5033444314518;2923.8245705257755;2929.4580502606873;2937.221636266391;38276.234475310615;38401.61598384036;38467.42298865519;38476.845694629206;38600;3008.8946886859076;3015.62304711911;3045.8020228685064;3051.52701331294;3066.8006579572257;28037;28365.716342836513;28463.146105616866;28658.283542911595;28859.27851803701;2796.7902407319534;2821.1677555121287;2821.3087793490727;2825.1383328084926;2867.956980645292;233514;234695;261624.9999999981;332314;335481.64518354746;46831.53168468272;46967.530324697;47011.29483057757;47144;49456.50543494591;51220.74389628028;51262.743686282076;51271;51310.48689513132;51328.97342053138;14575.344109515097;14651.560453186421;14654.194019328826;14661.413543458142;14687.192204428859;12007.339596322287;12044.337561434206;12065.758684826254;12082.939585302018;12098.274103553815;11964.222325548812;13900.721985560434;13909.956753243345;14033.71932561343;14210.644733881736;5065.746712664352;5273.209018647233;5844.240248767633;5900.911486327708;5982.252218472691;962.8363178259573;969.3941286695815;976.3507267667064;977.4721650308895;1019.3832731197518;24380.634290485657;24496.652684102188;24644;24653;24781.380465488146;1016.2936758952457;1051.8061999630474;1081.6268387406333;1124.1568823382463;1131.9717007074723;12067.931468783132;12465.439055242354;12544.24734515932;12583.182093163916;12667.493300267886;471534;472588;473674;475344;475716;56330;56439;56798.86402271932;56891.14663280054;56896.715516422155;1441.3297816515371;1451.6516036151036;1489.8882583806042;1495.8130233720785;1498.677784276364;24078.87960560256;29104.854475727487;29160;29602.815887365126;29687.703122968494;54895.72552137214;55280.44719552753;55321;55435.89128217494;55492.05777797758;433918;438274;439668;441220.7938960285;441631;35865.82067089648;36375.81812090923;36445.54217831257;36482.27035459223;36570.8171459141;44953.55046449624;45888.54111458976;46031.30953035774;46189.76905115453;46255.53744462647;34353;34534.48198277078;36742;37570.624293756715;37850.810745946095;36543.269134616625;36817.63182368142;37540.436893447164;37803.62196378111;37950.430743538316;35499.46750798688;36408.63591364052;36586;36854.07864803401;37493.625063749016;28397.574036389058;31485.367090621137;31588.842055790494;31655.683443165275;31803.20491987719;22680.546389072457;22833;24251.514969700154;24314.756852431958;25088.49823003566 20:10:49 INFO - PID 1640 | |2;jquery.html;409.56790585931867;419.897125204325;426.90262739162483;427.7625917615723;441.9845305414311;20211;20525.692114618276;20665;20994.26520071798;21009.789902100994;21494.205753252096;21926.013329400175;22006.44983875404;22812.88593557034;22852.31443056711;4516.796744146505;4688.695234809744;4694.788734506938;4695.178343789823;4697.459792123898;4373.912521749579;4428.822847086113;4460.97769511152;4625.306204069383;4651.651126165551;4654.441467023945;4685.344051832746;4703.811847526112;4714.717116972975;4719.985203181315;4538.319252112176;4620.029793743284;4665.2768820832825;4690.648201384893;4708.882277943045;4229.915401691949;4543.772811359452;4653.255479123324;4678.883027924295;4690.296455531663;28978.42043159146;28999.42001159986;29421.55867661987;29714.40571188586;29853.95511157099;1992.103553400961;2034.7558293004786;2037.6434124028235;2070.4346915052424;2102.1696429910253;16845.747313790303;17477.475675729747;17650.558736031573;17812.198451069602;18918;1419.2548911821273;1595.2900959073218;1739.5303268117664;1759.445774581003;1763.8941663500232;149805;161039;167742;171493.99999999875;173676;20125;24594.877025615115;25001.37496562564;25075.498490030463;25340.493190136094;35068.94793156209;39726.801365992986;41214.79392603018;41708.37437438441;42032.15935681269;11045;11329;11522.884771152349;11527.596534121265;11546.595869144707;7994.6002699864775;8971.37200395979;8975.50634715097;8980.101989801098;9169.724908252763;11551.76896462066;11639.243449175776;11747.412629368497;11773.411329433495;12027.338496382783;4122.051928056504;4568.053605424482;4573.81704731807;4630.490646028934;4669.7431641260055;800.4396922154515;933.6078846884325;940.4263399326405;944.5324564340696;975.5756246032998;17403.825961740473;20215.39353819388;21030.369088927357;21030.579388412145;21095.68356474654;936.0157163106485;943.2736792669743;991.0881988570533;1005.085372311208;1009.2834087797746;10789.136869050457;10964.725881852857;10977.451127443755;10983.560657573607;10997.780044399067;702779;704799;707439;710308;710964;109776;130437.29599082898;140071;143997;154450.50522221386;1152.567787079845;1182.7575347053833;1224.4979558381021;1232.3160645841645;1235.9629211123681;19594.90202548978;20822.479438014172;21004.949752512617;21473.785262147805;21843.126274948823;58586.12120818276;59201.11198332115;59710.70144649249;59976.700116500884;60011.69994150001;78786.6060669693;79932.60033699794;80505.59747201226;83350;83701;7274.381677557255;8378.58107094655;8494.32045436376;8555.31557475388;8642.481451112953;11083.445827708421;13252.933735331648;13336.599902002956;13380.799288010883;13677;10206.387616743019;10817.891821082003;11630.88369116298;11695.473703683525;11980.101492387932;10721.142308615448;10784.838227426439;11445.656630301104;11841.171118021655;11891.524339026342;10072;11108.888911110786;11695.415229238333;11882.46528906184;11983.820242696193;7143.249958754256;8305.086440491421;8521.53131577769;8578.571071446528;8599.183077607617;10006.199504039805;10300.124489418484;11475.770484590428;11820.054395648156;11860.881391185978 20:10:49 INFO - PID 1640 | |3;mootools.html;1255.5166260989529;1262.6149024547512;1297.6042307096332;1407.3666849917533;1414.7312010717962;10167.864748402835;10520.158387329015;10639.042486176253;10651.680449586514;10890.183236257293;10767.946160269188;10929.289596176262;10973.561057557688;10998.505067271972;11020.779584408327;2424.878756062194;2468.14848877138;2473.0602371098958;2483;2491.9003239870476;2411.7347091819884;2448.6204638281097;2459.4712136890566;2464.0759715106833;2465.765752253542;2414.9637755433682;2435.8051355891484;2466.7903228225623;2468.605023196289;2483.7392073832257;2396.0894859953105;2405.194259922928;2422.878856057199;2432.3675844280438;2436.500517393939;2094.7591027031935;2345.144022431817;2410.0960241409266;2418.3954011497126;2419.806415486757;10537.157027437786;10544.261901666887;10597.986382587284;10618.044376006119;10637.255392122555;6065.272167339904;6280.277768056686;6299.401556852092;6308.495320374359;6308.526860485482;3990.501187351581;3999.200159967989;4006.3790112532606;4018.3771515415156;4067.877963661095;1153.405995912106;1167.7722844045416;1188.383798034672;1207.2575366149842;1223.9938800306031;13327.866721332759;13714.657133571542;14943.327550260265;14974.47589334368;14980.325885335185;5144.6655967362;5297.920531192035;5307.65500242483;5358.5981051421295;5364.088105022156;10906.182036347305;10939.45302734876;11011.669649910515;11013.504392302366;11016.283941543774;5929.466348028698;6103.450689437972;6119.694015299217;6134.631922084689;6150.292716337589;5730.054541000772;5760.567957403127;5769.394213607511;5785.8553536161935;5807.738651760681;3980.24375368679;4146.5279825662055;4151;4193.559676233952;4199.118185181146;1105.2152971390403;1158.901493373056;1195.9940200298943;1255.2844878419214;1278.0797825565578;748.1770052941721;763.9121501027453;767.888656144867;770.4260326057123;787.7872974296907;5833.941660583425;6237.407446292595;6395.168628078413;6442.677866106769;6559.344065593403;569.4476357932798;573.2061095382842;573.3664300947477;586.3140126052443;588.3763210996358;3202.295494991098;3267.787593806395;3599.916764930334;3660.8834305536534;3702.092987218095;13227.537036203687;13677.931610342084;13778.793318100237;13806.171629702048;13823.377947992365;11441.31352118859;11601.361925094032;13584.252866092262;13662.385192666354;13742.65643358924;9913.603455861828;9977.950110249547;10045.899541004643;10139.391636501834;10150.289479736495;4852;5328.333958255218;6240.157578726814;6288.465480434214;6393.840153996187;12012.459439325427;12152.21010634306;12190.329531875832;12223.69440763988;12339.75320493603;10966.574345335055;12127.81808272859;12168.209066410654;12218.26690398579;12690.682732931751;7679.539227646359;7942.483738556975;7965.964424624994;7983.5209887406945;8008.479448835807;9579.568919398784;9743.756406089904;9796.9020309796;9822.263330250402;9864.950675246579;7571.924280757342;8674.30605551567;8714.38999270045;8778.604962776562;8797.032326444214;8499.32005439551;8521.360897932556;8553;8567.74296771098;8594.226519613265;7515.24847515266;7554.773356799305;7602.467827252261;7613.390928725578;7651.38788896898;4922.284941962202;5676.233708449472;5681.204631351531;5742.310922689304;5748.223989761496;5384.246205531151;5686.459786320293;5888.411158884077;5931.288245410578;5967.164596956516 20:10:49 INFO - PID 1640 | |4;prototype.html;383.52634496396945;399.50660933746826;402.87195851615485;406.1450646389352;407.02517470657773;5828.650280983139;5992.34084250732;6013.909791353133;6103.359147289531;6162.305366024346;4765.761711914408;5407.161889907071;5695.316562012554;5890.793822216213;5953.017752070903;3848.4804551385487;4139.710220284582;4385.605295523403;4422.84520041797;4607.262837945929;4224.986003359187;4409.819784300125;4523.321501774743;4546.204414227514;4593.862184134481;4253.1493701259715;4500.729956202638;4508.458984921797;4523.773811309437;4526.533039493484;4512.345709872066;4524.977375113136;4532.750698711569;4534.9319760203625;4556.726596404226;3796.6772824309965;3860.7876566788814;3899.863504777319;3922.3134052357473;3932.3118454270675;4996.252810392206;5399.541039011689;5901.616394934315;5916.763329466816;6002.399760023963;5087.389513258396;5201.817936372247;5317.867053323698;5344.2518047472995;5363.704996225206;5097.8215762448135;5133.743312834344;5326.147816349366;6416.807495775134;6518.250401203874;4307.8492252771;4321.222180007598;4329.393884856123;4331.870043898688;4347.5652434756585;5316.680999140064;6081.1790408294755;6163.753449862;6717.227518835348;6830.7609233676585;4350.890522916636;4374.321980093091;4403.075354175595;4418.403515525363;4423.955760442354;4074.3277359235394;4400.965773043332;4411.691181617256;4486.685931984795;4494.235979883428;5263.210518422267;5312.415634280226;5354.732263386815;5415.972920135374;5513.393526712059;6504.62581157874;6531;6535.954247320406;6548.869022619616;6552.475801935833;1511.591870195041;1644.9718925671455;1680.2774806832936;1686.1232159277108;1695.6608678264397;1008.9243306752023;1010.9435639756325;1152.2830981837003;1160.5415860735131;1164.394514852272;6203.937960620427;6232.189815323979;6240.563160578716;6259.217597800275;6285.025820997753;5838.474537291664;6619.168007354658;6644.568103073285;6795.7961261162245;6832.009358642969;5090.567301779391;6172.031514630766;6225.408586184305;6235.848632221876;6302.716377763011;2993.3265015371367;3493.9126521837156;3527.664871837171;3535.540379750616;3540.6459354064905;6689.6989635466525;7044.274152832589;7138.321859423347;7166.355028047501;7206.387457066103;6054.848628784315;6133.29467111279;6874.209465911485;6990.6155161465595;7024.789256322319;6258.967270400424;6634.379420128926;6961.965190174118;7038.894416583756;7173.6771845267085;6757.729690812509;6787.21946976104;6804.693788779616;6808.353206445379;6811.421029212573;5632.352279487911;5822.912656310244;5901.468867801918;6302.432781049728;6596.769113081019;6482.448991835747;6899.379055884994;6906.896396553955;7095.184053833876;7214.2785721427435;4402.757848318245;4409.64722822167;4418.756968366771;4426.712263702849;4427.092446048488;5800.8259752207505;6154.476869466145;6468.805935821744;6681.365270299314;6851.794446166623;4969.403671559436;6443.9355606445215;6502.219733631994;6524.543281970216;6584.12352479541;5456.399796022513;6240.290893409367;6469.902951455638;6517.576357536745;6562.606243625398;6358.809235722936;6372.840678983062;6403.7118329676205;6417.422431981144;6417.807465776034;5473.534749546333;6269.780557680459;6493.279280990447;6508.349165083454;6511.153550038464;5966.985612445981;6360.840978975562;6363.377338778582;6376.426121649074;6381.840453988501 20:10:49 INFO - PID 1640 | |5;yui.html;667.8630880669464;705.308797378569;705.3651713457888;732.414068745004;747.1295940229633;14707.485238016658;14997.850021499782;16381.672366552662;16387.672246555063;16436.34254629815;14705.705885882302;15199.544013679608;15270.236488175602;15470.381184752625;15505.844941550582;917.0737555069378;947.7677968897596;953.5470651440579;955.7706150523859;957.1720461800527;907.8275127725744;936.8032713130217;941.3222479814557;941.8963913969458;942.3074040580168;993.7813680990207;994.2096033653263;994.9005099490065;998.1116806042628;998.7652901568125;989.737719504332;991.1822746234313;991.1971303244395;992.8659630949837;998.880134383875;737.023443936786;737.959412232327;740.1155619035255;742.5470463017555;743.2715938380363;16158.75761863573;16534.925229860022;16629.83370166295;16839.07385093819;17159.828401716073;14518.854811451856;14718.190499522521;14734.70530589393;14841.925790371088;14863.479778207711;11698.649040528799;11699.532018719241;11793.705157371049;12030.218035827644;12091.879081209163;3076.7077127672837;3083.938321233585;3090.3510262844607;3106.4874295741174;3170.952435713466;114960;115519.42240288745;116545;118417.40791295988;120374;11382.943085284685;11499.827502587468;11558.711032224093;11573.88426115728;11909.821352679717;24973.375665608506;25156.496870062496;25162.993480260586;25176;25285.747142528708;7706.961465192639;7782.688692452239;7852.411069169835;7945.801354966056;8034.035915690038;3837.57786643469;3902.180542086194;3923.6076392360537;3939.428782826474;3951.920961580752;3536.681698647134;4093.2427500912427;4109.835606575763;4187.832486700559;4188.497380314382;698.1064237775655;790.6007466229518;793.8094857234222;801.1347744435996;807.9151689072563;532.7362955337055;544.9863254346911;560.4871542538532;564.7345747498669;574.4140976204249;8409;9594.232461403071;9820.214382849355;10103.444310562989;10161.339512931636;531.3358302122347;536.4421002157791;583.9883202336015;584.2054805464564;597.1818608506375;4381.627561657295;4602.217623004098;4777.378940737682;4825.371536680718;4902.460729319772;85201.57399212965;88056.11943880607;88319;92936.53531732298;94240.52879735557;60370;80201;80397;81363.59318203371;83260;59526.51183720355;60865.47836304128;66526.66736666382;70272;72914.63542682465;10429.739256518344;10470.947645261725;10709.357438553712;10799.892001079888;10814.783704325711;22760.65859012083;35103.64896351004;36370.90887273386;36657.26685466222;36919.44620830636;36358.636413635526;46041.53958460373;46764.7661761689;46831.12675493078;46869.29696054494;12932.418041188357;13173.275469848866;13198.406071726604;13314.93342533281;13699.027137225134;14159.716805663624;14193.645158871112;14259.215743134228;14288.214148221947;14493.78259326132;13119.212847229197;13166.605001849959;13311.80032299497;13425.462981480632;14056.297185140907;13133.934330328288;13249.933750331187;13313.879625218497;13878.097923634932;14146.151230926178;10712.585776050111;12902.80645790295;12921.536059694674;13087.672808179872;13627.318634068455;10766.542913299798;10798.244122911321;10845.783084338427;11305.26515776472;11385.601503947322;9780.706578802647;9948.502574871083;9953.950230248802;10862.511186996446;11103.66688999299 20:10:49 INFO - PID 1640 | __end_tp_report 20:10:49 INFO - PID 1640 | __start_cc_report 20:10:49 INFO - PID 1640 | _x_x_mozilla_cycle_collect,420 20:10:49 INFO - PID 1640 | __end_cc_report 20:10:49 INFO - PID 1640 | __startTimestamp1490065849394__endTimestamp 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | ------- Summary: start ------- 20:10:49 INFO - PID 1640 | Number of tests: 6 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:6053.29 Median:6234.35 stddev:693.19 (11.1%) stddev-sans-first:665.91 20:10:49 INFO - PID 1640 | Values: 3506.5 3507.6 3542.9 3548.0 3587.3 4855.7 6011.1 6021.6 6147.9 6165.3 6070.0 6105.4 6123.2 6139.2 6141.6 5476.4 5518.6 5571.3 5584.1 5650.5 5494.2 5649.4 5653.1 5662.8 5671.1 5143.8 5545.4 5629.2 5670.5 5671.3 5391.9 5436.7 5456.8 5550.1 5550.7 5389.6 5399.4 5459.4 5466.0 5478.2 4475.5 5251.7 6068.3 6129.5 6151.1 6525.5 6531.4 6534.3 6535.1 6544.3 6387.5 6455.4 6575.0 6642.9 6652.0 6135.3 6167.5 6173.8 6191.2 6193.6 6692.2 6819.1 6835.9 6837.9 6858.2 6241.8 6292.0 6392.8 6443.0 6470.6 6617.9 6639.2 6655.9 6686.6 6687.1 6445.2 6521.8 6530.7 6533.6 6543.1 5707.9 6326.7 6389.9 6417.6 6559.0 5305.9 5313.7 5320.1 5330.0 5362.8 4704.7 4712.1 4713.5 4725.2 4753.0 6132.8 6220.8 6226.0 6232.6 6268.9 5648.5 6560.1 6586.2 6619.1 6622.3 6223.8 6234.3 6242.8 6266.7 6278.8 5760.5 5902.4 5919.3 5923.7 5930.6 6730.8 6888.9 6909.1 6946.7 6973.4 6625.9 6679.5 6690.9 6702.6 6706.6 6208.1 6547.0 6713.7 6802.5 6959.3 5924.9 6289.4 6424.2 6448.7 6488.3 5268.9 6486.8 6570.5 6573.0 6593.5 6175.3 6216.4 6384.0 6387.9 6398.6 6371.9 6438.1 6449.9 6451.5 6463.6 5415.9 6191.4 6255.9 6361.1 6365.7 6139.8 6407.7 6472.4 6479.3 6480.4 6132.2 6223.6 6260.3 6281.5 6284.2 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:53590.56 Median:31537.10 stddev:108509.34 (344.1%) stddev-sans-first:108741.10 20:10:49 INFO - PID 1640 | Values: 708.1 785.8 798.2 800.0 805.4 36685.6 37502.6 37508.8 37526.8 37543.0 37177.9 39011.4 39443.0 39449.4 39473.0 2706.5 2772.0 2824.0 2910.9 2919.2 2869.0 2872.1 2908.8 2909.8 2915.6 2910.3 2914.9 2925.6 2934.2 2940.7 2908.3 2911.2 2915.3 2929.7 2930.4 2904.7 2921.5 2923.8 2929.5 2937.2 38276.2 38401.6 38467.4 38476.8 38600.0 3008.9 3015.6 3045.8 3051.5 3066.8 28037.0 28365.7 28463.1 28658.3 28859.3 2796.8 2821.2 2821.3 2825.1 2868.0 233514.0 234695.0 261625.0 332314.0 335481.6 46831.5 46967.5 47011.3 47144.0 49456.5 51220.7 51262.7 51271.0 51310.5 51329.0 14575.3 14651.6 14654.2 14661.4 14687.2 12007.3 12044.3 12065.8 12082.9 12098.3 11964.2 13900.7 13910.0 14033.7 14210.6 5065.7 5273.2 5844.2 5900.9 5982.3 962.8 969.4 976.4 977.5 1019.4 24380.6 24496.7 24644.0 24653.0 24781.4 1016.3 1051.8 1081.6 1124.2 1132.0 12067.9 12465.4 12544.2 12583.2 12667.5 471534.0 472588.0 473674.0 475344.0 475716.0 56330.0 56439.0 56798.9 56891.1 56896.7 1441.3 1451.7 1489.9 1495.8 1498.7 24078.9 29104.9 29160.0 29602.8 29687.7 54895.7 55280.4 55321.0 55435.9 55492.1 433918.0 438274.0 439668.0 441220.8 441631.0 35865.8 36375.8 36445.5 36482.3 36570.8 44953.6 45888.5 46031.3 46189.8 46255.5 34353.0 34534.5 36742.0 37570.6 37850.8 36543.3 36817.6 37540.4 37803.6 37950.4 35499.5 36408.6 36586.0 36854.1 37493.6 28397.6 31485.4 31588.8 31655.7 31803.2 22680.5 22833.0 24251.5 24314.8 25088.5 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:41550.63 Median:22409.67 stddev:118255.37 (527.7%) stddev-sans-first:118546.76 20:10:49 INFO - PID 1640 | Values: 409.6 419.9 426.9 427.8 442.0 20211.0 20525.7 20665.0 20994.3 21009.8 21494.2 21926.0 22006.4 22812.9 22852.3 4516.8 4688.7 4694.8 4695.2 4697.5 4373.9 4428.8 4461.0 4625.3 4651.7 4654.4 4685.3 4703.8 4714.7 4720.0 4538.3 4620.0 4665.3 4690.6 4708.9 4229.9 4543.8 4653.3 4678.9 4690.3 28978.4 28999.4 29421.6 29714.4 29854.0 1992.1 2034.8 2037.6 2070.4 2102.2 16845.7 17477.5 17650.6 17812.2 18918.0 1419.3 1595.3 1739.5 1759.4 1763.9 149805.0 161039.0 167742.0 171494.0 173676.0 20125.0 24594.9 25001.4 25075.5 25340.5 35068.9 39726.8 41214.8 41708.4 42032.2 11045.0 11329.0 11522.9 11527.6 11546.6 7994.6 8971.4 8975.5 8980.1 9169.7 11551.8 11639.2 11747.4 11773.4 12027.3 4122.1 4568.1 4573.8 4630.5 4669.7 800.4 933.6 940.4 944.5 975.6 17403.8 20215.4 21030.4 21030.6 21095.7 936.0 943.3 991.1 1005.1 1009.3 10789.1 10964.7 10977.5 10983.6 10997.8 702779.0 704799.0 707439.0 710308.0 710964.0 109776.0 130437.3 140071.0 143997.0 154450.5 1152.6 1182.8 1224.5 1232.3 1236.0 19594.9 20822.5 21004.9 21473.8 21843.1 58586.1 59201.1 59710.7 59976.7 60011.7 78786.6 79932.6 80505.6 83350.0 83701.0 7274.4 8378.6 8494.3 8555.3 8642.5 11083.4 13252.9 13336.6 13380.8 13677.0 10206.4 10817.9 11630.9 11695.5 11980.1 10721.1 10784.8 11445.7 11841.2 11891.5 10072.0 11108.9 11695.4 11882.5 11983.8 7143.2 8305.1 8521.5 8578.6 8599.2 10006.2 10300.1 11475.8 11820.1 11860.9 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:6560.75 Median:3630.40 stddev:4045.09 (111.4%) stddev-sans-first:4036.79 20:10:49 INFO - PID 1640 | Values: 1255.5 1262.6 1297.6 1407.4 1414.7 10167.9 10520.2 10639.0 10651.7 10890.2 10767.9 10929.3 10973.6 10998.5 11020.8 2424.9 2468.1 2473.1 2483.0 2491.9 2411.7 2448.6 2459.5 2464.1 2465.8 2415.0 2435.8 2466.8 2468.6 2483.7 2396.1 2405.2 2422.9 2432.4 2436.5 2094.8 2345.1 2410.1 2418.4 2419.8 10537.2 10544.3 10598.0 10618.0 10637.3 6065.3 6280.3 6299.4 6308.5 6308.5 3990.5 3999.2 4006.4 4018.4 4067.9 1153.4 1167.8 1188.4 1207.3 1224.0 13327.9 13714.7 14943.3 14974.5 14980.3 5144.7 5297.9 5307.7 5358.6 5364.1 10906.2 10939.5 11011.7 11013.5 11016.3 5929.5 6103.5 6119.7 6134.6 6150.3 5730.1 5760.6 5769.4 5785.9 5807.7 3980.2 4146.5 4151.0 4193.6 4199.1 1105.2 1158.9 1196.0 1255.3 1278.1 748.2 763.9 767.9 770.4 787.8 5833.9 6237.4 6395.2 6442.7 6559.3 569.4 573.2 573.4 586.3 588.4 3202.3 3267.8 3599.9 3660.9 3702.1 13227.5 13677.9 13778.8 13806.2 13823.4 11441.3 11601.4 13584.3 13662.4 13742.7 9913.6 9978.0 10045.9 10139.4 10150.3 4852.0 5328.3 6240.2 6288.5 6393.8 12012.5 12152.2 12190.3 12223.7 12339.8 10966.6 12127.8 12168.2 12218.3 12690.7 7679.5 7942.5 7966.0 7983.5 8008.5 9579.6 9743.8 9796.9 9822.3 9865.0 7571.9 8674.3 8714.4 8778.6 8797.0 8499.3 8521.4 8553.0 8567.7 8594.2 7515.2 7554.8 7602.5 7613.4 7651.4 4922.3 5676.2 5681.2 5742.3 5748.2 5384.2 5686.5 5888.4 5931.3 5967.2 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:5244.62 Median:5825.78 stddev:1625.16 (27.9%) stddev-sans-first:1588.23 20:10:49 INFO - PID 1640 | Values: 383.5 399.5 402.9 406.1 407.0 5828.7 5992.3 6013.9 6103.4 6162.3 4765.8 5407.2 5695.3 5890.8 5953.0 3848.5 4139.7 4385.6 4422.8 4607.3 4225.0 4409.8 4523.3 4546.2 4593.9 4253.1 4500.7 4508.5 4523.8 4526.5 4512.3 4525.0 4532.8 4534.9 4556.7 3796.7 3860.8 3899.9 3922.3 3932.3 4996.3 5399.5 5901.6 5916.8 6002.4 5087.4 5201.8 5317.9 5344.3 5363.7 5097.8 5133.7 5326.1 6416.8 6518.3 4307.8 4321.2 4329.4 4331.9 4347.6 5316.7 6081.2 6163.8 6717.2 6830.8 4350.9 4374.3 4403.1 4418.4 4424.0 4074.3 4401.0 4411.7 4486.7 4494.2 5263.2 5312.4 5354.7 5416.0 5513.4 6504.6 6531.0 6536.0 6548.9 6552.5 1511.6 1645.0 1680.3 1686.1 1695.7 1008.9 1010.9 1152.3 1160.5 1164.4 6203.9 6232.2 6240.6 6259.2 6285.0 5838.5 6619.2 6644.6 6795.8 6832.0 5090.6 6172.0 6225.4 6235.8 6302.7 2993.3 3493.9 3527.7 3535.5 3540.6 6689.7 7044.3 7138.3 7166.4 7206.4 6054.8 6133.3 6874.2 6990.6 7024.8 6259.0 6634.4 6962.0 7038.9 7173.7 6757.7 6787.2 6804.7 6808.4 6811.4 5632.4 5822.9 5901.5 6302.4 6596.8 6482.4 6899.4 6906.9 7095.2 7214.3 4402.8 4409.6 4418.8 4426.7 4427.1 5800.8 6154.5 6468.8 6681.4 6851.8 4969.4 6443.9 6502.2 6524.5 6584.1 5456.4 6240.3 6469.9 6517.6 6562.6 6358.8 6372.8 6403.7 6417.4 6417.8 5473.5 6269.8 6493.3 6508.3 6511.2 5967.0 6360.8 6363.4 6376.4 6381.8 20:10:49 INFO - PID 1640 | 20:10:49 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:18855.26 Median:20378.51 stddev:26906.42 (132.0%) stddev-sans-first:26947.24 20:10:49 INFO - PID 1640 | Values: 667.9 705.3 705.4 732.4 747.1 14707.5 14997.9 16381.7 16387.7 16436.3 14705.7 15199.5 15270.2 15470.4 15505.8 917.1 947.8 953.5 955.8 957.2 907.8 936.8 941.3 941.9 942.3 993.8 994.2 994.9 998.1 998.8 989.7 991.2 991.2 992.9 998.9 737.0 738.0 740.1 742.5 743.3 16158.8 16534.9 16629.8 16839.1 17159.8 14518.9 14718.2 14734.7 14841.9 14863.5 11698.6 11699.5 11793.7 12030.2 12091.9 3076.7 3083.9 3090.4 3106.5 3171.0 114960.0 115519.4 116545.0 118417.4 120374.0 11382.9 11499.8 11558.7 11573.9 11909.8 24973.4 25156.5 25163.0 25176.0 25285.7 7707.0 7782.7 7852.4 7945.8 8034.0 3837.6 3902.2 3923.6 3939.4 3951.9 3536.7 4093.2 4109.8 4187.8 4188.5 698.1 790.6 793.8 801.1 807.9 532.7 545.0 560.5 564.7 574.4 8409.0 9594.2 9820.2 10103.4 10161.3 531.3 536.4 584.0 584.2 597.2 4381.6 4602.2 4777.4 4825.4 4902.5 85201.6 88056.1 88319.0 92936.5 94240.5 60370.0 80201.0 80397.0 81363.6 83260.0 59526.5 60865.5 66526.7 70272.0 72914.6 10429.7 10470.9 10709.4 10799.9 10814.8 22760.7 35103.6 36370.9 36657.3 36919.4 36358.6 46041.5 46764.8 46831.1 46869.3 12932.4 13173.3 13198.4 13314.9 13699.0 14159.7 14193.6 14259.2 14288.2 14493.8 13119.2 13166.6 13311.8 13425.5 14056.3 13133.9 13249.9 13313.9 13878.1 14146.2 10712.6 12902.8 12921.5 13087.7 13627.3 10766.5 10798.2 10845.8 11305.3 11385.6 9780.7 9948.5 9954.0 10862.5 11103.7 20:10:49 INFO - PID 1640 | -------- Summary: end -------- 20:10:49 INFO - PID 1640 | 20:10:50 INFO - TEST-INFO | 1640: exit 0 20:10:50 INFO - TEST-OK | dromaeo_css | took 1117770ms 20:10:50 INFO - TEST-START | kraken 20:10:50 INFO - operating with platform_type : mac_ 20:10:50 INFO - Initialising browser for kraken test... 20:10:50 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmposiZLH/profile http://localhost:49242/getInfo.html) 20:10:52 INFO - PID 1651 | 2017-03-20 20:10:52.651 plugin-container[1652:10031] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x473b, name = 'com.apple.tsm.portname' 20:10:52 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:52 INFO - PID 1651 | 2017-03-20 20:10:52.654 plugin-container[1652:10031] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x430f, name = 'com.apple.CFPasteboardClient' 20:10:52 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:52 INFO - PID 1651 | 2017-03-20 20:10:52.654 plugin-container[1652:10031] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:10:52 INFO - PID 1651 | __metrics Screen width/height:1600/1200 20:10:52 INFO - PID 1651 | colorDepth:24 20:10:52 INFO - PID 1651 | Browser inner width/height: 1024/689 20:10:52 INFO - PID 1651 | __metrics 20:10:52 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3350: TypeError: this.tabs is undefined 20:10:53 INFO - TEST-INFO | 1651: exit 0 20:10:53 INFO - Browser initialized. 20:10:53 INFO - Running cycle 1/1 for kraken test... 20:10:53 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmposiZLH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:10:56 INFO - PID 1653 | 2017-03-20 20:10:56.011 plugin-container[1654:10155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 20:10:56 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:56 INFO - PID 1653 | 2017-03-20 20:10:56.012 plugin-container[1654:10155] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 20:10:56 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:10:56 INFO - PID 1653 | 2017-03-20 20:10:56.012 plugin-container[1654:10155] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:11:05 INFO - PID 1653 | RSS: Main: 227647488 20:11:05 INFO - PID 1653 | 20:11:08 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 20:11:09 INFO - PID 1653 | RSS: Main: 241688576 20:11:09 INFO - PID 1653 | 20:11:12 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 20:11:12 INFO - PID 1653 | RSS: Main: 250163200 20:11:12 INFO - PID 1653 | 20:11:16 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 20:11:16 INFO - PID 1653 | RSS: Main: 252641280 20:11:16 INFO - PID 1653 | 20:11:18 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 20:11:19 INFO - PID 1653 | RSS: Main: 255070208 20:11:19 INFO - PID 1653 | 20:11:21 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:11:22 INFO - PID 1653 | RSS: Main: 255311872 20:11:22 INFO - PID 1653 | 20:11:25 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 20:11:25 INFO - PID 1653 | RSS: Main: 260665344 20:11:25 INFO - PID 1653 | 20:11:29 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 20:11:29 INFO - PID 1653 | RSS: Main: 261050368 20:11:29 INFO - PID 1653 | 20:11:32 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 20:11:33 INFO - PID 1653 | RSS: Main: 261558272 20:11:33 INFO - PID 1653 | 20:11:35 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:11:35 INFO - PID 1653 | RSS: Main: 261210112 20:11:35 INFO - PID 1653 | 20:11:37 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:11:38 INFO - PID 1653 | RSS: Main: 261206016 20:11:38 INFO - PID 1653 | 20:11:40 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:11:41 INFO - PID 1653 | RSS: Main: 261165056 20:11:41 INFO - PID 1653 | 20:11:44 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:11:44 INFO - PID 1653 | RSS: Main: 261566464 20:11:44 INFO - PID 1653 | 20:11:48 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:11:48 INFO - PID 1653 | RSS: Main: 261447680 20:11:48 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 20:11:50 INFO - PID 1653 | RSS: Main: 263176192 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | __start_tp_report 20:11:50 INFO - PID 1653 | _x_x_mozilla_page_load 20:11:50 INFO - PID 1653 | _x_x_mozilla_page_load_details 20:11:50 INFO - PID 1653 | |i|pagename|runs| 20:11:50 INFO - PID 1653 | |0;ai-astar;104;109;115;116;140;170;157;116;116;115 20:11:50 INFO - PID 1653 | |1;audio-beat-detection;151;115;114;158;112;118;115;114;135;116 20:11:50 INFO - PID 1653 | |2;audio-dft;252;199;260;254;219;184;189;265;261;194 20:11:50 INFO - PID 1653 | |3;audio-fft;85;74;52;74;72;85;84;85;97;60 20:11:50 INFO - PID 1653 | |4;audio-oscillator;88;70;84;69;69;65;84;70;72;83 20:11:50 INFO - PID 1653 | |5;imaging-gaussian-blur;119;92;109;119;83;88;131;129;93;93 20:11:50 INFO - PID 1653 | |6;imaging-darkroom;99;118;147;99;99;99;100;100;99;98 20:11:50 INFO - PID 1653 | |7;imaging-desaturate;92;91;92;94;93;80;148;140;86;144 20:11:50 INFO - PID 1653 | |8;json-parse-financial;67;63;65;68;68;67;68;68;84;94 20:11:50 INFO - PID 1653 | |9;json-stringify-tinderbox;64;57;58;64;60;57;50;53;57;50 20:11:50 INFO - PID 1653 | |10;stanford-crypto-aes;96;99;77;80;84;85;85;81;83;84 20:11:50 INFO - PID 1653 | |11;stanford-crypto-ccm;150;150;152;156;145;140;142;163;198;159 20:11:50 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;189;185;181;189;188;188;190;233;224;223 20:11:50 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;67;71;69;64;71;99;95;93;83;72 20:11:50 INFO - PID 1653 | __end_tp_report 20:11:50 INFO - PID 1653 | __start_cc_report 20:11:50 INFO - PID 1653 | _x_x_mozilla_cycle_collect,1015 20:11:50 INFO - PID 1653 | __end_cc_report 20:11:50 INFO - PID 1653 | __startTimestamp1490065910765__endTimestamp 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | ------- Summary: start ------- 20:11:50 INFO - PID 1653 | Number of tests: 14 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:125.80 Median:116.00 stddev:22.13 (19.1%) stddev-sans-first:22.02 20:11:50 INFO - PID 1653 | Values: 104.0 109.0 115.0 116.0 140.0 170.0 157.0 116.0 116.0 115.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:124.80 Median:117.00 stddev:17.02 (14.5%) stddev-sans-first:15.18 20:11:50 INFO - PID 1653 | Values: 151.0 115.0 114.0 158.0 112.0 118.0 115.0 114.0 135.0 116.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:227.70 Median:253.00 stddev:33.78 (13.4%) stddev-sans-first:34.66 20:11:50 INFO - PID 1653 | Values: 252.0 199.0 260.0 254.0 219.0 184.0 189.0 265.0 261.0 194.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:76.80 Median:84.50 stddev:13.32 (15.8%) stddev-sans-first:13.80 20:11:50 INFO - PID 1653 | Values: 85.0 74.0 52.0 74.0 72.0 85.0 84.0 85.0 97.0 60.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.50 stddev:8.33 (10.7%) stddev-sans-first:7.48 20:11:50 INFO - PID 1653 | Values: 88.0 70.0 84.0 69.0 69.0 65.0 84.0 70.0 72.0 83.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:105.60 Median:85.50 stddev:17.91 (20.9%) stddev-sans-first:18.33 20:11:50 INFO - PID 1653 | Values: 119.0 92.0 109.0 119.0 83.0 88.0 131.0 129.0 93.0 93.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:99.00 stddev:15.65 (15.8%) stddev-sans-first:16.41 20:11:50 INFO - PID 1653 | Values: 99.0 118.0 147.0 99.0 99.0 99.0 100.0 100.0 99.0 98.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:91.50 stddev:26.60 (29.1%) stddev-sans-first:27.73 20:11:50 INFO - PID 1653 | Values: 92.0 91.0 92.0 94.0 93.0 80.0 148.0 140.0 86.0 144.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:68.00 stddev:9.81 (14.4%) stddev-sans-first:10.28 20:11:50 INFO - PID 1653 | Values: 67.0 63.0 65.0 68.0 68.0 67.0 68.0 68.0 84.0 94.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.50 stddev:4.97 (8.6%) stddev-sans-first:4.58 20:11:50 INFO - PID 1653 | Values: 64.0 57.0 58.0 64.0 60.0 57.0 50.0 53.0 57.0 50.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.50 stddev:6.88 (8.1%) stddev-sans-first:6.14 20:11:50 INFO - PID 1653 | Values: 96.0 99.0 77.0 80.0 84.0 85.0 85.0 81.0 83.0 84.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:155.50 Median:154.00 stddev:16.60 (10.8%) stddev-sans-first:17.49 20:11:50 INFO - PID 1653 | Values: 150.0 150.0 152.0 156.0 145.0 140.0 142.0 163.0 198.0 159.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.00 Median:189.50 stddev:19.44 (10.3%) stddev-sans-first:20.28 20:11:50 INFO - PID 1653 | Values: 189.0 185.0 181.0 189.0 188.0 188.0 190.0 233.0 224.0 223.0 20:11:50 INFO - PID 1653 | 20:11:50 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:77.50 stddev:12.95 (16.7%) stddev-sans-first:13.07 20:11:50 INFO - PID 1653 | Values: 67.0 71.0 69.0 64.0 71.0 99.0 95.0 93.0 83.0 72.0 20:11:50 INFO - PID 1653 | -------- Summary: end -------- 20:11:50 INFO - PID 1653 | 20:11:51 INFO - TEST-INFO | 1653: exit 0 20:11:51 INFO - TEST-OK | kraken | took 61609ms 20:11:51 INFO - SUITE-END | took 1179s 20:11:51 INFO - Completed test suite (00:19:39) 20:11:51 INFO - javascript benchmark 20:11:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7503.103849529726, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3506.5266189064473, 3507.5615548056494, 3542.911427214318, 3548.042028652264, 3587.3184095021943, 4855.660103792736, 6011.128386383972, 6021.638701677897, 6147.8770424591485, 6165.260168779752, 6069.969650151743, 6105.43571699886, 6123.173371594833, 6139.171211886394, 6141.608749743932, 5476.4249753775875, 5518.613697041199, 5571.331440227178, 5584.134459158837, 5650.51970582501, 5494.230807686927, 5649.350324712669, 5653.123765816305, 5662.773489060432, 5671.092625179972, 5143.794248230066, 5545.417731138233, 5629.211910332536, 5670.461306175906, 5671.347795003566, 5391.919121213185, 5436.700981446019, 5456.809011684572, 5550.111982082847, 5550.72246387679, 5389.568834493231, 5399.352077750656, 5459.3994660587305, 5466.043442397565, 5478.178273259004, 4475.48531918827, 5251.711155886463, 6068.271807383142, 6129.509639228895, 6151.077338399231, 6525.4779617630475, 6531.412172904414, 6534.281229064799, 6535.052417399498, 6544.345565443417, 6387.489000879918, 6455.419012288869, 6574.967125164391, 6642.903920853053, 6651.966740166316, 6135.293912123373, 6167.506599472032, 6173.783917562864, 6191.19514463117, 6193.59741616798, 6692.196936367667, 6819.113515242987, 6835.897461538081, 6837.863242735118, 6858.245592984767, 6241.812745617639, 6292.0, 6392.808215753535, 6443.0335449682925, 6470.611763294123, 6617.867642647217, 6639.236487803964, 6655.933440665532, 6686.5653732507235, 6687.130673012477, 6445.1621289233035, 6521.836954076186, 6530.706118224596, 6533.575317604341, 6543.051257567626, 5707.885842283131, 6326.6520341381665, 6389.904151437732, 6417.6149431033355, 6559.048937903977, 5305.946940530545, 5313.707746074003, 5320.068987927098, 5329.973350133225, 5362.839114826562, 4704.694194877322, 4712.081144176853, 4713.528647135327, 4725.220338644154, 4752.95247047532, 6132.816015519542, 6220.813375598739, 6226.034964580497, 6232.563720539519, 6268.937310626835, 5648.5481161507805, 6560.081588577603, 6586.176727909012, 6619.106420633249, 6622.2715501294815, 6223.751049958041, 6234.345393733593, 6242.812715618448, 6266.655333956676, 6278.780242691484, 5760.510356619734, 5902.4097590240635, 5919.260092488439, 5923.703814809242, 5930.584859059824, 6730.764423245163, 6888.862222755617, 6909.136357955255, 6946.722131114901, 6973.407260382722, 6625.900611490928, 6679.499037572299, 6690.866182676416, 6702.597844129368, 6706.631135287606, 6208.130861679459, 6546.967265163644, 6713.697883595348, 6802.489813263926, 6959.304069593203, 5924.874273887947, 6289.40250676185, 6424.164858568543, 6448.677566121769, 6488.318726533646, 5268.947310526845, 6486.805395838132, 6570.47436205112, 6573.04690819838, 6593.538452308292, 6175.289841668266, 6216.44052035319, 6383.96808015957, 6387.936120638734, 6398.584092034189, 6371.936280637135, 6438.098666186644, 6449.935500644933, 6451.4516266116025, 6463.612183269019, 5415.945840541544, 6191.411815877665, 6255.906161407674, 6361.109444677656, 6365.745370185141, 6139.798803208702, 6407.679616019087, 6472.449841763503, 6479.254885688206, 6480.384363485461, 6132.20254427538, 6223.564350495421, 6260.342664020394, 6281.528885333527, 6284.214473190851], "value": 6010.844643635208, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.1183926012116, 785.83104632504, 798.1858504325592, 799.9720009799654, 805.37583372886, 36685.63314366856, 37502.62497375025, 37508.812455937754, 37526.81236593813, 37543.0, 37177.88466346007, 39011.41482877759, 39443.0, 39449.40825887614, 39473.0, 2706.499297629935, 2771.9584206236923, 2823.9717602824016, 2910.9126726198247, 2919.226405002676, 2869.0, 2872.095289983659, 2908.7527560157305, 2909.810862293944, 2915.562665600156, 2910.3306239564913, 2914.8979785707506, 2925.634295713036, 2934.237098354422, 2940.7206315400003, 2908.2729317670583, 2911.228524441014, 2915.271182204449, 2929.6630887448005, 2930.3846192299643, 2904.7385735283924, 2921.5033444314518, 2923.8245705257755, 2929.4580502606873, 2937.221636266391, 38276.234475310615, 38401.61598384036, 38467.42298865519, 38476.845694629206, 38600.0, 3008.8946886859076, 3015.62304711911, 3045.8020228685064, 3051.52701331294, 3066.8006579572257, 28037.0, 28365.716342836513, 28463.146105616866, 28658.283542911595, 28859.27851803701, 2796.7902407319534, 2821.1677555121287, 2821.3087793490727, 2825.1383328084926, 2867.956980645292, 233514.0, 234695.0, 261624.9999999981, 332314.0, 335481.64518354746, 46831.53168468272, 46967.530324697, 47011.29483057757, 47144.0, 49456.50543494591, 51220.74389628028, 51262.743686282076, 51271.0, 51310.48689513132, 51328.97342053138, 14575.344109515097, 14651.560453186421, 14654.194019328826, 14661.413543458142, 14687.192204428859, 12007.339596322287, 12044.337561434206, 12065.758684826254, 12082.939585302018, 12098.274103553815, 11964.222325548812, 13900.721985560434, 13909.956753243345, 14033.71932561343, 14210.644733881736, 5065.746712664352, 5273.209018647233, 5844.240248767633, 5900.911486327708, 5982.252218472691, 962.8363178259573, 969.3941286695815, 976.3507267667064, 977.4721650308895, 1019.3832731197518, 24380.634290485657, 24496.652684102188, 24644.0, 24653.0, 24781.380465488146, 1016.2936758952457, 1051.8061999630474, 1081.6268387406333, 1124.1568823382463, 1131.9717007074723, 12067.931468783132, 12465.439055242354, 12544.24734515932, 12583.182093163916, 12667.493300267886, 471534.0, 472588.0, 473674.0, 475344.0, 475716.0, 56330.0, 56439.0, 56798.86402271932, 56891.14663280054, 56896.715516422155, 1441.3297816515371, 1451.6516036151036, 1489.8882583806042, 1495.8130233720785, 1498.677784276364, 24078.87960560256, 29104.854475727487, 29160.0, 29602.815887365126, 29687.703122968494, 54895.72552137214, 55280.44719552753, 55321.0, 55435.89128217494, 55492.05777797758, 433918.0, 438274.0, 439668.0, 441220.7938960285, 441631.0, 35865.82067089648, 36375.81812090923, 36445.54217831257, 36482.27035459223, 36570.8171459141, 44953.55046449624, 45888.54111458976, 46031.30953035774, 46189.76905115453, 46255.53744462647, 34353.0, 34534.48198277078, 36742.0, 37570.624293756715, 37850.810745946095, 36543.269134616625, 36817.63182368142, 37540.436893447164, 37803.62196378111, 37950.430743538316, 35499.46750798688, 36408.63591364052, 36586.0, 36854.07864803401, 37493.625063749016, 28397.574036389058, 31485.367090621137, 31588.842055790494, 31655.683443165275, 31803.20491987719, 22680.546389072457, 22833.0, 24251.514969700154, 24314.756852431958, 25088.49823003566], "value": 15681.516328225722, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.56790585931867, 419.897125204325, 426.90262739162483, 427.7625917615723, 441.9845305414311, 20211.0, 20525.692114618276, 20665.0, 20994.26520071798, 21009.789902100994, 21494.205753252096, 21926.013329400175, 22006.44983875404, 22812.88593557034, 22852.31443056711, 4516.796744146505, 4688.695234809744, 4694.788734506938, 4695.178343789823, 4697.459792123898, 4373.912521749579, 4428.822847086113, 4460.97769511152, 4625.306204069383, 4651.651126165551, 4654.441467023945, 4685.344051832746, 4703.811847526112, 4714.717116972975, 4719.985203181315, 4538.319252112176, 4620.029793743284, 4665.2768820832825, 4690.648201384893, 4708.882277943045, 4229.915401691949, 4543.772811359452, 4653.255479123324, 4678.883027924295, 4690.296455531663, 28978.42043159146, 28999.42001159986, 29421.55867661987, 29714.40571188586, 29853.95511157099, 1992.103553400961, 2034.7558293004786, 2037.6434124028235, 2070.4346915052424, 2102.1696429910253, 16845.747313790303, 17477.475675729747, 17650.558736031573, 17812.198451069602, 18918.0, 1419.2548911821273, 1595.2900959073218, 1739.5303268117664, 1759.445774581003, 1763.8941663500232, 149805.0, 161039.0, 167742.0, 171493.99999999875, 173676.0, 20125.0, 24594.877025615115, 25001.37496562564, 25075.498490030463, 25340.493190136094, 35068.94793156209, 39726.801365992986, 41214.79392603018, 41708.37437438441, 42032.15935681269, 11045.0, 11329.0, 11522.884771152349, 11527.596534121265, 11546.595869144707, 7994.6002699864775, 8971.37200395979, 8975.50634715097, 8980.101989801098, 9169.724908252763, 11551.76896462066, 11639.243449175776, 11747.412629368497, 11773.411329433495, 12027.338496382783, 4122.051928056504, 4568.053605424482, 4573.81704731807, 4630.490646028934, 4669.7431641260055, 800.4396922154515, 933.6078846884325, 940.4263399326405, 944.5324564340696, 975.5756246032998, 17403.825961740473, 20215.39353819388, 21030.369088927357, 21030.579388412145, 21095.68356474654, 936.0157163106485, 943.2736792669743, 991.0881988570533, 1005.085372311208, 1009.2834087797746, 10789.136869050457, 10964.725881852857, 10977.451127443755, 10983.560657573607, 10997.780044399067, 702779.0, 704799.0, 707439.0, 710308.0, 710964.0, 109776.0, 130437.29599082898, 140071.0, 143997.0, 154450.50522221386, 1152.567787079845, 1182.7575347053833, 1224.4979558381021, 1232.3160645841645, 1235.9629211123681, 19594.90202548978, 20822.479438014172, 21004.949752512617, 21473.785262147805, 21843.126274948823, 58586.12120818276, 59201.11198332115, 59710.70144649249, 59976.700116500884, 60011.69994150001, 78786.6060669693, 79932.60033699794, 80505.59747201226, 83350.0, 83701.0, 7274.381677557255, 8378.58107094655, 8494.32045436376, 8555.31557475388, 8642.481451112953, 11083.445827708421, 13252.933735331648, 13336.599902002956, 13380.799288010883, 13677.0, 10206.387616743019, 10817.891821082003, 11630.88369116298, 11695.473703683525, 11980.101492387932, 10721.142308615448, 10784.838227426439, 11445.656630301104, 11841.171118021655, 11891.524339026342, 10072.0, 11108.888911110786, 11695.415229238333, 11882.46528906184, 11983.820242696193, 7143.249958754256, 8305.086440491421, 8521.53131577769, 8578.571071446528, 8599.183077607617, 10006.199504039805, 10300.124489418484, 11475.770484590428, 11820.054395648156, 11860.881391185978], "value": 10869.103419360525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.5166260989529, 1262.6149024547512, 1297.6042307096332, 1407.3666849917533, 1414.7312010717962, 10167.864748402835, 10520.158387329015, 10639.042486176253, 10651.680449586514, 10890.183236257293, 10767.946160269188, 10929.289596176262, 10973.561057557688, 10998.505067271972, 11020.779584408327, 2424.878756062194, 2468.14848877138, 2473.0602371098958, 2483.0, 2491.9003239870476, 2411.7347091819884, 2448.6204638281097, 2459.4712136890566, 2464.0759715106833, 2465.765752253542, 2414.9637755433682, 2435.8051355891484, 2466.7903228225623, 2468.605023196289, 2483.7392073832257, 2396.0894859953105, 2405.194259922928, 2422.878856057199, 2432.3675844280438, 2436.500517393939, 2094.7591027031935, 2345.144022431817, 2410.0960241409266, 2418.3954011497126, 2419.806415486757, 10537.157027437786, 10544.261901666887, 10597.986382587284, 10618.044376006119, 10637.255392122555, 6065.272167339904, 6280.277768056686, 6299.401556852092, 6308.495320374359, 6308.526860485482, 3990.501187351581, 3999.200159967989, 4006.3790112532606, 4018.3771515415156, 4067.877963661095, 1153.405995912106, 1167.7722844045416, 1188.383798034672, 1207.2575366149842, 1223.9938800306031, 13327.866721332759, 13714.657133571542, 14943.327550260265, 14974.47589334368, 14980.325885335185, 5144.6655967362, 5297.920531192035, 5307.65500242483, 5358.5981051421295, 5364.088105022156, 10906.182036347305, 10939.45302734876, 11011.669649910515, 11013.504392302366, 11016.283941543774, 5929.466348028698, 6103.450689437972, 6119.694015299217, 6134.631922084689, 6150.292716337589, 5730.054541000772, 5760.567957403127, 5769.394213607511, 5785.8553536161935, 5807.738651760681, 3980.24375368679, 4146.5279825662055, 4151.0, 4193.559676233952, 4199.118185181146, 1105.2152971390403, 1158.901493373056, 1195.9940200298943, 1255.2844878419214, 1278.0797825565578, 748.1770052941721, 763.9121501027453, 767.888656144867, 770.4260326057123, 787.7872974296907, 5833.941660583425, 6237.407446292595, 6395.168628078413, 6442.677866106769, 6559.344065593403, 569.4476357932798, 573.2061095382842, 573.3664300947477, 586.3140126052443, 588.3763210996358, 3202.295494991098, 3267.787593806395, 3599.916764930334, 3660.8834305536534, 3702.092987218095, 13227.537036203687, 13677.931610342084, 13778.793318100237, 13806.171629702048, 13823.377947992365, 11441.31352118859, 11601.361925094032, 13584.252866092262, 13662.385192666354, 13742.65643358924, 9913.603455861828, 9977.950110249547, 10045.899541004643, 10139.391636501834, 10150.289479736495, 4852.0, 5328.333958255218, 6240.157578726814, 6288.465480434214, 6393.840153996187, 12012.459439325427, 12152.21010634306, 12190.329531875832, 12223.69440763988, 12339.75320493603, 10966.574345335055, 12127.81808272859, 12168.209066410654, 12218.26690398579, 12690.682732931751, 7679.539227646359, 7942.483738556975, 7965.964424624994, 7983.5209887406945, 8008.479448835807, 9579.568919398784, 9743.756406089904, 9796.9020309796, 9822.263330250402, 9864.950675246579, 7571.924280757342, 8674.30605551567, 8714.38999270045, 8778.604962776562, 8797.032326444214, 8499.32005439551, 8521.360897932556, 8553.0, 8567.74296771098, 8594.226519613265, 7515.24847515266, 7554.773356799305, 7602.467827252261, 7613.390928725578, 7651.38788896898, 4922.284941962202, 5676.233708449472, 5681.204631351531, 5742.310922689304, 5748.223989761496, 5384.246205531151, 5686.459786320293, 5888.411158884077, 5931.288245410578, 5967.164596956516], "value": 4971.807569570563, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.52634496396945, 399.50660933746826, 402.87195851615485, 406.1450646389352, 407.02517470657773, 5828.650280983139, 5992.34084250732, 6013.909791353133, 6103.359147289531, 6162.305366024346, 4765.761711914408, 5407.161889907071, 5695.316562012554, 5890.793822216213, 5953.017752070903, 3848.4804551385487, 4139.710220284582, 4385.605295523403, 4422.84520041797, 4607.262837945929, 4224.986003359187, 4409.819784300125, 4523.321501774743, 4546.204414227514, 4593.862184134481, 4253.1493701259715, 4500.729956202638, 4508.458984921797, 4523.773811309437, 4526.533039493484, 4512.345709872066, 4524.977375113136, 4532.750698711569, 4534.9319760203625, 4556.726596404226, 3796.6772824309965, 3860.7876566788814, 3899.863504777319, 3922.3134052357473, 3932.3118454270675, 4996.252810392206, 5399.541039011689, 5901.616394934315, 5916.763329466816, 6002.399760023963, 5087.389513258396, 5201.817936372247, 5317.867053323698, 5344.2518047472995, 5363.704996225206, 5097.8215762448135, 5133.743312834344, 5326.147816349366, 6416.807495775134, 6518.250401203874, 4307.8492252771, 4321.222180007598, 4329.393884856123, 4331.870043898688, 4347.5652434756585, 5316.680999140064, 6081.1790408294755, 6163.753449862, 6717.227518835348, 6830.7609233676585, 4350.890522916636, 4374.321980093091, 4403.075354175595, 4418.403515525363, 4423.955760442354, 4074.3277359235394, 4400.965773043332, 4411.691181617256, 4486.685931984795, 4494.235979883428, 5263.210518422267, 5312.415634280226, 5354.732263386815, 5415.972920135374, 5513.393526712059, 6504.62581157874, 6531.0, 6535.954247320406, 6548.869022619616, 6552.475801935833, 1511.591870195041, 1644.9718925671455, 1680.2774806832936, 1686.1232159277108, 1695.6608678264397, 1008.9243306752023, 1010.9435639756325, 1152.2830981837003, 1160.5415860735131, 1164.394514852272, 6203.937960620427, 6232.189815323979, 6240.563160578716, 6259.217597800275, 6285.025820997753, 5838.474537291664, 6619.168007354658, 6644.568103073285, 6795.7961261162245, 6832.009358642969, 5090.567301779391, 6172.031514630766, 6225.408586184305, 6235.848632221876, 6302.716377763011, 2993.3265015371367, 3493.9126521837156, 3527.664871837171, 3535.540379750616, 3540.6459354064905, 6689.6989635466525, 7044.274152832589, 7138.321859423347, 7166.355028047501, 7206.387457066103, 6054.848628784315, 6133.29467111279, 6874.209465911485, 6990.6155161465595, 7024.789256322319, 6258.967270400424, 6634.379420128926, 6961.965190174118, 7038.894416583756, 7173.6771845267085, 6757.729690812509, 6787.21946976104, 6804.693788779616, 6808.353206445379, 6811.421029212573, 5632.352279487911, 5822.912656310244, 5901.468867801918, 6302.432781049728, 6596.769113081019, 6482.448991835747, 6899.379055884994, 6906.896396553955, 7095.184053833876, 7214.2785721427435, 4402.757848318245, 4409.64722822167, 4418.756968366771, 4426.712263702849, 4427.092446048488, 5800.8259752207505, 6154.476869466145, 6468.805935821744, 6681.365270299314, 6851.794446166623, 4969.403671559436, 6443.9355606445215, 6502.219733631994, 6524.543281970216, 6584.12352479541, 5456.399796022513, 6240.290893409367, 6469.902951455638, 6517.576357536745, 6562.606243625398, 6358.809235722936, 6372.840678983062, 6403.7118329676205, 6417.422431981144, 6417.807465776034, 5473.534749546333, 6269.780557680459, 6493.279280990447, 6508.349165083454, 6511.153550038464, 5966.985612445981, 6360.840978975562, 6363.377338778582, 6376.426121649074, 6381.840453988501], "value": 4751.655657998454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [667.8630880669464, 705.308797378569, 705.3651713457888, 732.414068745004, 747.1295940229633, 14707.485238016658, 14997.850021499782, 16381.672366552662, 16387.672246555063, 16436.34254629815, 14705.705885882302, 15199.544013679608, 15270.236488175602, 15470.381184752625, 15505.844941550582, 917.0737555069378, 947.7677968897596, 953.5470651440579, 955.7706150523859, 957.1720461800527, 907.8275127725744, 936.8032713130217, 941.3222479814557, 941.8963913969458, 942.3074040580168, 993.7813680990207, 994.2096033653263, 994.9005099490065, 998.1116806042628, 998.7652901568125, 989.737719504332, 991.1822746234313, 991.1971303244395, 992.8659630949837, 998.880134383875, 737.023443936786, 737.959412232327, 740.1155619035255, 742.5470463017555, 743.2715938380363, 16158.75761863573, 16534.925229860022, 16629.83370166295, 16839.07385093819, 17159.828401716073, 14518.854811451856, 14718.190499522521, 14734.70530589393, 14841.925790371088, 14863.479778207711, 11698.649040528799, 11699.532018719241, 11793.705157371049, 12030.218035827644, 12091.879081209163, 3076.7077127672837, 3083.938321233585, 3090.3510262844607, 3106.4874295741174, 3170.952435713466, 114960.0, 115519.42240288745, 116545.0, 118417.40791295988, 120374.0, 11382.943085284685, 11499.827502587468, 11558.711032224093, 11573.88426115728, 11909.821352679717, 24973.375665608506, 25156.496870062496, 25162.993480260586, 25176.0, 25285.747142528708, 7706.961465192639, 7782.688692452239, 7852.411069169835, 7945.801354966056, 8034.035915690038, 3837.57786643469, 3902.180542086194, 3923.6076392360537, 3939.428782826474, 3951.920961580752, 3536.681698647134, 4093.2427500912427, 4109.835606575763, 4187.832486700559, 4188.497380314382, 698.1064237775655, 790.6007466229518, 793.8094857234222, 801.1347744435996, 807.9151689072563, 532.7362955337055, 544.9863254346911, 560.4871542538532, 564.7345747498669, 574.4140976204249, 8409.0, 9594.232461403071, 9820.214382849355, 10103.444310562989, 10161.339512931636, 531.3358302122347, 536.4421002157791, 583.9883202336015, 584.2054805464564, 597.1818608506375, 4381.627561657295, 4602.217623004098, 4777.378940737682, 4825.371536680718, 4902.460729319772, 85201.57399212965, 88056.11943880607, 88319.0, 92936.53531732298, 94240.52879735557, 60370.0, 80201.0, 80397.0, 81363.59318203371, 83260.0, 59526.51183720355, 60865.47836304128, 66526.66736666382, 70272.0, 72914.63542682465, 10429.739256518344, 10470.947645261725, 10709.357438553712, 10799.892001079888, 10814.783704325711, 22760.65859012083, 35103.64896351004, 36370.90887273386, 36657.26685466222, 36919.44620830636, 36358.636413635526, 46041.53958460373, 46764.7661761689, 46831.12675493078, 46869.29696054494, 12932.418041188357, 13173.275469848866, 13198.406071726604, 13314.93342533281, 13699.027137225134, 14159.716805663624, 14193.645158871112, 14259.215743134228, 14288.214148221947, 14493.78259326132, 13119.212847229197, 13166.605001849959, 13311.80032299497, 13425.462981480632, 14056.297185140907, 13133.934330328288, 13249.933750331187, 13313.879625218497, 13878.097923634932, 14146.151230926178, 10712.585776050111, 12902.80645790295, 12921.536059694674, 13087.672808179872, 13627.318634068455, 10766.542913299798, 10798.244122911321, 10845.783084338427, 11305.26515776472, 11385.601503947322, 9780.706578802647, 9948.502574871083, 9953.950230248802, 10862.511186996446, 11103.66688999299], "value": 7371.212357654896, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1594.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 115.0, 116.0, 140.0, 170.0, 157.0, 116.0, 116.0, 115.0], "value": 125.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 115.0, 114.0, 158.0, 112.0, 118.0, 115.0, 114.0, 135.0, 116.0], "value": 124.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [252.0, 199.0, 260.0, 254.0, 219.0, 184.0, 189.0, 265.0, 261.0, 194.0], "value": 227.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 74.0, 52.0, 74.0, 72.0, 85.0, 84.0, 85.0, 97.0, 60.0], "value": 76.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 84.0, 69.0, 69.0, 65.0, 84.0, 70.0, 72.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 92.0, 109.0, 119.0, 83.0, 88.0, 131.0, 129.0, 93.0, 93.0], "value": 105.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 118.0, 147.0, 99.0, 99.0, 99.0, 100.0, 100.0, 99.0, 98.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 92.0, 94.0, 93.0, 80.0, 148.0, 140.0, 86.0, 144.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 65.0, 68.0, 68.0, 67.0, 68.0, 68.0, 84.0, 94.0], "value": 71.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 57.0, 58.0, 64.0, 60.0, 57.0, 50.0, 53.0, 57.0, 50.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 77.0, 80.0, 84.0, 85.0, 85.0, 81.0, 83.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 152.0, 156.0, 145.0, 140.0, 142.0, 163.0, 198.0, 159.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 181.0, 189.0, 188.0, 188.0, 190.0, 233.0, 224.0, 223.0], "value": 199.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 69.0, 64.0, 71.0, 99.0, 95.0, 93.0, 83.0, 72.0], "value": 78.4, "unit": "score"}]}]} 20:11:52 INFO - Return code: 0 20:11:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:11:52 ERROR - # TBPL SUCCESS # 20:11:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:11:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:11:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:11:52 INFO - 2017-03-20 20:11:52.124 screenresolution[1658:10544] starting screenresolution argv=screenresolution get 20:11:52 INFO - 2017-03-20 20:11:52.126 screenresolution[1658:10544] Display 0: 1600x1200x32@60 20:11:52 INFO - 2017-03-20 20:11:52.132 screenresolution[1659:10547] starting screenresolution argv=screenresolution list 20:11:52 INFO - Available Modes on Display 0 20:11:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:11:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:11:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:11:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:11:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:11:52 INFO - Intel Iris: 20:11:52 INFO - Chipset Model: Intel Iris 20:11:52 INFO - Type: GPU 20:11:52 INFO - Bus: Built-In 20:11:52 INFO - VRAM (Dynamic, Max): 1536 MB 20:11:52 INFO - Vendor: Intel (0x8086) 20:11:52 INFO - Device ID: 0x0a2e 20:11:52 INFO - Revision ID: 0x0009 20:11:52 INFO - Displays: 20:11:52 INFO - Display: 20:11:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:11:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:11:52 INFO - Display Serial Number: 1600x1200 60 20:11:52 INFO - Main Display: Yes 20:11:52 INFO - Mirror: Off 20:11:52 INFO - Online: Yes 20:11:52 INFO - Rotation: Supported 20:11:52 INFO - Return code: 0 20:11:52 INFO - Running post-action listener: _resource_record_post_action 20:11:52 INFO - [mozharness: 2017-03-21 03:11:52.367387Z] Finished run-tests step (success) 20:11:52 INFO - Running post-run listener: _resource_record_post_run 20:11:52 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 38849024; Write bytes: 517307392; Read time: 249; Write time: 1604 20:11:52 INFO - TinderboxPrint: CPU usage
54.1% 20:11:52 INFO - TinderboxPrint: I/O read bytes / time
38,849,024 / 249 20:11:52 INFO - TinderboxPrint: I/O write bytes / time
517,307,392 / 1,604 20:11:52 INFO - TinderboxPrint: CPU idle
2,203.8 (45.9%) 20:11:52 INFO - TinderboxPrint: CPU system
967.9 (20.1%) 20:11:52 INFO - TinderboxPrint: CPU user
1,634.1 (34.0%) 20:11:52 INFO - TinderboxPrint: Swap in / out
249,352,192 / 0 20:11:52 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 211753472; Write bytes: 213977088; Read time: 16795; Write time: 472 20:11:52 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 35129856; Write bytes: 301986816; Read time: 222; Write time: 1127 20:11:52 INFO - Running post-run listener: _upload_blobber_files 20:11:52 INFO - Blob upload gear active. 20:11:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:11:52 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 20:11:52 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'] 20:11:52 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 20:11:53 INFO - (blobuploader) - INFO - Open directory for files ... 20:11:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:11:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:11:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:54 INFO - (blobuploader) - INFO - Done attempting. 20:11:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:11:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:11:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:55 INFO - (blobuploader) - INFO - Done attempting. 20:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:56 INFO - (blobuploader) - INFO - Done attempting. 20:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:11:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:11:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:11:59 INFO - (blobuploader) - INFO - Done attempting. 20:11:59 INFO - (blobuploader) - INFO - Iteration through files over. 20:11:59 INFO - Return code: 0 20:11:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:11:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:11:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21cc25eef301f16b36bcacc7c8276736aa351b0c81cbc75ea6e9e0cc105b42237eab307e27e71c9f4186ebc5785dd16e2433a238c7f8be2e5bece8f3ffba15a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f50decb4503c5145bd7334c0663ef7ee49c2c7a00ed1a581639a533006472715bae3bd8bf7bdad49e982c5f22c09b328aac1e100e3f22fa8ece659ad2fa64c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fd0b91c16990400eaeb44e540900ac3354ec9aae92a211ab047c9be232a7bac98d93a08dafdd9fa88f9dd2c12e7d22ed1d318ff1e94f67f17d1507b37b0303", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496bbc890ab3e3cd9f46c386367248fcddd8ffab3a52c0f757a3f86b72bff95d5db23ce51aa6076490e94e8b452801c0813c75bc742b48e8086395bc325de107"} 20:11:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:11:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:11:59 INFO - Contents: 20:11:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f21cc25eef301f16b36bcacc7c8276736aa351b0c81cbc75ea6e9e0cc105b42237eab307e27e71c9f4186ebc5785dd16e2433a238c7f8be2e5bece8f3ffba15a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f50decb4503c5145bd7334c0663ef7ee49c2c7a00ed1a581639a533006472715bae3bd8bf7bdad49e982c5f22c09b328aac1e100e3f22fa8ece659ad2fa64c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fd0b91c16990400eaeb44e540900ac3354ec9aae92a211ab047c9be232a7bac98d93a08dafdd9fa88f9dd2c12e7d22ed1d318ff1e94f67f17d1507b37b0303", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496bbc890ab3e3cd9f46c386367248fcddd8ffab3a52c0f757a3f86b72bff95d5db23ce51aa6076490e94e8b452801c0813c75bc742b48e8086395bc325de107"} 20:11:59 INFO - Running post-run listener: copy_logs_to_upload_dir 20:11:59 INFO - Copying logs to upload dir... 20:11:59 INFO - mkdir: /builds/slave/test/build/upload/logs 20:11:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.894802 ========= master_lag: 1.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-20 20:12:00.248114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 20:12:00.251202) ========= 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.gy6dxQFRqA/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.eiAS6otnMc/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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/f21cc25eef301f16b36bcacc7c8276736aa351b0c81cbc75ea6e9e0cc105b42237eab307e27e71c9f4186ebc5785dd16e2433a238c7f8be2e5bece8f3ffba15a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f50decb4503c5145bd7334c0663ef7ee49c2c7a00ed1a581639a533006472715bae3bd8bf7bdad49e982c5f22c09b328aac1e100e3f22fa8ece659ad2fa64c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fd0b91c16990400eaeb44e540900ac3354ec9aae92a211ab047c9be232a7bac98d93a08dafdd9fa88f9dd2c12e7d22ed1d318ff1e94f67f17d1507b37b0303", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496bbc890ab3e3cd9f46c386367248fcddd8ffab3a52c0f757a3f86b72bff95d5db23ce51aa6076490e94e8b452801c0813c75bc742b48e8086395bc325de107"} build_url:https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011097 build_url: 'https://queue.taskcluster.net/v1/task/LcLXfEwYTwiCwP4drUhn4Q/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/f21cc25eef301f16b36bcacc7c8276736aa351b0c81cbc75ea6e9e0cc105b42237eab307e27e71c9f4186ebc5785dd16e2433a238c7f8be2e5bece8f3ffba15a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/12f50decb4503c5145bd7334c0663ef7ee49c2c7a00ed1a581639a533006472715bae3bd8bf7bdad49e982c5f22c09b328aac1e100e3f22fa8ece659ad2fa64c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/67fd0b91c16990400eaeb44e540900ac3354ec9aae92a211ab047c9be232a7bac98d93a08dafdd9fa88f9dd2c12e7d22ed1d318ff1e94f67f17d1507b37b0303", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496bbc890ab3e3cd9f46c386367248fcddd8ffab3a52c0f757a3f86b72bff95d5db23ce51aa6076490e94e8b452801c0813c75bc742b48e8086395bc325de107"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 20:12:00.285586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 20:12:00.285957) ========= 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.gy6dxQFRqA/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.eiAS6otnMc/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.005451 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 20:12:00.334557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 20:12:00.334879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 20:12:00.335195) ========= ========= Total master_lag: 1.23 =========