builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0306 starttime: 1487880498.15 results: success (0) buildid: 20170223110523 builduid: a8f7f98ff1da4abf89d802ad7fa14909 revision: 5069348353f8fc1121e632e3208da33900627214 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.149464) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.149978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.150338) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.176792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.177384) ========= 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.IWELZGA29F/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.r4cIwZNgw5/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 12:08:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.5M=0.001s 2017-02-23 12:08:18 (18.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.171493 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.372844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.373169) ========= 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.IWELZGA29F/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.r4cIwZNgw5/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.026812 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:18.423362) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 12:08:18.423708) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5069348353f8fc1121e632e3208da33900627214 --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 5069348353f8fc1121e632e3208da33900627214 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IWELZGA29F/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.r4cIwZNgw5/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 12:08:18,523 truncating revision to first 12 chars 2017-02-23 12:08:18,523 Setting DEBUG logging. 2017-02-23 12:08:18,523 attempt 1/10 2017-02-23 12:08:18,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5069348353f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 12:08:19,718 unpacking tar archive at: mozilla-central-5069348353f8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.461904 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-23 12:08:19.910160) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:19.910691) ========= script_repo_revision: 5069348353f8fc1121e632e3208da33900627214 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:19.911314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:19.911742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 12:08:19.931107) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-23 12:08:19.931494) ========= /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.IWELZGA29F/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.r4cIwZNgw5/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:08:20 INFO - MultiFileLogger online at 20170223 12:08:20 in /builds/slave/test 12:08:20 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 12:08:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:08:20 INFO - {'append_to_log': False, 12:08:20 INFO - 'base_work_dir': '/builds/slave/test', 12:08:20 INFO - 'blob_upload_branch': 'Firefox', 12:08:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:08:20 INFO - 'branch': 'Firefox', 12:08:20 INFO - 'buildbot_json_path': 'buildprops.json', 12:08:20 INFO - 'config_files': ('talos/mac_config.py',), 12:08:20 INFO - 'default_actions': ('clobber', 12:08:20 INFO - 'read-buildbot-config', 12:08:20 INFO - 'download-and-extract', 12:08:20 INFO - 'populate-webroot', 12:08:20 INFO - 'create-virtualenv', 12:08:20 INFO - 'install', 12:08:20 INFO - 'run-tests'), 12:08:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:08:20 INFO - 'download_minidump_stackwalk': True, 12:08:20 INFO - 'download_symbols': 'ondemand', 12:08:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:08:20 INFO - 'tooltool.py': '/tools/tooltool.py', 12:08:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:08:20 INFO - '/tools/misc-python/virtualenv.py')}, 12:08:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:08:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:08:20 INFO - 'gecko_profile': False, 12:08:20 INFO - 'gecko_profile_interval': 0, 12:08:20 INFO - 'installer_path': 'installer.exe', 12:08:20 INFO - 'log_level': 'info', 12:08:20 INFO - 'log_name': 'talos', 12:08:20 INFO - 'log_to_console': True, 12:08:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:08:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:08:20 INFO - 'opt_config_files': (), 12:08:20 INFO - 'pip_index': False, 12:08:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:20 INFO - 'cmd': ('bash', 12:08:20 INFO - '-c', 12:08:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:20 INFO - 'enabled': True, 12:08:20 INFO - 'halt_on_failure': False, 12:08:20 INFO - 'name': 'check_screen_resolution'},), 12:08:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:08:20 INFO - 'cmd': ('bash', 12:08:20 INFO - '-c', 12:08:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:08:20 INFO - 'enabled': True, 12:08:20 INFO - 'halt_on_failure': False, 12:08:20 INFO - 'name': 'check_screen_resolution'},), 12:08:20 INFO - 'run_cmd_checks_enabled': True, 12:08:20 INFO - 'suite': 'dromaeojs-e10s', 12:08:20 INFO - 'system_bits': '32', 12:08:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:08:20 INFO - 'title': 't-yosemite-r7-0306', 12:08:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:08:20 INFO - 'use_talos_json': True, 12:08:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:08:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:08:20 INFO - 'work_dir': 'build'} 12:08:20 INFO - [mozharness: 2017-02-23 20:08:20.139047Z] Running clobber step. 12:08:20 INFO - Running pre-action listener: _resource_record_pre_action 12:08:20 INFO - Running main action method: clobber 12:08:20 INFO - rmtree: /builds/slave/test/build 12:08:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:08:22 INFO - Running post-action listener: _resource_record_post_action 12:08:22 INFO - [mozharness: 2017-02-23 20:08:22.570828Z] Finished clobber step (success) 12:08:22 INFO - [mozharness: 2017-02-23 20:08:22.570954Z] Running read-buildbot-config step. 12:08:22 INFO - Running pre-action listener: _resource_record_pre_action 12:08:22 INFO - Running main action method: read_buildbot_config 12:08:22 INFO - Using buildbot properties: 12:08:22 INFO - { 12:08:22 INFO - "project": "", 12:08:22 INFO - "product": "firefox", 12:08:22 INFO - "script_repo_revision": "production", 12:08:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:08:22 INFO - "repository": "", 12:08:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:08:22 INFO - "buildid": "20170223110523", 12:08:22 INFO - "pgo_build": "False", 12:08:22 INFO - "basedir": "/builds/slave/test", 12:08:22 INFO - "buildnumber": 96, 12:08:22 INFO - "slavename": "t-yosemite-r7-0306", 12:08:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:08:22 INFO - "platform": "yosemite_r7", 12:08:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:08:22 INFO - "branch": "mozilla-central", 12:08:22 INFO - "repo_path": "mozilla-central", 12:08:22 INFO - "revision": "5069348353f8fc1121e632e3208da33900627214", 12:08:22 INFO - "stage_platform": "macosx64", 12:08:22 INFO - "builduid": "a8f7f98ff1da4abf89d802ad7fa14909", 12:08:22 INFO - "slavebuilddir": "test" 12:08:22 INFO - } 12:08:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 12:08:22 INFO - Running post-action listener: _resource_record_post_action 12:08:22 INFO - [mozharness: 2017-02-23 20:08:22.574429Z] Finished read-buildbot-config step (success) 12:08:22 INFO - [mozharness: 2017-02-23 20:08:22.574566Z] Running download-and-extract step. 12:08:22 INFO - Running pre-action listener: _resource_record_pre_action 12:08:22 INFO - Running main action method: download_and_extract 12:08:22 INFO - mkdir: /builds/slave/test/build/tests 12:08:22 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')]} 12:08:22 INFO - trying https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 12:08:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 12:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 12:08:23 INFO - Downloaded 1199 bytes. 12:08:23 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 12:08:23 INFO - Using the following test package requirements: 12:08:23 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 12:08:23 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 12:08:23 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 12:08:23 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'jsshell-mac.zip'], 12:08:23 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 12:08:23 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 12:08:23 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 12:08:23 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 12:08:23 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 12:08:23 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 12:08:23 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 12:08:23 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:08:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 12:08:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:08:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 12:08:25 INFO - Expected file size: 51450560 12:08:25 INFO - Obtained file size: 51450560 12:08:41 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:08:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 12:08:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:08:41 INFO - Fetch https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 12:08:43 INFO - Expected file size: 51450560 12:08:43 INFO - Obtained file size: 51450560 12:08:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 12:08:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:08:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 12:08:59 INFO - Expected file size: 14404306 12:08:59 INFO - Obtained file size: 14404306 12:08:59 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')]} 12:08:59 INFO - trying https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 12:08:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 12:08:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 12:09:01 INFO - Downloaded 74934982 bytes. 12:09:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 12:09:01 INFO - mkdir: /builds/slave/test/properties 12:09:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:09:01 INFO - Writing to file /builds/slave/test/properties/build_url 12:09:01 INFO - Contents: 12:09:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 12:09:02 INFO - Running post-action listener: _resource_record_post_action 12:09:02 INFO - Running post-action listener: set_extra_try_arguments 12:09:02 INFO - [mozharness: 2017-02-23 20:09:02.250219Z] Finished download-and-extract step (success) 12:09:02 INFO - [mozharness: 2017-02-23 20:09:02.250338Z] Running populate-webroot step. 12:09:02 INFO - Running pre-action listener: _resource_record_pre_action 12:09:02 INFO - Running main action method: populate_webroot 12:09:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:09:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:09:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:09:02 INFO - '--tppagecycles', 12:09:02 INFO - '7'], 12:09:02 INFO - 'tests': ['tsvgm']}}, 12:09:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:09:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:09:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:09:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:09:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:09:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['damp', 'tps']}, 12:09:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'tests': ['damp', 'tps']}, 12:09:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['dromaeo_dom']}, 12:09:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:09:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['basic_compositor_video']}, 12:09:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:09:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['a11yr', 12:09:02 INFO - 'ts_paint', 12:09:02 INFO - 'tpaint', 12:09:02 INFO - 'sessionrestore', 12:09:02 INFO - 'sessionrestore_no_auto_restore', 12:09:02 INFO - 'tabpaint']}, 12:09:02 INFO - 'other-e10s': {'tests': ['a11yr', 12:09:02 INFO - 'ts_paint', 12:09:02 INFO - 'tpaint', 12:09:02 INFO - 'sessionrestore', 12:09:02 INFO - 'sessionrestore_no_auto_restore', 12:09:02 INFO - 'tabpaint']}, 12:09:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:09:02 INFO - 'ts_paint', 12:09:02 INFO - 'tpaint', 12:09:02 INFO - 'sessionrestore', 12:09:02 INFO - 'sessionrestore_no_auto_restore', 12:09:02 INFO - 'tabpaint']}, 12:09:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:09:02 INFO - 'ts_paint', 12:09:02 INFO - 'tpaint', 12:09:02 INFO - 'sessionrestore', 12:09:02 INFO - 'sessionrestore_no_auto_restore', 12:09:02 INFO - 'tabpaint']}, 12:09:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['a11yr', 12:09:02 INFO - 'ts_paint', 12:09:02 INFO - 'tpaint', 12:09:02 INFO - 'sessionrestore', 12:09:02 INFO - 'sessionrestore_no_auto_restore', 12:09:02 INFO - 'tabpaint']}, 12:09:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['a11yr', 12:09:02 INFO - 'ts_paint', 12:09:02 INFO - 'tpaint', 12:09:02 INFO - 'sessionrestore', 12:09:02 INFO - 'sessionrestore_no_auto_restore', 12:09:02 INFO - 'tabpaint']}, 12:09:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['tsvgx', 12:09:02 INFO - 'tsvgr_opacity', 12:09:02 INFO - 'tart', 12:09:02 INFO - 'tscrollx', 12:09:02 INFO - 'cart', 12:09:02 INFO - 'tsvg_static']}, 12:09:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:09:02 INFO - 'tsvgr_opacity', 12:09:02 INFO - 'tart', 12:09:02 INFO - 'tscrollx', 12:09:02 INFO - 'cart', 12:09:02 INFO - 'tsvg_static']}, 12:09:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'talos_options': ['--disable-e10s'], 12:09:02 INFO - 'tests': ['tp5o']}, 12:09:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:09:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'talos_options': ['--disable-e10s', 12:09:02 INFO - '--xperf_path', 12:09:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:02 INFO - 'tests': ['tp5n']}, 12:09:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:09:02 INFO - 'talos_options': ['--xperf_path', 12:09:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:09:02 INFO - 'tests': ['tp5n']}}, 12:09:02 INFO - 'talos.zip': {'path': '', 12:09:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:09:02 INFO - Running post-action listener: _resource_record_post_action 12:09:02 INFO - [mozharness: 2017-02-23 20:09:02.268581Z] Finished populate-webroot step (success) 12:09:02 INFO - [mozharness: 2017-02-23 20:09:02.268713Z] Running create-virtualenv step. 12:09:02 INFO - Running pre-action listener: _resource_record_pre_action 12:09:02 INFO - Running main action method: create_virtualenv 12:09:02 INFO - Creating virtualenv /builds/slave/test/build/venv 12:09:02 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 12:09:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:09:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:09:02 INFO - Using real prefix '/tools/python27' 12:09:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:09:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:09:05 INFO - Installing pip.................done. 12:09:05 INFO - Return code: 0 12:09:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:09:06 INFO - Reading from file tmpfile_stdout 12:09:06 INFO - Output received: 12:09:06 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) 12:09:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:06 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 12:09:06 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 12:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:06 INFO - 'HOME': '/Users/cltbld', 12:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:06 INFO - 'LOGNAME': 'cltbld', 12:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:06 INFO - 'MOZ_NO_REMOTE': '1', 12:09:06 INFO - 'NO_EM_RESTART': '1', 12:09:06 INFO - 'PAGER': '/bin/cat', 12:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:06 INFO - 'PWD': '/builds/slave/test', 12:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:06 INFO - 'SHELL': '/bin/bash', 12:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:06 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:06 INFO - 'USER': 'cltbld', 12:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:06 INFO - 'XPC_FLAGS': '0x0', 12:09:06 INFO - 'XPC_SERVICE_NAME': '0', 12:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:06 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 12:09:06 INFO - Cleaning up... 12:09:06 INFO - Return code: 0 12:09:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:06 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:06 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 12:09:06 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 12:09:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:06 INFO - 'HOME': '/Users/cltbld', 12:09:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:06 INFO - 'LOGNAME': 'cltbld', 12:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:06 INFO - 'MOZ_NO_REMOTE': '1', 12:09:06 INFO - 'NO_EM_RESTART': '1', 12:09:06 INFO - 'PAGER': '/bin/cat', 12:09:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:06 INFO - 'PWD': '/builds/slave/test', 12:09:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:06 INFO - 'SHELL': '/bin/bash', 12:09:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:06 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:06 INFO - 'USER': 'cltbld', 12:09:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:06 INFO - 'XPC_FLAGS': '0x0', 12:09:06 INFO - 'XPC_SERVICE_NAME': '0', 12:09:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:06 INFO - Downloading/unpacking psutil>=3.1.1 12:09:06 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 12:09:06 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 12:09:06 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 12:09:06 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 12:09:06 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 12:09:06 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 12:09:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:09:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:10 INFO - Installing collected packages: psutil 12:09:10 INFO - Running setup.py install for psutil 12:09:10 INFO - building 'psutil._psutil_osx' extension 12:09:10 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 12:09:10 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 12:09:11 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 12:09:11 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 12:09:11 INFO - building 'psutil._psutil_posix' extension 12:09:11 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 12:09:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:09:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:09:11 INFO - ^ 12:09:11 INFO - 1 warning generated. 12:09:11 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 12:09:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:09:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:09:11 INFO - Successfully installed psutil 12:09:11 INFO - Cleaning up... 12:09:11 INFO - Return code: 0 12:09:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:09:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:11 INFO - 'HOME': '/Users/cltbld', 12:09:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:11 INFO - 'LOGNAME': 'cltbld', 12:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:11 INFO - 'MOZ_NO_REMOTE': '1', 12:09:11 INFO - 'NO_EM_RESTART': '1', 12:09:11 INFO - 'PAGER': '/bin/cat', 12:09:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:11 INFO - 'PWD': '/builds/slave/test', 12:09:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:11 INFO - 'SHELL': '/bin/bash', 12:09:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:11 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:11 INFO - 'USER': 'cltbld', 12:09:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:11 INFO - 'XPC_FLAGS': '0x0', 12:09:11 INFO - 'XPC_SERVICE_NAME': '0', 12:09:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:09:11 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 12:09:11 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 12:09:11 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 12:09:11 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 12:09:11 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 12:09:11 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 12:09:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:09:14 INFO - Installing collected packages: mozsystemmonitor 12:09:14 INFO - Running setup.py install for mozsystemmonitor 12:09:14 INFO - Successfully installed mozsystemmonitor 12:09:14 INFO - Cleaning up... 12:09:14 INFO - Return code: 0 12:09:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:09:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:09:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:15 INFO - 'HOME': '/Users/cltbld', 12:09:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:15 INFO - 'LOGNAME': 'cltbld', 12:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:15 INFO - 'MOZ_NO_REMOTE': '1', 12:09:15 INFO - 'NO_EM_RESTART': '1', 12:09:15 INFO - 'PAGER': '/bin/cat', 12:09:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:15 INFO - 'PWD': '/builds/slave/test', 12:09:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:15 INFO - 'SHELL': '/bin/bash', 12:09:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:15 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:15 INFO - 'USER': 'cltbld', 12:09:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:15 INFO - 'XPC_FLAGS': '0x0', 12:09:15 INFO - 'XPC_SERVICE_NAME': '0', 12:09:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:09:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:09:18 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 12:09:18 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 12:09:18 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 12:09:18 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 12:09:18 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 12:09:18 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 12:09:18 INFO - Downloading functools32-3.2.3-2.tar.gz 12:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:09:18 INFO - warning: no files found matching '*.txt' 12:09:18 INFO - no previously-included directories found matching 'build' 12:09:18 INFO - no previously-included directories found matching 'dist' 12:09:18 INFO - no previously-included directories found matching '.git*' 12:09:18 INFO - Installing collected packages: jsonschema, functools32 12:09:18 INFO - Running setup.py install for functools32 12:09:18 INFO - warning: no files found matching '*.txt' 12:09:18 INFO - no previously-included directories found matching 'build' 12:09:18 INFO - no previously-included directories found matching 'dist' 12:09:18 INFO - no previously-included directories found matching '.git*' 12:09:18 INFO - Successfully installed jsonschema functools32 12:09:18 INFO - Cleaning up... 12:09:18 INFO - Return code: 0 12:09:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:18 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:18 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 12:09:18 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 12:09:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:18 INFO - 'HOME': '/Users/cltbld', 12:09:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:18 INFO - 'LOGNAME': 'cltbld', 12:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:18 INFO - 'MOZ_NO_REMOTE': '1', 12:09:18 INFO - 'NO_EM_RESTART': '1', 12:09:18 INFO - 'PAGER': '/bin/cat', 12:09:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:18 INFO - 'PWD': '/builds/slave/test', 12:09:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:18 INFO - 'SHELL': '/bin/bash', 12:09:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:18 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:18 INFO - 'USER': 'cltbld', 12:09:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:18 INFO - 'XPC_FLAGS': '0x0', 12:09:18 INFO - 'XPC_SERVICE_NAME': '0', 12:09:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:09:19 INFO - Cleaning up... 12:09:19 INFO - Return code: 0 12:09:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:09:19 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')]} 12:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:19 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')]} 12:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:19 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:19 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 12:09:19 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 12:09:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:19 INFO - 'HOME': '/Users/cltbld', 12:09:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:19 INFO - 'LOGNAME': 'cltbld', 12:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:19 INFO - 'MOZ_NO_REMOTE': '1', 12:09:19 INFO - 'NO_EM_RESTART': '1', 12:09:19 INFO - 'PAGER': '/bin/cat', 12:09:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:19 INFO - 'PWD': '/builds/slave/test', 12:09:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:19 INFO - 'SHELL': '/bin/bash', 12:09:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:19 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:19 INFO - 'USER': 'cltbld', 12:09:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:19 INFO - 'XPC_FLAGS': '0x0', 12:09:19 INFO - 'XPC_SERVICE_NAME': '0', 12:09:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:19 INFO - Downloading/unpacking blobuploader==1.2.4 12:09:19 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 12:09:19 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 12:09:19 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 12:09:19 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 12:09:19 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 12:09:19 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 12:09:22 INFO - Downloading blobuploader-1.2.4.tar.gz 12:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:09:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:09:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:22 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 12:09:23 INFO - Downloading docopt-0.6.1.tar.gz 12:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:09:23 INFO - Installing collected packages: blobuploader, requests, docopt 12:09:23 INFO - Running setup.py install for blobuploader 12:09:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:09:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:09:23 INFO - Running setup.py install for requests 12:09:24 INFO - Running setup.py install for docopt 12:09:24 INFO - Successfully installed blobuploader requests docopt 12:09:24 INFO - Cleaning up... 12:09:24 INFO - Return code: 0 12:09:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:24 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:24 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 12:09:24 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 12:09:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:24 INFO - 'HOME': '/Users/cltbld', 12:09:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:24 INFO - 'LOGNAME': 'cltbld', 12:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:24 INFO - 'MOZ_NO_REMOTE': '1', 12:09:24 INFO - 'NO_EM_RESTART': '1', 12:09:24 INFO - 'PAGER': '/bin/cat', 12:09:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:24 INFO - 'PWD': '/builds/slave/test', 12:09:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:24 INFO - 'SHELL': '/bin/bash', 12:09:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:24 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:24 INFO - 'USER': 'cltbld', 12:09:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:24 INFO - 'XPC_FLAGS': '0x0', 12:09:24 INFO - 'XPC_SERVICE_NAME': '0', 12:09:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_sMMGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-cQhCpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-24z82Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:24 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-5b8xtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-btbc10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-SP3oPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-hXmtOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-7XAkWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-vzumDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-XDFYxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-4o6AZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-YUcMnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:25 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-JQmNhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Oi2364-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-8BLdTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-qRUw7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:26 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-63F_5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:09:26 INFO - Running setup.py install for manifestparser 12:09:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:09:26 INFO - Running setup.py install for mozcrash 12:09:26 INFO - Running setup.py install for mozdebug 12:09:26 INFO - Running setup.py install for mozdevice 12:09:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Running setup.py install for mozfile 12:09:27 INFO - Running setup.py install for mozhttpd 12:09:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Running setup.py install for mozinfo 12:09:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Running setup.py install for mozInstall 12:09:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Running setup.py install for mozleak 12:09:27 INFO - Running setup.py install for mozlog 12:09:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:09:27 INFO - Running setup.py install for moznetwork 12:09:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:09:28 INFO - Running setup.py install for mozprocess 12:09:28 INFO - Running setup.py install for mozprofile 12:09:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:09:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:09:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:09:28 INFO - Running setup.py install for mozrunner 12:09:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:09:28 INFO - Running setup.py install for mozscreenshot 12:09:28 INFO - Running setup.py install for moztest 12:09:28 INFO - Running setup.py install for mozversion 12:09:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:09:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:09:28 INFO - Cleaning up... 12:09:28 INFO - Return code: 0 12:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:28 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:28 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 12:09:28 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 12:09:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:28 INFO - 'HOME': '/Users/cltbld', 12:09:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:28 INFO - 'LOGNAME': 'cltbld', 12:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:28 INFO - 'MOZ_NO_REMOTE': '1', 12:09:28 INFO - 'NO_EM_RESTART': '1', 12:09:28 INFO - 'PAGER': '/bin/cat', 12:09:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:28 INFO - 'PWD': '/builds/slave/test', 12:09:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:28 INFO - 'SHELL': '/bin/bash', 12:09:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:28 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:28 INFO - 'USER': 'cltbld', 12:09:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:28 INFO - 'XPC_FLAGS': '0x0', 12:09:28 INFO - 'XPC_SERVICE_NAME': '0', 12:09:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-91gfkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Vy657H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-xAQCmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-M5jyun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-R5QcH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-W7F2bi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-_jJwNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:09:29 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)) 12:09:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:09:29 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-dnQogR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-xKLPRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-8Z94N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-pj_hL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-4BAvUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-Vz18ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-wcsssp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-z4k2hs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-H5hzd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:09:30 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)) 12:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:09:30 INFO - Running setup.py (path:/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/pip-jiaqN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:09:31 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)) 12:09:31 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)) 12:09:31 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)) 12:09:31 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)) 12:09:31 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)) 12:09:31 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)) 12:09:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:09:33 INFO - Downloading blessings-1.6.tar.gz 12:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:09:33 INFO - Installing collected packages: blessings 12:09:33 INFO - Running setup.py install for blessings 12:09:33 INFO - Successfully installed blessings 12:09:33 INFO - Cleaning up... 12:09:33 INFO - Return code: 0 12:09:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:34 INFO - Reading from file tmpfile_stdout 12:09:34 INFO - Current package versions: 12:09:34 INFO - blessings == 1.6 12:09:34 INFO - blobuploader == 1.2.4 12:09:34 INFO - docopt == 0.6.1 12:09:34 INFO - functools32 == 3.2.3-2 12:09:34 INFO - jsonschema == 2.5.1 12:09:34 INFO - manifestparser == 1.1 12:09:34 INFO - mozInstall == 1.12 12:09:34 INFO - mozcrash == 1.0 12:09:34 INFO - mozdebug == 0.1 12:09:34 INFO - mozdevice == 0.49 12:09:34 INFO - mozfile == 1.2 12:09:34 INFO - mozhttpd == 0.7 12:09:34 INFO - mozinfo == 0.9 12:09:34 INFO - mozleak == 0.1 12:09:34 INFO - mozlog == 3.4 12:09:34 INFO - moznetwork == 0.27 12:09:34 INFO - mozprocess == 0.25 12:09:34 INFO - mozprofile == 0.28 12:09:34 INFO - mozrunner == 6.13 12:09:34 INFO - mozscreenshot == 0.1 12:09:34 INFO - mozsystemmonitor == 0.3 12:09:34 INFO - moztest == 0.8 12:09:34 INFO - mozversion == 1.4 12:09:34 INFO - psutil == 3.1.1 12:09:34 INFO - requests == 1.2.3 12:09:34 INFO - wsgiref == 0.1.2 12:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:34 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 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:34 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 12:09:34 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 12:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:34 INFO - 'HOME': '/Users/cltbld', 12:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:34 INFO - 'LOGNAME': 'cltbld', 12:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:34 INFO - 'MOZ_NO_REMOTE': '1', 12:09:34 INFO - 'NO_EM_RESTART': '1', 12:09:34 INFO - 'PAGER': '/bin/cat', 12:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:34 INFO - 'PWD': '/builds/slave/test', 12:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:34 INFO - 'SHELL': '/bin/bash', 12:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:34 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:34 INFO - 'USER': 'cltbld', 12:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:34 INFO - 'XPC_FLAGS': '0x0', 12:09:34 INFO - 'XPC_SERVICE_NAME': '0', 12:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 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)) 12:09:34 INFO - Cleaning up... 12:09:34 INFO - Return code: 0 12:09:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:09: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')]} 12:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09: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')]} 12:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:09:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101a34b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101a37768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1e8483cc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, '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.IWELZGA29F/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.r4cIwZNgw5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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 12:09:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:09:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:34 INFO - 'HOME': '/Users/cltbld', 12:09:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:34 INFO - 'LOGNAME': 'cltbld', 12:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:34 INFO - 'MOZ_NO_REMOTE': '1', 12:09:34 INFO - 'NO_EM_RESTART': '1', 12:09:34 INFO - 'PAGER': '/bin/cat', 12:09:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:34 INFO - 'PWD': '/builds/slave/test', 12:09:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:34 INFO - 'SHELL': '/bin/bash', 12:09:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:34 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:34 INFO - 'USER': 'cltbld', 12:09:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:34 INFO - 'XPC_FLAGS': '0x0', 12:09:34 INFO - 'XPC_SERVICE_NAME': '0', 12:09:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:09:34 INFO - Cleaning up... 12:09:34 INFO - Return code: 0 12:09:34 INFO - Running post-action listener: _resource_record_post_action 12:09:34 INFO - Running post-action listener: _start_resource_monitoring 12:09:34 INFO - Starting resource monitoring. 12:09:34 INFO - [mozharness: 2017-02-23 20:09:34.806007Z] Finished create-virtualenv step (success) 12:09:34 INFO - [mozharness: 2017-02-23 20:09:34.806957Z] Running install step. 12:09:34 INFO - Running pre-action listener: _resource_record_pre_action 12:09:34 INFO - Running main action method: install 12:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:09:35 INFO - Reading from file tmpfile_stdout 12:09:35 INFO - Detecting whether we're running mozinstall >=1.0... 12:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:09:35 INFO - Reading from file tmpfile_stdout 12:09:35 INFO - Output received: 12:09:35 INFO - Usage: mozinstall [options] installer 12:09:35 INFO - Options: 12:09:35 INFO - -h, --help show this help message and exit 12:09:35 INFO - -d DEST, --destination=DEST 12:09:35 INFO - Directory to install application into. [default: 12:09:35 INFO - "/builds/slave/test"] 12:09:35 INFO - --app=APP Application being installed. [default: firefox] 12:09:35 INFO - mkdir: /builds/slave/test/build/application 12:09:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:09:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:09:55 INFO - Reading from file tmpfile_stdout 12:09:55 INFO - Output received: 12:09:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:09:55 INFO - Running post-action listener: _resource_record_post_action 12:09:55 INFO - [mozharness: 2017-02-23 20:09:55.360933Z] Finished install step (success) 12:09:55 INFO - [mozharness: 2017-02-23 20:09:55.361096Z] Running run-tests step. 12:09:55 INFO - Running pre-action listener: _resource_record_pre_action 12:09:55 INFO - Running main action method: run_tests 12:09:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:09:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:09:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:09:55 INFO - 2017-02-23 12:09:55.375 screenresolution[1627:7588] starting screenresolution argv=screenresolution get 12:09:55 INFO - 2017-02-23 12:09:55.378 screenresolution[1627:7588] Display 0: 1600x1200x32@60 12:09:55 INFO - 2017-02-23 12:09:55.383 screenresolution[1628:7590] starting screenresolution argv=screenresolution list 12:09:55 INFO - Available Modes on Display 0 12:09:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:09:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:09:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:09:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:09:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:09:55 INFO - Intel Iris: 12:09:55 INFO - Chipset Model: Intel Iris 12:09:55 INFO - Type: GPU 12:09:55 INFO - Bus: Built-In 12:09:55 INFO - VRAM (Dynamic, Max): 1536 MB 12:09:55 INFO - Vendor: Intel (0x8086) 12:09:55 INFO - Device ID: 0x0a2e 12:09:55 INFO - Revision ID: 0x0009 12:09:55 INFO - Displays: 12:09:55 INFO - Display: 12:09:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:09:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:09:55 INFO - Display Serial Number: 1600x1200 60 12:09:55 INFO - Main Display: Yes 12:09:55 INFO - Mirror: Off 12:09:55 INFO - Online: Yes 12:09:55 INFO - Rotation: Supported 12:09:55 INFO - Return code: 0 12:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:09:55 INFO - Python 2.7.3 12:09:55 INFO - Return code: 0 12:09:55 INFO - grabbing minidump binary from tooltool 12:09:55 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')]} 12:09:55 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 0x101812d30>, '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 0x101739db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101807be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:09:55 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 12:09:55 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 12:09:55 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 12:09:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:09:55 INFO - Return code: 0 12:09:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:09:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:09:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:09:55 INFO - ENV: RUST_BACKTRACE is now 1 12:09:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:09:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:09:55 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/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 12:09:55 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/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0306 --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 12:09:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IWELZGA29F/Render', 12:09:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:09:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:09:55 INFO - 'HOME': '/Users/cltbld', 12:09:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:09:55 INFO - 'LOGNAME': 'cltbld', 12:09:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:09:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:09:55 INFO - 'MOZ_NO_REMOTE': '1', 12:09:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:09:55 INFO - 'NO_EM_RESTART': '1', 12:09:55 INFO - 'PAGER': '/bin/cat', 12:09:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:09:55 INFO - 'PWD': '/builds/slave/test', 12:09:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:09:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:09:55 INFO - 'RUST_BACKTRACE': '1', 12:09:55 INFO - 'SHELL': '/bin/bash', 12:09:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.r4cIwZNgw5/Listeners', 12:09:55 INFO - 'TMPDIR': '/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/', 12:09:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:09:55 INFO - 'USER': 'cltbld', 12:09:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:09:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:09:55 INFO - 'XPC_FLAGS': '0x0', 12:09:55 INFO - 'XPC_SERVICE_NAME': '0', 12:09:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:09:55 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/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0306', '--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 12:09:55 INFO - mozversion application_buildid: 20170223110523 12:09:55 INFO - mozversion application_changeset: 5069348353f8fc1121e632e3208da33900627214 12:09:55 INFO - mozversion application_display_name: Nightly 12:09:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:09:55 INFO - mozversion application_name: Firefox 12:09:55 INFO - mozversion application_remotingname: firefox 12:09:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:09:55 INFO - mozversion application_vendor: Mozilla 12:09:55 INFO - mozversion application_version: 54.0a1 12:09:55 INFO - mozversion platform_buildid: 20170223110523 12:09:55 INFO - mozversion platform_changeset: 5069348353f8fc1121e632e3208da33900627214 12:09:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:09:55 INFO - mozversion platform_version: 54.0a1 12:09:55 INFO - using testdate: 1487880595 12:09:55 INFO - actual date: 1487880595 12:09:55 INFO - starting webserver on 'localhost:49243' 12:09:55 INFO - SUITE-START | Running 2 tests 12:09:55 INFO - TEST-START | dromaeo_css 12:09:55 INFO - operating with platform_type : mac_ 12:09:55 INFO - Initialising browser for dromaeo_css test... 12:09:55 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpq4si0g/profile http://localhost:49243/getInfo.html) 12:09:56 INFO - PROCESS | 1638 | 1487880596528 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 12:09:56 INFO - PROCESS | 1638 | 1487880596529 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 12:09:56 INFO - PROCESS | 1638 | 1487880596571 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 12:09:58 INFO - PROCESS | 1638 | 2017-02-23 12:09:58.942 plugin-container[1640:7766] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b43, name = 'com.apple.tsm.portname' 12:09:58 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:09:58 INFO - PROCESS | 1638 | 2017-02-23 12:09:58.945 plugin-container[1640:7766] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 12:09:58 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:09:58 INFO - PROCESS | 1638 | 2017-02-23 12:09:58.945 plugin-container[1640:7766] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:09:59 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 12:09:59 INFO - PROCESS | 1638 | colorDepth:24 12:09:59 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 12:09:59 INFO - PROCESS | 1638 | __metrics 12:09:59 ERROR - PROCESS | 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 12:09:59 INFO - PROCESS | 1638 | 1487880599139 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 12:09:59 INFO - TEST-INFO | 1638: exit 0 12:09:59 INFO - Browser initialized. 12:09:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:09:59 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpq4si0g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:10:00 INFO - PROCESS | 1641 | 1487880600100 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 12:10:00 INFO - PROCESS | 1641 | 1487880600101 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 12:10:02 INFO - PROCESS | 1641 | 2017-02-23 12:10:02.272 plugin-container[1642:7901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 12:10:02 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:10:02 INFO - PROCESS | 1641 | 2017-02-23 12:10:02.273 plugin-container[1642:7901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 12:10:02 INFO - PROCESS | 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:10:02 INFO - PROCESS | 1641 | 2017-02-23 12:10:02.273 plugin-container[1642:7901] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:10:11 INFO - PROCESS | 1641 | RSS: Main: 227184640 12:10:11 INFO - PROCESS | 1641 | 12:13:14 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 12:13:16 INFO - PROCESS | 1641 | RSS: Main: 248729600 12:13:16 INFO - PROCESS | 1641 | 12:15:00 INFO - PROCESS | 1641 | ************************* 12:15:00 INFO - PROCESS | 1641 | A coding exception was thrown and uncaught in a Task. 12:15:00 INFO - PROCESS | 1641 | 12:15:00 ERROR - PROCESS | 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:15:00 INFO - PROCESS | 1641 | Full stack: 12:15:00 INFO - PROCESS | 1641 | ************************* 12:16:19 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 12:16:19 INFO - PROCESS | 1641 | RSS: Main: 257417216 12:16:19 INFO - PROCESS | 1641 | 12:19:22 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 12:19:22 INFO - PROCESS | 1641 | RSS: Main: 269107200 12:19:22 INFO - PROCESS | 1641 | 12:22:24 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 12:22:25 INFO - PROCESS | 1641 | RSS: Main: 261959680 12:22:25 INFO - PROCESS | 1641 | 12:25:28 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 12:25:29 INFO - PROCESS | 1641 | RSS: Main: 272232448 12:25:29 INFO - PROCESS | 1641 | 12:28:31 INFO - PROCESS | 1641 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 12:28:32 INFO - PROCESS | 1641 | RSS: Main: 265773056 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | __start_tp_report 12:28:32 INFO - PROCESS | 1641 | _x_x_mozilla_page_load 12:28:32 INFO - PROCESS | 1641 | _x_x_mozilla_page_load_details 12:28:32 INFO - PROCESS | 1641 | |i|pagename|runs| 12:28:32 INFO - PROCESS | 1641 | |0;dojo.html;3080.9524761581088;3210.614726232852;3238.967610323896;3306.33873225355;3329.633740288568;4468.882779305174;5046.167382381912;5501.257330260413;5520.447955204478;5640.435956404358;5561.721913904299;5563.109902415625;5571.609987300891;5627.352854421742;5630.09918413054;4944.184209605411;5058.519440653132;5076.543111119999;5147.897042059157;5161.4322424533275;5083.034223497542;5158.638895277332;5159.742012899359;5169.190783225859;5174.870628234286;4856.514348565133;4951.678140920829;4960.404751429815;4995.450500444948;5082.618803589727;5010.949890501085;5044.319016932704;5114.028334616411;5126.71803050832;5154.226865970097;5015.699058056528;5050.848474545733;5053.519915608012;5059.392872855244;5080.364954380702;4396.472423309191;5335.439778823206;5343.625946183769;5464.726763661801;5544.445555444423;6018.15745795589;6060.878782424327;6073.908891366633;6103.908441373383;6133.907991380132;6213.068039794022;6221.844453888643;6227.750889964396;6230.43926046658;6238.500919926395;4829.73436460991;5722.5433526011475;5729.684867332337;5779.971100144472;5820.010598198316;5284.788608455696;5346.385165705916;6090.390960903874;6090.573659843857;6115.362036198677;6010.699465026732;6038.6678732670125;6053.334133245339;6103.877922441615;6142.416470435302;6069.726862291208;6111.266648002268;6114.938850611437;6120.387961203844;6130.47890929276;5946.910796338058;5988.461038506468;6076.301225359052;6113.602615829956;6120.816375508742;5978.342382337939;6059.787907423219;6092.939070609325;6110.406879924458;6150.692465376714;4156.45966024421;4926.236433352836;4936.456989731127;4958.776855041532;4995.525425084611;4267.487901451846;4358.259095953696;4379.4087798147475;4380.824767009284;4427.5572442755465;4640.303954406866;5487.725613719298;5536.114221724505;5546.750396232179;5553.389127196006;6167.938320616826;6169.2288463942;6191.442770150708;6201.162843016225;6218.284897236876;5049.31834202378;5604.327480702342;5607.130894711327;5629.634073785191;5657.6039677223025;4479.417675702203;5153.871153221125;5178.8964220716125;5217.2434996925995;5296.602754793329;5190.273361729285;6206.968965155145;6212.409821066992;6215;6216.720247588869;5994.310654274815;6046.425589568984;6187.226596675416;6214.347493513116;6217.720202590985;6087.086936959491;6135.907961380493;6186.257649082139;6200.689965501797;6205.47253483459;6086.269647642134;6129.172561704291;6152;6167.506599472121;6187.319394866651;5044.9243261350375;5961.225040744675;5970.731317090655;6101.664408457577;6172.4136207060255;4786.2820576912345;5787.39232380594;5874.882502350015;5898.997170481114;5944.940550594439;5934.465898069195;5966.105084237399;6008.339082700987;6034.788782392595;6037.909431358621;5728.598998070262;5787.39232380594;5789.768409263751;5831.70841457917;5845.444682755132;5761.452661997104;5841.50347220491;5958.880822383615;6007.249093863267;6012.338642749207;5792.594518383673;5829.038208695687;5864.32560255559;5915.467607915309;5951.642901425755 12:28:32 INFO - PROCESS | 1641 | |1;ext.html;486.3045844442448;490.63202598051464;491.82294374025344;510.6068327387911;513.3967588084;33578;40240.79879600601;42464.57535424645;42715;42874.35688464668;43257.78371108148;43592.3461148083;43649.34525982105;43659.12681746371;43726.99999999992;9440.197583205436;9646.517674116267;9649.083337083;9659.951700241489;11080.778384432306;11155.776884462306;11342.60300889469;11405.31568105912;11415.200935934488;11431.428428578538;11404.600838970639;11431.142664300169;11445.198836081478;11451.96932276095;11466.827997580043;11359.204855660108;11359.318440893532;11412.20114591979;11424.600138995178;11426.600068997628;11151.219414640897;11231.494582743797;11249.212555121145;11254.381009044499;11285.887141128565;29991.250218744488;36840.63159368426;36979.81510092459;37083.62916370856;37108.62891371106;3733.6453036961716;3734.981325093357;3773;3786.5266841644793;3913.491246137984;23404.882975585013;27681.584776228374;28533.001344953034;28823;28867.27831804201;3051.4049760296753;3114.527697615607;3239.1092449576317;3262.9021129366156;3271.247613048988;365270;365447.2093476742;367002;432674;438721;53006;54261.72869135629;65344.34655653383;66316.66841665858;66499;69667.21331146697;71138.28861711317;71218.64390678014;76526.61736691392;76530.23469765231;15390.615234619225;15419.922900385427;15432.38270469191;15585.298661560257;15618.68762624741;11672.241304315192;11797.587084452174;11858.288502689866;11876.821847672292;11888.94055529734;18442.985635789893;19552.502924327484;20330.848718448666;20368.981550922395;20374.796252037588;7002.859942801116;8594.894250908568;8607.784805379915;8679;8697.391182617155;695.9860802784017;824.3570015388007;837.2046555772041;839.5969934431384;868.7567481105301;21950.45123871916;29630.85184574063;29741.702582974325;29773.40453190924;30043.849780750956;984.2519685039422;1012.5443550402348;1027.3117011602244;1053.9051485366354;1059.6662051453768;11438.428078596036;13152.802707959388;13648.83984861278;14575.781363279559;15709.764353534707;533340;538812;539634;540602;541135.2943235259;59182.704086479294;59487.40512594905;59665.70167149136;59702.701486493155;60201.397986019576;1336.7994800779961;1394.525861207174;1398.4406237504877;1398.608389650879;1402.396969303189;21285.68071478898;28242.85878570594;29399.11802645924;29540.409191815612;29550.261243469085;51012;51052.23421648604;51601.7419912913;51645;51665.741671291406;363192;457462;459505.4049459596;459509;460080.69959649985;25498.362540936625;25888.8705556471;25961.221163365128;26668.866655666596;41464.75605731833;40766.57316994009;41278.587214127474;42025.579744202165;42153.36769948515;42317;32653.18367040748;34501;34796.65203348036;35801.64198357983;35956;33288;34638.78764243239;34754.82622586871;35612.465813012306;35615.19194908654;33515.32969340551;34096.65903341034;34632.961011169704;34757.13107172341;34987.65012349844;23310.533789324458;29379.706202937698;29644.55533167047;29813;30350.84824575863;22890.771092288865;23576.288726795952;23641.645375319727;23694.763052369257;24316.75683243145 12:28:32 INFO - PROCESS | 1641 | |2;jquery.html;377.0893292698134;391.25661243637086;395.0715817828104;401.1035336023984;415.09509269791863;19371.709424358647;21303.57392852146;21344.146234150634;21438.785612143874;21440.785592144075;21093.894530527363;21284.36146915595;21849.344519664435;21958.780412195872;22119.336419907388;5382.6770393776305;5767.106098554731;5836.007878660616;5836.5914385993;5852.707364631773;5720.856978575548;5765.279340082489;5832.154337621042;6070.0591408331775;6085.569891075594;5083.949160508403;5317.644000779815;5808.332041815182;6015.157877897076;6084.178635884144;5708.229389032469;6043.335233124353;6059.454649081582;6084.391560843925;6121.785737499211;5066.062778385974;5960.523158147338;5962.970185149046;5967.194428752106;5975.880482390371;12850.935745321214;13081.542146024938;13142.342882855915;13165.802512962313;13175.934120329433;2487.751224877498;2524.9495010099877;2548.0826902315152;2585.3924327782956;2589.029114082219;9802.509874506317;10026.59893604255;10317.484125793755;10332.896671033344;14928.552143435714;1736.8697347698974;1804.691598591011;1826.9269229230815;1835.431016384925;1840.6686796376646;113669;116473;121334;123940;125235.99056037748;9632.892217394949;11454.656360309204;11612.12909031826;11901.452811134497;11939.76120477603;15231.543053708407;15397.538073857802;15403.22983850803;15420.691586168437;15421.074735515906;7557.697692092364;7771.572563509061;7784.883226751604;7872.606369681493;7890.053193616803;7192.728490255736;7271.157938598437;7271.647699158832;7387.8153046174275;7407;4689.155951928686;4712.340272361872;4722.362481065081;4726.1020406122725;4805.399325084364;2006.3278801601334;2015.4054553906633;2023.3828682252054;2030.7563092428707;2040.3878836349036;956.1490273656451;971.9562619682131;985.5072463768116;994.3387647214521;1018.4754851251612;16513.504594862174;17893.7315940261;21016.579668406546;21025.26411575618;21111;930.7300882744064;1001.8046480936148;1015.7155996320894;1046.4140081554353;1095.9287646302964;10651.041406273473;10858.914108589079;10897.83653245202;10903.509342079626;10961.163592742476;390733;521418;656195;665256.7794576422;672655;98557.01442985622;107549.4622526898;131647.68352316355;139176;144435;970.3401686853008;995.875515560555;1047.989520104789;1050.2648146297622;1054.9525271362654;18394.72407913909;19253.518662033563;19307.4207773767;19327.613447730684;19328.806711933263;56483.71758141183;56741.71629141828;57354.7132264336;57526.84946301134;59118.40881591129;76787;81661.59169204354;81705;81920.18079819126;82014.17985820066;7831.334336581454;7971.322437592869;8057.879131812911;8085.353171746128;8191.05802832658;7277;9633.855492167482;10536.894631053592;12111.636650900487;12272.815907761213;9456.479893605643;10274.383536987805;10683;10992.835107473235;11186.720331991766;8441.944756905386;10923.180761443082;10986.560537578407;11026.614068507564;11304.886951130384;8940.68707595231;10941.835872461761;11264.493097810455;11547.595834145764;11663.125265604944;8147.877781833396;8214.959425269553;8258.009038915368;8306.210909963544;8393.202645748644;9047.502387368759;10909.072728818139;11224.94387528057;11256.606018789304;11269.323840569592 12:28:32 INFO - PROCESS | 1641 | |3;mootools.html;1440.7190597833421;1440.7694768836989;1441.437839242695;1464.7143806957642;1477.9852201477986;8120.390970677201;8436.36727245456;8571.014333351673;8603.225709686127;8758.12418758124;8552.871706924401;8648.91351086489;8655.653773849053;8679.392442529026;8687.56562171892;2270.6594010898416;2325.1164557468137;2328.4528135888054;2329.2662811214414;2338.9064437422485;2295.8737269450176;2321.8606883586954;2330.592146374386;2331.8600883946933;2333.6266197408418;2267.5124848157643;2272.8295377846644;2290.5876942150408;2293.919712810052;2304.976950230493;2085.103405535619;2244.304265677637;2273.3520946530325;2273.7498875123724;2279.3959600705825;1667.9749803752954;1905.6284024615206;2068.6586713192305;2079.189116244666;2272.9090036782436;8459;8515.616797244138;8532.14678532148;8542.14578542147;8543.615537300837;5046.899062018776;5189.1697328427645;5214.765335559871;5223.764930578095;5232.790688372461;3185.984070079658;3267.477203647405;3391.6099648540485;3393.1856354474994;3407.505911642798;1051.337657275919;1110.5835311758092;1185.9407029648569;1243.0863315463127;1243.148443316322;10027.699169024869;10245.948770256176;10682.893171068268;10894.782104357948;10909.618163364245;3968.7420317679257;4382.737035777864;4498.572635599613;4515.300128480091;4520.276755719069;8669.003064647646;8755.649774008969;8773.780655483537;8783.385163038525;8787.165219304155;5060.063888180698;5110.3356563646485;5142.228665700175;5147.124988751922;5165.457626949192;4656.906861862812;4741.57325840676;4800.35195248644;4804.855854324306;4819.012102518976;3608.4948107265004;3615.5480564929385;3652.7990960496895;3685.9262814743556;3701.148735790783;1139.6865861888048;1144.4449442020614;1146.7534480086822;1153.6366044695894;1161.1465572803982;762.8626847167563;808.8675853804721;880.1726377205534;888.7200531832452;927.0914503786328;4536.72779633223;5314.28257185275;5837.923052362762;5929.3181284152015;5963.5527335450015;878.8574852691476;984.4093543873619;984.4241118945354;999.1058003087196;1021.1313296667081;3634.67287944081;3791.545014598266;3858.2090671412293;3908.1988192420486;3908.335582950905;9672.903270967341;9935.751606209758;9936.304458687968;9950.900490995142;9975.60097596088;8419.95790021046;9837.754056148653;9923.603055877684;9926.900730992742;9971.551280192409;6567.605943643397;6788.762393316309;7651.961740191375;7905.407094467938;7929.841403171904;4943.555080042814;5385.488378604026;5403.7838486460105;5691.743871525874;5871.588988770745;8956.731298061068;9139.680111196076;9156;9179.219766319671;9186.862197067183;8878.334124940526;9279.582418791306;9283.48940808262;9285.953570232106;9402.247820174232;7110.075690160453;7239.746608868875;7262.818429539092;7271.127464704269;7294.525855819355;6712.563683360566;7785.377169826287;7815.96092019559;7866.9213307866185;7890.447668663139;7073.540219885691;7134.500584959003;7164.67758950838;7182.820429489305;7311.890321645286;6972.965135174291;7050.612216327946;7075.292470752884;7085.39774119185;7107.466939979418;6307.526935479766;6406.775762848464;6427.839304017437;6452.22573291208;6458.515611329263;4784.856454306377;4882.218844984785;4987.451380348231;4989.426215985063;5005.549500544968;4881.80472781099;4946.480619535041;5035.420926593342;5060.3927528696795;5150.948490515047 12:28:32 INFO - PROCESS | 1641 | |4;prototype.html;309.7552933182786;349.32754447688194;357.5030707316832;363.268014949876;373.2870217883841;5025.447200807908;5192.961407718452;5421.078416669171;5489.478499542542;5556.527695145907;4547.09058188362;4866.732329721864;4917.721392437974;5273.8600198843915;5428.9185662214995;3880.26275007749;4220.746755194683;4271.914561708764;4274.957250427487;4293.527711951699;4177.97911010446;4206.20082184384;4284.179223829876;4295.9785201073955;4316.892077698067;3365.9299530788635;3504.754667173299;4169.520505141902;4181.268278051344;4205.97897010516;4206.095689426757;4216.789160541991;4232.407462955189;4238.957610423887;4239.342901850218;3735.7384983051197;3758.5489741230954;3763.8870833875026;3767.397216445383;3784.7539909905768;4314.439122914033;4807.6394270429855;5033.723145227011;5208.947321098528;5264.8683782905355;4315.482142142963;4731.313959475891;4796.7841447134615;4929.802807887716;4946.530079642464;4373.9125217495475;4883.658143929926;5161.638685292031;5541.944580554183;5867.442592953663;3153.211697075731;3348.7136465324425;3654.689351405134;3789.4315852622053;3825.483559719458;5013.621254155064;5275.57795376369;5466.398696143421;6053.364396738323;6058;3603.5135256740004;3925.391564307537;3926.4306675532457;3970.404439334065;3976.6023397660583;3993.8602148924647;3996.4813370919446;4000.27994960904;4014.698897582693;4022.6580740636787;4195.685323600742;4678.274867395559;4703.270992996091;4708.905821883612;4718.598919091915;4664.883377915511;4671;4952.603791696655;5739.8565035874435;5875.823725288248;1055.6358056470506;1127.1658972360394;1145.8166693329026;1305.9673508162182;1316.5918565244804;817.3787921179827;871.8822958900594;872.2019352292581;879.2482427524502;881.9647214111492;4626.768661566908;4646.3495110684535;4961.179891483537;5152.4847515248175;5219.947800521946;5086.474057782651;5198.246254293106;5589.664620122806;5741.598088133791;5781.277340332458;4509.407090922733;4643.976780116078;4998.825041123543;5151.5878729701535;5182.300389447451;2555.9105431309813;2673.345030467509;2800.3338013881707;2869.727375899286;2970.4207679502288;4995;5496.5053145217125;5648.604597678205;5802.272931722084;5869;5056.823011194664;5072.6195535335;5699.715014249271;5803.100519419497;5833.270841144857;4884.682495637772;5780.393058728857;5798.362180160179;5807.738651760596;5819.679917604572;4730.290456431563;4893.119238537098;4914.70511769295;5300.337457817773;5661.603687741818;4688.5545873142;4817.566419022165;5388.865278367915;5581.888362232651;5653.049697854233;5155.994581056808;5346.866328341667;5780.7398667060925;5921.2006379138265;5921.4966727826895;3477.8087205202946;3482.634323396007;3635.818209089482;3876.9224615508097;3907.159960608483;5776.682282474504;5906.616069955611;5916.28427755946;5931.970340148272;5937.34689184198;4666.929996049994;5042.621803364689;5087.60713643539;5442.945570544244;5579.609427340048;5311.256424100707;5338.599605029561;5431.918521222264;5801.941980580309;5815.302163740378;5339.626226164131;5658.717064146694;5674.77300907959;5677.858053548694;5698.4016678249845;5310.583684423501;5402.6758394496455;5752.382665887095;5777.7977770777825;5791.449812267828;4961.305417241661;5668.574856885668;5696.743646535833;5698.430156984268;5706.430731548858 12:28:32 INFO - PROCESS | 1641 | |5;yui.html;646.5215740352139;670.5339788846753;691.885838836592;756.1926994483186;764.705588348486;13953.651158721037;15268.694626107472;15288.770668439969;15294.31175597098;15333.233338333066;13848.09987350824;14028.719425611507;14063.08589941653;14238.430462781502;14280.571582852504;873.6287077991828;875.3478658399501;883.4037025008126;885.8936927568701;888.7067267801642;882.1399135842566;884.1247165306332;888.693400776731;889.0753616239136;890.145460358057;953.6805170267934;956.6460409648405;969.2827307792219;969.2924165359292;970.2722957781664;963.1957315641483;964.1659964131011;964.4647220792457;965.8937516873139;966.9419834809934;715.6314498033516;716.6237725194262;716.8602122586097;716.9928300716978;723.8660847743184;14514.637134071627;15050.247487625575;15684.294206760724;15689.843101568953;15800;13815.447382104805;14149.575512734635;14171.929140354232;14206.928965355108;14231.217283049427;11521.711957201052;11601.76796464066;11665.533378664843;11678.24091434054;12120.969717574017;3533.8939831805087;3692.8707495237536;3719.3119272934596;3774.5281839770028;3880.262750077476;102601.4869925653;103973;104492;105173.4741326296;106342;10431.947840260902;10533.210009249337;10544.947275263728;10807.08139808125;11098.722531936766;15894.52316430509;17969.921804691498;21607.891960540095;21658.35024949254;21801.454963625718;7463.552186868806;7501.362384197295;7573.545587264672;7670.156282808886;7695.23047695226;4056.6551843093075;4172.5893894732835;4209.957900421018;4214.304639734471;4224.619784219435;3547.113221694576;3562.750607457505;3575.8748443804343;3623.4927110204594;3631.328204282216;604.1029071828332;612.9816105516842;616.1712496691943;622.243973572112;622.9750809967551;621.832105331558;633.6673246545508;641.1084715775199;647.5175993884586;666.466826538767;9573.425594464354;9624.51877406127;9680.612775488902;9906.157976572073;9977.002299769965;647.6017249391684;686.1800148822109;698.9760001597582;700.9649517524206;704.5878161275712;4467.329900514884;4475.395821564047;4754.904901901942;4805.711657300573;4837.129316722953;72733.81798546053;73336;82300;85987.14012859791;90196.5490172545;68315;69929.3007069933;79141.60429197818;82922.58538707267;85211.5739421299;74520.41096917861;74732;74985.25014749891;75003.62498187475;76033.61983190049;10219.642312519027;10532;10598.25812193139;10660.73348166271;10720;45942.770286148356;46995;47591.1474606686;47699;48196;40658.1868362637;48363;62234.755304892744;63092;64072.67963660152;12211.970099634551;12256.38718064111;12464.937675311929;12496.312702801433;12736.936315318364;10716.464176790972;13014.414351354022;13978.930105349407;14015.649608759863;14359.856401435853;10597.9470102649;12685.492580297054;12924.806127908278;13086.738265234451;13473;10010.549525271235;12611.93694031524;13090.14914030585;13107.737845242851;13831.446742130605;12260.509579616715;12414.441350139447;12652.240865548096;12871.034672399795;12980.870191298343;10264.692059238234;10345.84481232767;10538.894611054098;10611.946940265558;11444.370559619301;7218.217073534572;9080.772980675536;9167.358284919992;10505.579776809147;10542.789144216918 12:28:32 INFO - PROCESS | 1641 | __end_tp_report 12:28:32 INFO - PROCESS | 1641 | __start_cc_report 12:28:32 INFO - PROCESS | 1641 | _x_x_mozilla_cycle_collect,424 12:28:32 INFO - PROCESS | 1641 | __end_cc_report 12:28:32 INFO - PROCESS | 1641 | __startTimestamp1487881712126__endTimestamp 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | ------- Summary: start ------- 12:28:32 INFO - PROCESS | 1641 | Number of tests: 6 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | [#0] dojo.html Cycles:165 Average:5557.54 Median:5787.39 stddev:672.22 (11.6%) stddev-sans-first:645.60 12:28:32 INFO - PROCESS | 1641 | Values: 3081.0 3210.6 3239.0 3306.3 3329.6 4468.9 5046.2 5501.3 5520.4 5640.4 5561.7 5563.1 5571.6 5627.4 5630.1 4944.2 5058.5 5076.5 5147.9 5161.4 5083.0 5158.6 5159.7 5169.2 5174.9 4856.5 4951.7 4960.4 4995.5 5082.6 5010.9 5044.3 5114.0 5126.7 5154.2 5015.7 5050.8 5053.5 5059.4 5080.4 4396.5 5335.4 5343.6 5464.7 5544.4 6018.2 6060.9 6073.9 6103.9 6133.9 6213.1 6221.8 6227.8 6230.4 6238.5 4829.7 5722.5 5729.7 5780.0 5820.0 5284.8 5346.4 6090.4 6090.6 6115.4 6010.7 6038.7 6053.3 6103.9 6142.4 6069.7 6111.3 6114.9 6120.4 6130.5 5946.9 5988.5 6076.3 6113.6 6120.8 5978.3 6059.8 6092.9 6110.4 6150.7 4156.5 4926.2 4936.5 4958.8 4995.5 4267.5 4358.3 4379.4 4380.8 4427.6 4640.3 5487.7 5536.1 5546.8 5553.4 6167.9 6169.2 6191.4 6201.2 6218.3 5049.3 5604.3 5607.1 5629.6 5657.6 4479.4 5153.9 5178.9 5217.2 5296.6 5190.3 6207.0 6212.4 6215.0 6216.7 5994.3 6046.4 6187.2 6214.3 6217.7 6087.1 6135.9 6186.3 6200.7 6205.5 6086.3 6129.2 6152.0 6167.5 6187.3 5044.9 5961.2 5970.7 6101.7 6172.4 4786.3 5787.4 5874.9 5899.0 5944.9 5934.5 5966.1 6008.3 6034.8 6037.9 5728.6 5787.4 5789.8 5831.7 5845.4 5761.5 5841.5 5958.9 6007.2 6012.3 5792.6 5829.0 5864.3 5915.5 5951.6 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | [#1] ext.html Cycles:180 Average:60624.44 Median:34566.98 stddev:122922.94 (355.6%) stddev-sans-first:123184.84 12:28:32 INFO - PROCESS | 1641 | Values: 486.3 490.6 491.8 510.6 513.4 33578.0 40240.8 42464.6 42715.0 42874.4 43257.8 43592.3 43649.3 43659.1 43727.0 9440.2 9646.5 9649.1 9660.0 11080.8 11155.8 11342.6 11405.3 11415.2 11431.4 11404.6 11431.1 11445.2 11452.0 11466.8 11359.2 11359.3 11412.2 11424.6 11426.6 11151.2 11231.5 11249.2 11254.4 11285.9 29991.3 36840.6 36979.8 37083.6 37108.6 3733.6 3735.0 3773.0 3786.5 3913.5 23404.9 27681.6 28533.0 28823.0 28867.3 3051.4 3114.5 3239.1 3262.9 3271.2 365270.0 365447.2 367002.0 432674.0 438721.0 53006.0 54261.7 65344.3 66316.7 66499.0 69667.2 71138.3 71218.6 76526.6 76530.2 15390.6 15419.9 15432.4 15585.3 15618.7 11672.2 11797.6 11858.3 11876.8 11888.9 18443.0 19552.5 20330.8 20369.0 20374.8 7002.9 8594.9 8607.8 8679.0 8697.4 696.0 824.4 837.2 839.6 868.8 21950.5 29630.9 29741.7 29773.4 30043.8 984.3 1012.5 1027.3 1053.9 1059.7 11438.4 13152.8 13648.8 14575.8 15709.8 533340.0 538812.0 539634.0 540602.0 541135.3 59182.7 59487.4 59665.7 59702.7 60201.4 1336.8 1394.5 1398.4 1398.6 1402.4 21285.7 28242.9 29399.1 29540.4 29550.3 51012.0 51052.2 51601.7 51645.0 51665.7 363192.0 457462.0 459505.4 459509.0 460080.7 25498.4 25888.9 25961.2 26668.9 41464.8 40766.6 41278.6 42025.6 42153.4 42317.0 32653.2 34501.0 34796.7 35801.6 35956.0 33288.0 34638.8 34754.8 35612.5 35615.2 33515.3 34096.7 34633.0 34757.1 34987.7 23310.5 29379.7 29644.6 29813.0 30350.8 22890.8 23576.3 23641.6 23694.8 24316.8 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | [#2] jquery.html Cycles:180 Average:34303.28 Median:2536.52 stddev:99044.92 (3904.8%) stddev-sans-first:99290.01 12:28:32 INFO - PROCESS | 1641 | Values: 377.1 391.3 395.1 401.1 415.1 19371.7 21303.6 21344.1 21438.8 21440.8 21093.9 21284.4 21849.3 21958.8 22119.3 5382.7 5767.1 5836.0 5836.6 5852.7 5720.9 5765.3 5832.2 6070.1 6085.6 5083.9 5317.6 5808.3 6015.2 6084.2 5708.2 6043.3 6059.5 6084.4 6121.8 5066.1 5960.5 5963.0 5967.2 5975.9 12850.9 13081.5 13142.3 13165.8 13175.9 2487.8 2524.9 2548.1 2585.4 2589.0 9802.5 10026.6 10317.5 10332.9 14928.6 1736.9 1804.7 1826.9 1835.4 1840.7 113669.0 116473.0 121334.0 123940.0 125236.0 9632.9 11454.7 11612.1 11901.5 11939.8 15231.5 15397.5 15403.2 15420.7 15421.1 7557.7 7771.6 7784.9 7872.6 7890.1 7192.7 7271.2 7271.6 7387.8 7407.0 4689.2 4712.3 4722.4 4726.1 4805.4 2006.3 2015.4 2023.4 2030.8 2040.4 956.1 972.0 985.5 994.3 1018.5 16513.5 17893.7 21016.6 21025.3 21111.0 930.7 1001.8 1015.7 1046.4 1095.9 10651.0 10858.9 10897.8 10903.5 10961.2 390733.0 521418.0 656195.0 665256.8 672655.0 98557.0 107549.5 131647.7 139176.0 144435.0 970.3 995.9 1048.0 1050.3 1055.0 18394.7 19253.5 19307.4 19327.6 19328.8 56483.7 56741.7 57354.7 57526.8 59118.4 76787.0 81661.6 81705.0 81920.2 82014.2 7831.3 7971.3 8057.9 8085.4 8191.1 7277.0 9633.9 10536.9 12111.6 12272.8 9456.5 10274.4 10683.0 10992.8 11186.7 8441.9 10923.2 10986.6 11026.6 11304.9 8940.7 10941.8 11264.5 11547.6 11663.1 8147.9 8215.0 8258.0 8306.2 8393.2 9047.5 10909.1 11224.9 11256.6 11269.3 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | [#3] mootools.html Cycles:180 Average:5378.12 Median:5219.27 stddev:2936.73 (56.3%) stddev-sans-first:2930.06 12:28:32 INFO - PROCESS | 1641 | Values: 1440.7 1440.8 1441.4 1464.7 1478.0 8120.4 8436.4 8571.0 8603.2 8758.1 8552.9 8648.9 8655.7 8679.4 8687.6 2270.7 2325.1 2328.5 2329.3 2338.9 2295.9 2321.9 2330.6 2331.9 2333.6 2267.5 2272.8 2290.6 2293.9 2305.0 2085.1 2244.3 2273.4 2273.7 2279.4 1668.0 1905.6 2068.7 2079.2 2272.9 8459.0 8515.6 8532.1 8542.1 8543.6 5046.9 5189.2 5214.8 5223.8 5232.8 3186.0 3267.5 3391.6 3393.2 3407.5 1051.3 1110.6 1185.9 1243.1 1243.1 10027.7 10245.9 10682.9 10894.8 10909.6 3968.7 4382.7 4498.6 4515.3 4520.3 8669.0 8755.6 8773.8 8783.4 8787.2 5060.1 5110.3 5142.2 5147.1 5165.5 4656.9 4741.6 4800.4 4804.9 4819.0 3608.5 3615.5 3652.8 3685.9 3701.1 1139.7 1144.4 1146.8 1153.6 1161.1 762.9 808.9 880.2 888.7 927.1 4536.7 5314.3 5837.9 5929.3 5963.6 878.9 984.4 984.4 999.1 1021.1 3634.7 3791.5 3858.2 3908.2 3908.3 9672.9 9935.8 9936.3 9950.9 9975.6 8420.0 9837.8 9923.6 9926.9 9971.6 6567.6 6788.8 7652.0 7905.4 7929.8 4943.6 5385.5 5403.8 5691.7 5871.6 8956.7 9139.7 9156.0 9179.2 9186.9 8878.3 9279.6 9283.5 9286.0 9402.2 7110.1 7239.7 7262.8 7271.1 7294.5 6712.6 7785.4 7816.0 7866.9 7890.4 7073.5 7134.5 7164.7 7182.8 7311.9 6973.0 7050.6 7075.3 7085.4 7107.5 6307.5 6406.8 6427.8 6452.2 6458.5 4784.9 4882.2 4987.5 4989.4 5005.5 4881.8 4946.5 5035.4 5060.4 5150.9 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | [#4] prototype.html Cycles:180 Average:4512.02 Median:4956.89 stddev:1372.63 (27.7%) stddev-sans-first:1339.75 12:28:32 INFO - PROCESS | 1641 | Values: 309.8 349.3 357.5 363.3 373.3 5025.4 5193.0 5421.1 5489.5 5556.5 4547.1 4866.7 4917.7 5273.9 5428.9 3880.3 4220.7 4271.9 4275.0 4293.5 4178.0 4206.2 4284.2 4296.0 4316.9 3365.9 3504.8 4169.5 4181.3 4206.0 4206.1 4216.8 4232.4 4239.0 4239.3 3735.7 3758.5 3763.9 3767.4 3784.8 4314.4 4807.6 5033.7 5208.9 5264.9 4315.5 4731.3 4796.8 4929.8 4946.5 4373.9 4883.7 5161.6 5541.9 5867.4 3153.2 3348.7 3654.7 3789.4 3825.5 5013.6 5275.6 5466.4 6053.4 6058.0 3603.5 3925.4 3926.4 3970.4 3976.6 3993.9 3996.5 4000.3 4014.7 4022.7 4195.7 4678.3 4703.3 4708.9 4718.6 4664.9 4671.0 4952.6 5739.9 5875.8 1055.6 1127.2 1145.8 1306.0 1316.6 817.4 871.9 872.2 879.2 882.0 4626.8 4646.3 4961.2 5152.5 5219.9 5086.5 5198.2 5589.7 5741.6 5781.3 4509.4 4644.0 4998.8 5151.6 5182.3 2555.9 2673.3 2800.3 2869.7 2970.4 4995.0 5496.5 5648.6 5802.3 5869.0 5056.8 5072.6 5699.7 5803.1 5833.3 4884.7 5780.4 5798.4 5807.7 5819.7 4730.3 4893.1 4914.7 5300.3 5661.6 4688.6 4817.6 5388.9 5581.9 5653.0 5156.0 5346.9 5780.7 5921.2 5921.5 3477.8 3482.6 3635.8 3876.9 3907.2 5776.7 5906.6 5916.3 5932.0 5937.3 4666.9 5042.6 5087.6 5442.9 5579.6 5311.3 5338.6 5431.9 5801.9 5815.3 5339.6 5658.7 5674.8 5677.9 5698.4 5310.6 5402.7 5752.4 5777.8 5791.4 4961.3 5668.6 5696.7 5698.4 5706.4 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | [#5] yui.html Cycles:180 Average:18770.46 Median:4212.13 stddev:26288.62 (624.1%) stddev-sans-first:26327.14 12:28:32 INFO - PROCESS | 1641 | Values: 646.5 670.5 691.9 756.2 764.7 13953.7 15268.7 15288.8 15294.3 15333.2 13848.1 14028.7 14063.1 14238.4 14280.6 873.6 875.3 883.4 885.9 888.7 882.1 884.1 888.7 889.1 890.1 953.7 956.6 969.3 969.3 970.3 963.2 964.2 964.5 965.9 966.9 715.6 716.6 716.9 717.0 723.9 14514.6 15050.2 15684.3 15689.8 15800.0 13815.4 14149.6 14171.9 14206.9 14231.2 11521.7 11601.8 11665.5 11678.2 12121.0 3533.9 3692.9 3719.3 3774.5 3880.3 102601.5 103973.0 104492.0 105173.5 106342.0 10431.9 10533.2 10544.9 10807.1 11098.7 15894.5 17969.9 21607.9 21658.4 21801.5 7463.6 7501.4 7573.5 7670.2 7695.2 4056.7 4172.6 4210.0 4214.3 4224.6 3547.1 3562.8 3575.9 3623.5 3631.3 604.1 613.0 616.2 622.2 623.0 621.8 633.7 641.1 647.5 666.5 9573.4 9624.5 9680.6 9906.2 9977.0 647.6 686.2 699.0 701.0 704.6 4467.3 4475.4 4754.9 4805.7 4837.1 72733.8 73336.0 82300.0 85987.1 90196.5 68315.0 69929.3 79141.6 82922.6 85211.6 74520.4 74732.0 74985.3 75003.6 76033.6 10219.6 10532.0 10598.3 10660.7 10720.0 45942.8 46995.0 47591.1 47699.0 48196.0 40658.2 48363.0 62234.8 63092.0 64072.7 12212.0 12256.4 12464.9 12496.3 12736.9 10716.5 13014.4 13978.9 14015.6 14359.9 10597.9 12685.5 12924.8 13086.7 13473.0 10010.5 12611.9 13090.1 13107.7 13831.4 12260.5 12414.4 12652.2 12871.0 12980.9 10264.7 10345.8 10538.9 10611.9 11444.4 7218.2 9080.8 9167.4 10505.6 10542.8 12:28:32 INFO - PROCESS | 1641 | -------- Summary: end -------- 12:28:32 INFO - PROCESS | 1641 | 12:28:32 INFO - PROCESS | 1641 | 1487881712153 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 12:28:32 INFO - TEST-INFO | 1641: exit 0 12:28:32 INFO - TEST-OK | dromaeo_css | took 1116817ms 12:28:32 INFO - TEST-START | kraken 12:28:32 INFO - operating with platform_type : mac_ 12:28:32 INFO - Initialising browser for kraken test... 12:28:32 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpGYh6dn/profile http://localhost:49243/getInfo.html) 12:28:33 INFO - PROCESS | 1653 | 1487881713295 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 12:28:33 INFO - PROCESS | 1653 | 1487881713296 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method install 12:28:33 INFO - PROCESS | 1653 | 1487881713336 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 12:28:35 INFO - PROCESS | 1653 | 2017-02-23 12:28:35.486 plugin-container[1654:10582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 12:28:35 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:28:35 INFO - PROCESS | 1653 | 2017-02-23 12:28:35.489 plugin-container[1654:10582] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 12:28:35 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:28:35 INFO - PROCESS | 1653 | 2017-02-23 12:28:35.489 plugin-container[1654:10582] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:28:35 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 12:28:35 INFO - PROCESS | 1653 | colorDepth:24 12:28:35 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 12:28:35 INFO - PROCESS | 1653 | __metrics 12:28:35 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 12:28:35 INFO - PROCESS | 1653 | 1487881715653 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 12:28:36 INFO - TEST-INFO | 1653: exit 0 12:28:36 INFO - Browser initialized. 12:28:36 INFO - Running cycle 1/1 for kraken test... 12:28:36 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/T/tmpGYh6dn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:28:36 INFO - PROCESS | 1655 | 1487881716817 addons.xpi WARN Error loading bootstrap.js for disableSHA1rollout@mozilla.org: Error opening input stream (invalid filename?): jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/disableSHA1rollout@mozilla.org.xpi!/bootstrap.js 12:28:36 INFO - PROCESS | 1655 | 1487881716818 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method startup 12:28:38 INFO - PROCESS | 1655 | 2017-02-23 12:28:38.971 plugin-container[1656:10716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x894b, name = 'com.apple.tsm.portname' 12:28:38 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:28:38 INFO - PROCESS | 1655 | 2017-02-23 12:28:38.972 plugin-container[1656:10716] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 12:28:38 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:28:38 INFO - PROCESS | 1655 | 2017-02-23 12:28:38.972 plugin-container[1656:10716] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:28:48 INFO - PROCESS | 1655 | RSS: Main: 227901440 12:28:48 INFO - PROCESS | 1655 | 12:28:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 12:28:52 INFO - PROCESS | 1655 | RSS: Main: 240775168 12:28:52 INFO - PROCESS | 1655 | 12:28:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 12:28:56 INFO - PROCESS | 1655 | RSS: Main: 248832000 12:28:56 INFO - PROCESS | 1655 | 12:28:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 12:29:00 INFO - PROCESS | 1655 | RSS: Main: 251527168 12:29:00 INFO - PROCESS | 1655 | 12:29:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 12:29:03 INFO - PROCESS | 1655 | RSS: Main: 253640704 12:29:03 INFO - PROCESS | 1655 | 12:29:05 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:29:05 INFO - PROCESS | 1655 | RSS: Main: 254226432 12:29:05 INFO - PROCESS | 1655 | 12:29:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 12:29:09 INFO - PROCESS | 1655 | RSS: Main: 259801088 12:29:09 INFO - PROCESS | 1655 | 12:29:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 12:29:12 INFO - PROCESS | 1655 | RSS: Main: 259772416 12:29:12 INFO - PROCESS | 1655 | 12:29:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 12:29:16 INFO - PROCESS | 1655 | RSS: Main: 259461120 12:29:16 INFO - PROCESS | 1655 | 12:29:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:29:19 INFO - PROCESS | 1655 | RSS: Main: 258383872 12:29:19 INFO - PROCESS | 1655 | 12:29:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:29:21 INFO - PROCESS | 1655 | RSS: Main: 258363392 12:29:21 INFO - PROCESS | 1655 | 12:29:23 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:29:24 INFO - PROCESS | 1655 | RSS: Main: 258424832 12:29:24 INFO - PROCESS | 1655 | 12:29:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:29:28 INFO - PROCESS | 1655 | RSS: Main: 258715648 12:29:28 INFO - PROCESS | 1655 | 12:29:31 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:29:32 INFO - PROCESS | 1655 | RSS: Main: 256008192 12:29:32 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 12:29:34 INFO - PROCESS | 1655 | RSS: Main: 259534848 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | __start_tp_report 12:29:34 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:29:34 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:29:34 INFO - PROCESS | 1655 | |i|pagename|runs| 12:29:34 INFO - PROCESS | 1655 | |0;ai-astar;106;118;118;118;117;123;135;123;118;119 12:29:34 INFO - PROCESS | 1655 | |1;audio-beat-detection;143;136;144;153;114;112;117;114;142;145 12:29:34 INFO - PROCESS | 1655 | |2;audio-dft;230;265;287;197;201;202;167;244;274;202 12:29:34 INFO - PROCESS | 1655 | |3;audio-fft;82;68;69;88;78;87;83;85;78;64 12:29:34 INFO - PROCESS | 1655 | |4;audio-oscillator;124;106;120;70;72;73;84;72;70;86 12:29:34 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;91;101;90;91;90;91;90;89;108 12:29:34 INFO - PROCESS | 1655 | |6;imaging-darkroom;151;152;99;99;98;106;99;112;99;93 12:29:34 INFO - PROCESS | 1655 | |7;imaging-desaturate;83;79;99;109;140;144;94;91;77;144 12:29:34 INFO - PROCESS | 1655 | |8;json-parse-financial;62;64;63;65;64;79;83;66;64;65 12:29:34 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;70;70;71;85;74;84;86;89;83;63 12:29:34 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;90;89;90;90;93;92;89;94;87;91 12:29:34 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;144;147;145;144;162;153;161;166;194;150 12:29:34 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;182;209;178;175;212;239;188;183;241;241 12:29:34 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;67;72;70;68;82;91;87;76;73;71 12:29:34 INFO - PROCESS | 1655 | __end_tp_report 12:29:34 INFO - PROCESS | 1655 | __start_cc_report 12:29:34 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,1024 12:29:34 INFO - PROCESS | 1655 | __end_cc_report 12:29:34 INFO - PROCESS | 1655 | __startTimestamp1487881774418__endTimestamp 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:29:34 INFO - PROCESS | 1655 | Number of tests: 14 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:119.50 Median:118.50 stddev:7.17 (6.0%) stddev-sans-first:5.70 12:29:34 INFO - PROCESS | 1655 | Values: 106.0 118.0 118.0 118.0 117.0 123.0 135.0 123.0 118.0 119.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:142.50 stddev:15.86 (11.1%) stddev-sans-first:16.32 12:29:34 INFO - PROCESS | 1655 | Values: 143.0 136.0 144.0 153.0 114.0 112.0 117.0 114.0 142.0 145.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:226.90 Median:237.00 stddev:39.41 (16.6%) stddev-sans-first:41.78 12:29:34 INFO - PROCESS | 1655 | Values: 230.0 265.0 287.0 197.0 201.0 202.0 167.0 244.0 274.0 202.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:78.20 Median:82.50 stddev:8.48 (10.3%) stddev-sans-first:8.89 12:29:34 INFO - PROCESS | 1655 | Values: 82.0 68.0 69.0 88.0 78.0 87.0 83.0 85.0 78.0 64.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:72.00 stddev:21.21 (29.5%) stddev-sans-first:17.97 12:29:34 INFO - PROCESS | 1655 | Values: 124.0 106.0 120.0 70.0 72.0 73.0 84.0 72.0 70.0 86.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:90.00 stddev:6.32 (7.0%) stddev-sans-first:6.54 12:29:34 INFO - PROCESS | 1655 | Values: 89.0 91.0 101.0 90.0 91.0 90.0 91.0 90.0 89.0 108.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:110.80 Median:98.50 stddev:22.05 (22.4%) stddev-sans-first:17.96 12:29:34 INFO - PROCESS | 1655 | Values: 151.0 152.0 99.0 99.0 98.0 106.0 99.0 112.0 99.0 93.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:106.00 Median:81.00 stddev:27.02 (33.4%) stddev-sans-first:27.35 12:29:34 INFO - PROCESS | 1655 | Values: 83.0 79.0 99.0 109.0 140.0 144.0 94.0 91.0 77.0 144.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:65.00 stddev:7.26 (11.2%) stddev-sans-first:7.42 12:29:34 INFO - PROCESS | 1655 | Values: 62.0 64.0 63.0 65.0 64.0 79.0 83.0 66.0 64.0 65.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:83.50 stddev:8.89 (10.6%) stddev-sans-first:9.00 12:29:34 INFO - PROCESS | 1655 | Values: 70.0 70.0 71.0 85.0 74.0 84.0 86.0 89.0 83.0 63.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:90.50 stddev:2.07 (2.3%) stddev-sans-first:2.19 12:29:34 INFO - PROCESS | 1655 | Values: 90.0 89.0 90.0 90.0 93.0 92.0 89.0 94.0 87.0 91.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:156.60 Median:157.00 stddev:15.41 (9.8%) stddev-sans-first:15.65 12:29:34 INFO - PROCESS | 1655 | Values: 144.0 147.0 145.0 144.0 162.0 153.0 161.0 166.0 194.0 150.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.80 Median:210.50 stddev:27.37 (13.0%) stddev-sans-first:27.76 12:29:34 INFO - PROCESS | 1655 | Values: 182.0 209.0 178.0 175.0 212.0 239.0 188.0 183.0 241.0 241.0 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:74.50 stddev:8.25 (11.1%) stddev-sans-first:8.12 12:29:34 INFO - PROCESS | 1655 | Values: 67.0 72.0 70.0 68.0 82.0 91.0 87.0 76.0 73.0 71.0 12:29:34 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:29:34 INFO - PROCESS | 1655 | 12:29:34 INFO - PROCESS | 1655 | 1487881774441 addons.xpi WARN Add-on disableSHA1rollout@mozilla.org is missing bootstrap method shutdown 12:29:35 INFO - TEST-INFO | 1655: exit 0 12:29:35 INFO - TEST-OK | kraken | took 62579ms 12:29:35 INFO - SUITE-END | took 1179s 12:29:35 INFO - Completed test suite (00:19:39) 12:29:35 INFO - javascript benchmark 12:29:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7123.584361803619, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3080.9524761581088, 3210.614726232852, 3238.967610323896, 3306.33873225355, 3329.633740288568, 4468.882779305174, 5046.167382381912, 5501.257330260413, 5520.447955204478, 5640.435956404358, 5561.721913904299, 5563.109902415625, 5571.609987300891, 5627.352854421742, 5630.09918413054, 4944.184209605411, 5058.519440653132, 5076.543111119999, 5147.897042059157, 5161.4322424533275, 5083.034223497542, 5158.638895277332, 5159.742012899359, 5169.190783225859, 5174.870628234286, 4856.514348565133, 4951.678140920829, 4960.404751429815, 4995.450500444948, 5082.618803589727, 5010.949890501085, 5044.319016932704, 5114.028334616411, 5126.71803050832, 5154.226865970097, 5015.699058056528, 5050.848474545733, 5053.519915608012, 5059.392872855244, 5080.364954380702, 4396.472423309191, 5335.439778823206, 5343.625946183769, 5464.726763661801, 5544.445555444423, 6018.15745795589, 6060.878782424327, 6073.908891366633, 6103.908441373383, 6133.907991380132, 6213.068039794022, 6221.844453888643, 6227.750889964396, 6230.43926046658, 6238.500919926395, 4829.73436460991, 5722.5433526011475, 5729.684867332337, 5779.971100144472, 5820.010598198316, 5284.788608455696, 5346.385165705916, 6090.390960903874, 6090.573659843857, 6115.362036198677, 6010.699465026732, 6038.6678732670125, 6053.334133245339, 6103.877922441615, 6142.416470435302, 6069.726862291208, 6111.266648002268, 6114.938850611437, 6120.387961203844, 6130.47890929276, 5946.910796338058, 5988.461038506468, 6076.301225359052, 6113.602615829956, 6120.816375508742, 5978.342382337939, 6059.787907423219, 6092.939070609325, 6110.406879924458, 6150.692465376714, 4156.45966024421, 4926.236433352836, 4936.456989731127, 4958.776855041532, 4995.525425084611, 4267.487901451846, 4358.259095953696, 4379.4087798147475, 4380.824767009284, 4427.5572442755465, 4640.303954406866, 5487.725613719298, 5536.114221724505, 5546.750396232179, 5553.389127196006, 6167.938320616826, 6169.2288463942, 6191.442770150708, 6201.162843016225, 6218.284897236876, 5049.31834202378, 5604.327480702342, 5607.130894711327, 5629.634073785191, 5657.6039677223025, 4479.417675702203, 5153.871153221125, 5178.8964220716125, 5217.2434996925995, 5296.602754793329, 5190.273361729285, 6206.968965155145, 6212.409821066992, 6215.0, 6216.720247588869, 5994.310654274815, 6046.425589568984, 6187.226596675416, 6214.347493513116, 6217.720202590985, 6087.086936959491, 6135.907961380493, 6186.257649082139, 6200.689965501797, 6205.47253483459, 6086.269647642134, 6129.172561704291, 6152.0, 6167.506599472121, 6187.319394866651, 5044.9243261350375, 5961.225040744675, 5970.731317090655, 6101.664408457577, 6172.4136207060255, 4786.2820576912345, 5787.39232380594, 5874.882502350015, 5898.997170481114, 5944.940550594439, 5934.465898069195, 5966.105084237399, 6008.339082700987, 6034.788782392595, 6037.909431358621, 5728.598998070262, 5787.39232380594, 5789.768409263751, 5831.70841457917, 5845.444682755132, 5761.452661997104, 5841.50347220491, 5958.880822383615, 6007.249093863267, 6012.338642749207, 5792.594518383673, 5829.038208695687, 5864.32560255559, 5915.467607915309, 5951.642901425755], "value": 5515.202032017688, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.3045844442448, 490.63202598051464, 491.82294374025344, 510.6068327387911, 513.3967588084, 33578.0, 40240.79879600601, 42464.57535424645, 42715.0, 42874.35688464668, 43257.78371108148, 43592.3461148083, 43649.34525982105, 43659.12681746371, 43726.99999999992, 9440.197583205436, 9646.517674116267, 9649.083337083, 9659.951700241489, 11080.778384432306, 11155.776884462306, 11342.60300889469, 11405.31568105912, 11415.200935934488, 11431.428428578538, 11404.600838970639, 11431.142664300169, 11445.198836081478, 11451.96932276095, 11466.827997580043, 11359.204855660108, 11359.318440893532, 11412.20114591979, 11424.600138995178, 11426.600068997628, 11151.219414640897, 11231.494582743797, 11249.212555121145, 11254.381009044499, 11285.887141128565, 29991.250218744488, 36840.63159368426, 36979.81510092459, 37083.62916370856, 37108.62891371106, 3733.6453036961716, 3734.981325093357, 3773.0, 3786.5266841644793, 3913.491246137984, 23404.882975585013, 27681.584776228374, 28533.001344953034, 28823.0, 28867.27831804201, 3051.4049760296753, 3114.527697615607, 3239.1092449576317, 3262.9021129366156, 3271.247613048988, 365270.0, 365447.2093476742, 367002.0, 432674.0, 438721.0, 53006.0, 54261.72869135629, 65344.34655653383, 66316.66841665858, 66499.0, 69667.21331146697, 71138.28861711317, 71218.64390678014, 76526.61736691392, 76530.23469765231, 15390.615234619225, 15419.922900385427, 15432.38270469191, 15585.298661560257, 15618.68762624741, 11672.241304315192, 11797.587084452174, 11858.288502689866, 11876.821847672292, 11888.94055529734, 18442.985635789893, 19552.502924327484, 20330.848718448666, 20368.981550922395, 20374.796252037588, 7002.859942801116, 8594.894250908568, 8607.784805379915, 8679.0, 8697.391182617155, 695.9860802784017, 824.3570015388007, 837.2046555772041, 839.5969934431384, 868.7567481105301, 21950.45123871916, 29630.85184574063, 29741.702582974325, 29773.40453190924, 30043.849780750956, 984.2519685039422, 1012.5443550402348, 1027.3117011602244, 1053.9051485366354, 1059.6662051453768, 11438.428078596036, 13152.802707959388, 13648.83984861278, 14575.781363279559, 15709.764353534707, 533340.0, 538812.0, 539634.0, 540602.0, 541135.2943235259, 59182.704086479294, 59487.40512594905, 59665.70167149136, 59702.701486493155, 60201.397986019576, 1336.7994800779961, 1394.525861207174, 1398.4406237504877, 1398.608389650879, 1402.396969303189, 21285.68071478898, 28242.85878570594, 29399.11802645924, 29540.409191815612, 29550.261243469085, 51012.0, 51052.23421648604, 51601.7419912913, 51645.0, 51665.741671291406, 363192.0, 457462.0, 459505.4049459596, 459509.0, 460080.69959649985, 25498.362540936625, 25888.8705556471, 25961.221163365128, 26668.866655666596, 41464.75605731833, 40766.57316994009, 41278.587214127474, 42025.579744202165, 42153.36769948515, 42317.0, 32653.18367040748, 34501.0, 34796.65203348036, 35801.64198357983, 35956.0, 33288.0, 34638.78764243239, 34754.82622586871, 35612.465813012306, 35615.19194908654, 33515.32969340551, 34096.65903341034, 34632.961011169704, 34757.13107172341, 34987.65012349844, 23310.533789324458, 29379.706202937698, 29644.55533167047, 29813.0, 30350.84824575863, 22890.771092288865, 23576.288726795952, 23641.645375319727, 23694.763052369257, 24316.75683243145], "value": 19501.32826500978, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.0893292698134, 391.25661243637086, 395.0715817828104, 401.1035336023984, 415.09509269791863, 19371.709424358647, 21303.57392852146, 21344.146234150634, 21438.785612143874, 21440.785592144075, 21093.894530527363, 21284.36146915595, 21849.344519664435, 21958.780412195872, 22119.336419907388, 5382.6770393776305, 5767.106098554731, 5836.007878660616, 5836.5914385993, 5852.707364631773, 5720.856978575548, 5765.279340082489, 5832.154337621042, 6070.0591408331775, 6085.569891075594, 5083.949160508403, 5317.644000779815, 5808.332041815182, 6015.157877897076, 6084.178635884144, 5708.229389032469, 6043.335233124353, 6059.454649081582, 6084.391560843925, 6121.785737499211, 5066.062778385974, 5960.523158147338, 5962.970185149046, 5967.194428752106, 5975.880482390371, 12850.935745321214, 13081.542146024938, 13142.342882855915, 13165.802512962313, 13175.934120329433, 2487.751224877498, 2524.9495010099877, 2548.0826902315152, 2585.3924327782956, 2589.029114082219, 9802.509874506317, 10026.59893604255, 10317.484125793755, 10332.896671033344, 14928.552143435714, 1736.8697347698974, 1804.691598591011, 1826.9269229230815, 1835.431016384925, 1840.6686796376646, 113669.0, 116473.0, 121334.0, 123940.0, 125235.99056037748, 9632.892217394949, 11454.656360309204, 11612.12909031826, 11901.452811134497, 11939.76120477603, 15231.543053708407, 15397.538073857802, 15403.22983850803, 15420.691586168437, 15421.074735515906, 7557.697692092364, 7771.572563509061, 7784.883226751604, 7872.606369681493, 7890.053193616803, 7192.728490255736, 7271.157938598437, 7271.647699158832, 7387.8153046174275, 7407.0, 4689.155951928686, 4712.340272361872, 4722.362481065081, 4726.1020406122725, 4805.399325084364, 2006.3278801601334, 2015.4054553906633, 2023.3828682252054, 2030.7563092428707, 2040.3878836349036, 956.1490273656451, 971.9562619682131, 985.5072463768116, 994.3387647214521, 1018.4754851251612, 16513.504594862174, 17893.7315940261, 21016.579668406546, 21025.26411575618, 21111.0, 930.7300882744064, 1001.8046480936148, 1015.7155996320894, 1046.4140081554353, 1095.9287646302964, 10651.041406273473, 10858.914108589079, 10897.83653245202, 10903.509342079626, 10961.163592742476, 390733.0, 521418.0, 656195.0, 665256.7794576422, 672655.0, 98557.01442985622, 107549.4622526898, 131647.68352316355, 139176.0, 144435.0, 970.3401686853008, 995.875515560555, 1047.989520104789, 1050.2648146297622, 1054.9525271362654, 18394.72407913909, 19253.518662033563, 19307.4207773767, 19327.613447730684, 19328.806711933263, 56483.71758141183, 56741.71629141828, 57354.7132264336, 57526.84946301134, 59118.40881591129, 76787.0, 81661.59169204354, 81705.0, 81920.18079819126, 82014.17985820066, 7831.334336581454, 7971.322437592869, 8057.879131812911, 8085.353171746128, 8191.05802832658, 7277.0, 9633.855492167482, 10536.894631053592, 12111.636650900487, 12272.815907761213, 9456.479893605643, 10274.383536987805, 10683.0, 10992.835107473235, 11186.720331991766, 8441.944756905386, 10923.180761443082, 10986.560537578407, 11026.614068507564, 11304.886951130384, 8940.68707595231, 10941.835872461761, 11264.493097810455, 11547.595834145764, 11663.125265604944, 8147.877781833396, 8214.959425269553, 8258.009038915368, 8306.210909963544, 8393.202645748644, 9047.502387368759, 10909.072728818139, 11224.94387528057, 11256.606018789304, 11269.323840569592], "value": 9413.131059670606, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.7190597833421, 1440.7694768836989, 1441.437839242695, 1464.7143806957642, 1477.9852201477986, 8120.390970677201, 8436.36727245456, 8571.014333351673, 8603.225709686127, 8758.12418758124, 8552.871706924401, 8648.91351086489, 8655.653773849053, 8679.392442529026, 8687.56562171892, 2270.6594010898416, 2325.1164557468137, 2328.4528135888054, 2329.2662811214414, 2338.9064437422485, 2295.8737269450176, 2321.8606883586954, 2330.592146374386, 2331.8600883946933, 2333.6266197408418, 2267.5124848157643, 2272.8295377846644, 2290.5876942150408, 2293.919712810052, 2304.976950230493, 2085.103405535619, 2244.304265677637, 2273.3520946530325, 2273.7498875123724, 2279.3959600705825, 1667.9749803752954, 1905.6284024615206, 2068.6586713192305, 2079.189116244666, 2272.9090036782436, 8459.0, 8515.616797244138, 8532.14678532148, 8542.14578542147, 8543.615537300837, 5046.899062018776, 5189.1697328427645, 5214.765335559871, 5223.764930578095, 5232.790688372461, 3185.984070079658, 3267.477203647405, 3391.6099648540485, 3393.1856354474994, 3407.505911642798, 1051.337657275919, 1110.5835311758092, 1185.9407029648569, 1243.0863315463127, 1243.148443316322, 10027.699169024869, 10245.948770256176, 10682.893171068268, 10894.782104357948, 10909.618163364245, 3968.7420317679257, 4382.737035777864, 4498.572635599613, 4515.300128480091, 4520.276755719069, 8669.003064647646, 8755.649774008969, 8773.780655483537, 8783.385163038525, 8787.165219304155, 5060.063888180698, 5110.3356563646485, 5142.228665700175, 5147.124988751922, 5165.457626949192, 4656.906861862812, 4741.57325840676, 4800.35195248644, 4804.855854324306, 4819.012102518976, 3608.4948107265004, 3615.5480564929385, 3652.7990960496895, 3685.9262814743556, 3701.148735790783, 1139.6865861888048, 1144.4449442020614, 1146.7534480086822, 1153.6366044695894, 1161.1465572803982, 762.8626847167563, 808.8675853804721, 880.1726377205534, 888.7200531832452, 927.0914503786328, 4536.72779633223, 5314.28257185275, 5837.923052362762, 5929.3181284152015, 5963.5527335450015, 878.8574852691476, 984.4093543873619, 984.4241118945354, 999.1058003087196, 1021.1313296667081, 3634.67287944081, 3791.545014598266, 3858.2090671412293, 3908.1988192420486, 3908.335582950905, 9672.903270967341, 9935.751606209758, 9936.304458687968, 9950.900490995142, 9975.60097596088, 8419.95790021046, 9837.754056148653, 9923.603055877684, 9926.900730992742, 9971.551280192409, 6567.605943643397, 6788.762393316309, 7651.961740191375, 7905.407094467938, 7929.841403171904, 4943.555080042814, 5385.488378604026, 5403.7838486460105, 5691.743871525874, 5871.588988770745, 8956.731298061068, 9139.680111196076, 9156.0, 9179.219766319671, 9186.862197067183, 8878.334124940526, 9279.582418791306, 9283.48940808262, 9285.953570232106, 9402.247820174232, 7110.075690160453, 7239.746608868875, 7262.818429539092, 7271.127464704269, 7294.525855819355, 6712.563683360566, 7785.377169826287, 7815.96092019559, 7866.9213307866185, 7890.447668663139, 7073.540219885691, 7134.500584959003, 7164.67758950838, 7182.820429489305, 7311.890321645286, 6972.965135174291, 7050.612216327946, 7075.292470752884, 7085.39774119185, 7107.466939979418, 6307.526935479766, 6406.775762848464, 6427.839304017437, 6452.22573291208, 6458.515611329263, 4784.856454306377, 4882.218844984785, 4987.451380348231, 4989.426215985063, 5005.549500544968, 4881.80472781099, 4946.480619535041, 5035.420926593342, 5060.3927528696795, 5150.948490515047], "value": 4358.955260882099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.7552933182786, 349.32754447688194, 357.5030707316832, 363.268014949876, 373.2870217883841, 5025.447200807908, 5192.961407718452, 5421.078416669171, 5489.478499542542, 5556.527695145907, 4547.09058188362, 4866.732329721864, 4917.721392437974, 5273.8600198843915, 5428.9185662214995, 3880.26275007749, 4220.746755194683, 4271.914561708764, 4274.957250427487, 4293.527711951699, 4177.97911010446, 4206.20082184384, 4284.179223829876, 4295.9785201073955, 4316.892077698067, 3365.9299530788635, 3504.754667173299, 4169.520505141902, 4181.268278051344, 4205.97897010516, 4206.095689426757, 4216.789160541991, 4232.407462955189, 4238.957610423887, 4239.342901850218, 3735.7384983051197, 3758.5489741230954, 3763.8870833875026, 3767.397216445383, 3784.7539909905768, 4314.439122914033, 4807.6394270429855, 5033.723145227011, 5208.947321098528, 5264.8683782905355, 4315.482142142963, 4731.313959475891, 4796.7841447134615, 4929.802807887716, 4946.530079642464, 4373.9125217495475, 4883.658143929926, 5161.638685292031, 5541.944580554183, 5867.442592953663, 3153.211697075731, 3348.7136465324425, 3654.689351405134, 3789.4315852622053, 3825.483559719458, 5013.621254155064, 5275.57795376369, 5466.398696143421, 6053.364396738323, 6058.0, 3603.5135256740004, 3925.391564307537, 3926.4306675532457, 3970.404439334065, 3976.6023397660583, 3993.8602148924647, 3996.4813370919446, 4000.27994960904, 4014.698897582693, 4022.6580740636787, 4195.685323600742, 4678.274867395559, 4703.270992996091, 4708.905821883612, 4718.598919091915, 4664.883377915511, 4671.0, 4952.603791696655, 5739.8565035874435, 5875.823725288248, 1055.6358056470506, 1127.1658972360394, 1145.8166693329026, 1305.9673508162182, 1316.5918565244804, 817.3787921179827, 871.8822958900594, 872.2019352292581, 879.2482427524502, 881.9647214111492, 4626.768661566908, 4646.3495110684535, 4961.179891483537, 5152.4847515248175, 5219.947800521946, 5086.474057782651, 5198.246254293106, 5589.664620122806, 5741.598088133791, 5781.277340332458, 4509.407090922733, 4643.976780116078, 4998.825041123543, 5151.5878729701535, 5182.300389447451, 2555.9105431309813, 2673.345030467509, 2800.3338013881707, 2869.727375899286, 2970.4207679502288, 4995.0, 5496.5053145217125, 5648.604597678205, 5802.272931722084, 5869.0, 5056.823011194664, 5072.6195535335, 5699.715014249271, 5803.100519419497, 5833.270841144857, 4884.682495637772, 5780.393058728857, 5798.362180160179, 5807.738651760596, 5819.679917604572, 4730.290456431563, 4893.119238537098, 4914.70511769295, 5300.337457817773, 5661.603687741818, 4688.5545873142, 4817.566419022165, 5388.865278367915, 5581.888362232651, 5653.049697854233, 5155.994581056808, 5346.866328341667, 5780.7398667060925, 5921.2006379138265, 5921.4966727826895, 3477.8087205202946, 3482.634323396007, 3635.818209089482, 3876.9224615508097, 3907.159960608483, 5776.682282474504, 5906.616069955611, 5916.28427755946, 5931.970340148272, 5937.34689184198, 4666.929996049994, 5042.621803364689, 5087.60713643539, 5442.945570544244, 5579.609427340048, 5311.256424100707, 5338.599605029561, 5431.918521222264, 5801.941980580309, 5815.302163740378, 5339.626226164131, 5658.717064146694, 5674.77300907959, 5677.858053548694, 5698.4016678249845, 5310.583684423501, 5402.6758394496455, 5752.382665887095, 5777.7977770777825, 5791.449812267828, 4961.305417241661, 5668.574856885668, 5696.743646535833, 5698.430156984268, 5706.430731548858], "value": 4079.8467204432022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.5215740352139, 670.5339788846753, 691.885838836592, 756.1926994483186, 764.705588348486, 13953.651158721037, 15268.694626107472, 15288.770668439969, 15294.31175597098, 15333.233338333066, 13848.09987350824, 14028.719425611507, 14063.08589941653, 14238.430462781502, 14280.571582852504, 873.6287077991828, 875.3478658399501, 883.4037025008126, 885.8936927568701, 888.7067267801642, 882.1399135842566, 884.1247165306332, 888.693400776731, 889.0753616239136, 890.145460358057, 953.6805170267934, 956.6460409648405, 969.2827307792219, 969.2924165359292, 970.2722957781664, 963.1957315641483, 964.1659964131011, 964.4647220792457, 965.8937516873139, 966.9419834809934, 715.6314498033516, 716.6237725194262, 716.8602122586097, 716.9928300716978, 723.8660847743184, 14514.637134071627, 15050.247487625575, 15684.294206760724, 15689.843101568953, 15800.0, 13815.447382104805, 14149.575512734635, 14171.929140354232, 14206.928965355108, 14231.217283049427, 11521.711957201052, 11601.76796464066, 11665.533378664843, 11678.24091434054, 12120.969717574017, 3533.8939831805087, 3692.8707495237536, 3719.3119272934596, 3774.5281839770028, 3880.262750077476, 102601.4869925653, 103973.0, 104492.0, 105173.4741326296, 106342.0, 10431.947840260902, 10533.210009249337, 10544.947275263728, 10807.08139808125, 11098.722531936766, 15894.52316430509, 17969.921804691498, 21607.891960540095, 21658.35024949254, 21801.454963625718, 7463.552186868806, 7501.362384197295, 7573.545587264672, 7670.156282808886, 7695.23047695226, 4056.6551843093075, 4172.5893894732835, 4209.957900421018, 4214.304639734471, 4224.619784219435, 3547.113221694576, 3562.750607457505, 3575.8748443804343, 3623.4927110204594, 3631.328204282216, 604.1029071828332, 612.9816105516842, 616.1712496691943, 622.243973572112, 622.9750809967551, 621.832105331558, 633.6673246545508, 641.1084715775199, 647.5175993884586, 666.466826538767, 9573.425594464354, 9624.51877406127, 9680.612775488902, 9906.157976572073, 9977.002299769965, 647.6017249391684, 686.1800148822109, 698.9760001597582, 700.9649517524206, 704.5878161275712, 4467.329900514884, 4475.395821564047, 4754.904901901942, 4805.711657300573, 4837.129316722953, 72733.81798546053, 73336.0, 82300.0, 85987.14012859791, 90196.5490172545, 68315.0, 69929.3007069933, 79141.60429197818, 82922.58538707267, 85211.5739421299, 74520.41096917861, 74732.0, 74985.25014749891, 75003.62498187475, 76033.61983190049, 10219.642312519027, 10532.0, 10598.25812193139, 10660.73348166271, 10720.0, 45942.770286148356, 46995.0, 47591.1474606686, 47699.0, 48196.0, 40658.1868362637, 48363.0, 62234.755304892744, 63092.0, 64072.67963660152, 12211.970099634551, 12256.38718064111, 12464.937675311929, 12496.312702801433, 12736.936315318364, 10716.464176790972, 13014.414351354022, 13978.930105349407, 14015.649608759863, 14359.856401435853, 10597.9470102649, 12685.492580297054, 12924.806127908278, 13086.738265234451, 13473.0, 10010.549525271235, 12611.93694031524, 13090.14914030585, 13107.737845242851, 13831.446742130605, 12260.509579616715, 12414.441350139447, 12652.240865548096, 12871.034672399795, 12980.870191298343, 10264.692059238234, 10345.84481232767, 10538.894611054098, 10611.946940265558, 11444.370559619301, 7218.217073534572, 9080.772980675536, 9167.358284919992, 10505.579776809147, 10542.789144216918], "value": 7257.017616996936, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1626.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 118.0, 118.0, 117.0, 123.0, 135.0, 123.0, 118.0, 119.0], "value": 119.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 136.0, 144.0, 153.0, 114.0, 112.0, 117.0, 114.0, 142.0, 145.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [230.0, 265.0, 287.0, 197.0, 201.0, 202.0, 167.0, 244.0, 274.0, 202.0], "value": 226.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 68.0, 69.0, 88.0, 78.0, 87.0, 83.0, 85.0, 78.0, 64.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 106.0, 120.0, 70.0, 72.0, 73.0, 84.0, 72.0, 70.0, 86.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 91.0, 101.0, 90.0, 91.0, 90.0, 91.0, 90.0, 89.0, 108.0], "value": 93.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 99.0, 99.0, 98.0, 106.0, 99.0, 112.0, 99.0, 93.0], "value": 110.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 99.0, 109.0, 140.0, 144.0, 94.0, 91.0, 77.0, 144.0], "value": 106.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 65.0, 64.0, 79.0, 83.0, 66.0, 64.0, 65.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 85.0, 74.0, 84.0, 86.0, 89.0, 83.0, 63.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 90.0, 93.0, 92.0, 89.0, 94.0, 87.0, 91.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 147.0, 145.0, 144.0, 162.0, 153.0, 161.0, 166.0, 194.0, 150.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 209.0, 178.0, 175.0, 212.0, 239.0, 188.0, 183.0, 241.0, 241.0], "value": 204.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 70.0, 68.0, 82.0, 91.0, 87.0, 76.0, 73.0, 71.0], "value": 75.7, "unit": "score"}]}]} 12:29:35 INFO - Return code: 0 12:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:29:35 ERROR - # TBPL SUCCESS # 12:29:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:29:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:29:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:29:35 INFO - 2017-02-23 12:29:35.772 screenresolution[1660:11107] starting screenresolution argv=screenresolution get 12:29:35 INFO - 2017-02-23 12:29:35.775 screenresolution[1660:11107] Display 0: 1600x1200x32@60 12:29:35 INFO - 2017-02-23 12:29:35.782 screenresolution[1661:11111] starting screenresolution argv=screenresolution list 12:29:35 INFO - Available Modes on Display 0 12:29:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:29:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:29:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:29:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:29:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:29:36 INFO - Intel Iris: 12:29:36 INFO - Chipset Model: Intel Iris 12:29:36 INFO - Type: GPU 12:29:36 INFO - Bus: Built-In 12:29:36 INFO - VRAM (Dynamic, Max): 1536 MB 12:29:36 INFO - Vendor: Intel (0x8086) 12:29:36 INFO - Device ID: 0x0a2e 12:29:36 INFO - Revision ID: 0x0009 12:29:36 INFO - Displays: 12:29:36 INFO - Display: 12:29:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:29:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:29:36 INFO - Display Serial Number: 1600x1200 60 12:29:36 INFO - Main Display: Yes 12:29:36 INFO - Mirror: Off 12:29:36 INFO - Online: Yes 12:29:36 INFO - Rotation: Supported 12:29:36 INFO - Return code: 0 12:29:36 INFO - Running post-action listener: _resource_record_post_action 12:29:36 INFO - [mozharness: 2017-02-23 20:29:36.020232Z] Finished run-tests step (success) 12:29:36 INFO - Running post-run listener: _resource_record_post_run 12:29:36 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 38033920; Write bytes: 518903808; Read time: 250; Write time: 1669 12:29:36 INFO - TinderboxPrint: CPU usage
54.5% 12:29:36 INFO - TinderboxPrint: I/O read bytes / time
38,033,920 / 250 12:29:36 INFO - TinderboxPrint: I/O write bytes / time
518,903,808 / 1,669 12:29:36 INFO - TinderboxPrint: CPU idle
2,182.5 (45.5%) 12:29:36 INFO - TinderboxPrint: CPU system
966.5 (20.1%) 12:29:36 INFO - TinderboxPrint: CPU user
1,652.5 (34.4%) 12:29:36 INFO - TinderboxPrint: Swap in / out
248,258,560 / 0 12:29:36 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 206270976; Write bytes: 204920832; Read time: 15703; Write time: 452 12:29:36 INFO - run-tests - Wall time: 1181s; CPU: 55.0%; Read bytes: 36055552; Write bytes: 303353856; Read time: 231; Write time: 1183 12:29:36 INFO - Running post-run listener: _upload_blobber_files 12:29:36 INFO - Blob upload gear active. 12:29:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:29:36 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 12:29:36 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'] 12:29:36 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 12:29:36 INFO - (blobuploader) - INFO - Open directory for files ... 12:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:37 INFO - (blobuploader) - INFO - Done attempting. 12:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:38 INFO - (blobuploader) - INFO - Done attempting. 12:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:39 INFO - (blobuploader) - INFO - Done attempting. 12:29:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:29:42 INFO - (blobuploader) - INFO - Done attempting. 12:29:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:29:42 INFO - Return code: 0 12:29:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:29:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:29:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2941b4a399affbd938f29734634f0340264aa17051566d12b0366c9311f207a66ccd828d5090e00cc3bc2d81f1ddf773cc573c8f64fd2e7899aed8da0d80d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c010b7857b3d434078fad5f9beade4451cb7c4380fccbc501efbef5fffbca0182c753f09c7b74b0d533dc470c8ea9e3f7276d288515f4ca04e8c486bc14ba0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2744ed7caa9b84d1adbcd51972c1b6e1f54f2b0b8fa237f88859df88e5c8bc10bbf628d21960de8c7feb992c8bca5dd80e04631f720950b497ebbd6956bd9b37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21378302cc1825da1f36976cb1b66117ab710c493c6a6ca150e6c78264ac39c66d510f95188947aadb5a3f6e6d7dfc278f1fab37723d15b00b1388b32a85d500"} 12:29:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:29:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:29:42 INFO - Contents: 12:29:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2941b4a399affbd938f29734634f0340264aa17051566d12b0366c9311f207a66ccd828d5090e00cc3bc2d81f1ddf773cc573c8f64fd2e7899aed8da0d80d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c010b7857b3d434078fad5f9beade4451cb7c4380fccbc501efbef5fffbca0182c753f09c7b74b0d533dc470c8ea9e3f7276d288515f4ca04e8c486bc14ba0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2744ed7caa9b84d1adbcd51972c1b6e1f54f2b0b8fa237f88859df88e5c8bc10bbf628d21960de8c7feb992c8bca5dd80e04631f720950b497ebbd6956bd9b37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21378302cc1825da1f36976cb1b66117ab710c493c6a6ca150e6c78264ac39c66d510f95188947aadb5a3f6e6d7dfc278f1fab37723d15b00b1388b32a85d500"} 12:29:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:29:42 INFO - Copying logs to upload dir... 12:29:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:29:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.528229 ========= master_lag: 2.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-23 12:29:44.518305) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 12:29:44.521792) ========= 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.IWELZGA29F/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.r4cIwZNgw5/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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/e2941b4a399affbd938f29734634f0340264aa17051566d12b0366c9311f207a66ccd828d5090e00cc3bc2d81f1ddf773cc573c8f64fd2e7899aed8da0d80d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c010b7857b3d434078fad5f9beade4451cb7c4380fccbc501efbef5fffbca0182c753f09c7b74b0d533dc470c8ea9e3f7276d288515f4ca04e8c486bc14ba0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2744ed7caa9b84d1adbcd51972c1b6e1f54f2b0b8fa237f88859df88e5c8bc10bbf628d21960de8c7feb992c8bca5dd80e04631f720950b497ebbd6956bd9b37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21378302cc1825da1f36976cb1b66117ab710c493c6a6ca150e6c78264ac39c66d510f95188947aadb5a3f6e6d7dfc278f1fab37723d15b00b1388b32a85d500"} build_url:https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011255 build_url: 'https://queue.taskcluster.net/v1/task/Nv66kwh3RCSSFpP3d3NMsw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e2941b4a399affbd938f29734634f0340264aa17051566d12b0366c9311f207a66ccd828d5090e00cc3bc2d81f1ddf773cc573c8f64fd2e7899aed8da0d80d68", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7c010b7857b3d434078fad5f9beade4451cb7c4380fccbc501efbef5fffbca0182c753f09c7b74b0d533dc470c8ea9e3f7276d288515f4ca04e8c486bc14ba0b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2744ed7caa9b84d1adbcd51972c1b6e1f54f2b0b8fa237f88859df88e5c8bc10bbf628d21960de8c7feb992c8bca5dd80e04631f720950b497ebbd6956bd9b37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21378302cc1825da1f36976cb1b66117ab710c493c6a6ca150e6c78264ac39c66d510f95188947aadb5a3f6e6d7dfc278f1fab37723d15b00b1388b32a85d500"}' ========= master_lag: 0.59 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 12:29:45.121143) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:29:45.121494) ========= 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.IWELZGA29F/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.r4cIwZNgw5/Listeners TMPDIR=/var/folders/tn/81tmcd2n6_38yjsnzhmnyzmm00000w/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.005372 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 12:29:45.150528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 12:29:45.150837) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 12:29:45.151210) ========= ========= Total master_lag: 2.74 =========