builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0255 starttime: 1483590246.71 results: success (0) buildid: 20170104182942 builduid: 8b68893678b04effb9bd0ed62d9ef9d4 revision: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.711332) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.711776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.712065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.739625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.740043) ========= 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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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-01-04 20:24:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 171M=0s 2017-01-04 20:24:06 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080935 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.845081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.845432) ========= 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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.027038 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:06.894596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 20:24:06.894987) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1bf65dbb4d71ccc02ad63b95a039112073d83e5e --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 1bf65dbb4d71ccc02ad63b95a039112073d83e5e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qjCRWa9GpH/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.YxGuhmz2kN/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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-01-04 20:24:06,992 truncating revision to first 12 chars 2017-01-04 20:24:06,992 Setting DEBUG logging. 2017-01-04 20:24:06,992 attempt 1/10 2017-01-04 20:24:06,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1bf65dbb4d71?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 20:24:08,029 unpacking tar archive at: mozilla-central-1bf65dbb4d71/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313291 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 20:24:08.232462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:08.232847) ========= script_repo_revision: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:08.233275) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:08.233569) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 20:24:08.253835) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-04 20:24:08.254234) ========= /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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:08 INFO - MultiFileLogger online at 20170104 20:24:08 in /builds/slave/test 20:24:08 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 20:24:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:24:08 INFO - {'append_to_log': False, 20:24:08 INFO - 'base_work_dir': '/builds/slave/test', 20:24:08 INFO - 'blob_upload_branch': 'Firefox', 20:24:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:24:08 INFO - 'branch': 'Firefox', 20:24:08 INFO - 'buildbot_json_path': 'buildprops.json', 20:24:08 INFO - 'config_files': ('talos/mac_config.py',), 20:24:08 INFO - 'default_actions': ('clobber', 20:24:08 INFO - 'read-buildbot-config', 20:24:08 INFO - 'download-and-extract', 20:24:08 INFO - 'populate-webroot', 20:24:08 INFO - 'create-virtualenv', 20:24:08 INFO - 'install', 20:24:08 INFO - 'run-tests'), 20:24:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:24:08 INFO - 'download_minidump_stackwalk': True, 20:24:08 INFO - 'download_symbols': 'ondemand', 20:24:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:24:08 INFO - 'tooltool.py': '/tools/tooltool.py', 20:24:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:24:08 INFO - '/tools/misc-python/virtualenv.py')}, 20:24:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:24:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:24:08 INFO - 'installer_path': 'installer.exe', 20:24:08 INFO - 'log_level': 'info', 20:24:08 INFO - 'log_name': 'talos', 20:24:08 INFO - 'log_to_console': True, 20:24:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:24:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:24:08 INFO - 'opt_config_files': (), 20:24:08 INFO - 'pip_index': False, 20:24:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:24:08 INFO - 'cmd': ('bash', 20:24:08 INFO - '-c', 20:24:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:24:08 INFO - 'enabled': True, 20:24:08 INFO - 'halt_on_failure': False, 20:24:08 INFO - 'name': 'check_screen_resolution'},), 20:24:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:24:08 INFO - 'cmd': ('bash', 20:24:08 INFO - '-c', 20:24:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:24:08 INFO - 'enabled': True, 20:24:08 INFO - 'halt_on_failure': False, 20:24:08 INFO - 'name': 'check_screen_resolution'},), 20:24:08 INFO - 'run_cmd_checks_enabled': True, 20:24:08 INFO - 'sps_profile': False, 20:24:08 INFO - 'sps_profile_interval': 0, 20:24:08 INFO - 'suite': 'dromaeojs-e10s', 20:24:08 INFO - 'system_bits': '32', 20:24:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:24:08 INFO - 'title': 't-yosemite-r7-0255', 20:24:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:24:08 INFO - 'use_talos_json': True, 20:24:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:24:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:24:08 INFO - 'work_dir': 'build'} 20:24:08 INFO - [mozharness: 2017-01-05 04:24:08.454123Z] Running clobber step. 20:24:08 INFO - Running pre-action listener: _resource_record_pre_action 20:24:08 INFO - Running main action method: clobber 20:24:08 INFO - rmtree: /builds/slave/test/build 20:24:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:24:11 INFO - Running post-action listener: _resource_record_post_action 20:24:11 INFO - [mozharness: 2017-01-05 04:24:11.067705Z] Finished clobber step (success) 20:24:11 INFO - [mozharness: 2017-01-05 04:24:11.067830Z] Running read-buildbot-config step. 20:24:11 INFO - Running pre-action listener: _resource_record_pre_action 20:24:11 INFO - Running main action method: read_buildbot_config 20:24:11 INFO - Using buildbot properties: 20:24:11 INFO - { 20:24:11 INFO - "project": "", 20:24:11 INFO - "product": "firefox", 20:24:11 INFO - "script_repo_revision": "production", 20:24:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:24:11 INFO - "repository": "", 20:24:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:24:11 INFO - "buildid": "20170104182942", 20:24:11 INFO - "pgo_build": "False", 20:24:11 INFO - "basedir": "/builds/slave/test", 20:24:11 INFO - "buildnumber": 45, 20:24:11 INFO - "slavename": "t-yosemite-r7-0255", 20:24:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 20:24:11 INFO - "platform": "yosemite_r7", 20:24:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:24:11 INFO - "branch": "mozilla-central", 20:24:11 INFO - "repo_path": "mozilla-central", 20:24:11 INFO - "revision": "1bf65dbb4d71ccc02ad63b95a039112073d83e5e", 20:24:11 INFO - "stage_platform": "macosx64", 20:24:11 INFO - "builduid": "8b68893678b04effb9bd0ed62d9ef9d4", 20:24:11 INFO - "slavebuilddir": "test" 20:24:11 INFO - } 20:24:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 20:24:11 INFO - Running post-action listener: _resource_record_post_action 20:24:11 INFO - [mozharness: 2017-01-05 04:24:11.071095Z] Finished read-buildbot-config step (success) 20:24:11 INFO - [mozharness: 2017-01-05 04:24:11.071250Z] Running download-and-extract step. 20:24:11 INFO - Running pre-action listener: _resource_record_pre_action 20:24:11 INFO - Running main action method: download_and_extract 20:24:11 INFO - mkdir: /builds/slave/test/build/tests 20:24: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')]} 20:24:11 INFO - trying https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 20:24:11 INFO - Downloading https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:24:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 20:24:12 INFO - Downloaded 1199 bytes. 20:24:12 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 20:24:12 INFO - Using the following test package requirements: 20:24:12 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:24:12 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 20:24:12 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 20:24:12 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'jsshell-mac.zip'], 20:24:12 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 20:24:12 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 20:24:12 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 20:24:12 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 20:24:12 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 20:24:12 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 20:24:12 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 20:24:12 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:24:12 INFO - Fetch https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:24:13 INFO - Expected file size: 16298520 20:24:13 INFO - Obtained file size: 16298520 20:24:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 20:24:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 20:24:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:24:19 INFO - Fetch https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 20:24:20 INFO - Expected file size: 16298520 20:24:20 INFO - Obtained file size: 16298520 20:24:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 20:24:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:24:27 INFO - Fetch https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 20:24:27 INFO - Expected file size: 14403730 20:24:27 INFO - Obtained file size: 14403730 20:24:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:28 INFO - trying https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:24:28 INFO - Downloading https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 20:24:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 20:24:30 INFO - Downloaded 69654942 bytes. 20:24:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:24:30 INFO - mkdir: /builds/slave/test/properties 20:24:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:24:30 INFO - Writing to file /builds/slave/test/properties/build_url 20:24:30 INFO - Contents: 20:24:30 INFO - build_url:https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 20:24:30 INFO - Running post-action listener: _resource_record_post_action 20:24:30 INFO - Running post-action listener: set_extra_try_arguments 20:24:30 INFO - [mozharness: 2017-01-05 04:24:30.841137Z] Finished download-and-extract step (success) 20:24:30 INFO - [mozharness: 2017-01-05 04:24:30.841294Z] Running populate-webroot step. 20:24:30 INFO - Running pre-action listener: _resource_record_pre_action 20:24:30 INFO - Running main action method: populate_webroot 20:24:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:24:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:24:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:24:30 INFO - '--tppagecycles', 20:24:30 INFO - '7'], 20:24:30 INFO - 'tests': ['tsvgm']}}, 20:24:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:24:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:24:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:24:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:24:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:24:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['damp', 'tps']}, 20:24:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'tests': ['damp', 'tps']}, 20:24:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['dromaeo_dom']}, 20:24:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:24:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['basic_compositor_video']}, 20:24:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:24:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['a11yr', 20:24:30 INFO - 'ts_paint', 20:24:30 INFO - 'tpaint', 20:24:30 INFO - 'sessionrestore', 20:24:30 INFO - 'sessionrestore_no_auto_restore', 20:24:30 INFO - 'tabpaint']}, 20:24:30 INFO - 'other-e10s': {'tests': ['a11yr', 20:24:30 INFO - 'ts_paint', 20:24:30 INFO - 'tpaint', 20:24:30 INFO - 'sessionrestore', 20:24:30 INFO - 'sessionrestore_no_auto_restore', 20:24:30 INFO - 'tabpaint']}, 20:24:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:24:30 INFO - 'ts_paint', 20:24:30 INFO - 'tpaint', 20:24:30 INFO - 'sessionrestore', 20:24:30 INFO - 'sessionrestore_no_auto_restore', 20:24:30 INFO - 'tabpaint']}, 20:24:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:24:30 INFO - 'ts_paint', 20:24:30 INFO - 'tpaint', 20:24:30 INFO - 'sessionrestore', 20:24:30 INFO - 'sessionrestore_no_auto_restore', 20:24:30 INFO - 'tabpaint']}, 20:24:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['a11yr', 20:24:30 INFO - 'ts_paint', 20:24:30 INFO - 'tpaint', 20:24:30 INFO - 'sessionrestore', 20:24:30 INFO - 'sessionrestore_no_auto_restore', 20:24:30 INFO - 'tabpaint']}, 20:24:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['a11yr', 20:24:30 INFO - 'ts_paint', 20:24:30 INFO - 'tpaint', 20:24:30 INFO - 'sessionrestore', 20:24:30 INFO - 'sessionrestore_no_auto_restore', 20:24:30 INFO - 'tabpaint']}, 20:24:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['tsvgx', 20:24:30 INFO - 'tsvgr_opacity', 20:24:30 INFO - 'tart', 20:24:30 INFO - 'tscrollx', 20:24:30 INFO - 'cart', 20:24:30 INFO - 'tsvg_static']}, 20:24:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:24:30 INFO - 'tsvgr_opacity', 20:24:30 INFO - 'tart', 20:24:30 INFO - 'tscrollx', 20:24:30 INFO - 'cart', 20:24:30 INFO - 'tsvg_static']}, 20:24:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'talos_options': ['--disable-e10s'], 20:24:30 INFO - 'tests': ['tp5o']}, 20:24:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:24:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'talos_options': ['--disable-e10s', 20:24:30 INFO - '--xperf_path', 20:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:30 INFO - 'tests': ['tp5n']}, 20:24:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:24:30 INFO - 'talos_options': ['--xperf_path', 20:24:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:24:30 INFO - 'tests': ['tp5n']}}, 20:24:30 INFO - 'talos.zip': {'path': '', 20:24:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:24:30 INFO - Running post-action listener: _resource_record_post_action 20:24:30 INFO - [mozharness: 2017-01-05 04:24:30.859617Z] Finished populate-webroot step (success) 20:24:30 INFO - [mozharness: 2017-01-05 04:24:30.859752Z] Running create-virtualenv step. 20:24:30 INFO - Running pre-action listener: _resource_record_pre_action 20:24:30 INFO - Running main action method: create_virtualenv 20:24:30 INFO - Creating virtualenv /builds/slave/test/build/venv 20:24:30 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 20:24:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:24:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:24:30 INFO - Using real prefix '/tools/python27' 20:24:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:24:31 INFO - Installing distribute.............................................................................................................................................................................................done. 20:24:34 INFO - Installing pip.................done. 20:24:34 INFO - Return code: 0 20:24:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:24:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:24:34 INFO - Reading from file tmpfile_stdout 20:24:34 INFO - Output received: 20:24:34 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) 20:24:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24: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', 'pip>=1.5'] in /builds/slave/test/build 20:24: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 pip>=1.5 20:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:34 INFO - 'HOME': '/Users/cltbld', 20:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:34 INFO - 'LOGNAME': 'cltbld', 20:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:34 INFO - 'MOZ_NO_REMOTE': '1', 20:24:34 INFO - 'NO_EM_RESTART': '1', 20:24:34 INFO - 'PAGER': '/bin/cat', 20:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:34 INFO - 'PWD': '/builds/slave/test', 20:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:34 INFO - 'SHELL': '/bin/bash', 20:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:34 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:34 INFO - 'USER': 'cltbld', 20:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:34 INFO - 'XPC_FLAGS': '0x0', 20:24:34 INFO - 'XPC_SERVICE_NAME': '0', 20:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:35 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 20:24:35 INFO - Cleaning up... 20:24:35 INFO - Return code: 0 20:24:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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', '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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:24: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 psutil>=3.1.1 20:24:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:35 INFO - 'HOME': '/Users/cltbld', 20:24:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:35 INFO - 'LOGNAME': 'cltbld', 20:24:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:35 INFO - 'MOZ_NO_REMOTE': '1', 20:24:35 INFO - 'NO_EM_RESTART': '1', 20:24:35 INFO - 'PAGER': '/bin/cat', 20:24:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:35 INFO - 'PWD': '/builds/slave/test', 20:24:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:35 INFO - 'SHELL': '/bin/bash', 20:24:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:35 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:35 INFO - 'USER': 'cltbld', 20:24:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:35 INFO - 'XPC_FLAGS': '0x0', 20:24:35 INFO - 'XPC_SERVICE_NAME': '0', 20:24:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:35 INFO - Downloading/unpacking psutil>=3.1.1 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:24:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:38 INFO - Installing collected packages: psutil 20:24:38 INFO - Running setup.py install for psutil 20:24:39 INFO - building 'psutil._psutil_osx' extension 20:24:39 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 20:24:39 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 20:24:39 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 20:24:39 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 20:24:39 INFO - building 'psutil._psutil_posix' extension 20:24:39 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 20:24:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:24:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:24:39 INFO - ^ 20:24:39 INFO - 1 warning generated. 20:24:39 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 20:24:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:24:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:24:40 INFO - Successfully installed psutil 20:24:40 INFO - Cleaning up... 20:24:40 INFO - Return code: 0 20:24:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:24: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')]} 20:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24: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')]} 20:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:40 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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:40 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 20:24:40 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 20:24:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:40 INFO - 'HOME': '/Users/cltbld', 20:24:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:40 INFO - 'LOGNAME': 'cltbld', 20:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:40 INFO - 'MOZ_NO_REMOTE': '1', 20:24:40 INFO - 'NO_EM_RESTART': '1', 20:24:40 INFO - 'PAGER': '/bin/cat', 20:24:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:40 INFO - 'PWD': '/builds/slave/test', 20:24:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:40 INFO - 'SHELL': '/bin/bash', 20:24:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:40 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:40 INFO - 'USER': 'cltbld', 20:24:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:40 INFO - 'XPC_FLAGS': '0x0', 20:24:40 INFO - 'XPC_SERVICE_NAME': '0', 20:24:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:24:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:24:43 INFO - Installing collected packages: mozsystemmonitor 20:24:43 INFO - Running setup.py install for mozsystemmonitor 20:24:43 INFO - Successfully installed mozsystemmonitor 20:24:43 INFO - Cleaning up... 20:24:43 INFO - Return code: 0 20:24:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:24:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:24:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:43 INFO - 'HOME': '/Users/cltbld', 20:24:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:43 INFO - 'LOGNAME': 'cltbld', 20:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:43 INFO - 'MOZ_NO_REMOTE': '1', 20:24:43 INFO - 'NO_EM_RESTART': '1', 20:24:43 INFO - 'PAGER': '/bin/cat', 20:24:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:43 INFO - 'PWD': '/builds/slave/test', 20:24:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:43 INFO - 'SHELL': '/bin/bash', 20:24:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:43 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:43 INFO - 'USER': 'cltbld', 20:24:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:43 INFO - 'XPC_FLAGS': '0x0', 20:24:43 INFO - 'XPC_SERVICE_NAME': '0', 20:24:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:43 INFO - Downloading/unpacking jsonschema==2.5.1 20:24:43 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 20:24:43 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 20:24:43 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 20:24:43 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 20:24:43 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 20:24:43 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 20:24:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:24:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24: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 20:24:46 INFO - Downloading functools32-3.2.3-2.tar.gz 20:24:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:24:46 INFO - warning: no files found matching '*.txt' 20:24:46 INFO - no previously-included directories found matching 'build' 20:24:46 INFO - no previously-included directories found matching 'dist' 20:24:46 INFO - no previously-included directories found matching '.git*' 20:24:46 INFO - Installing collected packages: jsonschema, functools32 20:24:46 INFO - Running setup.py install for functools32 20:24:46 INFO - warning: no files found matching '*.txt' 20:24:46 INFO - no previously-included directories found matching 'build' 20:24:46 INFO - no previously-included directories found matching 'dist' 20:24:46 INFO - no previously-included directories found matching '.git*' 20:24:46 INFO - Successfully installed jsonschema functools32 20:24:46 INFO - Cleaning up... 20:24:47 INFO - Return code: 0 20:24:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:47 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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:47 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 20:24:47 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 20:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:47 INFO - 'HOME': '/Users/cltbld', 20:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:47 INFO - 'LOGNAME': 'cltbld', 20:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:47 INFO - 'MOZ_NO_REMOTE': '1', 20:24:47 INFO - 'NO_EM_RESTART': '1', 20:24:47 INFO - 'PAGER': '/bin/cat', 20:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:47 INFO - 'PWD': '/builds/slave/test', 20:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:47 INFO - 'SHELL': '/bin/bash', 20:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:47 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:47 INFO - 'USER': 'cltbld', 20:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:47 INFO - 'XPC_FLAGS': '0x0', 20:24:47 INFO - 'XPC_SERVICE_NAME': '0', 20:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:24:47 INFO - Cleaning up... 20:24:47 INFO - Return code: 0 20:24:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:47 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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:47 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 20:24:47 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 20:24:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:47 INFO - 'HOME': '/Users/cltbld', 20:24:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:47 INFO - 'LOGNAME': 'cltbld', 20:24:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:47 INFO - 'MOZ_NO_REMOTE': '1', 20:24:47 INFO - 'NO_EM_RESTART': '1', 20:24:47 INFO - 'PAGER': '/bin/cat', 20:24:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:47 INFO - 'PWD': '/builds/slave/test', 20:24:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:47 INFO - 'SHELL': '/bin/bash', 20:24:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:47 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:47 INFO - 'USER': 'cltbld', 20:24:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:47 INFO - 'XPC_FLAGS': '0x0', 20:24:47 INFO - 'XPC_SERVICE_NAME': '0', 20:24:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:47 INFO - Downloading/unpacking blobuploader==1.2.4 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 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 20:24:47 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 20:24:50 INFO - Downloading blobuploader-1.2.4.tar.gz 20:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:24:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:24:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:24:51 INFO - Downloading docopt-0.6.1.tar.gz 20:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:24:51 INFO - Installing collected packages: blobuploader, requests, docopt 20:24:51 INFO - Running setup.py install for blobuploader 20:24:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:24:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:24:51 INFO - Running setup.py install for requests 20:24:52 INFO - Running setup.py install for docopt 20:24:52 INFO - Successfully installed blobuploader requests docopt 20:24:52 INFO - Cleaning up... 20:24:52 INFO - Return code: 0 20:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:52 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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:52 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 20:24:52 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 20:24:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:52 INFO - 'HOME': '/Users/cltbld', 20:24:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:52 INFO - 'LOGNAME': 'cltbld', 20:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:52 INFO - 'MOZ_NO_REMOTE': '1', 20:24:52 INFO - 'NO_EM_RESTART': '1', 20:24:52 INFO - 'PAGER': '/bin/cat', 20:24:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:52 INFO - 'PWD': '/builds/slave/test', 20:24:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:52 INFO - 'SHELL': '/bin/bash', 20:24:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:52 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:52 INFO - 'USER': 'cltbld', 20:24:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:52 INFO - 'XPC_FLAGS': '0x0', 20:24:52 INFO - 'XPC_SERVICE_NAME': '0', 20:24:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:52 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-yG8Fsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:52 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-rYH0g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:52 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-CjPDVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:52 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-tkuoq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-ACZm8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-mdwMIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Fj3QWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-7UQe6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-GksIJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Te_FNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-7TxQX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-FZS_un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-XeufO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:53 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-etn3Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-Ec3PsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-ypsIjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:54 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-IRogaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:24:54 INFO - Running setup.py install for manifestparser 20:24:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:24:54 INFO - Running setup.py install for mozcrash 20:24:54 INFO - Running setup.py install for mozdebug 20:24:54 INFO - Running setup.py install for mozdevice 20:24:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:24:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:24:54 INFO - Running setup.py install for mozfile 20:24:55 INFO - Running setup.py install for mozhttpd 20:24:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Running setup.py install for mozinfo 20:24:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Running setup.py install for mozInstall 20:24:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Running setup.py install for mozleak 20:24:55 INFO - Running setup.py install for mozlog 20:24:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:24:55 INFO - Running setup.py install for moznetwork 20:24:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozprocess 20:24:56 INFO - Running setup.py install for mozprofile 20:24:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozrunner 20:24:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Running setup.py install for mozscreenshot 20:24:56 INFO - Running setup.py install for moztest 20:24:56 INFO - Running setup.py install for mozversion 20:24:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:24:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:24:56 INFO - Cleaning up... 20:24:56 INFO - Return code: 0 20:24:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:24:56 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')]} 20:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:56 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')]} 20:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:24:56 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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:24:56 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 20:24:56 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 20:24:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:24:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:24:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:24:56 INFO - 'HOME': '/Users/cltbld', 20:24:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:24:56 INFO - 'LOGNAME': 'cltbld', 20:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:24:56 INFO - 'MOZ_NO_REMOTE': '1', 20:24:56 INFO - 'NO_EM_RESTART': '1', 20:24:56 INFO - 'PAGER': '/bin/cat', 20:24:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:24:56 INFO - 'PWD': '/builds/slave/test', 20:24:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:24:56 INFO - 'SHELL': '/bin/bash', 20:24:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:24:56 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:24:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:24:56 INFO - 'USER': 'cltbld', 20:24:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:24:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:24:56 INFO - 'XPC_FLAGS': '0x0', 20:24:56 INFO - 'XPC_SERVICE_NAME': '0', 20:24:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-av0obs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-iZZj1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-DYpcFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-nIzVGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-DwAo7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-DIEz5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-PTqAHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:24:57 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)) 20:24:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:24:57 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-6TJ4lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-16zmWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-36qOQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-hw_crq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-pFSlmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-2n2me8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-N3xCXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-D5Be7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-f5ykoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:24:58 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)) 20:24:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:24:58 INFO - Running setup.py (path:/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/pip-HQE7YT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:24:59 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)) 20:24:59 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)) 20:24:59 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)) 20:24:59 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)) 20:24:59 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)) 20:24:59 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)) 20:24:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:24:59 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 20:24:59 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 20:24:59 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 20:24:59 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 20:24:59 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 20:24:59 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 20:25:01 INFO - Downloading blessings-1.6.tar.gz 20:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:25:01 INFO - Installing collected packages: blessings 20:25:01 INFO - Running setup.py install for blessings 20:25:01 INFO - Successfully installed blessings 20:25:01 INFO - Cleaning up... 20:25:02 INFO - Return code: 0 20:25:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:25:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:02 INFO - Reading from file tmpfile_stdout 20:25:02 INFO - Current package versions: 20:25:02 INFO - blessings == 1.6 20:25:02 INFO - blobuploader == 1.2.4 20:25:02 INFO - docopt == 0.6.1 20:25:02 INFO - functools32 == 3.2.3-2 20:25:02 INFO - jsonschema == 2.5.1 20:25:02 INFO - manifestparser == 1.1 20:25:02 INFO - mozInstall == 1.12 20:25:02 INFO - mozcrash == 1.0 20:25:02 INFO - mozdebug == 0.1 20:25:02 INFO - mozdevice == 0.49 20:25:02 INFO - mozfile == 1.2 20:25:02 INFO - mozhttpd == 0.7 20:25:02 INFO - mozinfo == 0.9 20:25:02 INFO - mozleak == 0.1 20:25:02 INFO - mozlog == 3.4 20:25:02 INFO - moznetwork == 0.27 20:25:02 INFO - mozprocess == 0.23 20:25:02 INFO - mozprofile == 0.28 20:25:02 INFO - mozrunner == 6.13 20:25:02 INFO - mozscreenshot == 0.1 20:25:02 INFO - mozsystemmonitor == 0.3 20:25:02 INFO - moztest == 0.8 20:25:02 INFO - mozversion == 1.4 20:25:02 INFO - psutil == 3.1.1 20:25:02 INFO - requests == 1.2.3 20:25:02 INFO - wsgiref == 0.1.2 20:25:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:25:02 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')]} 20:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:02 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')]} 20:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:02 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 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:25:02 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 20:25:02 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 20:25:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:25:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:02 INFO - 'HOME': '/Users/cltbld', 20:25:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:02 INFO - 'LOGNAME': 'cltbld', 20:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:02 INFO - 'MOZ_NO_REMOTE': '1', 20:25:02 INFO - 'NO_EM_RESTART': '1', 20:25:02 INFO - 'PAGER': '/bin/cat', 20:25:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:02 INFO - 'PWD': '/builds/slave/test', 20:25:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:02 INFO - 'SHELL': '/bin/bash', 20:25:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:25:02 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:25:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:02 INFO - 'USER': 'cltbld', 20:25:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:02 INFO - 'XPC_FLAGS': '0x0', 20:25:02 INFO - 'XPC_SERVICE_NAME': '0', 20:25:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 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)) 20:25:02 INFO - Cleaning up... 20:25:02 INFO - Return code: 0 20:25:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:25:02 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')]} 20:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:02 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')]} 20:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:25:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a8cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a8f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85fb57c010>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, '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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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 20:25:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:25:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:25:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:03 INFO - 'HOME': '/Users/cltbld', 20:25:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:03 INFO - 'LOGNAME': 'cltbld', 20:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:03 INFO - 'MOZ_NO_REMOTE': '1', 20:25:03 INFO - 'NO_EM_RESTART': '1', 20:25:03 INFO - 'PAGER': '/bin/cat', 20:25:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:03 INFO - 'PWD': '/builds/slave/test', 20:25:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:03 INFO - 'SHELL': '/bin/bash', 20:25:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:25:03 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:25:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:03 INFO - 'USER': 'cltbld', 20:25:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:03 INFO - 'XPC_FLAGS': '0x0', 20:25:03 INFO - 'XPC_SERVICE_NAME': '0', 20:25:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:25:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:25:03 INFO - Cleaning up... 20:25:03 INFO - Return code: 0 20:25:03 INFO - Running post-action listener: _resource_record_post_action 20:25:03 INFO - Running post-action listener: _start_resource_monitoring 20:25:03 INFO - Starting resource monitoring. 20:25:03 INFO - [mozharness: 2017-01-05 04:25:03.698273Z] Finished create-virtualenv step (success) 20:25:03 INFO - [mozharness: 2017-01-05 04:25:03.699182Z] Running install step. 20:25:03 INFO - Running pre-action listener: _resource_record_pre_action 20:25:03 INFO - Running main action method: install 20:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:25:03 INFO - Reading from file tmpfile_stdout 20:25:03 INFO - Detecting whether we're running mozinstall >=1.0... 20:25:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:25:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:25:04 INFO - Reading from file tmpfile_stdout 20:25:04 INFO - Output received: 20:25:04 INFO - Usage: mozinstall [options] installer 20:25:04 INFO - Options: 20:25:04 INFO - -h, --help show this help message and exit 20:25:04 INFO - -d DEST, --destination=DEST 20:25:04 INFO - Directory to install application into. [default: 20:25:04 INFO - "/builds/slave/test"] 20:25:04 INFO - --app=APP Application being installed. [default: firefox] 20:25:04 INFO - mkdir: /builds/slave/test/build/application 20:25:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 20:25:25 INFO - Reading from file tmpfile_stdout 20:25:25 INFO - Output received: 20:25:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:25:25 INFO - Running post-action listener: _resource_record_post_action 20:25:25 INFO - [mozharness: 2017-01-05 04:25:25.535183Z] Finished install step (success) 20:25:25 INFO - [mozharness: 2017-01-05 04:25:25.535314Z] Running run-tests step. 20:25:25 INFO - Running pre-action listener: _resource_record_pre_action 20:25:25 INFO - Running main action method: run_tests 20:25:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:25:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:25:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:25:25 INFO - 2017-01-04 20:25:25.549 screenresolution[1626:7434] starting screenresolution argv=screenresolution get 20:25:25 INFO - 2017-01-04 20:25:25.552 screenresolution[1626:7434] Display 0: 1600x1200x32@60 20:25:25 INFO - 2017-01-04 20:25:25.558 screenresolution[1627:7437] starting screenresolution argv=screenresolution list 20:25:25 INFO - Available Modes on Display 0 20:25:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:25:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:25:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:25:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:25:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:25:25 INFO - Intel Iris: 20:25:25 INFO - Chipset Model: Intel Iris 20:25:25 INFO - Type: GPU 20:25:25 INFO - Bus: Built-In 20:25:25 INFO - VRAM (Dynamic, Max): 1536 MB 20:25:25 INFO - Vendor: Intel (0x8086) 20:25:25 INFO - Device ID: 0x0a2e 20:25:25 INFO - Revision ID: 0x0009 20:25:25 INFO - Displays: 20:25:25 INFO - Display: 20:25:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:25:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:25:25 INFO - Display Serial Number: 1600x1200 60 20:25:25 INFO - Main Display: Yes 20:25:25 INFO - Mirror: Off 20:25:25 INFO - Online: Yes 20:25:25 INFO - Rotation: Supported 20:25:25 INFO - Return code: 0 20:25:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:25:25 INFO - Python 2.7.3 20:25:25 INFO - Return code: 0 20:25:25 INFO - grabbing minidump binary from tooltool 20:25:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:25:25 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 0x10586ad30>, '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 0x105791db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10585fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:25:25 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 20:25:25 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 20:25:25 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 20:25:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:25:25 INFO - Return code: 0 20:25:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:25:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:25:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:25:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:25:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:25:25 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/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--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 20:25:25 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/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0255 --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 20:25:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qjCRWa9GpH/Render', 20:25:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:25:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:25:25 INFO - 'HOME': '/Users/cltbld', 20:25:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:25:25 INFO - 'LOGNAME': 'cltbld', 20:25:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:25:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:25:25 INFO - 'MOZ_NO_REMOTE': '1', 20:25:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:25:25 INFO - 'NO_EM_RESTART': '1', 20:25:25 INFO - 'PAGER': '/bin/cat', 20:25:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:25:25 INFO - 'PWD': '/builds/slave/test', 20:25:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:25:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:25:25 INFO - 'SHELL': '/bin/bash', 20:25:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YxGuhmz2kN/Listeners', 20:25:25 INFO - 'TMPDIR': '/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/', 20:25:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:25:25 INFO - 'USER': 'cltbld', 20:25:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:25:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:25:25 INFO - 'XPC_FLAGS': '0x0', 20:25:25 INFO - 'XPC_SERVICE_NAME': '0', 20:25:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:25:25 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/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0255', '--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 20:25:26 INFO - mozversion application_buildid: 20170104182942 20:25:26 INFO - mozversion application_changeset: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e 20:25:26 INFO - mozversion application_display_name: Nightly 20:25:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:25:26 INFO - mozversion application_name: Firefox 20:25:26 INFO - mozversion application_remotingname: firefox 20:25:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:25:26 INFO - mozversion application_vendor: Mozilla 20:25:26 INFO - mozversion application_version: 53.0a1 20:25:26 INFO - mozversion platform_buildid: 20170104182942 20:25:26 INFO - mozversion platform_changeset: 1bf65dbb4d71ccc02ad63b95a039112073d83e5e 20:25:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:25:26 INFO - mozversion platform_version: 53.0a1 20:25:26 INFO - using testdate: 1483590326 20:25:26 INFO - actual date: 1483590326 20:25:26 INFO - starting webserver on 'localhost:49250' 20:25:26 INFO - SUITE-START | Running 2 tests 20:25:26 INFO - TEST-START | dromaeo_css 20:25:26 INFO - operating with platform_type : mac_ 20:25:26 INFO - Initialising browser for dromaeo_css test... 20:25:26 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpbFOoO6/profile http://localhost:49250/getInfo.html) 20:25:26 INFO - PROCESS | 1637 | 1483590326668 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 20:25:29 INFO - PROCESS | 1637 | 2017-01-04 20:25:29.216 plugin-container[1639:7607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a43, name = 'com.apple.tsm.portname' 20:25:29 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:29 INFO - PROCESS | 1637 | 2017-01-04 20:25:29.220 plugin-container[1639:7607] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 20:25:29 INFO - PROCESS | 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:29 INFO - PROCESS | 1637 | 2017-01-04 20:25:29.220 plugin-container[1639:7607] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:25:29 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 20:25:29 INFO - PROCESS | 1637 | colorDepth:24 20:25:29 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 20:25:29 INFO - PROCESS | 1637 | __metrics 20:25:29 ERROR - PROCESS | 1637 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 20:25:29 INFO - TEST-INFO | 1637: exit 0 20:25:29 INFO - Browser initialized. 20:25:29 INFO - Running cycle 1/1 for dromaeo_css test... 20:25:29 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpbFOoO6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:32 INFO - PROCESS | 1640 | 2017-01-04 20:25:32.542 plugin-container[1641:7728] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4743, name = 'com.apple.tsm.portname' 20:25:32 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:32 INFO - PROCESS | 1640 | 2017-01-04 20:25:32.542 plugin-container[1641:7728] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8733, name = 'com.apple.CFPasteboardClient' 20:25:32 INFO - PROCESS | 1640 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:25:32 INFO - PROCESS | 1640 | 2017-01-04 20:25:32.542 plugin-container[1641:7728] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:25:42 INFO - PROCESS | 1640 | RSS: Main: 232394752 20:25:42 INFO - PROCESS | 1640 | 20:26:31 INFO - PROCESS | 1640 | 1483590391811 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:28:45 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 20:28:46 INFO - PROCESS | 1640 | RSS: Main: 261521408 20:28:46 INFO - PROCESS | 1640 | 20:30:30 INFO - PROCESS | 1640 | ************************* 20:30:30 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 20:30:30 INFO - PROCESS | 1640 | 20:30:30 INFO - PROCESS | 1640 | Full message: ReferenceError: fetch is not defined 20:30:30 INFO - PROCESS | 1640 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 20:30:30 INFO - PROCESS | 1640 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 20:30:30 INFO - PROCESS | 1640 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 20:30:30 INFO - PROCESS | 1640 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 20:30:30 INFO - PROCESS | 1640 | TaskImpl@resource://gre/modules/Task.jsm:277:3 20:30:30 INFO - PROCESS | 1640 | asyncFunction@resource://gre/modules/Task.jsm:252:14 20:30:30 INFO - PROCESS | 1640 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 20:30:30 INFO - PROCESS | 1640 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 20:30:30 INFO - PROCESS | 1640 | TaskImpl@resource://gre/modules/Task.jsm:277:3 20:30:30 INFO - PROCESS | 1640 | asyncFunction@resource://gre/modules/Task.jsm:252:14 20:30:30 INFO - PROCESS | 1640 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 20:30:30 INFO - PROCESS | 1640 | 20:30:30 INFO - PROCESS | 1640 | ************************* 20:31:49 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 20:31:49 INFO - PROCESS | 1640 | RSS: Main: 265515008 20:31:49 INFO - PROCESS | 1640 | 20:34:51 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 20:34:52 INFO - PROCESS | 1640 | RSS: Main: 272957440 20:34:52 INFO - PROCESS | 1640 | 20:37:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 20:37:55 INFO - PROCESS | 1640 | RSS: Main: 269144064 20:37:55 INFO - PROCESS | 1640 | 20:40:57 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 20:40:58 INFO - PROCESS | 1640 | RSS: Main: 273805312 20:40:58 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 20:44:01 INFO - PROCESS | 1640 | RSS: Main: 279605248 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | __start_tp_report 20:44:01 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 20:44:01 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 20:44:01 INFO - PROCESS | 1640 | |i|pagename|runs| 20:44:01 INFO - PROCESS | 1640 | |0;dojo.html;3278.131295206769;3316.7014968652825;3330.2007518195624;3351.463765797473;3355.83220838958;5577.135543990677;5620.156976453534;5624.493795558399;5697.971510142444;5715.028445164322;4456.6657500687415;4704.929426058603;5449.891002179954;5576.414476479972;5743.798967036144;4770.880727981794;5168.715720635363;5174.2238664200295;5184.1705327147665;5228.451012643655;5055;5165.870853228681;5193.402758682762;5231.843044708646;5322.787088516455;5064.164412871909;5202.4537423570355;5207.973960130213;5214.426413094557;5219.817306394277;5072.746362681851;5156.845294641167;5157.896842063138;5162.096633089194;5163.457836927144;4027.556968733437;4995.125852975751;5079;5134.306868572732;5167.121589329785;4595.2188128018315;5433.538149257318;5551.500364967132;5551.833444996616;5557.694326812024;6138.785142519991;6140.324564297924;6141.846453838645;6142.385761423822;6184.81445556634;5569.663280812616;5776.624519406268;6129.695011270001;6174.96912515439;6218.720157592874;5766.94233057664;5833.679147646878;5834.124881267759;5852.736626851802;5861.9706901465215;5557.499825015768;6125.295591007002;6228.6574238416415;6230;6240.188775459162;5798.33319168301;5844.795432159854;5867.061270196833;6128.3258841527395;6133.080037994337;6039.849003774941;6043.637381757108;6055.182550355646;6074.939250607437;6086.6348019119;5943.375945525744;5955.37468565803;6002.699865006733;6044.304904935989;6076.513878889678;6105.694715264219;6118.051701986199;6174.536909731698;6191.535634827406;6195.659238741822;4875.829345972874;4883.9011222474655;4910.435299940481;4913.31213630092;4925.236588328815;4304.870853874389;4312.331588603772;4365.781710914442;4407.162639098561;4432.534583868647;5700.287464066992;5773.134029895549;5810.912836307459;5817.214676018683;5853.1220316952795;6143.385661433821;6197.225346831646;6204.503639708812;6218.284897236786;6261.9373806262265;5526.977509160818;5586;5769.394213607511;5783.797567085132;5792.681402522901;5261.947380526146;5287.101192797234;5291.04761142998;5301.893962120813;5307.867303317448;6221.813345599639;6222.439980401786;6222.906656400248;6227.252729672468;6240.188775459162;5297.337832770903;6187.783427580013;6211.782587609412;6218;6225.968870155621;6097.32929377777;6139.26328840542;6139.798803208702;6147.262328520606;6207.503399727921;4668.976655116703;5623.746931388016;6146.078088286793;6150.323464418821;6185.752569897334;5127.615428842926;5281.867953301198;5459.317585301837;6063.545234107548;6129.908051379322;6069.666168360783;6079.635221886701;6135.5082808396355;6135.814547850547;6161.168242287234;5843.328017278068;5918.496927761188;6088.117223002729;6098.5426093042315;6125.571210015434;5613.803516877053;5791.507721843691;5875.50058245054;5945.791897283574;6058.969705151446;6011.218541589566;6098.725557350019;6105.847353816012;6122.204113465399;6141.84645383869;5544.1960915667805;5727.284089488814;5746.770129194785;5756.7409466574945;5763.33721622002 20:44:01 INFO - PROCESS | 1640 | |1;ext.html;457.86950719045075;461.99076018479633;497.5596597011644;503.19740014676603;507.7892674540065;39885.002874928105;40853.182936341254;40972.59027409725;42648.786756066176;42994;41869.58130418695;42147;42341.7882910585;42410.36384454236;42543.361849572204;7430.219826918177;7874.724384646539;9241.861372079407;9461.006594307568;9488.288378371615;11089.390083545402;11423.885761142406;11487.712807179803;11612.825807612893;11633.94183029088;11338;11378.2035257532;11389.316641001526;11419.600313989013;11421.771564568704;11220;11302.378369189692;11315.660530184066;11329.09367250618;11332.546698132064;11193.99254067138;11254.831177532344;11261.66215013551;11262.493187806487;11309.830352544719;40351.798241008604;40389.1922161558;40468.595314047074;40670.796646016875;40795.38806917869;3925.6663183629425;3977.204559088194;3992.0818211811447;4025.2754504189234;4121.91756164875;30009.949651762083;30491.390172196654;30563.38873222523;30608.928687496053;31405.37189256225;3071.66211716711;3104.5964024676646;3112.2997325601787;3176.2059485128716;3198.8080715157166;488846.5557672224;496135.0386496161;497060;498157;500515;57404;57638.7118064407;57668.71165644145;57879.71060144672;58185.418145818;60538.69730651407;60853.69573152195;60929;61202.69398653067;61222;15333.539993800205;15772;15773.763393549107;15794;15812.209389530477;11121.388323642277;11441.599544016086;12062.819057714141;12290.508379664714;12331.50673973031;15334.003289786127;15356.692866142615;15388.384464621513;15399.692006160038;15451.690966180613;6279.623222606659;7251.92748072523;7294.234105418961;7331.340179383775;7371.226021267689;637.5568979559255;724.478375569589;760.3764912771475;766.237593594366;784.8548018616574;24496.877515612665;29075.418491630047;29457.11628651144;30096.548551771742;30189.245268868453;898.6180873128894;1024.4109636958779;1034.363866222268;1036.3419228789774;1072.7586293083993;13255.801162982563;14298.28508574567;15178.089314640936;15251.694966100838;15584.84415155834;519097;526164;629208;631906;633362;54911.45088549143;56116.71941640266;56680.71659641758;56924.71537642368;57048.71475642595;1409.393960596953;1414.1373762005169;1429.199648197013;1431.355889849572;1431.8711315981611;28237;28541.28646783847;29224.853875730485;29375.559366609945;29575;40439.797801010805;40568.580099696366;48244.93428189989;48713.26930096122;48742.75628621834;454442;455532;459483;459791;460953;29225.26936826511;32101.876434324688;36775.632243677224;38456.423153653275;38836.41745373765;46122;46198.07603847972;46396.53603463922;47254.76372618252;47395.289070663275;37924.62075379321;38160.42759358556;38234;38846;39549.60450395574;37202.627973719915;37294.81352593219;37632.247355053296;38366.23267534578;38599.6140038596;36637.633623664486;36850.8157459211;36893.07767305839;37304.813475932446;37443.6255637451;26837.194884153505;27291.181264562096;31003.224919376295;33194.00417987464;33239.83380083084;24309.75690243075;24417.877910611045;24627.753722462545;24989.375265618506;25128.37179070538 20:44:01 INFO - PROCESS | 1640 | |2;jquery.html;361.78112242093533;387.98254078566447;389.14776639160243;405.3534612293395;417.8725488725937;18369.816301836996;19466.221351145974;20086.6986995195;20307.898460507713;20398.490037749027;19444.611107777837;19692.212311507523;19880.801191988077;19883.30408435705;20396.59206815863;4878.4145902491755;5744.195812586252;5946.316173640043;5984.760609575612;5988.670623115727;5810.041343178371;5905.379935106816;5915.704214789265;5918.4673379395845;5919.822405327825;5599.524040456566;5784.479396854304;5842.5618078644275;5849.473547380735;5852.9707351463185;5650.056200824279;5790.305163380401;5836.766529338822;5842.9774789411895;5848.590598658096;4983.426905905831;5069.543741063285;5092.337996060489;5099.311592934981;5099.87250318745;24035.39911502209;24075.638865417033;24287.757122428728;24585.38536536583;24748;2657.9257484081227;2720.7143249958667;2724.809263351566;2758.3793646429594;2761.8066735328534;14638.121712697166;15431.537053888402;15518.922405388013;15635.29641166139;15705.293261803246;1850.9537261568435;1869.05612665603;1982.5737466444639;2001.8698784578955;2006.618742438932;124239;137351;140636;143347.28326358303;143758;10182.694519164437;11307.886921130683;11561.248518846249;11728.237664551776;11731.47208375625;15048.548543543711;15049.774253386207;15057.698846023019;15107.39570417193;15126.697466050617;8344.123866994;8466.407351485337;8476.27951624119;8497.575121244037;8617.698380556776;6800.489963252776;7391.926080739231;8280;8308.335333173332;8386.951631046119;3757.661810437019;4694.976525117352;4698.647601429906;4737.6683632146105;4786.593139583105;1983.2364539652049;2025.7163997040427;2030.878147311166;2033.4916270932267;2042.3362407217714;944.5041353289578;957.4398976598628;959.5681943125621;982.4547376206132;995.2585323933571;18851.811481885004;20038.899805501173;20264;20422.387328380173;20433.69349459759;970.7912798748303;995.4574756757585;995.8406654935176;1022.4580972084807;1028.475477506477;9795.677583526132;10151.187904967584;10341.9482902585;10461.372317660813;10486.73783155412;460667;466829;467892;745418;759775;100763.49618251862;112302.43848780704;112544.87455125508;150295;161521;967.1972263021676;995.6714284286313;1026.1482969135748;1038.314712289885;1038.984415233772;18252.08739563043;18554.44336669902;18639.627207455505;18671.6265674683;18780.7182892254;51046.744766277414;58285.83428331494;60900.69549652223;61094;61783.96808414877;85211.60532310413;89986;90155.19689606302;90725.54637227036;90782.09217907736;7686.730964416219;8090.959545202236;8397.37019723511;8475.32197424217;8499.490030597937;11822;12239.449224784728;12535.623931282076;13040.478380864659;13243;10894.400807955639;11080.778384432428;11226;11268.323900565993;11472.082233421474;9757.707268781947;11022.071137550736;11056.834147487632;11127.22109452363;11146.665600032013;11042.668719938414;11210.159238057015;11260.268082574607;11404.94297528507;11423.428828558704;8242.340612751086;8398.706045288385;8403.915960840313;8543.957280213808;8616.181462761027;9841.507924603884;10384.273100882865;10595.576176952836;11015.284006539548;11221.353060255613 20:44:01 INFO - PROCESS | 1640 | |3;mootools.html;1280.1359082619233;1307.1111644082032;1323.8411390633125;1368.3705495472082;1407.6973450708101;6709.832254193648;6949.305069493048;7514.66184021719;8487.787805304863;8496.32029437645;7083.1854336751285;7229.819254518639;7996.640151193195;8128.715494957678;8342.416030877826;2287.7025986621757;2333.6966194394704;2334.6964894563685;2335.4628435459854;2350.6944097267333;2066.6693329067352;2279.088364654135;2338.368640467073;2345.3901985483812;2352.647102934565;2078.449210959097;2096.2348742708878;2198.9010494527784;2219.966700499494;2308.134449581407;1948.4836518322513;2306.4925716342545;2321.442853715105;2330.0446816805115;2337.322176568793;2326.336993956731;2326.860388376686;2339.894704738291;2356.8585884846966;2377.3699969508093;8363.498190108612;8415.537145456998;8479.66081356745;8491.150884911522;8494.108118647515;5050.84847454577;5143.3570803649545;5195.9480405195845;5201.687898726089;5206;3273.8035717856765;3396.524486571882;3410.6248312685584;3447.379471695094;3477.23500829817;1163.2903928603546;1165.6095208105296;1183.7040739815047;1207.8550573931097;1226.129448091856;10806.081483073947;10857;10954;10965.945170274177;10974.231803773739;4294.227039132924;4428.3800267962515;4428.446444194476;4507.616852567503;4509.301058335963;8513.74458766238;8650.35122365825;8669.306455483546;8695.260902823331;8712.912870871336;5047.965167140801;5109.284700141909;5126.487351264844;5133.666311689728;5148.897022059537;4713.882152946135;4747.074320507468;4756.310335001405;4792.0895029944195;4799.448063472745;3624.8187590620364;3642.34437801193;3672.3573374659327;3700.666939975415;3716.851325946986;1069.2141276162015;1145.799485090106;1150.8446359741495;1162.110985096402;1164.5691094295164;802.4984384759525;897.7306807957586;899.1233547291339;904.6471875968377;938.3853575907655;5317;5515.200295957144;5588.692621905753;5642.492175704207;5657.717114144276;899.802043550431;944.4852555357347;955.5843208204453;967.8112768010311;1034.281174583657;3514.1741690702665;3678.33789917812;3766.6233376662663;3803.391457366808;3803.8858834235016;9725.756856078513;10008.049235322633;10015.298929075041;10017.14854237398;10047.748806279902;9947;9962.551685174185;9975.800483990424;9985.900140998643;10004;6329;7539.698412063456;7723.304902558684;7745.728899488491;7868.72459463916;4942.308076869169;5157.690538567698;5509.311336082989;5617.915731264116;5660.971695141498;8934.687285944961;9001.729948101567;9197.172254497127;9280.860787088064;9432.292578056537;9223.907760922304;9365.625374984924;9440.244780417413;9530.523473826142;9540.093691099335;7055.682494287872;7232.312930271616;7241.877508986116;7259.709611615476;7286.562806231643;7750.186230445947;7784.532928024337;7815.413843961612;7844.529328240324;7871;6240.375962403723;6991.930080699128;6993.300669932966;7018.929810701828;7048;6970.372666460043;6979.336962988508;6987.266337034538;7090.64546772649;7099.077119974577;6290.654014029273;6304.747810087545;6405.903911441425;6405.967970160305;6443.065755465525;4776.188048031773;4810.302506136521;4831.9275210872565;4844.688227477477;4937.456879743154;4591.793369298456;4603.355530225704;4696.577308042292;4718;4770 20:44:01 INFO - PROCESS | 1640 | |4;prototype.html;328.80929061144536;329.6390452454562;348.95463589733333;352.3252970561375;368.9686376657984;4579.8397056103;5267.5760755508845;5338.67967921925;5428.592855535836;5513.365962914261;4320.740755554669;4836.588889944359;4950.678205916613;5231.032259032082;5399.029354285687;3705.3330400527893;4052.8581499647516;4239.152169566084;4249.511306199795;4294.914101717964;3676.466912297715;3774.4527043578664;4099.392425639042;4240.448741663579;4251.298535741599;3518.753687241894;4202;4207.389928460371;4215.978920105411;4217.451731274945;3714.962850371489;4196.853110141145;4214.452121224236;4220.662347012231;4237.7669228192435;3427.8628854845774;3482.3905816482265;3563.055790215595;3727.1986522897705;3770.359038963383;3913.8630147944687;4447.488538818013;5269.074539468083;5287.603429742746;5311.893762124774;4640.582347588733;4643.305193604344;4701.083288758693;4751.239801631722;4752.839361824383;4810.532787499811;5706.885862282773;5725;5801.970990145064;5847.707614619295;3462.9134271643156;3777.905552361213;3793.9810300948593;3807.2766174427047;3917.4319723640197;6062.817385741129;6075.453209211192;6085.513158947274;6091.51267898567;6094.329623741429;3677.669009789132;3922.8623699126933;3931.783751893616;3935.0949281665376;3950.6839452843706;3322.352141332465;3791.7914514701406;3936.488256526633;3969.940450893239;4007.8597249096724;4004.3593025115842;4154.813033413504;4669.696469729457;4680.46174689915;4689.859304220879;5045.949540504622;5725.764942807301;5824.2236117983575;5839.000284804837;5839.357670656224;1074.8172810622214;1086.9184811139196;1170.169179882276;1222.4315693202705;1265.5127775806197;782.8316911863863;816.6284340625001;840.6297734692412;869.1438932651333;878.550391853447;4866.369766128387;4931.580815630711;5030.597552195815;5115.335006449138;5240.768419421433;5141.897162056738;5611.102223644198;5661.547076233891;5695.373508914016;5712.400197979152;4262.893427664333;4437.400950871655;5069.656541016633;5203.453637368098;5275.60432967529;2772.50094982905;2847.615571897809;2960.422717570096;2983.612130423031;3032.166154307583;5128.384593848762;5561.054620714407;5618.971905140448;5795.043817770105;5892.322382926019;4658.091672123971;5097.490250974947;5110.4634013428795;5655.0386434306265;5703.944770217523;5130.51260130287;5822.311529656352;6022.006368949162;6098.237720284965;6099.634021958696;5110.66780659256;5296.841094767163;5859.6278115759515;5886.499647530008;6008.519318454426;4935.555799978019;5516.724163791875;5776.653400795798;5783.248177736868;5881.441263080001;5919.704014799329;5955.166276721349;5984.700764961822;5991.820245392645;6012.458878700763;3467.826608669506;3763.3226019316785;3858.5176852893387;3895.435161901565;3928.9214215714956;5387;5837.67892765902;5889.793857214977;5938;5938.881222375442;4498.977505112453;4603.631709463168;4654.627629789541;5618.6628802272;5650.378458369494;4479.238529450066;5283.815066472809;5312.28284181646;5698.202251684685;5828.53371730269;5214.661047031931;5401.9466204091395;5618.803341883015;5622.156676498558;5636.2954630671165;5262.947370526245;5456.345238571397;5535.5848311376;5767.365589785204;5785.8553536161935;5539.612227144223;5541.833744987657;5546.861328466821;5560.277163968658;5567.359753628384 20:44:01 INFO - PROCESS | 1640 | |5;yui.html;698.4970821008872;762.0169980724866;778.5834578500496;793.333599776188;813.7355359508159;13185.7362852743;15889.44386946457;15901.92049039756;15915.442959496406;15964.521064368073;14401.13593184407;14555;14572.489962851303;14588.708225835477;14621.926890365534;682.6791408038239;707.2573797512591;861.8965724113115;884.8761173435724;888.471359541072;899.9460032398044;900.5047224026791;900.693764120199;902.6569903436684;906.3610154840854;843.3759018326456;932.0260327957267;933.6592143867507;958.3674774648733;964.0600414595748;951.362587066667;957.200737384278;960.3853533738378;963.2342287881152;965.918171647759;695.2977492732326;702.420503084957;705.8094314535098;707.6002058836741;709.439542761218;14852.702945941128;15190.240487975667;15497.45758898433;15542.145182015098;15758.684826303524;14161.716765664629;14450.927745361207;14452.50773993808;14549.78175327371;14590.90568207378;11733.12001599875;11783.823242651368;11798.115141364431;11812.645620631394;11828.05375569961;3695.224002959382;3729.515163028816;3780.9621903780885;3811.352070148054;3942.25097231528;86104;103145.4842725789;103271.48364258131;105185;108450.45774771155;10965.396903170242;10999.285046471954;11107.278026928223;11155.051820595178;11456.599019034295;19697.803021969597;20277.79722202759;22770.544589108125;22805.543889122124;22817;7815.491993020435;7864.921350786533;7881.211878812073;8043.638036288381;8160.591970401456;4294.377315289265;4317.481902171697;4326.437563116838;4406.581374769392;4480;3614.204874927512;3654.488371627974;3692.593814680383;3694.9076273093387;3697.7226707997006;651.485326591987;660.0923729871427;669.7856685860478;676.6413800685644;678.1015154919751;617.4751461257895;639.6002498438476;644.0693198328464;653.8463461086641;669.2537820330297;9071.727848164566;9419.34064615484;9422.586612008254;9428.95285523568;10061.396316220904;552.8009916430082;560.15137067343;570.9200711900337;627.4603840696997;660.7125900233414;4112.588741125864;4409.206342858316;4586.926759071363;4604.286335617984;4674.135284972291;77063.22936770672;95715;96434.51782741041;102025.48987255164;103278.96721032694;87979;88276.11723882679;89625;91050.54474727716;91508.54245728863;77650;77688.61155694185;78420;79258.6037069811;80096.3980720394;7646.65590048438;7767;7773.766786996399;7928.920710793049;7983.680652773824;35375;37754.62245377621;45229.773851130536;46286;49069.77325566747;40592;54049.18926216031;63957.680211600506;65372.67313663401;66014.66992665007;12783.48866045385;12913.031522635652;13010.21938683682;13024.47902083906;13032.609021729364;12217.93891030539;12908.548200812926;13200.471981121033;14697.485588004369;14900.403983840524;10935.781284374427;12690.92127169201;13833.446662133401;13857.237851918242;14369.928150359181;11066;11951.62155184401;13103.934480327538;13832.446702131801;14226.502072427415;12231.108112398835;12307;12947.611571652866;12983.35083245853;13263.535776247785;11139.636009035083;11350.943245284052;11384.316940983568;11435.828462573234;11555.306681599131;8250.349930014141;9584.318017861086;9923.702288931343;11168.944155279496;11209.047230985458 20:44:01 INFO - PROCESS | 1640 | __end_tp_report 20:44:01 INFO - PROCESS | 1640 | __start_cc_report 20:44:01 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,395 20:44:01 INFO - PROCESS | 1640 | __end_cc_report 20:44:01 INFO - PROCESS | 1640 | __startTimestamp1483591441548__endTimestamp 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | ------- Summary: start ------- 20:44:01 INFO - PROCESS | 1640 | Number of tests: 6 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5606.43 Median:5791.51 stddev:651.75 (11.3%) stddev-sans-first:627.63 20:44:01 INFO - PROCESS | 1640 | Values: 3278.1 3316.7 3330.2 3351.5 3355.8 5577.1 5620.2 5624.5 5698.0 5715.0 4456.7 4704.9 5449.9 5576.4 5743.8 4770.9 5168.7 5174.2 5184.2 5228.5 5055.0 5165.9 5193.4 5231.8 5322.8 5064.2 5202.5 5208.0 5214.4 5219.8 5072.7 5156.8 5157.9 5162.1 5163.5 4027.6 4995.1 5079.0 5134.3 5167.1 4595.2 5433.5 5551.5 5551.8 5557.7 6138.8 6140.3 6141.8 6142.4 6184.8 5569.7 5776.6 6129.7 6175.0 6218.7 5766.9 5833.7 5834.1 5852.7 5862.0 5557.5 6125.3 6228.7 6230.0 6240.2 5798.3 5844.8 5867.1 6128.3 6133.1 6039.8 6043.6 6055.2 6074.9 6086.6 5943.4 5955.4 6002.7 6044.3 6076.5 6105.7 6118.1 6174.5 6191.5 6195.7 4875.8 4883.9 4910.4 4913.3 4925.2 4304.9 4312.3 4365.8 4407.2 4432.5 5700.3 5773.1 5810.9 5817.2 5853.1 6143.4 6197.2 6204.5 6218.3 6261.9 5527.0 5586.0 5769.4 5783.8 5792.7 5261.9 5287.1 5291.0 5301.9 5307.9 6221.8 6222.4 6222.9 6227.3 6240.2 5297.3 6187.8 6211.8 6218.0 6226.0 6097.3 6139.3 6139.8 6147.3 6207.5 4669.0 5623.7 6146.1 6150.3 6185.8 5127.6 5281.9 5459.3 6063.5 6129.9 6069.7 6079.6 6135.5 6135.8 6161.2 5843.3 5918.5 6088.1 6098.5 6125.6 5613.8 5791.5 5875.5 5945.8 6059.0 6011.2 6098.7 6105.8 6122.2 6141.8 5544.2 5727.3 5746.8 5756.7 5763.3 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:65412.34 Median:38042.52 stddev:137950.86 (362.6%) stddev-sans-first:138251.64 20:44:01 INFO - PROCESS | 1640 | Values: 457.9 462.0 497.6 503.2 507.8 39885.0 40853.2 40972.6 42648.8 42994.0 41869.6 42147.0 42341.8 42410.4 42543.4 7430.2 7874.7 9241.9 9461.0 9488.3 11089.4 11423.9 11487.7 11612.8 11633.9 11338.0 11378.2 11389.3 11419.6 11421.8 11220.0 11302.4 11315.7 11329.1 11332.5 11194.0 11254.8 11261.7 11262.5 11309.8 40351.8 40389.2 40468.6 40670.8 40795.4 3925.7 3977.2 3992.1 4025.3 4121.9 30009.9 30491.4 30563.4 30608.9 31405.4 3071.7 3104.6 3112.3 3176.2 3198.8 488846.6 496135.0 497060.0 498157.0 500515.0 57404.0 57638.7 57668.7 57879.7 58185.4 60538.7 60853.7 60929.0 61202.7 61222.0 15333.5 15772.0 15773.8 15794.0 15812.2 11121.4 11441.6 12062.8 12290.5 12331.5 15334.0 15356.7 15388.4 15399.7 15451.7 6279.6 7251.9 7294.2 7331.3 7371.2 637.6 724.5 760.4 766.2 784.9 24496.9 29075.4 29457.1 30096.5 30189.2 898.6 1024.4 1034.4 1036.3 1072.8 13255.8 14298.3 15178.1 15251.7 15584.8 519097.0 526164.0 629208.0 631906.0 633362.0 54911.5 56116.7 56680.7 56924.7 57048.7 1409.4 1414.1 1429.2 1431.4 1431.9 28237.0 28541.3 29224.9 29375.6 29575.0 40439.8 40568.6 48244.9 48713.3 48742.8 454442.0 455532.0 459483.0 459791.0 460953.0 29225.3 32101.9 36775.6 38456.4 38836.4 46122.0 46198.1 46396.5 47254.8 47395.3 37924.6 38160.4 38234.0 38846.0 39549.6 37202.6 37294.8 37632.2 38366.2 38599.6 36637.6 36850.8 36893.1 37304.8 37443.6 26837.2 27291.2 31003.2 33194.0 33239.8 24309.8 24417.9 24627.8 24989.4 25128.4 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:35563.69 Median:24666.69 stddev:100573.82 (407.7%) stddev-sans-first:100821.23 20:44:01 INFO - PROCESS | 1640 | Values: 361.8 388.0 389.1 405.4 417.9 18369.8 19466.2 20086.7 20307.9 20398.5 19444.6 19692.2 19880.8 19883.3 20396.6 4878.4 5744.2 5946.3 5984.8 5988.7 5810.0 5905.4 5915.7 5918.5 5919.8 5599.5 5784.5 5842.6 5849.5 5853.0 5650.1 5790.3 5836.8 5843.0 5848.6 4983.4 5069.5 5092.3 5099.3 5099.9 24035.4 24075.6 24287.8 24585.4 24748.0 2657.9 2720.7 2724.8 2758.4 2761.8 14638.1 15431.5 15518.9 15635.3 15705.3 1851.0 1869.1 1982.6 2001.9 2006.6 124239.0 137351.0 140636.0 143347.3 143758.0 10182.7 11307.9 11561.2 11728.2 11731.5 15048.5 15049.8 15057.7 15107.4 15126.7 8344.1 8466.4 8476.3 8497.6 8617.7 6800.5 7391.9 8280.0 8308.3 8387.0 3757.7 4695.0 4698.6 4737.7 4786.6 1983.2 2025.7 2030.9 2033.5 2042.3 944.5 957.4 959.6 982.5 995.3 18851.8 20038.9 20264.0 20422.4 20433.7 970.8 995.5 995.8 1022.5 1028.5 9795.7 10151.2 10341.9 10461.4 10486.7 460667.0 466829.0 467892.0 745418.0 759775.0 100763.5 112302.4 112544.9 150295.0 161521.0 967.2 995.7 1026.1 1038.3 1039.0 18252.1 18554.4 18639.6 18671.6 18780.7 51046.7 58285.8 60900.7 61094.0 61784.0 85211.6 89986.0 90155.2 90725.5 90782.1 7686.7 8091.0 8397.4 8475.3 8499.5 11822.0 12239.4 12535.6 13040.5 13243.0 10894.4 11080.8 11226.0 11268.3 11472.1 9757.7 11022.1 11056.8 11127.2 11146.7 11042.7 11210.2 11260.3 11404.9 11423.4 8242.3 8398.7 8403.9 8544.0 8616.2 9841.5 10384.3 10595.6 11015.3 11221.4 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:5339.79 Median:5130.08 stddev:2926.89 (57.1%) stddev-sans-first:2919.19 20:44:01 INFO - PROCESS | 1640 | Values: 1280.1 1307.1 1323.8 1368.4 1407.7 6709.8 6949.3 7514.7 8487.8 8496.3 7083.2 7229.8 7996.6 8128.7 8342.4 2287.7 2333.7 2334.7 2335.5 2350.7 2066.7 2279.1 2338.4 2345.4 2352.6 2078.4 2096.2 2198.9 2220.0 2308.1 1948.5 2306.5 2321.4 2330.0 2337.3 2326.3 2326.9 2339.9 2356.9 2377.4 8363.5 8415.5 8479.7 8491.2 8494.1 5050.8 5143.4 5195.9 5201.7 5206.0 3273.8 3396.5 3410.6 3447.4 3477.2 1163.3 1165.6 1183.7 1207.9 1226.1 10806.1 10857.0 10954.0 10965.9 10974.2 4294.2 4428.4 4428.4 4507.6 4509.3 8513.7 8650.4 8669.3 8695.3 8712.9 5048.0 5109.3 5126.5 5133.7 5148.9 4713.9 4747.1 4756.3 4792.1 4799.4 3624.8 3642.3 3672.4 3700.7 3716.9 1069.2 1145.8 1150.8 1162.1 1164.6 802.5 897.7 899.1 904.6 938.4 5317.0 5515.2 5588.7 5642.5 5657.7 899.8 944.5 955.6 967.8 1034.3 3514.2 3678.3 3766.6 3803.4 3803.9 9725.8 10008.0 10015.3 10017.1 10047.7 9947.0 9962.6 9975.8 9985.9 10004.0 6329.0 7539.7 7723.3 7745.7 7868.7 4942.3 5157.7 5509.3 5617.9 5661.0 8934.7 9001.7 9197.2 9280.9 9432.3 9223.9 9365.6 9440.2 9530.5 9540.1 7055.7 7232.3 7241.9 7259.7 7286.6 7750.2 7784.5 7815.4 7844.5 7871.0 6240.4 6991.9 6993.3 7018.9 7048.0 6970.4 6979.3 6987.3 7090.6 7099.1 6290.7 6304.7 6405.9 6406.0 6443.1 4776.2 4810.3 4831.9 4844.7 4937.5 4591.8 4603.4 4696.6 4718.0 4770.0 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4553.12 Median:5103.98 stddev:1416.62 (27.8%) stddev-sans-first:1384.66 20:44:01 INFO - PROCESS | 1640 | Values: 328.8 329.6 349.0 352.3 369.0 4579.8 5267.6 5338.7 5428.6 5513.4 4320.7 4836.6 4950.7 5231.0 5399.0 3705.3 4052.9 4239.2 4249.5 4294.9 3676.5 3774.5 4099.4 4240.4 4251.3 3518.8 4202.0 4207.4 4216.0 4217.5 3715.0 4196.9 4214.5 4220.7 4237.8 3427.9 3482.4 3563.1 3727.2 3770.4 3913.9 4447.5 5269.1 5287.6 5311.9 4640.6 4643.3 4701.1 4751.2 4752.8 4810.5 5706.9 5725.0 5802.0 5847.7 3462.9 3777.9 3794.0 3807.3 3917.4 6062.8 6075.5 6085.5 6091.5 6094.3 3677.7 3922.9 3931.8 3935.1 3950.7 3322.4 3791.8 3936.5 3969.9 4007.9 4004.4 4154.8 4669.7 4680.5 4689.9 5045.9 5725.8 5824.2 5839.0 5839.4 1074.8 1086.9 1170.2 1222.4 1265.5 782.8 816.6 840.6 869.1 878.6 4866.4 4931.6 5030.6 5115.3 5240.8 5141.9 5611.1 5661.5 5695.4 5712.4 4262.9 4437.4 5069.7 5203.5 5275.6 2772.5 2847.6 2960.4 2983.6 3032.2 5128.4 5561.1 5619.0 5795.0 5892.3 4658.1 5097.5 5110.5 5655.0 5703.9 5130.5 5822.3 6022.0 6098.2 6099.6 5110.7 5296.8 5859.6 5886.5 6008.5 4935.6 5516.7 5776.7 5783.2 5881.4 5919.7 5955.2 5984.7 5991.8 6012.5 3467.8 3763.3 3858.5 3895.4 3928.9 5387.0 5837.7 5889.8 5938.0 5938.9 4499.0 4603.6 4654.6 5618.7 5650.4 4479.2 5283.8 5312.3 5698.2 5828.5 5214.7 5401.9 5618.8 5622.2 5636.3 5262.9 5456.3 5535.6 5767.4 5785.9 5539.6 5541.8 5546.9 5560.3 5567.4 20:44:01 INFO - PROCESS | 1640 | 20:44:01 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:19575.17 Median:4366.51 stddev:28042.92 (642.2%) stddev-sans-first:28085.77 20:44:01 INFO - PROCESS | 1640 | Values: 698.5 762.0 778.6 793.3 813.7 13185.7 15889.4 15901.9 15915.4 15964.5 14401.1 14555.0 14572.5 14588.7 14621.9 682.7 707.3 861.9 884.9 888.5 899.9 900.5 900.7 902.7 906.4 843.4 932.0 933.7 958.4 964.1 951.4 957.2 960.4 963.2 965.9 695.3 702.4 705.8 707.6 709.4 14852.7 15190.2 15497.5 15542.1 15758.7 14161.7 14450.9 14452.5 14549.8 14590.9 11733.1 11783.8 11798.1 11812.6 11828.1 3695.2 3729.5 3781.0 3811.4 3942.3 86104.0 103145.5 103271.5 105185.0 108450.5 10965.4 10999.3 11107.3 11155.1 11456.6 19697.8 20277.8 22770.5 22805.5 22817.0 7815.5 7864.9 7881.2 8043.6 8160.6 4294.4 4317.5 4326.4 4406.6 4480.0 3614.2 3654.5 3692.6 3694.9 3697.7 651.5 660.1 669.8 676.6 678.1 617.5 639.6 644.1 653.8 669.3 9071.7 9419.3 9422.6 9429.0 10061.4 552.8 560.2 570.9 627.5 660.7 4112.6 4409.2 4586.9 4604.3 4674.1 77063.2 95715.0 96434.5 102025.5 103279.0 87979.0 88276.1 89625.0 91050.5 91508.5 77650.0 77688.6 78420.0 79258.6 80096.4 7646.7 7767.0 7773.8 7928.9 7983.7 35375.0 37754.6 45229.8 46286.0 49069.8 40592.0 54049.2 63957.7 65372.7 66014.7 12783.5 12913.0 13010.2 13024.5 13032.6 12217.9 12908.5 13200.5 14697.5 14900.4 10935.8 12690.9 13833.4 13857.2 14369.9 11066.0 11951.6 13103.9 13832.4 14226.5 12231.1 12307.0 12947.6 12983.4 13263.5 11139.6 11350.9 11384.3 11435.8 11555.3 8250.3 9584.3 9923.7 11168.9 11209.0 20:44:01 INFO - PROCESS | 1640 | -------- Summary: end -------- 20:44:01 INFO - PROCESS | 1640 | 20:44:02 INFO - TEST-INFO | 1640: exit 0 20:44:02 INFO - TEST-OK | dromaeo_css | took 1116143ms 20:44:02 INFO - TEST-START | kraken 20:44:02 INFO - operating with platform_type : mac_ 20:44:02 INFO - Initialising browser for kraken test... 20:44:02 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpfFgme5/profile http://localhost:49250/getInfo.html) 20:44:02 INFO - PROCESS | 1653 | 1483591442769 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 20:44:05 INFO - PROCESS | 1653 | 2017-01-04 20:44:05.019 plugin-container[1654:10108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 20:44:05 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:44:05 INFO - PROCESS | 1653 | 2017-01-04 20:44:05.023 plugin-container[1654:10108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 20:44:05 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:44:05 INFO - PROCESS | 1653 | 2017-01-04 20:44:05.023 plugin-container[1654:10108] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:44:05 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 20:44:05 INFO - PROCESS | 1653 | colorDepth:24 20:44:05 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 20:44:05 INFO - PROCESS | 1653 | __metrics 20:44:05 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 20:44:05 INFO - TEST-INFO | 1653: exit 0 20:44:05 INFO - Browser initialized. 20:44:05 INFO - Running cycle 1/1 for kraken test... 20:44:05 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/T/tmpfFgme5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:44:08 INFO - PROCESS | 1655 | 2017-01-04 20:44:08.218 plugin-container[1656:10223] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.tsm.portname' 20:44:08 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:44:08 INFO - PROCESS | 1655 | 2017-01-04 20:44:08.219 plugin-container[1656:10223] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 20:44:08 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:44:08 INFO - PROCESS | 1655 | 2017-01-04 20:44:08.219 plugin-container[1656:10223] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:44:17 INFO - PROCESS | 1655 | RSS: Main: 232521728 20:44:17 INFO - PROCESS | 1655 | 20:44:20 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 20:44:21 INFO - PROCESS | 1655 | RSS: Main: 245018624 20:44:21 INFO - PROCESS | 1655 | 20:44:24 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 20:44:25 INFO - PROCESS | 1655 | RSS: Main: 252690432 20:44:25 INFO - PROCESS | 1655 | 20:44:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 20:44:29 INFO - PROCESS | 1655 | RSS: Main: 255303680 20:44:29 INFO - PROCESS | 1655 | 20:44:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 20:44:31 INFO - PROCESS | 1655 | RSS: Main: 257556480 20:44:31 INFO - PROCESS | 1655 | 20:44:33 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:44:34 INFO - PROCESS | 1655 | RSS: Main: 258252800 20:44:34 INFO - PROCESS | 1655 | 20:44:37 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 20:44:38 INFO - PROCESS | 1655 | RSS: Main: 263774208 20:44:38 INFO - PROCESS | 1655 | 20:44:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 20:44:41 INFO - PROCESS | 1655 | RSS: Main: 262868992 20:44:41 INFO - PROCESS | 1655 | 20:44:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 20:44:45 INFO - PROCESS | 1655 | RSS: Main: 262889472 20:44:45 INFO - PROCESS | 1655 | 20:44:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:44:47 INFO - PROCESS | 1655 | RSS: Main: 262025216 20:44:47 INFO - PROCESS | 1655 | 20:44:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:44:50 INFO - PROCESS | 1655 | RSS: Main: 262066176 20:44:50 INFO - PROCESS | 1655 | 20:44:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:44:53 INFO - PROCESS | 1655 | RSS: Main: 262127616 20:44:53 INFO - PROCESS | 1655 | 20:44:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:44:56 INFO - PROCESS | 1655 | RSS: Main: 262418432 20:44:56 INFO - PROCESS | 1655 | 20:44:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:45:00 INFO - PROCESS | 1655 | RSS: Main: 262258688 20:45:00 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 20:45:02 INFO - PROCESS | 1655 | RSS: Main: 264151040 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | __start_tp_report 20:45:02 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 20:45:02 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 20:45:02 INFO - PROCESS | 1655 | |i|pagename|runs| 20:45:02 INFO - PROCESS | 1655 | |0;ai-astar;108;119;120;117;118;117;118;118;117;118 20:45:02 INFO - PROCESS | 1655 | |1;audio-beat-detection;143;115;113;149;118;157;143;114;135;115 20:45:02 INFO - PROCESS | 1655 | |2;audio-dft;199;205;235;242;216;274;276;201;195;188 20:45:02 INFO - PROCESS | 1655 | |3;audio-fft;80;57;59;86;73;54;75;73;67;81 20:45:02 INFO - PROCESS | 1655 | |4;audio-oscillator;95;101;117;100;72;72;82;72;69;82 20:45:02 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;88;89;88;97;128;78;129;134;88 20:45:02 INFO - PROCESS | 1655 | |6;imaging-darkroom;99;101;99;100;100;99;100;99;111;172 20:45:02 INFO - PROCESS | 1655 | |7;imaging-desaturate;117;95;144;89;148;143;114;94;97;109 20:45:02 INFO - PROCESS | 1655 | |8;json-parse-financial;60;60;60;59;61;64;60;61;63;61 20:45:02 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;66;79;73;78;75;71;71;71;71;73 20:45:02 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;91;91;88;93;88;89;91;105;108;110 20:45:02 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;141;139;141;145;159;144;143;144;207;154 20:45:02 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;171;173;173;172;174;174;175;201;236;196 20:45:02 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;71;76;86;67;61;61;62;68;86;88 20:45:02 INFO - PROCESS | 1655 | __end_tp_report 20:45:02 INFO - PROCESS | 1655 | __start_cc_report 20:45:02 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,923 20:45:02 INFO - PROCESS | 1655 | __end_cc_report 20:45:02 INFO - PROCESS | 1655 | __startTimestamp1483591502631__endTimestamp 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | ------- Summary: start ------- 20:45:02 INFO - PROCESS | 1655 | Number of tests: 14 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.00 stddev:3.30 (2.8%) stddev-sans-first:1.00 20:45:02 INFO - PROCESS | 1655 | Values: 108.0 119.0 120.0 117.0 118.0 117.0 118.0 118.0 117.0 118.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:139.00 stddev:16.97 (12.2%) stddev-sans-first:17.35 20:45:02 INFO - PROCESS | 1655 | Values: 143.0 115.0 113.0 149.0 118.0 157.0 143.0 114.0 135.0 115.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:223.10 Median:225.50 stddev:32.24 (14.3%) stddev-sans-first:33.00 20:45:02 INFO - PROCESS | 1655 | Values: 199.0 205.0 235.0 242.0 216.0 274.0 276.0 201.0 195.0 188.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:70.50 Median:74.00 stddev:10.92 (14.8%) stddev-sans-first:11.02 20:45:02 INFO - PROCESS | 1655 | Values: 80.0 57.0 59.0 86.0 73.0 54.0 75.0 73.0 67.0 81.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:86.20 Median:72.00 stddev:16.23 (22.5%) stddev-sans-first:16.90 20:45:02 INFO - PROCESS | 1655 | Values: 95.0 101.0 117.0 100.0 72.0 72.0 82.0 72.0 69.0 82.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:100.80 Median:88.00 stddev:20.93 (23.8%) stddev-sans-first:21.76 20:45:02 INFO - PROCESS | 1655 | Values: 89.0 88.0 89.0 88.0 97.0 128.0 78.0 129.0 134.0 88.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:108.00 Median:135.50 stddev:22.78 (16.8%) stddev-sans-first:23.93 20:45:02 INFO - PROCESS | 1655 | Values: 99.0 101.0 99.0 100.0 100.0 99.0 100.0 99.0 111.0 172.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:115.00 Median:118.50 stddev:22.60 (19.1%) stddev-sans-first:23.96 20:45:02 INFO - PROCESS | 1655 | Values: 117.0 95.0 144.0 89.0 148.0 143.0 114.0 94.0 97.0 109.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.52 (2.5%) stddev-sans-first:1.58 20:45:02 INFO - PROCESS | 1655 | Values: 60.0 60.0 60.0 59.0 61.0 64.0 60.0 61.0 63.0 61.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:73.00 stddev:3.79 (5.2%) stddev-sans-first:3.13 20:45:02 INFO - PROCESS | 1655 | Values: 66.0 79.0 73.0 78.0 75.0 71.0 71.0 71.0 71.0 73.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:95.40 Median:90.00 stddev:8.68 (9.6%) stddev-sans-first:9.06 20:45:02 INFO - PROCESS | 1655 | Values: 91.0 91.0 88.0 93.0 88.0 89.0 91.0 105.0 108.0 110.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:144.50 stddev:20.40 (14.1%) stddev-sans-first:21.27 20:45:02 INFO - PROCESS | 1655 | Values: 141.0 139.0 141.0 145.0 159.0 144.0 143.0 144.0 207.0 154.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.50 Median:174.50 stddev:21.00 (12.0%) stddev-sans-first:21.70 20:45:02 INFO - PROCESS | 1655 | Values: 171.0 173.0 173.0 172.0 174.0 174.0 175.0 201.0 236.0 196.0 20:45:02 INFO - PROCESS | 1655 | 20:45:02 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:73.50 stddev:10.77 (14.7%) stddev-sans-first:11.41 20:45:02 INFO - PROCESS | 1655 | Values: 71.0 76.0 86.0 67.0 61.0 61.0 62.0 68.0 86.0 88.0 20:45:02 INFO - PROCESS | 1655 | -------- Summary: end -------- 20:45:02 INFO - PROCESS | 1655 | 20:45:03 INFO - TEST-INFO | 1655: exit 0 20:45:03 INFO - TEST-OK | kraken | took 61208ms 20:45:03 INFO - SUITE-END | took 1177s 20:45:03 INFO - Completed test suite (00:19:37) 20:45:03 INFO - javascript benchmark 20:45:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7208.026271849078, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3278.131295206769, 3316.7014968652825, 3330.2007518195624, 3351.463765797473, 3355.83220838958, 5577.135543990677, 5620.156976453534, 5624.493795558399, 5697.971510142444, 5715.028445164322, 4456.6657500687415, 4704.929426058603, 5449.891002179954, 5576.414476479972, 5743.798967036144, 4770.880727981794, 5168.715720635363, 5174.2238664200295, 5184.1705327147665, 5228.451012643655, 5055.0, 5165.870853228681, 5193.402758682762, 5231.843044708646, 5322.787088516455, 5064.164412871909, 5202.4537423570355, 5207.973960130213, 5214.426413094557, 5219.817306394277, 5072.746362681851, 5156.845294641167, 5157.896842063138, 5162.096633089194, 5163.457836927144, 4027.556968733437, 4995.125852975751, 5079.0, 5134.306868572732, 5167.121589329785, 4595.2188128018315, 5433.538149257318, 5551.500364967132, 5551.833444996616, 5557.694326812024, 6138.785142519991, 6140.324564297924, 6141.846453838645, 6142.385761423822, 6184.81445556634, 5569.663280812616, 5776.624519406268, 6129.695011270001, 6174.96912515439, 6218.720157592874, 5766.94233057664, 5833.679147646878, 5834.124881267759, 5852.736626851802, 5861.9706901465215, 5557.499825015768, 6125.295591007002, 6228.6574238416415, 6230.0, 6240.188775459162, 5798.33319168301, 5844.795432159854, 5867.061270196833, 6128.3258841527395, 6133.080037994337, 6039.849003774941, 6043.637381757108, 6055.182550355646, 6074.939250607437, 6086.6348019119, 5943.375945525744, 5955.37468565803, 6002.699865006733, 6044.304904935989, 6076.513878889678, 6105.694715264219, 6118.051701986199, 6174.536909731698, 6191.535634827406, 6195.659238741822, 4875.829345972874, 4883.9011222474655, 4910.435299940481, 4913.31213630092, 4925.236588328815, 4304.870853874389, 4312.331588603772, 4365.781710914442, 4407.162639098561, 4432.534583868647, 5700.287464066992, 5773.134029895549, 5810.912836307459, 5817.214676018683, 5853.1220316952795, 6143.385661433821, 6197.225346831646, 6204.503639708812, 6218.284897236786, 6261.9373806262265, 5526.977509160818, 5586.0, 5769.394213607511, 5783.797567085132, 5792.681402522901, 5261.947380526146, 5287.101192797234, 5291.04761142998, 5301.893962120813, 5307.867303317448, 6221.813345599639, 6222.439980401786, 6222.906656400248, 6227.252729672468, 6240.188775459162, 5297.337832770903, 6187.783427580013, 6211.782587609412, 6218.0, 6225.968870155621, 6097.32929377777, 6139.26328840542, 6139.798803208702, 6147.262328520606, 6207.503399727921, 4668.976655116703, 5623.746931388016, 6146.078088286793, 6150.323464418821, 6185.752569897334, 5127.615428842926, 5281.867953301198, 5459.317585301837, 6063.545234107548, 6129.908051379322, 6069.666168360783, 6079.635221886701, 6135.5082808396355, 6135.814547850547, 6161.168242287234, 5843.328017278068, 5918.496927761188, 6088.117223002729, 6098.5426093042315, 6125.571210015434, 5613.803516877053, 5791.507721843691, 5875.50058245054, 5945.791897283574, 6058.969705151446, 6011.218541589566, 6098.725557350019, 6105.847353816012, 6122.204113465399, 6141.84645383869, 5544.1960915667805, 5727.284089488814, 5746.770129194785, 5756.7409466574945, 5763.33721622002], "value": 5566.772068004926, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.86950719045075, 461.99076018479633, 497.5596597011644, 503.19740014676603, 507.7892674540065, 39885.002874928105, 40853.182936341254, 40972.59027409725, 42648.786756066176, 42994.0, 41869.58130418695, 42147.0, 42341.7882910585, 42410.36384454236, 42543.361849572204, 7430.219826918177, 7874.724384646539, 9241.861372079407, 9461.006594307568, 9488.288378371615, 11089.390083545402, 11423.885761142406, 11487.712807179803, 11612.825807612893, 11633.94183029088, 11338.0, 11378.2035257532, 11389.316641001526, 11419.600313989013, 11421.771564568704, 11220.0, 11302.378369189692, 11315.660530184066, 11329.09367250618, 11332.546698132064, 11193.99254067138, 11254.831177532344, 11261.66215013551, 11262.493187806487, 11309.830352544719, 40351.798241008604, 40389.1922161558, 40468.595314047074, 40670.796646016875, 40795.38806917869, 3925.6663183629425, 3977.204559088194, 3992.0818211811447, 4025.2754504189234, 4121.91756164875, 30009.949651762083, 30491.390172196654, 30563.38873222523, 30608.928687496053, 31405.37189256225, 3071.66211716711, 3104.5964024676646, 3112.2997325601787, 3176.2059485128716, 3198.8080715157166, 488846.5557672224, 496135.0386496161, 497060.0, 498157.0, 500515.0, 57404.0, 57638.7118064407, 57668.71165644145, 57879.71060144672, 58185.418145818, 60538.69730651407, 60853.69573152195, 60929.0, 61202.69398653067, 61222.0, 15333.539993800205, 15772.0, 15773.763393549107, 15794.0, 15812.209389530477, 11121.388323642277, 11441.599544016086, 12062.819057714141, 12290.508379664714, 12331.50673973031, 15334.003289786127, 15356.692866142615, 15388.384464621513, 15399.692006160038, 15451.690966180613, 6279.623222606659, 7251.92748072523, 7294.234105418961, 7331.340179383775, 7371.226021267689, 637.5568979559255, 724.478375569589, 760.3764912771475, 766.237593594366, 784.8548018616574, 24496.877515612665, 29075.418491630047, 29457.11628651144, 30096.548551771742, 30189.245268868453, 898.6180873128894, 1024.4109636958779, 1034.363866222268, 1036.3419228789774, 1072.7586293083993, 13255.801162982563, 14298.28508574567, 15178.089314640936, 15251.694966100838, 15584.84415155834, 519097.0, 526164.0, 629208.0, 631906.0, 633362.0, 54911.45088549143, 56116.71941640266, 56680.71659641758, 56924.71537642368, 57048.71475642595, 1409.393960596953, 1414.1373762005169, 1429.199648197013, 1431.355889849572, 1431.8711315981611, 28237.0, 28541.28646783847, 29224.853875730485, 29375.559366609945, 29575.0, 40439.797801010805, 40568.580099696366, 48244.93428189989, 48713.26930096122, 48742.75628621834, 454442.0, 455532.0, 459483.0, 459791.0, 460953.0, 29225.26936826511, 32101.876434324688, 36775.632243677224, 38456.423153653275, 38836.41745373765, 46122.0, 46198.07603847972, 46396.53603463922, 47254.76372618252, 47395.289070663275, 37924.62075379321, 38160.42759358556, 38234.0, 38846.0, 39549.60450395574, 37202.627973719915, 37294.81352593219, 37632.247355053296, 38366.23267534578, 38599.6140038596, 36637.633623664486, 36850.8157459211, 36893.07767305839, 37304.813475932446, 37443.6255637451, 26837.194884153505, 27291.181264562096, 31003.224919376295, 33194.00417987464, 33239.83380083084, 24309.75690243075, 24417.877910611045, 24627.753722462545, 24989.375265618506, 25128.37179070538], "value": 19705.448769609935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.78112242093533, 387.98254078566447, 389.14776639160243, 405.3534612293395, 417.8725488725937, 18369.816301836996, 19466.221351145974, 20086.6986995195, 20307.898460507713, 20398.490037749027, 19444.611107777837, 19692.212311507523, 19880.801191988077, 19883.30408435705, 20396.59206815863, 4878.4145902491755, 5744.195812586252, 5946.316173640043, 5984.760609575612, 5988.670623115727, 5810.041343178371, 5905.379935106816, 5915.704214789265, 5918.4673379395845, 5919.822405327825, 5599.524040456566, 5784.479396854304, 5842.5618078644275, 5849.473547380735, 5852.9707351463185, 5650.056200824279, 5790.305163380401, 5836.766529338822, 5842.9774789411895, 5848.590598658096, 4983.426905905831, 5069.543741063285, 5092.337996060489, 5099.311592934981, 5099.87250318745, 24035.39911502209, 24075.638865417033, 24287.757122428728, 24585.38536536583, 24748.0, 2657.9257484081227, 2720.7143249958667, 2724.809263351566, 2758.3793646429594, 2761.8066735328534, 14638.121712697166, 15431.537053888402, 15518.922405388013, 15635.29641166139, 15705.293261803246, 1850.9537261568435, 1869.05612665603, 1982.5737466444639, 2001.8698784578955, 2006.618742438932, 124239.0, 137351.0, 140636.0, 143347.28326358303, 143758.0, 10182.694519164437, 11307.886921130683, 11561.248518846249, 11728.237664551776, 11731.47208375625, 15048.548543543711, 15049.774253386207, 15057.698846023019, 15107.39570417193, 15126.697466050617, 8344.123866994, 8466.407351485337, 8476.27951624119, 8497.575121244037, 8617.698380556776, 6800.489963252776, 7391.926080739231, 8280.0, 8308.335333173332, 8386.951631046119, 3757.661810437019, 4694.976525117352, 4698.647601429906, 4737.6683632146105, 4786.593139583105, 1983.2364539652049, 2025.7163997040427, 2030.878147311166, 2033.4916270932267, 2042.3362407217714, 944.5041353289578, 957.4398976598628, 959.5681943125621, 982.4547376206132, 995.2585323933571, 18851.811481885004, 20038.899805501173, 20264.0, 20422.387328380173, 20433.69349459759, 970.7912798748303, 995.4574756757585, 995.8406654935176, 1022.4580972084807, 1028.475477506477, 9795.677583526132, 10151.187904967584, 10341.9482902585, 10461.372317660813, 10486.73783155412, 460667.0, 466829.0, 467892.0, 745418.0, 759775.0, 100763.49618251862, 112302.43848780704, 112544.87455125508, 150295.0, 161521.0, 967.1972263021676, 995.6714284286313, 1026.1482969135748, 1038.314712289885, 1038.984415233772, 18252.08739563043, 18554.44336669902, 18639.627207455505, 18671.6265674683, 18780.7182892254, 51046.744766277414, 58285.83428331494, 60900.69549652223, 61094.0, 61783.96808414877, 85211.60532310413, 89986.0, 90155.19689606302, 90725.54637227036, 90782.09217907736, 7686.730964416219, 8090.959545202236, 8397.37019723511, 8475.32197424217, 8499.490030597937, 11822.0, 12239.449224784728, 12535.623931282076, 13040.478380864659, 13243.0, 10894.400807955639, 11080.778384432428, 11226.0, 11268.323900565993, 11472.082233421474, 9757.707268781947, 11022.071137550736, 11056.834147487632, 11127.22109452363, 11146.665600032013, 11042.668719938414, 11210.159238057015, 11260.268082574607, 11404.94297528507, 11423.428828558704, 8242.340612751086, 8398.706045288385, 8403.915960840313, 8543.957280213808, 8616.181462761027, 9841.507924603884, 10384.273100882865, 10595.576176952836, 11015.284006539548, 11221.353060255613], "value": 9786.946339282113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.1359082619233, 1307.1111644082032, 1323.8411390633125, 1368.3705495472082, 1407.6973450708101, 6709.832254193648, 6949.305069493048, 7514.66184021719, 8487.787805304863, 8496.32029437645, 7083.1854336751285, 7229.819254518639, 7996.640151193195, 8128.715494957678, 8342.416030877826, 2287.7025986621757, 2333.6966194394704, 2334.6964894563685, 2335.4628435459854, 2350.6944097267333, 2066.6693329067352, 2279.088364654135, 2338.368640467073, 2345.3901985483812, 2352.647102934565, 2078.449210959097, 2096.2348742708878, 2198.9010494527784, 2219.966700499494, 2308.134449581407, 1948.4836518322513, 2306.4925716342545, 2321.442853715105, 2330.0446816805115, 2337.322176568793, 2326.336993956731, 2326.860388376686, 2339.894704738291, 2356.8585884846966, 2377.3699969508093, 8363.498190108612, 8415.537145456998, 8479.66081356745, 8491.150884911522, 8494.108118647515, 5050.84847454577, 5143.3570803649545, 5195.9480405195845, 5201.687898726089, 5206.0, 3273.8035717856765, 3396.524486571882, 3410.6248312685584, 3447.379471695094, 3477.23500829817, 1163.2903928603546, 1165.6095208105296, 1183.7040739815047, 1207.8550573931097, 1226.129448091856, 10806.081483073947, 10857.0, 10954.0, 10965.945170274177, 10974.231803773739, 4294.227039132924, 4428.3800267962515, 4428.446444194476, 4507.616852567503, 4509.301058335963, 8513.74458766238, 8650.35122365825, 8669.306455483546, 8695.260902823331, 8712.912870871336, 5047.965167140801, 5109.284700141909, 5126.487351264844, 5133.666311689728, 5148.897022059537, 4713.882152946135, 4747.074320507468, 4756.310335001405, 4792.0895029944195, 4799.448063472745, 3624.8187590620364, 3642.34437801193, 3672.3573374659327, 3700.666939975415, 3716.851325946986, 1069.2141276162015, 1145.799485090106, 1150.8446359741495, 1162.110985096402, 1164.5691094295164, 802.4984384759525, 897.7306807957586, 899.1233547291339, 904.6471875968377, 938.3853575907655, 5317.0, 5515.200295957144, 5588.692621905753, 5642.492175704207, 5657.717114144276, 899.802043550431, 944.4852555357347, 955.5843208204453, 967.8112768010311, 1034.281174583657, 3514.1741690702665, 3678.33789917812, 3766.6233376662663, 3803.391457366808, 3803.8858834235016, 9725.756856078513, 10008.049235322633, 10015.298929075041, 10017.14854237398, 10047.748806279902, 9947.0, 9962.551685174185, 9975.800483990424, 9985.900140998643, 10004.0, 6329.0, 7539.698412063456, 7723.304902558684, 7745.728899488491, 7868.72459463916, 4942.308076869169, 5157.690538567698, 5509.311336082989, 5617.915731264116, 5660.971695141498, 8934.687285944961, 9001.729948101567, 9197.172254497127, 9280.860787088064, 9432.292578056537, 9223.907760922304, 9365.625374984924, 9440.244780417413, 9530.523473826142, 9540.093691099335, 7055.682494287872, 7232.312930271616, 7241.877508986116, 7259.709611615476, 7286.562806231643, 7750.186230445947, 7784.532928024337, 7815.413843961612, 7844.529328240324, 7871.0, 6240.375962403723, 6991.930080699128, 6993.300669932966, 7018.929810701828, 7048.0, 6970.372666460043, 6979.336962988508, 6987.266337034538, 7090.64546772649, 7099.077119974577, 6290.654014029273, 6304.747810087545, 6405.903911441425, 6405.967970160305, 6443.065755465525, 4776.188048031773, 4810.302506136521, 4831.9275210872565, 4844.688227477477, 4937.456879743154, 4591.793369298456, 4603.355530225704, 4696.577308042292, 4718.0, 4770.0], "value": 4335.599613965807, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.80929061144536, 329.6390452454562, 348.95463589733333, 352.3252970561375, 368.9686376657984, 4579.8397056103, 5267.5760755508845, 5338.67967921925, 5428.592855535836, 5513.365962914261, 4320.740755554669, 4836.588889944359, 4950.678205916613, 5231.032259032082, 5399.029354285687, 3705.3330400527893, 4052.8581499647516, 4239.152169566084, 4249.511306199795, 4294.914101717964, 3676.466912297715, 3774.4527043578664, 4099.392425639042, 4240.448741663579, 4251.298535741599, 3518.753687241894, 4202.0, 4207.389928460371, 4215.978920105411, 4217.451731274945, 3714.962850371489, 4196.853110141145, 4214.452121224236, 4220.662347012231, 4237.7669228192435, 3427.8628854845774, 3482.3905816482265, 3563.055790215595, 3727.1986522897705, 3770.359038963383, 3913.8630147944687, 4447.488538818013, 5269.074539468083, 5287.603429742746, 5311.893762124774, 4640.582347588733, 4643.305193604344, 4701.083288758693, 4751.239801631722, 4752.839361824383, 4810.532787499811, 5706.885862282773, 5725.0, 5801.970990145064, 5847.707614619295, 3462.9134271643156, 3777.905552361213, 3793.9810300948593, 3807.2766174427047, 3917.4319723640197, 6062.817385741129, 6075.453209211192, 6085.513158947274, 6091.51267898567, 6094.329623741429, 3677.669009789132, 3922.8623699126933, 3931.783751893616, 3935.0949281665376, 3950.6839452843706, 3322.352141332465, 3791.7914514701406, 3936.488256526633, 3969.940450893239, 4007.8597249096724, 4004.3593025115842, 4154.813033413504, 4669.696469729457, 4680.46174689915, 4689.859304220879, 5045.949540504622, 5725.764942807301, 5824.2236117983575, 5839.000284804837, 5839.357670656224, 1074.8172810622214, 1086.9184811139196, 1170.169179882276, 1222.4315693202705, 1265.5127775806197, 782.8316911863863, 816.6284340625001, 840.6297734692412, 869.1438932651333, 878.550391853447, 4866.369766128387, 4931.580815630711, 5030.597552195815, 5115.335006449138, 5240.768419421433, 5141.897162056738, 5611.102223644198, 5661.547076233891, 5695.373508914016, 5712.400197979152, 4262.893427664333, 4437.400950871655, 5069.656541016633, 5203.453637368098, 5275.60432967529, 2772.50094982905, 2847.615571897809, 2960.422717570096, 2983.612130423031, 3032.166154307583, 5128.384593848762, 5561.054620714407, 5618.971905140448, 5795.043817770105, 5892.322382926019, 4658.091672123971, 5097.490250974947, 5110.4634013428795, 5655.0386434306265, 5703.944770217523, 5130.51260130287, 5822.311529656352, 6022.006368949162, 6098.237720284965, 6099.634021958696, 5110.66780659256, 5296.841094767163, 5859.6278115759515, 5886.499647530008, 6008.519318454426, 4935.555799978019, 5516.724163791875, 5776.653400795798, 5783.248177736868, 5881.441263080001, 5919.704014799329, 5955.166276721349, 5984.700764961822, 5991.820245392645, 6012.458878700763, 3467.826608669506, 3763.3226019316785, 3858.5176852893387, 3895.435161901565, 3928.9214215714956, 5387.0, 5837.67892765902, 5889.793857214977, 5938.0, 5938.881222375442, 4498.977505112453, 4603.631709463168, 4654.627629789541, 5618.6628802272, 5650.378458369494, 4479.238529450066, 5283.815066472809, 5312.28284181646, 5698.202251684685, 5828.53371730269, 5214.661047031931, 5401.9466204091395, 5618.803341883015, 5622.156676498558, 5636.2954630671165, 5262.947370526245, 5456.345238571397, 5535.5848311376, 5767.365589785204, 5785.8553536161935, 5539.612227144223, 5541.833744987657, 5546.861328466821, 5560.277163968658, 5567.359753628384], "value": 4103.089896930103, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.4970821008872, 762.0169980724866, 778.5834578500496, 793.333599776188, 813.7355359508159, 13185.7362852743, 15889.44386946457, 15901.92049039756, 15915.442959496406, 15964.521064368073, 14401.13593184407, 14555.0, 14572.489962851303, 14588.708225835477, 14621.926890365534, 682.6791408038239, 707.2573797512591, 861.8965724113115, 884.8761173435724, 888.471359541072, 899.9460032398044, 900.5047224026791, 900.693764120199, 902.6569903436684, 906.3610154840854, 843.3759018326456, 932.0260327957267, 933.6592143867507, 958.3674774648733, 964.0600414595748, 951.362587066667, 957.200737384278, 960.3853533738378, 963.2342287881152, 965.918171647759, 695.2977492732326, 702.420503084957, 705.8094314535098, 707.6002058836741, 709.439542761218, 14852.702945941128, 15190.240487975667, 15497.45758898433, 15542.145182015098, 15758.684826303524, 14161.716765664629, 14450.927745361207, 14452.50773993808, 14549.78175327371, 14590.90568207378, 11733.12001599875, 11783.823242651368, 11798.115141364431, 11812.645620631394, 11828.05375569961, 3695.224002959382, 3729.515163028816, 3780.9621903780885, 3811.352070148054, 3942.25097231528, 86104.0, 103145.4842725789, 103271.48364258131, 105185.0, 108450.45774771155, 10965.396903170242, 10999.285046471954, 11107.278026928223, 11155.051820595178, 11456.599019034295, 19697.803021969597, 20277.79722202759, 22770.544589108125, 22805.543889122124, 22817.0, 7815.491993020435, 7864.921350786533, 7881.211878812073, 8043.638036288381, 8160.591970401456, 4294.377315289265, 4317.481902171697, 4326.437563116838, 4406.581374769392, 4480.0, 3614.204874927512, 3654.488371627974, 3692.593814680383, 3694.9076273093387, 3697.7226707997006, 651.485326591987, 660.0923729871427, 669.7856685860478, 676.6413800685644, 678.1015154919751, 617.4751461257895, 639.6002498438476, 644.0693198328464, 653.8463461086641, 669.2537820330297, 9071.727848164566, 9419.34064615484, 9422.586612008254, 9428.95285523568, 10061.396316220904, 552.8009916430082, 560.15137067343, 570.9200711900337, 627.4603840696997, 660.7125900233414, 4112.588741125864, 4409.206342858316, 4586.926759071363, 4604.286335617984, 4674.135284972291, 77063.22936770672, 95715.0, 96434.51782741041, 102025.48987255164, 103278.96721032694, 87979.0, 88276.11723882679, 89625.0, 91050.54474727716, 91508.54245728863, 77650.0, 77688.61155694185, 78420.0, 79258.6037069811, 80096.3980720394, 7646.65590048438, 7767.0, 7773.766786996399, 7928.920710793049, 7983.680652773824, 35375.0, 37754.62245377621, 45229.773851130536, 46286.0, 49069.77325566747, 40592.0, 54049.18926216031, 63957.680211600506, 65372.67313663401, 66014.66992665007, 12783.48866045385, 12913.031522635652, 13010.21938683682, 13024.47902083906, 13032.609021729364, 12217.93891030539, 12908.548200812926, 13200.471981121033, 14697.485588004369, 14900.403983840524, 10935.781284374427, 12690.92127169201, 13833.446662133401, 13857.237851918242, 14369.928150359181, 11066.0, 11951.62155184401, 13103.934480327538, 13832.446702131801, 14226.502072427415, 12231.108112398835, 12307.0, 12947.611571652866, 12983.35083245853, 13263.535776247785, 11139.636009035083, 11350.943245284052, 11384.316940983568, 11435.828462573234, 11555.306681599131, 8250.349930014141, 9584.318017861086, 9923.702288931343, 11168.944155279496, 11209.047230985458], "value": 7342.651539094593, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 120.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 113.0, 149.0, 118.0, 157.0, 143.0, 114.0, 135.0, 115.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 205.0, 235.0, 242.0, 216.0, 274.0, 276.0, 201.0, 195.0, 188.0], "value": 223.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 59.0, 86.0, 73.0, 54.0, 75.0, 73.0, 67.0, 81.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 117.0, 100.0, 72.0, 72.0, 82.0, 72.0, 69.0, 82.0], "value": 86.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 89.0, 88.0, 97.0, 128.0, 78.0, 129.0, 134.0, 88.0], "value": 100.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 99.0, 100.0, 100.0, 99.0, 100.0, 99.0, 111.0, 172.0], "value": 108.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 95.0, 144.0, 89.0, 148.0, 143.0, 114.0, 94.0, 97.0, 109.0], "value": 115.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 61.0, 64.0, 60.0, 61.0, 63.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 79.0, 73.0, 78.0, 75.0, 71.0, 71.0, 71.0, 71.0, 73.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 88.0, 93.0, 88.0, 89.0, 91.0, 105.0, 108.0, 110.0], "value": 95.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 141.0, 145.0, 159.0, 144.0, 143.0, 144.0, 207.0, 154.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 173.0, 172.0, 174.0, 174.0, 175.0, 201.0, 236.0, 196.0], "value": 184.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 76.0, 86.0, 67.0, 61.0, 61.0, 62.0, 68.0, 86.0, 88.0], "value": 72.6, "unit": "score"}]}]} 20:45:03 INFO - Return code: 0 20:45:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:45:03 ERROR - # TBPL SUCCESS # 20:45:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:45:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:45:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:45:03 INFO - 2017-01-04 20:45:03.909 screenresolution[1660:10610] starting screenresolution argv=screenresolution get 20:45:03 INFO - 2017-01-04 20:45:03.912 screenresolution[1660:10610] Display 0: 1600x1200x32@60 20:45:03 INFO - 2017-01-04 20:45:03.918 screenresolution[1661:10613] starting screenresolution argv=screenresolution list 20:45:03 INFO - Available Modes on Display 0 20:45:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:45:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:45:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:45:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:45:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:45:04 INFO - Intel Iris: 20:45:04 INFO - Chipset Model: Intel Iris 20:45:04 INFO - Type: GPU 20:45:04 INFO - Bus: Built-In 20:45:04 INFO - VRAM (Dynamic, Max): 1536 MB 20:45:04 INFO - Vendor: Intel (0x8086) 20:45:04 INFO - Device ID: 0x0a2e 20:45:04 INFO - Revision ID: 0x0009 20:45:04 INFO - Displays: 20:45:04 INFO - Display: 20:45:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:45:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:45:04 INFO - Display Serial Number: 1600x1200 60 20:45:04 INFO - Main Display: Yes 20:45:04 INFO - Mirror: Off 20:45:04 INFO - Online: Yes 20:45:04 INFO - Rotation: Supported 20:45:04 INFO - Return code: 0 20:45:04 INFO - Running post-action listener: _resource_record_post_action 20:45:04 INFO - [mozharness: 2017-01-05 04:45:04.155598Z] Finished run-tests step (success) 20:45:04 INFO - Running post-run listener: _resource_record_post_run 20:45:04 INFO - Total resource usage - Wall time: 1199s; CPU: 55.0%; Read bytes: 38664704; Write bytes: 550849536; Read time: 250; Write time: 1679 20:45:04 INFO - TinderboxPrint: CPU usage
55.0% 20:45:04 INFO - TinderboxPrint: I/O read bytes / time
38,664,704 / 250 20:45:04 INFO - TinderboxPrint: I/O write bytes / time
550,849,536 / 1,679 20:45:04 INFO - TinderboxPrint: CPU idle
2,159.4 (45.0%) 20:45:04 INFO - TinderboxPrint: CPU system
973.9 (20.3%) 20:45:04 INFO - TinderboxPrint: CPU user
1,664.3 (34.7%) 20:45:04 INFO - TinderboxPrint: Swap in / out
288,268,288 / 0 20:45:04 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 231234048; Write bytes: 224802304; Read time: 16435; Write time: 496 20:45:04 INFO - run-tests - Wall time: 1179s; CPU: 55.0%; Read bytes: 37706240; Write bytes: 299116032; Read time: 237; Write time: 1122 20:45:04 INFO - Running post-run listener: _upload_blobber_files 20:45:04 INFO - Blob upload gear active. 20:45:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:45:04 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:45:04 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:45:04 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:45:05 INFO - (blobuploader) - INFO - Open directory for files ... 20:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:05 INFO - (blobuploader) - INFO - Done attempting. 20:45:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:45:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:06 INFO - (blobuploader) - INFO - Done attempting. 20:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:45:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:07 INFO - (blobuploader) - INFO - Done attempting. 20:45:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:45:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:45:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:45:10 INFO - (blobuploader) - INFO - Done attempting. 20:45:10 INFO - (blobuploader) - INFO - Iteration through files over. 20:45:10 INFO - Return code: 0 20:45:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:45:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:45:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf9d52059e3d70c77c5a4a3aa19df7cbb8f000b0f3bdc4106f503135ec248dda593c46792c019df2f27d0ebbe43621ee432200bad883589146a0e1cd45994bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c2bf91ab7f6901d99724a0dc887d806fb7a23edb31e7b2b6ae7810e77dced13f72e7067a0815543c59ece579944a5e1f379be6cbd835e79968dc7739d07019f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c24e90fa968f51712038f9270e05322b0a700e878d6900e748e31c007499dc3215a9b321ac9a4f03653b260f1044ab7a691f611d6dbc07e09ca126015ec09a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b174861f7cc2c61c3792365193b0689547a6bf34722e563c8297e1be41f4359ab19ad7e4f0ea70c8143d71dd7d4a619284d2e9452fb08195f5bcb856d472a2f9"} 20:45:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:45:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:45:10 INFO - Contents: 20:45:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf9d52059e3d70c77c5a4a3aa19df7cbb8f000b0f3bdc4106f503135ec248dda593c46792c019df2f27d0ebbe43621ee432200bad883589146a0e1cd45994bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c2bf91ab7f6901d99724a0dc887d806fb7a23edb31e7b2b6ae7810e77dced13f72e7067a0815543c59ece579944a5e1f379be6cbd835e79968dc7739d07019f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c24e90fa968f51712038f9270e05322b0a700e878d6900e748e31c007499dc3215a9b321ac9a4f03653b260f1044ab7a691f611d6dbc07e09ca126015ec09a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b174861f7cc2c61c3792365193b0689547a6bf34722e563c8297e1be41f4359ab19ad7e4f0ea70c8143d71dd7d4a619284d2e9452fb08195f5bcb856d472a2f9"} 20:45:10 INFO - Running post-run listener: copy_logs_to_upload_dir 20:45:10 INFO - Copying logs to upload dir... 20:45:10 INFO - mkdir: /builds/slave/test/build/upload/logs 20:45:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.783996 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-04 20:45:10.083064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 20:45:10.087381) ========= 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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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/bbf9d52059e3d70c77c5a4a3aa19df7cbb8f000b0f3bdc4106f503135ec248dda593c46792c019df2f27d0ebbe43621ee432200bad883589146a0e1cd45994bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c2bf91ab7f6901d99724a0dc887d806fb7a23edb31e7b2b6ae7810e77dced13f72e7067a0815543c59ece579944a5e1f379be6cbd835e79968dc7739d07019f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c24e90fa968f51712038f9270e05322b0a700e878d6900e748e31c007499dc3215a9b321ac9a4f03653b260f1044ab7a691f611d6dbc07e09ca126015ec09a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b174861f7cc2c61c3792365193b0689547a6bf34722e563c8297e1be41f4359ab19ad7e4f0ea70c8143d71dd7d4a619284d2e9452fb08195f5bcb856d472a2f9"} build_url:https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011034 build_url: 'https://queue.taskcluster.net/v1/task/CeIly1lBQ1Cywxs2JNgArA/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbf9d52059e3d70c77c5a4a3aa19df7cbb8f000b0f3bdc4106f503135ec248dda593c46792c019df2f27d0ebbe43621ee432200bad883589146a0e1cd45994bd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c2bf91ab7f6901d99724a0dc887d806fb7a23edb31e7b2b6ae7810e77dced13f72e7067a0815543c59ece579944a5e1f379be6cbd835e79968dc7739d07019f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c24e90fa968f51712038f9270e05322b0a700e878d6900e748e31c007499dc3215a9b321ac9a4f03653b260f1044ab7a691f611d6dbc07e09ca126015ec09a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b174861f7cc2c61c3792365193b0689547a6bf34722e563c8297e1be41f4359ab19ad7e4f0ea70c8143d71dd7d4a619284d2e9452fb08195f5bcb856d472a2f9"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 20:45:10.127910) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 20:45:10.128357) ========= 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.qjCRWa9GpH/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.YxGuhmz2kN/Listeners TMPDIR=/var/folders/8q/hdbfxhcs15739c66r08gln1r00000w/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.004987 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 20:45:10.178679) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 20:45:10.179356) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 20:45:10.180042) ========= ========= Total master_lag: 0.19 =========