builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0282 starttime: 1492369311.14 results: success (0) buildid: 20170416110106 builduid: 3e5c7d46a6144eb38fa34dbfbbc58e6d revision: c697e756f738ce37abc56f31bfbc48f55625d617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.140693) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.141153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.141436) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.166356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.166651) ========= 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.DOOvRHNTk7/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.P6fWHkPM00/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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-04-16 12:01:51-- 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% 69.5M=0s 2017-04-16 12:01:51 (69.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.518693 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.741993) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.742310) ========= 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.DOOvRHNTk7/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.P6fWHkPM00/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.022390 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:51.792097) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-16 12:01:51.792542) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c697e756f738ce37abc56f31bfbc48f55625d617 --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 c697e756f738ce37abc56f31bfbc48f55625d617 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DOOvRHNTk7/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.P6fWHkPM00/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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-04-16 12:01:51,880 truncating revision to first 12 chars 2017-04-16 12:01:51,880 Setting DEBUG logging. 2017-04-16 12:01:51,880 attempt 1/10 2017-04-16 12:01:51,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c697e756f738?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-16 12:01:52,922 unpacking tar archive at: mozilla-central-c697e756f738/testing/mozharness/ program finished with exit code 0 elapsedTime=1.319007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-16 12:01:53.136087) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:53.136406) ========= script_repo_revision: c697e756f738ce37abc56f31bfbc48f55625d617 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:53.136810) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:53.137117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-16 12:01:53.157291) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-16 12:01:53.157715) ========= /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.DOOvRHNTk7/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.P6fWHkPM00/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:01:53 INFO - MultiFileLogger online at 20170416 12:01:53 in /builds/slave/test 12:01:53 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:01:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:01:53 INFO - {'append_to_log': False, 12:01:53 INFO - 'base_work_dir': '/builds/slave/test', 12:01:53 INFO - 'blob_upload_branch': 'Firefox', 12:01:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:01:53 INFO - 'branch': 'Firefox', 12:01:53 INFO - 'buildbot_json_path': 'buildprops.json', 12:01:53 INFO - 'config_files': ('talos/mac_config.py',), 12:01:53 INFO - 'default_actions': ('clobber', 12:01:53 INFO - 'read-buildbot-config', 12:01:53 INFO - 'download-and-extract', 12:01:53 INFO - 'populate-webroot', 12:01:53 INFO - 'create-virtualenv', 12:01:53 INFO - 'install', 12:01:53 INFO - 'run-tests'), 12:01:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:01:53 INFO - 'download_minidump_stackwalk': True, 12:01:53 INFO - 'download_symbols': 'ondemand', 12:01:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:01:53 INFO - 'tooltool.py': '/tools/tooltool.py', 12:01:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:01:53 INFO - '/tools/misc-python/virtualenv.py')}, 12:01:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:01:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:01:53 INFO - 'gecko_profile': False, 12:01:53 INFO - 'gecko_profile_interval': 0, 12:01:53 INFO - 'installer_path': 'installer.exe', 12:01:53 INFO - 'log_level': 'info', 12:01:53 INFO - 'log_name': 'talos', 12:01:53 INFO - 'log_to_console': True, 12:01:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:01:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:01:53 INFO - 'opt_config_files': (), 12:01:53 INFO - 'pip_index': False, 12:01:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:01:53 INFO - 'cmd': ('bash', 12:01:53 INFO - '-c', 12:01:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:01:53 INFO - 'enabled': True, 12:01:53 INFO - 'halt_on_failure': False, 12:01:53 INFO - 'name': 'check_screen_resolution'},), 12:01:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:01:53 INFO - 'cmd': ('bash', 12:01:53 INFO - '-c', 12:01:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:01:53 INFO - 'enabled': True, 12:01:53 INFO - 'halt_on_failure': False, 12:01:53 INFO - 'name': 'check_screen_resolution'},), 12:01:53 INFO - 'run_cmd_checks_enabled': True, 12:01:53 INFO - 'suite': 'dromaeojs-e10s', 12:01:53 INFO - 'system_bits': '32', 12:01:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:01:53 INFO - 'title': 't-yosemite-r7-0282', 12:01:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:01:53 INFO - 'use_talos_json': True, 12:01:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:01:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:01:53 INFO - 'work_dir': 'build'} 12:01:53 INFO - [mozharness: 2017-04-16 19:01:53.366652Z] Running clobber step. 12:01:53 INFO - Running pre-action listener: _resource_record_pre_action 12:01:53 INFO - Running main action method: clobber 12:01:53 INFO - rmtree: /builds/slave/test/build 12:01:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:01:55 INFO - Running post-action listener: _resource_record_post_action 12:01:55 INFO - [mozharness: 2017-04-16 19:01:55.303107Z] Finished clobber step (success) 12:01:55 INFO - [mozharness: 2017-04-16 19:01:55.303352Z] Running read-buildbot-config step. 12:01:55 INFO - Running pre-action listener: _resource_record_pre_action 12:01:55 INFO - Running main action method: read_buildbot_config 12:01:55 INFO - Using buildbot properties: 12:01:55 INFO - { 12:01:55 INFO - "project": "", 12:01:55 INFO - "product": "firefox", 12:01:55 INFO - "script_repo_revision": "production", 12:01:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:01:55 INFO - "repository": "", 12:01:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:01:55 INFO - "buildid": "20170416110106", 12:01:55 INFO - "pgo_build": "False", 12:01:55 INFO - "basedir": "/builds/slave/test", 12:01:55 INFO - "buildnumber": 38, 12:01:55 INFO - "slavename": "t-yosemite-r7-0282", 12:01:55 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:01:55 INFO - "platform": "yosemite_r7", 12:01:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:01:55 INFO - "branch": "mozilla-central", 12:01:55 INFO - "repo_path": "mozilla-central", 12:01:55 INFO - "revision": "c697e756f738ce37abc56f31bfbc48f55625d617", 12:01:55 INFO - "stage_platform": "macosx64", 12:01:55 INFO - "builduid": "3e5c7d46a6144eb38fa34dbfbbc58e6d", 12:01:55 INFO - "slavebuilddir": "test" 12:01:55 INFO - } 12:01:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:01:55 INFO - Running post-action listener: _resource_record_post_action 12:01:55 INFO - [mozharness: 2017-04-16 19:01:55.307474Z] Finished read-buildbot-config step (success) 12:01:55 INFO - [mozharness: 2017-04-16 19:01:55.307605Z] Running download-and-extract step. 12:01:55 INFO - Running pre-action listener: _resource_record_pre_action 12:01:55 INFO - Running main action method: download_and_extract 12:01:55 INFO - mkdir: /builds/slave/test/build/tests 12:01: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:01:55 INFO - trying https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:01:55 INFO - Downloading https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:01:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 12:01:56 INFO - Downloaded 1325 bytes. 12:01:56 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:01:56 INFO - Using the following test package requirements: 12:01:56 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:01:56 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:01:56 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:01:56 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:01:56 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'jsshell-mac.zip'], 12:01:56 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:01:56 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:01:56 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:01:56 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:01:56 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:01:56 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:01:56 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:01:56 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:01:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:01:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:01:56 INFO - Fetch https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:01:58 INFO - Expected file size: 52664064 12:01:58 INFO - Obtained file size: 52664064 12:02:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:02:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:02:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:02:15 INFO - Fetch https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:02:16 INFO - Expected file size: 52664064 12:02:16 INFO - Obtained file size: 52664064 12:02:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:02:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:02:32 INFO - Fetch https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:02:33 INFO - Expected file size: 14408802 12:02:33 INFO - Obtained file size: 14408802 12:02:33 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:02:33 INFO - trying https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:02:33 INFO - Downloading https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 12:02:35 INFO - Downloaded 71444644 bytes. 12:02:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:02:35 INFO - mkdir: /builds/slave/test/properties 12:02:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:02:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:02:35 INFO - Contents: 12:02:35 INFO - build_url:https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:02:36 INFO - Running post-action listener: _resource_record_post_action 12:02:36 INFO - Running post-action listener: set_extra_try_arguments 12:02:36 INFO - [mozharness: 2017-04-16 19:02:36.333546Z] Finished download-and-extract step (success) 12:02:36 INFO - [mozharness: 2017-04-16 19:02:36.333666Z] Running populate-webroot step. 12:02:36 INFO - Running pre-action listener: _resource_record_pre_action 12:02:36 INFO - Running main action method: populate_webroot 12:02:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:02:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:02:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:02:36 INFO - '--tppagecycles', 12:02:36 INFO - '7'], 12:02:36 INFO - 'tests': ['tsvgm']}}, 12:02:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:02:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:02:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:02:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:02:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:02:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:02:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['damp', 'tps']}, 12:02:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'tests': ['damp', 'tps']}, 12:02:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['dromaeo_dom']}, 12:02:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:02:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 12:02:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 12:02:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['a11yr', 12:02:36 INFO - 'ts_paint', 12:02:36 INFO - 'tpaint', 12:02:36 INFO - 'sessionrestore', 12:02:36 INFO - 'sessionrestore_no_auto_restore', 12:02:36 INFO - 'tabpaint']}, 12:02:36 INFO - 'other-e10s': {'tests': ['a11yr', 12:02:36 INFO - 'ts_paint', 12:02:36 INFO - 'tpaint', 12:02:36 INFO - 'sessionrestore', 12:02:36 INFO - 'sessionrestore_no_auto_restore', 12:02:36 INFO - 'tabpaint']}, 12:02:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:02:36 INFO - 'ts_paint', 12:02:36 INFO - 'tpaint', 12:02:36 INFO - 'sessionrestore', 12:02:36 INFO - 'sessionrestore_no_auto_restore', 12:02:36 INFO - 'tabpaint']}, 12:02:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:02:36 INFO - 'ts_paint', 12:02:36 INFO - 'tpaint', 12:02:36 INFO - 'sessionrestore', 12:02:36 INFO - 'sessionrestore_no_auto_restore', 12:02:36 INFO - 'tabpaint']}, 12:02:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['a11yr', 12:02:36 INFO - 'ts_paint', 12:02:36 INFO - 'tpaint', 12:02:36 INFO - 'sessionrestore', 12:02:36 INFO - 'sessionrestore_no_auto_restore', 12:02:36 INFO - 'tabpaint']}, 12:02:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['a11yr', 12:02:36 INFO - 'ts_paint', 12:02:36 INFO - 'tpaint', 12:02:36 INFO - 'sessionrestore', 12:02:36 INFO - 'sessionrestore_no_auto_restore', 12:02:36 INFO - 'tabpaint']}, 12:02:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 12:02:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 12:02:36 INFO - 'bloom_basic_ref']}, 12:02:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['tsvgx', 12:02:36 INFO - 'tsvgr_opacity', 12:02:36 INFO - 'tart', 12:02:36 INFO - 'tscrollx', 12:02:36 INFO - 'cart', 12:02:36 INFO - 'tsvg_static']}, 12:02:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:02:36 INFO - 'tsvgr_opacity', 12:02:36 INFO - 'tart', 12:02:36 INFO - 'tscrollx', 12:02:36 INFO - 'cart', 12:02:36 INFO - 'tsvg_static']}, 12:02:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'talos_options': ['--disable-e10s'], 12:02:36 INFO - 'tests': ['tp5o']}, 12:02:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:02:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'talos_options': ['--disable-e10s', 12:02:36 INFO - '--xperf_path', 12:02:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:02:36 INFO - 'tests': ['tp5n']}, 12:02:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:02:36 INFO - 'talos_options': ['--xperf_path', 12:02:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:02:36 INFO - 'tests': ['tp5n']}}, 12:02:36 INFO - 'talos.zip': {'path': '', 12:02:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:02:36 INFO - Running post-action listener: _resource_record_post_action 12:02:36 INFO - [mozharness: 2017-04-16 19:02:36.352812Z] Finished populate-webroot step (success) 12:02:36 INFO - [mozharness: 2017-04-16 19:02:36.352943Z] Running create-virtualenv step. 12:02:36 INFO - Running pre-action listener: _resource_record_pre_action 12:02:36 INFO - Running main action method: create_virtualenv 12:02:36 INFO - Creating virtualenv /builds/slave/test/build/venv 12:02:36 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:02:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:02:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:02:36 INFO - Using real prefix '/tools/python27' 12:02:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:02:37 INFO - Installing distribute.............................................................................................................................................................................................done. 12:02:40 INFO - Installing pip.................done. 12:02:40 INFO - Return code: 0 12:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:02:40 INFO - Reading from file tmpfile_stdout 12:02:40 INFO - Output received: 12:02:40 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:02:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:40 INFO - 'HOME': '/Users/cltbld', 12:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:40 INFO - 'LOGNAME': 'cltbld', 12:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:40 INFO - 'MOZ_NO_REMOTE': '1', 12:02:40 INFO - 'NO_EM_RESTART': '1', 12:02:40 INFO - 'PAGER': '/bin/cat', 12:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:40 INFO - 'PWD': '/builds/slave/test', 12:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:40 INFO - 'SHELL': '/bin/bash', 12:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:40 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:40 INFO - 'USER': 'cltbld', 12:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:40 INFO - 'XPC_FLAGS': '0x0', 12:02:40 INFO - 'XPC_SERVICE_NAME': '0', 12:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:40 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:02:40 INFO - Cleaning up... 12:02:40 INFO - Return code: 0 12:02:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:02:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:40 INFO - 'HOME': '/Users/cltbld', 12:02:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:40 INFO - 'LOGNAME': 'cltbld', 12:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:40 INFO - 'MOZ_NO_REMOTE': '1', 12:02:40 INFO - 'NO_EM_RESTART': '1', 12:02:40 INFO - 'PAGER': '/bin/cat', 12:02:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:40 INFO - 'PWD': '/builds/slave/test', 12:02:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:40 INFO - 'SHELL': '/bin/bash', 12:02:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:40 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:40 INFO - 'USER': 'cltbld', 12:02:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:40 INFO - 'XPC_FLAGS': '0x0', 12:02:40 INFO - 'XPC_SERVICE_NAME': '0', 12:02:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:40 INFO - Downloading/unpacking psutil>=3.1.1 12:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:02:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:02:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:02:44 INFO - Installing collected packages: psutil 12:02:44 INFO - Running setup.py install for psutil 12:02:44 INFO - building 'psutil._psutil_osx' extension 12:02:44 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:02:45 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:02:45 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:02:45 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:02:45 INFO - building 'psutil._psutil_posix' extension 12:02:45 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:02:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:02:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:02:45 INFO - ^ 12:02:45 INFO - 1 warning generated. 12:02:45 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:02:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:02:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:02:45 INFO - Successfully installed psutil 12:02:45 INFO - Cleaning up... 12:02:45 INFO - Return code: 0 12:02:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:02:45 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:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:45 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:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:45 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:45 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:02:45 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:02:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:45 INFO - 'HOME': '/Users/cltbld', 12:02:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:45 INFO - 'LOGNAME': 'cltbld', 12:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:45 INFO - 'MOZ_NO_REMOTE': '1', 12:02:45 INFO - 'NO_EM_RESTART': '1', 12:02:45 INFO - 'PAGER': '/bin/cat', 12:02:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:45 INFO - 'PWD': '/builds/slave/test', 12:02:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:45 INFO - 'SHELL': '/bin/bash', 12:02:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:45 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:45 INFO - 'USER': 'cltbld', 12:02:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:45 INFO - 'XPC_FLAGS': '0x0', 12:02:45 INFO - 'XPC_SERVICE_NAME': '0', 12:02:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:02:45 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:02:45 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:02:45 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:02:45 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:02:45 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:02:45 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:02:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:02:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:02:48 INFO - Installing collected packages: mozsystemmonitor 12:02:48 INFO - Running setup.py install for mozsystemmonitor 12:02:48 INFO - Successfully installed mozsystemmonitor 12:02:48 INFO - Cleaning up... 12:02:48 INFO - Return code: 0 12:02:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:48 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:48 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:02:48 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:02:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:48 INFO - 'HOME': '/Users/cltbld', 12:02:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:48 INFO - 'LOGNAME': 'cltbld', 12:02:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:48 INFO - 'MOZ_NO_REMOTE': '1', 12:02:48 INFO - 'NO_EM_RESTART': '1', 12:02:48 INFO - 'PAGER': '/bin/cat', 12:02:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:48 INFO - 'PWD': '/builds/slave/test', 12:02:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:48 INFO - 'SHELL': '/bin/bash', 12:02:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:48 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:48 INFO - 'USER': 'cltbld', 12:02:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:48 INFO - 'XPC_FLAGS': '0x0', 12:02:48 INFO - 'XPC_SERVICE_NAME': '0', 12:02:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:49 INFO - Downloading/unpacking jsonschema==2.5.1 12:02:49 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:02:49 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:02:49 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:02:49 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:02:49 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:02:49 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:02:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:02:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:51 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:02:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:02:52 INFO - warning: no files found matching '*.txt' 12:02:52 INFO - no previously-included directories found matching 'build' 12:02:52 INFO - no previously-included directories found matching 'dist' 12:02:52 INFO - no previously-included directories found matching '.git*' 12:02:52 INFO - Installing collected packages: jsonschema, functools32 12:02:52 INFO - Running setup.py install for functools32 12:02:52 INFO - warning: no files found matching '*.txt' 12:02:52 INFO - no previously-included directories found matching 'build' 12:02:52 INFO - no previously-included directories found matching 'dist' 12:02:52 INFO - no previously-included directories found matching '.git*' 12:02:52 INFO - Successfully installed jsonschema functools32 12:02:52 INFO - Cleaning up... 12:02:52 INFO - Return code: 0 12:02:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:52 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:52 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:02:52 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:02:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:52 INFO - 'HOME': '/Users/cltbld', 12:02:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:52 INFO - 'LOGNAME': 'cltbld', 12:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:52 INFO - 'MOZ_NO_REMOTE': '1', 12:02:52 INFO - 'NO_EM_RESTART': '1', 12:02:52 INFO - 'PAGER': '/bin/cat', 12:02:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:52 INFO - 'PWD': '/builds/slave/test', 12:02:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:52 INFO - 'SHELL': '/bin/bash', 12:02:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:52 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:52 INFO - 'USER': 'cltbld', 12:02:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:52 INFO - 'XPC_FLAGS': '0x0', 12:02:52 INFO - 'XPC_SERVICE_NAME': '0', 12:02:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:02:52 INFO - Cleaning up... 12:02:52 INFO - Return code: 0 12:02:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:52 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:52 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:02:52 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:02:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:52 INFO - 'HOME': '/Users/cltbld', 12:02:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:52 INFO - 'LOGNAME': 'cltbld', 12:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:52 INFO - 'MOZ_NO_REMOTE': '1', 12:02:52 INFO - 'NO_EM_RESTART': '1', 12:02:52 INFO - 'PAGER': '/bin/cat', 12:02:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:52 INFO - 'PWD': '/builds/slave/test', 12:02:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:52 INFO - 'SHELL': '/bin/bash', 12:02:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:52 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:52 INFO - 'USER': 'cltbld', 12:02:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:52 INFO - 'XPC_FLAGS': '0x0', 12:02:52 INFO - 'XPC_SERVICE_NAME': '0', 12:02:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:02:53 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:02:53 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:02:53 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:02:53 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:02:53 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:02:53 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:02:55 INFO - Downloading blobuploader-1.2.4.tar.gz 12:02:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:02:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:02:55 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:02:55 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:02:55 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:02:55 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:02:55 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:02:55 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:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:02:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:02:56 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:02:56 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:02:56 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:02:56 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:02:56 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:02:56 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:02:56 INFO - Downloading docopt-0.6.1.tar.gz 12:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:02:56 INFO - Installing collected packages: blobuploader, requests, docopt 12:02:56 INFO - Running setup.py install for blobuploader 12:02:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:02:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:02:57 INFO - Running setup.py install for requests 12:02:57 INFO - Running setup.py install for docopt 12:02:57 INFO - Successfully installed blobuploader requests docopt 12:02:57 INFO - Cleaning up... 12:02:57 INFO - Return code: 0 12:02:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:02:57 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:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:57 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:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:02:57 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:02:57 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:02:57 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:02:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:02:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:02:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:02:57 INFO - 'HOME': '/Users/cltbld', 12:02:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:02:57 INFO - 'LOGNAME': 'cltbld', 12:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:02:57 INFO - 'MOZ_NO_REMOTE': '1', 12:02:57 INFO - 'NO_EM_RESTART': '1', 12:02:57 INFO - 'PAGER': '/bin/cat', 12:02:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:02:57 INFO - 'PWD': '/builds/slave/test', 12:02:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:02:57 INFO - 'SHELL': '/bin/bash', 12:02:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:02:57 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:02:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:02:57 INFO - 'USER': 'cltbld', 12:02:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:02:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:02:57 INFO - 'XPC_FLAGS': '0x0', 12:02:57 INFO - 'XPC_SERVICE_NAME': '0', 12:02:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:02:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-cMrAq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-v4ExHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-RjdZ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-fCIID8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-1Hco5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-zL4FoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-exh8xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-mLGBIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:02:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:02:58 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-9ec7Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-TBnqc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-fTdcxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-epX0dX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-88jaWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-dSbmaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-_9etUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-Cj6gyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:02:59 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-mmuJlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:02:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:02:59 INFO - Running setup.py install for manifestparser 12:03:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:03:00 INFO - Running setup.py install for mozcrash 12:03:00 INFO - Running setup.py install for mozdebug 12:03:00 INFO - Running setup.py install for mozdevice 12:03:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:03:00 INFO - Running setup.py install for mozfile 12:03:00 INFO - Running setup.py install for mozhttpd 12:03:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:03:00 INFO - Running setup.py install for mozinfo 12:03:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:03:00 INFO - Running setup.py install for mozInstall 12:03:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Running setup.py install for mozleak 12:03:01 INFO - Running setup.py install for mozlog 12:03:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Running setup.py install for moznetwork 12:03:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Running setup.py install for mozprocess 12:03:01 INFO - Running setup.py install for mozprofile 12:03:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:03:01 INFO - Running setup.py install for mozrunner 12:03:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:03:02 INFO - Running setup.py install for mozscreenshot 12:03:02 INFO - Running setup.py install for moztest 12:03:02 INFO - Running setup.py install for mozversion 12:03:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:03:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:03:02 INFO - Cleaning up... 12:03:02 INFO - Return code: 0 12:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:02 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:03:02 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:03:02 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:03:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:03:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:02 INFO - 'HOME': '/Users/cltbld', 12:03:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:02 INFO - 'LOGNAME': 'cltbld', 12:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:02 INFO - 'MOZ_NO_REMOTE': '1', 12:03:02 INFO - 'NO_EM_RESTART': '1', 12:03:02 INFO - 'PAGER': '/bin/cat', 12:03:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:02 INFO - 'PWD': '/builds/slave/test', 12:03:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:02 INFO - 'SHELL': '/bin/bash', 12:03:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:03:02 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:03:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:02 INFO - 'USER': 'cltbld', 12:03:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:02 INFO - 'XPC_FLAGS': '0x0', 12:03:02 INFO - 'XPC_SERVICE_NAME': '0', 12:03:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:03:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-eCb5mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:03:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-vT3cwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:03:02 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:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:03:02 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-WHoBmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-IrdcMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:03:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-mdUbmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-0_Owyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-CrhxX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-wiCnyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-WVIO0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-glosbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-lAXd4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:03:03 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:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:03:03 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-FCGJz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:03:04 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:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:03:04 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-tvauVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:03:04 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:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:03:04 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-0bhy0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:03:04 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:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:04 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-AYKt6i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:03:04 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:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:03:04 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-f_7o3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:03:04 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:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:03:04 INFO - Running setup.py (path:/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/pip-KmwknK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:04 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:03:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:04 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:03:07 INFO - Downloading blessings-1.6.tar.gz 12:03:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:03:07 INFO - Installing collected packages: blessings 12:03:07 INFO - Running setup.py install for blessings 12:03:07 INFO - Successfully installed blessings 12:03:07 INFO - Cleaning up... 12:03:07 INFO - Return code: 0 12:03:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:03:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:07 INFO - Reading from file tmpfile_stdout 12:03:07 INFO - Current package versions: 12:03:07 INFO - blessings == 1.6 12:03:07 INFO - blobuploader == 1.2.4 12:03:07 INFO - docopt == 0.6.1 12:03:07 INFO - functools32 == 3.2.3-2 12:03:07 INFO - jsonschema == 2.5.1 12:03:07 INFO - manifestparser == 1.1 12:03:07 INFO - mozInstall == 1.12 12:03:07 INFO - mozcrash == 1.0 12:03:07 INFO - mozdebug == 0.1 12:03:07 INFO - mozdevice == 0.50 12:03:07 INFO - mozfile == 1.2 12:03:07 INFO - mozhttpd == 0.7 12:03:07 INFO - mozinfo == 0.9 12:03:07 INFO - mozleak == 0.1 12:03:07 INFO - mozlog == 3.4 12:03:07 INFO - moznetwork == 0.27 12:03:07 INFO - mozprocess == 0.25 12:03:07 INFO - mozprofile == 0.28 12:03:07 INFO - mozrunner == 6.13 12:03:07 INFO - mozscreenshot == 0.1 12:03:07 INFO - mozsystemmonitor == 0.3 12:03:07 INFO - moztest == 0.8 12:03:07 INFO - mozversion == 1.4 12:03:07 INFO - psutil == 3.1.1 12:03:07 INFO - requests == 1.2.3 12:03:07 INFO - wsgiref == 0.1.2 12:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:07 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:03:07 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:03:07 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:03:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:03:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:07 INFO - 'HOME': '/Users/cltbld', 12:03:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:07 INFO - 'LOGNAME': 'cltbld', 12:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:07 INFO - 'MOZ_NO_REMOTE': '1', 12:03:07 INFO - 'NO_EM_RESTART': '1', 12:03:07 INFO - 'PAGER': '/bin/cat', 12:03:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:07 INFO - 'PWD': '/builds/slave/test', 12:03:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:07 INFO - 'SHELL': '/bin/bash', 12:03:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:03:07 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:03:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:07 INFO - 'USER': 'cltbld', 12:03:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:07 INFO - 'XPC_FLAGS': '0x0', 12:03:07 INFO - 'XPC_SERVICE_NAME': '0', 12:03:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 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:03:08 INFO - Cleaning up... 12:03:08 INFO - Return code: 0 12:03:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:03:08 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:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:03:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:08 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:03:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:03:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:03:08 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 0x108ee4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ee7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5ebc5eb10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, '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.DOOvRHNTk7/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.P6fWHkPM00/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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:03:08 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:03:08 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:03:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:03:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:08 INFO - 'HOME': '/Users/cltbld', 12:03:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:08 INFO - 'LOGNAME': 'cltbld', 12:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:08 INFO - 'MOZ_NO_REMOTE': '1', 12:03:08 INFO - 'NO_EM_RESTART': '1', 12:03:08 INFO - 'PAGER': '/bin/cat', 12:03:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:08 INFO - 'PWD': '/builds/slave/test', 12:03:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:08 INFO - 'SHELL': '/bin/bash', 12:03:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:03:08 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:03:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:08 INFO - 'USER': 'cltbld', 12:03:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:08 INFO - 'XPC_FLAGS': '0x0', 12:03:08 INFO - 'XPC_SERVICE_NAME': '0', 12:03:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:03:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:03:08 INFO - Cleaning up... 12:03:08 INFO - Return code: 0 12:03:08 INFO - Running post-action listener: _resource_record_post_action 12:03:08 INFO - Running post-action listener: _start_resource_monitoring 12:03:08 INFO - Starting resource monitoring. 12:03:08 INFO - [mozharness: 2017-04-16 19:03:08.406907Z] Finished create-virtualenv step (success) 12:03:08 INFO - [mozharness: 2017-04-16 19:03:08.407924Z] Running install step. 12:03:08 INFO - Running pre-action listener: _resource_record_pre_action 12:03:08 INFO - Running main action method: install 12:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:03:08 INFO - Reading from file tmpfile_stdout 12:03:08 INFO - Detecting whether we're running mozinstall >=1.0... 12:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:03:08 INFO - Reading from file tmpfile_stdout 12:03:08 INFO - Output received: 12:03:08 INFO - Usage: mozinstall [options] installer 12:03:08 INFO - Options: 12:03:08 INFO - -h, --help show this help message and exit 12:03:08 INFO - -d DEST, --destination=DEST 12:03:08 INFO - Directory to install application into. [default: 12:03:08 INFO - "/builds/slave/test"] 12:03:08 INFO - --app=APP Application being installed. [default: firefox] 12:03:08 INFO - mkdir: /builds/slave/test/build/application 12:03:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:03:28 INFO - Reading from file tmpfile_stdout 12:03:28 INFO - Output received: 12:03:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:03:28 INFO - Running post-action listener: _resource_record_post_action 12:03:28 INFO - [mozharness: 2017-04-16 19:03:28.461842Z] Finished install step (success) 12:03:28 INFO - [mozharness: 2017-04-16 19:03:28.461979Z] Running run-tests step. 12:03:28 INFO - Running pre-action listener: _resource_record_pre_action 12:03:28 INFO - Running main action method: run_tests 12:03:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:03:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:03:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:03:28 INFO - 2017-04-16 12:03:28.477 screenresolution[3149:60334] starting screenresolution argv=screenresolution get 12:03:28 INFO - 2017-04-16 12:03:28.479 screenresolution[3149:60334] Display 0: 1600x1200x32@60 12:03:28 INFO - 2017-04-16 12:03:28.485 screenresolution[3150:60337] starting screenresolution argv=screenresolution list 12:03:28 INFO - Available Modes on Display 0 12:03:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:03:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:03:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:03:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:03:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:03:28 INFO - Intel Iris: 12:03:28 INFO - Chipset Model: Intel Iris 12:03:28 INFO - Type: GPU 12:03:28 INFO - Bus: Built-In 12:03:28 INFO - VRAM (Dynamic, Max): 1536 MB 12:03:28 INFO - Vendor: Intel (0x8086) 12:03:28 INFO - Device ID: 0x0a2e 12:03:28 INFO - Revision ID: 0x0009 12:03:28 INFO - Displays: 12:03:28 INFO - Display: 12:03:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:03:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:03:28 INFO - Display Serial Number: 1600x1200 60 12:03:28 INFO - Main Display: Yes 12:03:28 INFO - Mirror: Off 12:03:28 INFO - Online: Yes 12:03:28 INFO - Rotation: Supported 12:03:28 INFO - Return code: 0 12:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:03:28 INFO - Python 2.7.3 12:03:28 INFO - Return code: 0 12:03:28 INFO - grabbing minidump binary from tooltool 12:03: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:03:28 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 0x108cc2d30>, '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 0x108be8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108cb7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:03:28 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:03:28 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:03:28 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:03:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:03:28 INFO - Return code: 0 12:03:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:03:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:03:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:03:28 INFO - ENV: RUST_BACKTRACE is now 1 12:03:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:03:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:03:28 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/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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:03:28 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/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0282 --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:03:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DOOvRHNTk7/Render', 12:03:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:03:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:03:28 INFO - 'HOME': '/Users/cltbld', 12:03:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:03:28 INFO - 'LOGNAME': 'cltbld', 12:03:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:03:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:03:28 INFO - 'MOZ_NO_REMOTE': '1', 12:03:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:03:28 INFO - 'NO_EM_RESTART': '1', 12:03:28 INFO - 'PAGER': '/bin/cat', 12:03:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:03:28 INFO - 'PWD': '/builds/slave/test', 12:03:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:03:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:03:28 INFO - 'RUST_BACKTRACE': '1', 12:03:28 INFO - 'SHELL': '/bin/bash', 12:03:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.P6fWHkPM00/Listeners', 12:03:28 INFO - 'TMPDIR': '/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/', 12:03:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:03:28 INFO - 'USER': 'cltbld', 12:03:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:03:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:03:28 INFO - 'XPC_FLAGS': '0x0', 12:03:28 INFO - 'XPC_SERVICE_NAME': '0', 12:03:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:03:28 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/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0282', '--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:03:29 INFO - mozversion application_buildid: 20170416110106 12:03:29 INFO - mozversion application_changeset: c697e756f738ce37abc56f31bfbc48f55625d617 12:03:29 INFO - mozversion application_display_name: Nightly 12:03:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:03:29 INFO - mozversion application_name: Firefox 12:03:29 INFO - mozversion application_remotingname: firefox 12:03:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:03:29 INFO - mozversion application_vendor: Mozilla 12:03:29 INFO - mozversion application_version: 55.0a1 12:03:29 INFO - mozversion platform_buildid: 20170416110106 12:03:29 INFO - mozversion platform_changeset: c697e756f738ce37abc56f31bfbc48f55625d617 12:03:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:03:29 INFO - mozversion platform_version: 55.0a1 12:03:29 INFO - using testdate: 1492369409 12:03:29 INFO - actual date: 1492369409 12:03:29 INFO - starting webserver on 'localhost:64556' 12:03:29 INFO - SUITE-START | Running 2 tests 12:03:29 INFO - TEST-START | dromaeo_css 12:03:29 INFO - operating with platform_type : mac_ 12:03:29 INFO - Initialising browser for dromaeo_css test... 12:03:29 INFO - TEST-INFO | started process 3160 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpRX3ffN/profile http://localhost:64556/getInfo.html) 12:03:32 INFO - PID 3160 | 2017-04-16 12:03:32.182 plugin-container[3162:60507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3f, name = 'com.apple.tsm.portname' 12:03:32 INFO - PID 3160 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:03:32 INFO - PID 3160 | 2017-04-16 12:03:32.185 plugin-container[3162:60507] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 12:03:32 INFO - PID 3160 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:03:32 INFO - PID 3160 | 2017-04-16 12:03:32.185 plugin-container[3162:60507] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:03:32 INFO - PID 3160 | __metrics Screen width/height:1600/1200 12:03:32 INFO - PID 3160 | colorDepth:24 12:03:32 INFO - PID 3160 | Browser inner width/height: 1024/689 12:03:32 INFO - PID 3160 | __metrics 12:03:32 ERROR - PID 3160 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 12:03:33 INFO - TEST-INFO | 3160: exit 0 12:03:33 INFO - Browser initialized. 12:03:33 INFO - Running cycle 1/1 for dromaeo_css test... 12:03:33 INFO - TEST-INFO | started process 3163 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpRX3ffN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:03:35 INFO - PID 3163 | 2017-04-16 12:03:35.909 plugin-container[3164:60634] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 12:03:35 INFO - PID 3163 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:03:35 INFO - PID 3163 | 2017-04-16 12:03:35.910 plugin-container[3164:60634] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4513, name = 'com.apple.CFPasteboardClient' 12:03:35 INFO - PID 3163 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:03:35 INFO - PID 3163 | 2017-04-16 12:03:35.910 plugin-container[3164:60634] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:03:45 INFO - PID 3163 | RSS: Main: 238059520 12:03:45 INFO - PID 3163 | 12:06:50 INFO - PID 3163 | Cycle 1(1): loaded http://localhost:64556/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64556/tests/dromaeo/cssquery-ext.html) 12:06:51 INFO - PID 3163 | RSS: Main: 255287296 12:06:51 INFO - PID 3163 | 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | A coding exception was thrown and uncaught in a Task. 12:08:33 INFO - PID 3163 | 12:08:33 ERROR - PID 3163 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:33 INFO - PID 3163 | Full stack: 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | A coding exception was thrown and uncaught in a Task. 12:08:33 INFO - PID 3163 | 12:08:33 ERROR - PID 3163 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:33 INFO - PID 3163 | Full stack: 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | A coding exception was thrown and uncaught in a Task. 12:08:33 INFO - PID 3163 | 12:08:33 ERROR - PID 3163 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:33 INFO - PID 3163 | Full stack: 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | ************************* 12:08:33 INFO - PID 3163 | A coding exception was thrown and uncaught in a Task. 12:08:33 INFO - PID 3163 | 12:08:33 ERROR - PID 3163 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:08:33 INFO - PID 3163 | Full stack: 12:08:33 INFO - PID 3163 | ************************* 12:09:53 INFO - PID 3163 | Cycle 1(1): loaded http://localhost:64556/tests/dromaeo/cssquery-ext.html (next: http://localhost:64556/tests/dromaeo/cssquery-jquery.html) 12:09:54 INFO - PID 3163 | RSS: Main: 260345856 12:09:54 INFO - PID 3163 | 12:12:56 INFO - PID 3163 | Cycle 1(1): loaded http://localhost:64556/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64556/tests/dromaeo/cssquery-mootools.html) 12:12:56 INFO - PID 3163 | RSS: Main: 270372864 12:12:56 INFO - PID 3163 | 12:15:58 INFO - PID 3163 | Cycle 1(1): loaded http://localhost:64556/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64556/tests/dromaeo/cssquery-prototype.html) 12:15:59 INFO - PID 3163 | RSS: Main: 264384512 12:15:59 INFO - PID 3163 | 12:19:02 INFO - PID 3163 | Cycle 1(1): loaded http://localhost:64556/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64556/tests/dromaeo/cssquery-yui.html) 12:19:02 INFO - PID 3163 | RSS: Main: 273793024 12:19:02 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | Cycle 1(1): loaded http://localhost:64556/tests/dromaeo/cssquery-yui.html (next: http://localhost:64556/tests/dromaeo/cssquery-dojo.html) 12:22:04 INFO - PID 3163 | RSS: Main: 268660736 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | __start_tp_report 12:22:04 INFO - PID 3163 | _x_x_mozilla_page_load 12:22:04 INFO - PID 3163 | _x_x_mozilla_page_load_details 12:22:04 INFO - PID 3163 | |i|pagename|runs| 12:22:04 INFO - PID 3163 | |0;dojo.html;3516.2967406518687;3533.0813988363025;3539.1152211947015;3565.0017994961404;3574.535310409647;5783.132530120479;6027.638341699501;6143.201383820103;6188.535859810515;6249.625022498653;5369.24830523727;5596.2165296858475;6131.8660487576235;6142.069075791497;6240.344763799803;5394.541463975547;5408.864778380543;5416.1063424534905;5424.864378390552;5515.090010148341;5384.811531596395;5471.671699698011;5521.5306698930635;5532.529734972532;5542.722863856791;4487.977560112211;5375.6774593524515;5379.946200537984;5452.482014208644;5493.285872836525;5379.058664733656;5383.838484845461;5416.160495123262;5430.864228394283;5492.231087647732;4646.651501137429;4776.23580227162;4846.39420072491;5347.572194224453;5373.194020896858;5418;5612.354579223401;5974.581779275452;6077.939220607782;6205.627662340229;5598;6493.93506064938;6507.609543427362;6521.054447105191;6620.966895165541;6667.799966001027;6682.665866706645;6692.330766923269;6699.899501507482;6701.798946031627;5085.95737873735;6118.131909153847;6169.907451388232;6279.372062793684;6316.147320111818;6775.119234499483;6840.794776156723;6854.760083397057;6857.177138743383;6883.449324054063;6195.535334849904;6266.592671476339;6444.903326450107;6460.773872914426;6525.608463492205;6658;6661.134052573135;6680.3987641112535;6686.933130668728;6716.194056713128;6218.751249949952;6297.748090076438;6587.275399706028;6591.901121483182;6624.735010599522;6377.362263773678;6493.70778314977;6561.639109848908;6595.208574971034;6652.36802503771;5352.812651557255;5355.062863998784;5369.40936496985;5371.086915224421;5380;4751.881202969954;4763.595094417014;4771.9522804772205;4783.560384204012;4810.182269014276;6106.603070800473;6198.442140207403;6277.811665650038;6308.08532762756;6309;6749.797506074826;6754.358335958076;6758.864822703518;6761.898571521431;6772.187337519529;6259.530535209787;6279.843003924939;6284.183056202756;6306.463950564162;6342.39747224013;5711.314642242957;5785.797497087666;5794.362620111784;5806.854828629233;5927.851803704942;6700.631465269359;6777.796666099827;6801.625910574966;6829.419499342612;6839.213490448463;6667;6700.061991321121;6712.39588437043;6732.225794033749;6742.730290788313;6506.089147519446;6744.527883048139;6769.830754231184;6787.762428314985;6817;6385.808425747235;6504.772332968512;6567.868642627216;6590.7693230736695;6623.470122390294;6708.563943343667;6729.0579318894415;6730.293319201609;6735.62954037513;6759.459243260429;6165.106059621419;6348.238211414475;6361.777337793155;6459.224893012869;6475.255345635123;6487.318831522811;6519.7392104315295;6544.3782840630065;6554.082428459924;6559.278479367361;6119.44924956756;6124.533510047256;6257.468115210076;6275.874482510416;6298.338674439118;6480.513961452815;6549.967250163719;6553.082568440327;6553.4101930824545;6581.6709164542535;6360.236771587439;6379.7129129190225;6384.553081284265;6395.264544577433;6403.135576697273 12:22:04 INFO - PID 3163 | |1;ext.html;742.5915746339512;796.4464697035561;822.8148666550026;1279.9168054076479;1283;37536.43695344572;38598.807005965;38599;38607.22785544294;38612.42081368775;38984.22031559367;39331.80334098333;39359.606403935955;39394.81815545531;39403.605963940354;7992.680292788282;8109.472884262534;8418.158184181593;8707.651693932236;8732;7171.462140339469;8523.318134549252;8578.957105214466;8650.394472386935;8650.826983460327;7417.332440080391;8578.270846978014;8658.87011694825;8658.913410865905;8679.262262707678;8545.829083418328;8598.699045533407;8629.309655227567;8632.56837158146;8644.35167362444;8448.408611397204;8509.48943063412;8510.361722870748;8515.233628973423;8535;38381.61618383809;38541.80729096365;38545.421818672745;38559;38661.420078698844;3597.568291805;3622.1850083731215;3639.8726044588575;3640.7815531068222;3642.1987162824134;30903.845480772452;31139.377212455624;31272.843635781905;31287.84356078228;31331.216719581964;3177.396294704022;3216.083416226364;3217.5495430639494;3219.3078488125166;3225.483922572377;219257.51856203564;231593;286707.9999999979;307222;308918;49956.50130496091;50477;50594.74702626463;50655;50839.695419797594;52042.73978630082;52293.47706522962;52358.21462678063;52426.737866310425;52454;14499.782503262459;14518.491852785313;14627.488037918622;14635.853641463662;14667.826573874065;11800.055995520337;12044.21712588679;12056.21634593766;12068.456919438646;12072.698182545506;14007.17906672126;14008.509702160376;14010.649733756738;14013.5095271665;14041.297935103408;4840.588549973291;5629.380768115504;5886.3230728465915;5924.437178468039;6002.939970600238;1000.9899901001043;1023.3194925374543;1028.8713910761155;1044.9216308776872;1056.1867362131115;18888.71666924997;19890.80655160695;20253.49366265855;24651.658092481186;24726.876365618416;1033.5452400943711;1101.5979167603766;1115.59838458155;1139.2651739628059;1140.863096428434;12317.568885088978;12596.370181490889;12710.618681439571;12734.554290599785;12737.172083814523;310655;310897;311597;313873;314153;56517.717411413505;56951.715241423524;56956.86086278334;57027.714861425426;57110.85778284411;1502.7971223884635;1556.2918871913253;1569.803774528184;1574.2758331167563;1582.8654564361927;21059;23387.5967441954;24342.63486047746;24450.388740281636;24699.135530256353;40264.59735402608;40435;40448.3932741015;40555.59444405636;40566.79716601516;296330;296779;297417;297499.5125024361;298389;35104.420301086;35425.291494169454;35659.10852228715;35850.41495850394;36255.81872090622;31142.532862006636;35664.10839729028;43293.70118896438;44884.77557612191;46382.53617463782;29541;30849.845750772;31580.210494737814;31711;31751.364972700878;30734;31105.066847994596;31220.063398098093;31553.36893262076;31674.04977850668;37416.81291593525;37569;37624.62375376211;37642.623573765006;37669;30657.846710766302;31423.214419638778;31716.365672685955;32312.030639080866;32506;18235;22187.667184991915;24455.633165502175;24672.506549868544;24850.875745621157 12:22:04 INFO - PID 3163 | |2;jquery.html;419.3186072631971;421.23545764437523;428.43874524373075;436.30627302588886;440.7377610321859;17767.64464710705;20883;21648.99999999998;21974.340769776933;22136.225232116878;21100.261490847824;21872.01575929083;22473.887630561865;22553.661695074545;22594;5977.491913187384;6257.155284036665;6258.937410625904;6266.780662676807;6268.122462855204;6123.418275263843;6601.900971485432;6983.68573414195;7028.226895041541;7046.224915259343;6718.294579069201;6967.1291088613925;7010.6494675266285;7011.719531218745;7037.225905150455;7092.6808293626655;7140.892886606705;7156.355927966508;7166.426685865118;7180.748673796418;6660.467162626978;6931.480138989596;6990.6155161466095;7010;7010.123734533184;29295.2676183095;29316.853415732785;29440.411191776046;30117.548236776467;30648;2308.4690521180223;2355.552445035455;2374.6200607902824;2376.7860892519757;2377.655239990209;17007.979521228764;17345.91327043369;18479.907600462047;18715.064246787606;18937;2252.2117258959397;2293.151533932439;2359.445530300378;2375.3705268103968;2395.652630368604;158314;161851;166731;171410.28589714193;172506;19498.902505487382;25253.494930101664;25831.483370332488;26202.737972620413;26435;33510.832445837616;33956.1510962223;40383.39424908629;40613.79693101575;40660.39009414861;10685.305455145392;11074.224804263624;11254.15593830466;11254.212205145725;11450.083993280517;8769.035406105324;8793;8856;8903.510306933182;9029.187373136449;9461.49270443333;11309.09527237819;11324.603638872764;11420.828687569694;11524.423778811026;3826.6747326477002;4005.899852503711;4195.622393984556;4729.787159577827;4742.340180936713;892.794657228828;913.2465715784505;937.7514958535993;952.79991201847;978.7699890525721;20592.58814823695;21157;21186.94065296729;21232.150713971267;21252.043658035425;816.9175842009242;989.3371441134457;993.7614972406715;1021.3463383434607;1024.8616436781087;10189.694309170589;10198.694039178836;10572.841407378895;10768.946155269174;10793.892061079447;559432;560202;560686;575229;577924;110939;128705;143140;144157;148094.25952870166;1122.2200570603516;1195.6413266106242;1210.8910198082215;1243.4839541590138;1280.974380512366;17734;18264.543386415447;20702.585948281252;22141.77858221397;22961.54076918419;55185.37211847463;56350.718246408505;56956;57138.14292785528;58300.29546602025;77165.07087322861;77842.6107869457;78074;79984.8002279978;80244.59877700574;11867.881321186678;12073.154879158727;12590.685232868886;12683.746325073262;13266.734665306833;14021.228832414316;14061.437542498186;14275.428982840986;14311.856881431053;14515.129092254498;9522.23822094217;11599.188056835941;11838.112141589243;12065.939670301592;12311.015118790296;9010.90989090127;11035.944820276169;11124.165687573626;11388.54445822191;11523.596674116367;12231.877681223074;12237.69405764863;12240.755184896074;12435.37823108859;12455;12995.805062923875;13037.15258508194;13136.27750473733;13358.332083395986;13465.39405726725;9070.319726020707;11870.169088163746;11925.34410607425;12076.45655945467;12213.206141600767 12:22:04 INFO - PID 3163 | |3;mootools.html;1377.4972135170663;1431.699343137941;1434.9497767578137;1454.6217983324345;1462.9268536573168;11277.37974411407;11407.48666310016;11587.304761714282;11623.418829058544;11797.941010294948;11173;11343.773124537503;11361.204715669906;11371;11411.201215914889;2481.206014075501;2522.72250052495;2526.734692857251;2531.4177739119923;2540.2252313044514;2146.2488129154826;2297.115610489965;2490.7633774791366;2497.4880149569385;2509.2723110297993;2449.2774631483667;2457.9016839326405;2474.307193985687;2488.191337815217;2497.213377786001;2438.6829712137487;2440.4752978109614;2470.0613766768693;2470.28361775085;2487.490064536784;2408.8072954163626;2468.5680005999056;2493.47636996231;2494.052260141153;2514.635377870217;9132.954335228347;11556.479958401893;11572.24780389272;11596;11608;5312.442193569658;6597.175353080865;6664.733410663568;6671.86656266872;6700.363465470772;3613.7831730096013;3918.8236529356245;4209.494860616715;4222.092250166198;4239.830406783725;1053.7260312318776;1138.6356365962895;1264.4120483974905;1272;1284.3963337231487;12302.876971230353;15230.46693365727;15704.371825126982;16089.758653620205;16142.515724528283;5541.833744987657;5794.21778059965;6091.573589848668;6097.939020609826;6098.26820781509;13503.459861605623;13571.389287482087;13617.863821361858;13625.931870340584;13629.931850340685;6758.290379510179;6759.493038022168;6759.662016899136;6769.42459890905;6777.3900348967845;5960.5827592068135;6148.9692551536955;6178.41305076017;6192.380761923771;6230.59501132425;4093.263212621697;4284.700070995001;4467.374567560544;4516.23224051912;4779.522047795263;1406.92965351732;1443.9061461005;1447.8479759625297;1468.324570697491;1468.3686015013648;805.8831469437016;811.9769090945333;829.8257365953217;832.342449464928;863.6070587882498;6170.784022559189;6183;6291.6854157291955;6449.355064493607;6449.451796597248;594.7710131599365;606.2482521673094;613.7913109542777;617.305531277313;620.385818040137;3918.3534716771983;4176.686748493875;4367.816091954023;4484.529124441952;4577.771111444415;13914.234717090454;14473.27633618315;14487.78268325976;14490;14504.854951450561;13034.47862085506;14357.56927292162;14359.353829077716;14390;14401.99186056966;7390.224026477143;8303.792405189797;8396.286315663116;8446.197611226924;8490.320774338039;6160.353162918008;6888.41448476885;6936.445084393337;7095.751648692271;7109.466789990668;12472.438740256528;12493.375331233221;12840.229586224856;13113.475460981454;13329.733405332034;13245.940324773803;13298.00264980111;13354.931605471345;13357.732845342844;13505.729885402434;9165.862512062191;9406.623735050794;9440.19758320523;9543.522823858919;9555.522223888916;10510.211734119819;10542.103921166787;10659.89340106589;10673.733156671145;10675.359478431319;8889.911100889167;9077.636894524145;9131.908680913106;9139.908600914172;9186.31102667316;8874.29005679557;8887.555622218733;8962.507062111647;9008.729738107868;9079.818403632022;8145.470544414594;8180.14108518597;8219.342452603896;8237.917620823715;8238.711645092393;5149.253358263106;6071.332153463027;6130.01919692847;6172.660503672341;6244.562880598314;6008.909866351921;6027.75888964454;6165.229346331708;6203.937960620517;6326.4622507087415 12:22:04 INFO - PID 3163 | |4;prototype.html;364.761081491623;387.6375588824449;390.46701252789944;396.40737098038437;410.71660554217607;5582.972085139569;5935.872184284988;6245.437910588046;6271;6363.995341467435;4671.042436300559;4957.330760347352;4970.602351811855;5273.973630131844;5935.821925342236;4293.978530107345;4557.886052848688;4562.908741825178;4568.269076947689;4618.699784514012;4379.824807007716;4488.775561221926;4551.816527702788;4577.404937358138;4590.2196626573395;4409.911801763963;4465.508794032654;4471.105778844244;4471.5081341052455;4471.642268618502;3925.470061541698;4497.865064048084;4507.57178068083;4530.139273538017;4531.818727250906;3734.271816995687;3833.367494363427;3883.941740873889;3906.648401643837;3909.0032041829436;5418.864528386783;6022.066579680157;6032.185654936615;6036.597245465327;6053.001254792954;5141.254518094893;5363.280313324289;5384.300040994684;5393.622446428752;5404.405885175138;6055.818325450244;6136.7545298188015;6361.2048493938255;6543.705533251015;6608.900866487006;4394.8681539553545;4405.801738921757;4411.338299255105;4416.911661766779;4434.955650443519;6027.216461859974;6830.829229269259;6854.68761709679;6952.157678215277;7065.576065436039;4101.323281658552;4464;4471.754053527022;4473.351364052194;4482.103579284156;4555.9772201138785;4563.516857021481;4569.588737013684;4571.771411429415;4573.885652858705;5213.113770658997;5311.28297679816;5368.355797304349;5370.8657283567445;5410.48600382963;6606.339366063451;6647.268800431949;6650.406341526808;6667.366495208608;6669.699863506154;1420.7229590229806;1473.9659270207046;1511.9773203401958;1537.8846586506056;1571.8899677022728;872.4983134697575;1002.2082554781787;1015.8831734350645;1032.2464600841429;1042.525650828871;5064.797408103708;6286.937130628727;6304.369563043659;6341.365863413622;6385.393387628168;6207.379262073757;6500.9349906501275;6838.418734407532;6851.828704282333;6878.518503704692;6269.905951410732;6386.584871983399;6434.163558737334;6441.452476539453;6495.610263384212;2854.986479799683;3143.795653282575;3560.6973407260675;3609.566851977727;3621.7102631789394;5574.386817450078;6650;7009.2990700929495;7038.612876291853;7109.751158709524;5915.881682366328;5926.585139040226;7012.649367531603;7157.821054473576;7170.494196218852;5248.317718696545;5711.914321285184;6072.906876762137;6082.026875699867;7085.362317391459;5593.804216852391;6099.425430926805;6198.6280823150755;6531.542792004514;6895.65573688573;5948.048312270016;6488.604949935598;6592.604443733199;6726.6972986216715;6767.695453704693;5587.69267690281;6321.0834429008455;6467;6706.329367063255;7064.633347828535;3762.2099359133795;4496.235639941153;4521.954780452285;4531.501534831232;4538.568835960578;6659.934410494491;6728.865422691617;6808.319168083152;6851;6878.896816547855;6311.463525600192;6636.2368327642935;6643.202815662152;6655.933440665532;6672.232693240339;5739.569532285179;5742.655440673573;6357.809265722036;6402.295747467681;6676.298988606127;6045.425684559959;6096.786612468542;6460.967695161494;6505.60966342002;6527.988161834924;6100.816975490742;6332.905006425;6627.204735431779;6655.800325990228;6681.318681318681;5318.654287471302;6524.380183882713;6525.184351956005;6555.2789193187755;6575.178102737158 12:22:04 INFO - PID 3163 | |5;yui.html;833.4415941319315;843.2579330189428;856.0925419055801;865.0052439694351;867.6876324523171;14030.508932187375;14619.853801461983;16445.917770411146;16855.241514131863;16932.746008809878;16838.494845154633;17244.22400991955;17575.209115589798;17607.91196044018;17614.20736066877;972.0182615558266;977.1889331854561;990.301837204769;993.5578667492969;995.7659949911765;983.7884854756226;1004.4525733475238;1007.9949600251988;1011.1203253169753;1014.467404612577;1054.114543783222;1063.6064656077224;1064.1008347946013;1064.1486810551567;1068.6633710381243;1032.8554002439664;1049.5329578337644;1060.0618452669444;1060.9522571484301;1064.1858977881927;778.7858338956776;787.6140691061339;787.7124849429974;791.8653828849109;792.5482474989259;13537.458501659921;13672.316384180851;15684.843151568452;16255.674886502204;16515.256813443422;16625.7506137408;16879.07165105919;17199.828001720074;17358.56603584908;17379.044152571605;13752.243626600533;14096.859031409656;14134.010619256656;14297.285135743172;14299.428022879072;3453.3611281912927;3456.913577160566;3567.6432356764376;3580.0154957386667;3609.7292703047115;115744;118614;119109.40445297718;119384;119760.40119799346;11820.0543956485;13137.802932956014;13650.249236292098;13690.247036412893;13697.315134243248;24975.875120624645;25024.999000039796;25460.363490912507;25734.48531029369;25896.093636723002;6416.294207637156;7348.375388092072;7555.055618047744;7630.2751238633355;7643.9617801911745;3856.8650097246464;3945.861894833667;3947.940780888289;3948.230095131422;3948.368261078271;4322.330038843984;4683.250679891201;4801.087793319258;4857.125717370907;4857.80568777252;953.1850268020881;969.96120155193;973.1679414100842;988.7874107067015;990.4206039466849;645.602954183174;663.465909942501;665.1253601513994;670.3497607320891;685.6229074009375;9787.972262912434;10007.349522281029;10693.465326733633;10999.945000274947;12067.405507815685;648.8410339466861;651.1567520061532;660.3129005391271;665.1286814273318;668.3350066683681;4573.474050484237;5104.183330667075;5414.35027796667;5473;5641.435856414408;101924;104752.47623761985;105719.47140264403;105790.47104764427;106748.46625766977;93984;95805;96303.51848240713;96439.51780241194;96885;72011.63994179995;73584.63207684034;76260;76864;76941;11651.41742912834;12153;12217.633470995885;12281.263124212575;12352.814707779211;25985.870070649526;38348.80825595854;38947.02632434212;39473.013174670865;40518.18963620652;42952;45016.54983450124;49063.509364907324;50287.497125029746;50813.98372032613;13482;15410;15691.293891775125;15884.205789710237;16426.85012049145;17988.37040703569;18018.099095045458;18198.636027279645;18229.726554101435;18285;14404.42382304696;15842.890997630517;16256.91871540682;16320.67358652844;16324.755128673318;15646.139462329225;16137;16189.919050404673;16223.837761622233;16296.918515407348;15849.603759906095;16013.91993040074;16240.02559846413;16303.755443668117;16408.917955410147;10619.469026548797;10626.149908007495;10631.096356809758;11171.832422513506;11412.828807567726;12488.687782805502;12562.748745024866;12574.245545267313;12593.244405335709;12629.179103358252 12:22:04 INFO - PID 3163 | __end_tp_report 12:22:04 INFO - PID 3163 | __start_cc_report 12:22:04 INFO - PID 3163 | _x_x_mozilla_cycle_collect,417 12:22:04 INFO - PID 3163 | __end_cc_report 12:22:04 INFO - PID 3163 | __startTimestamp1492370524791__endTimestamp 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | ------- Summary: start ------- 12:22:04 INFO - PID 3163 | Number of tests: 6 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | [#0] dojo.html Cycles:165 Average:6080.65 Median:6308.09 stddev:735.57 (11.7%) stddev-sans-first:709.78 12:22:04 INFO - PID 3163 | Values: 3516.3 3533.1 3539.1 3565.0 3574.5 5783.1 6027.6 6143.2 6188.5 6249.6 5369.2 5596.2 6131.9 6142.1 6240.3 5394.5 5408.9 5416.1 5424.9 5515.1 5384.8 5471.7 5521.5 5532.5 5542.7 4488.0 5375.7 5379.9 5452.5 5493.3 5379.1 5383.8 5416.2 5430.9 5492.2 4646.7 4776.2 4846.4 5347.6 5373.2 5418.0 5612.4 5974.6 6077.9 6205.6 5598.0 6493.9 6507.6 6521.1 6621.0 6667.8 6682.7 6692.3 6699.9 6701.8 5086.0 6118.1 6169.9 6279.4 6316.1 6775.1 6840.8 6854.8 6857.2 6883.4 6195.5 6266.6 6444.9 6460.8 6525.6 6658.0 6661.1 6680.4 6686.9 6716.2 6218.8 6297.7 6587.3 6591.9 6624.7 6377.4 6493.7 6561.6 6595.2 6652.4 5352.8 5355.1 5369.4 5371.1 5380.0 4751.9 4763.6 4772.0 4783.6 4810.2 6106.6 6198.4 6277.8 6308.1 6309.0 6749.8 6754.4 6758.9 6761.9 6772.2 6259.5 6279.8 6284.2 6306.5 6342.4 5711.3 5785.8 5794.4 5806.9 5927.9 6700.6 6777.8 6801.6 6829.4 6839.2 6667.0 6700.1 6712.4 6732.2 6742.7 6506.1 6744.5 6769.8 6787.8 6817.0 6385.8 6504.8 6567.9 6590.8 6623.5 6708.6 6729.1 6730.3 6735.6 6759.5 6165.1 6348.2 6361.8 6459.2 6475.3 6487.3 6519.7 6544.4 6554.1 6559.3 6119.4 6124.5 6257.5 6275.9 6298.3 6480.5 6550.0 6553.1 6553.4 6581.7 6360.2 6379.7 6384.6 6395.3 6403.1 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | [#1] ext.html Cycles:180 Average:44894.94 Median:17768.76 stddev:77257.94 (434.8%) stddev-sans-first:77403.54 12:22:04 INFO - PID 3163 | Values: 742.6 796.4 822.8 1279.9 1283.0 37536.4 38598.8 38599.0 38607.2 38612.4 38984.2 39331.8 39359.6 39394.8 39403.6 7992.7 8109.5 8418.2 8707.7 8732.0 7171.5 8523.3 8579.0 8650.4 8650.8 7417.3 8578.3 8658.9 8658.9 8679.3 8545.8 8598.7 8629.3 8632.6 8644.4 8448.4 8509.5 8510.4 8515.2 8535.0 38381.6 38541.8 38545.4 38559.0 38661.4 3597.6 3622.2 3639.9 3640.8 3642.2 30903.8 31139.4 31272.8 31287.8 31331.2 3177.4 3216.1 3217.5 3219.3 3225.5 219257.5 231593.0 286708.0 307222.0 308918.0 49956.5 50477.0 50594.7 50655.0 50839.7 52042.7 52293.5 52358.2 52426.7 52454.0 14499.8 14518.5 14627.5 14635.9 14667.8 11800.1 12044.2 12056.2 12068.5 12072.7 14007.2 14008.5 14010.6 14013.5 14041.3 4840.6 5629.4 5886.3 5924.4 6002.9 1001.0 1023.3 1028.9 1044.9 1056.2 18888.7 19890.8 20253.5 24651.7 24726.9 1033.5 1101.6 1115.6 1139.3 1140.9 12317.6 12596.4 12710.6 12734.6 12737.2 310655.0 310897.0 311597.0 313873.0 314153.0 56517.7 56951.7 56956.9 57027.7 57110.9 1502.8 1556.3 1569.8 1574.3 1582.9 21059.0 23387.6 24342.6 24450.4 24699.1 40264.6 40435.0 40448.4 40555.6 40566.8 296330.0 296779.0 297417.0 297499.5 298389.0 35104.4 35425.3 35659.1 35850.4 36255.8 31142.5 35664.1 43293.7 44884.8 46382.5 29541.0 30849.8 31580.2 31711.0 31751.4 30734.0 31105.1 31220.1 31553.4 31674.0 37416.8 37569.0 37624.6 37642.6 37669.0 30657.8 31423.2 31716.4 32312.0 32506.0 18235.0 22187.7 24455.6 24672.5 24850.9 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | [#2] jquery.html Cycles:180 Average:38113.88 Median:12635.00 stddev:96185.87 (761.3%) stddev-sans-first:96414.06 12:22:04 INFO - PID 3163 | Values: 419.3 421.2 428.4 436.3 440.7 17767.6 20883.0 21649.0 21974.3 22136.2 21100.3 21872.0 22473.9 22553.7 22594.0 5977.5 6257.2 6258.9 6266.8 6268.1 6123.4 6601.9 6983.7 7028.2 7046.2 6718.3 6967.1 7010.6 7011.7 7037.2 7092.7 7140.9 7156.4 7166.4 7180.7 6660.5 6931.5 6990.6 7010.0 7010.1 29295.3 29316.9 29440.4 30117.5 30648.0 2308.5 2355.6 2374.6 2376.8 2377.7 17008.0 17345.9 18479.9 18715.1 18937.0 2252.2 2293.2 2359.4 2375.4 2395.7 158314.0 161851.0 166731.0 171410.3 172506.0 19498.9 25253.5 25831.5 26202.7 26435.0 33510.8 33956.2 40383.4 40613.8 40660.4 10685.3 11074.2 11254.2 11254.2 11450.1 8769.0 8793.0 8856.0 8903.5 9029.2 9461.5 11309.1 11324.6 11420.8 11524.4 3826.7 4005.9 4195.6 4729.8 4742.3 892.8 913.2 937.8 952.8 978.8 20592.6 21157.0 21186.9 21232.2 21252.0 816.9 989.3 993.8 1021.3 1024.9 10189.7 10198.7 10572.8 10768.9 10793.9 559432.0 560202.0 560686.0 575229.0 577924.0 110939.0 128705.0 143140.0 144157.0 148094.3 1122.2 1195.6 1210.9 1243.5 1281.0 17734.0 18264.5 20702.6 22141.8 22961.5 55185.4 56350.7 56956.0 57138.1 58300.3 77165.1 77842.6 78074.0 79984.8 80244.6 11867.9 12073.2 12590.7 12683.7 13266.7 14021.2 14061.4 14275.4 14311.9 14515.1 9522.2 11599.2 11838.1 12065.9 12311.0 9010.9 11035.9 11124.2 11388.5 11523.6 12231.9 12237.7 12240.8 12435.4 12455.0 12995.8 13037.2 13136.3 13358.3 13465.4 9070.3 11870.2 11925.3 12076.5 12213.2 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | [#3] mootools.html Cycles:180 Average:7025.20 Median:3918.59 stddev:4369.99 (111.5%) stddev-sans-first:4361.64 12:22:04 INFO - PID 3163 | Values: 1377.5 1431.7 1434.9 1454.6 1462.9 11277.4 11407.5 11587.3 11623.4 11797.9 11173.0 11343.8 11361.2 11371.0 11411.2 2481.2 2522.7 2526.7 2531.4 2540.2 2146.2 2297.1 2490.8 2497.5 2509.3 2449.3 2457.9 2474.3 2488.2 2497.2 2438.7 2440.5 2470.1 2470.3 2487.5 2408.8 2468.6 2493.5 2494.1 2514.6 9133.0 11556.5 11572.2 11596.0 11608.0 5312.4 6597.2 6664.7 6671.9 6700.4 3613.8 3918.8 4209.5 4222.1 4239.8 1053.7 1138.6 1264.4 1272.0 1284.4 12302.9 15230.5 15704.4 16089.8 16142.5 5541.8 5794.2 6091.6 6097.9 6098.3 13503.5 13571.4 13617.9 13625.9 13629.9 6758.3 6759.5 6759.7 6769.4 6777.4 5960.6 6149.0 6178.4 6192.4 6230.6 4093.3 4284.7 4467.4 4516.2 4779.5 1406.9 1443.9 1447.8 1468.3 1468.4 805.9 812.0 829.8 832.3 863.6 6170.8 6183.0 6291.7 6449.4 6449.5 594.8 606.2 613.8 617.3 620.4 3918.4 4176.7 4367.8 4484.5 4577.8 13914.2 14473.3 14487.8 14490.0 14504.9 13034.5 14357.6 14359.4 14390.0 14402.0 7390.2 8303.8 8396.3 8446.2 8490.3 6160.4 6888.4 6936.4 7095.8 7109.5 12472.4 12493.4 12840.2 13113.5 13329.7 13245.9 13298.0 13354.9 13357.7 13505.7 9165.9 9406.6 9440.2 9543.5 9555.5 10510.2 10542.1 10659.9 10673.7 10675.4 8889.9 9077.6 9131.9 9139.9 9186.3 8874.3 8887.6 8962.5 9008.7 9079.8 8145.5 8180.1 8219.3 8237.9 8238.7 5149.3 6071.3 6130.0 6172.7 6244.6 6008.9 6027.8 6165.2 6203.9 6326.5 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | [#4] prototype.html Cycles:180 Average:5268.08 Median:5931.20 stddev:1650.20 (27.8%) stddev-sans-first:1613.27 12:22:04 INFO - PID 3163 | Values: 364.8 387.6 390.5 396.4 410.7 5583.0 5935.9 6245.4 6271.0 6364.0 4671.0 4957.3 4970.6 5274.0 5935.8 4294.0 4557.9 4562.9 4568.3 4618.7 4379.8 4488.8 4551.8 4577.4 4590.2 4409.9 4465.5 4471.1 4471.5 4471.6 3925.5 4497.9 4507.6 4530.1 4531.8 3734.3 3833.4 3883.9 3906.6 3909.0 5418.9 6022.1 6032.2 6036.6 6053.0 5141.3 5363.3 5384.3 5393.6 5404.4 6055.8 6136.8 6361.2 6543.7 6608.9 4394.9 4405.8 4411.3 4416.9 4435.0 6027.2 6830.8 6854.7 6952.2 7065.6 4101.3 4464.0 4471.8 4473.4 4482.1 4556.0 4563.5 4569.6 4571.8 4573.9 5213.1 5311.3 5368.4 5370.9 5410.5 6606.3 6647.3 6650.4 6667.4 6669.7 1420.7 1474.0 1512.0 1537.9 1571.9 872.5 1002.2 1015.9 1032.2 1042.5 5064.8 6286.9 6304.4 6341.4 6385.4 6207.4 6500.9 6838.4 6851.8 6878.5 6269.9 6386.6 6434.2 6441.5 6495.6 2855.0 3143.8 3560.7 3609.6 3621.7 5574.4 6650.0 7009.3 7038.6 7109.8 5915.9 5926.6 7012.6 7157.8 7170.5 5248.3 5711.9 6072.9 6082.0 7085.4 5593.8 6099.4 6198.6 6531.5 6895.7 5948.0 6488.6 6592.6 6726.7 6767.7 5587.7 6321.1 6467.0 6706.3 7064.6 3762.2 4496.2 4522.0 4531.5 4538.6 6659.9 6728.9 6808.3 6851.0 6878.9 6311.5 6636.2 6643.2 6655.9 6672.2 5739.6 5742.7 6357.8 6402.3 6676.3 6045.4 6096.8 6461.0 6505.6 6528.0 6100.8 6332.9 6627.2 6655.8 6681.3 5318.7 6524.4 6525.2 6555.3 6575.2 12:22:04 INFO - PID 3163 | 12:22:04 INFO - PID 3163 | [#5] yui.html Cycles:180 Average:21044.67 Median:17591.56 stddev:29774.25 (169.3%) stddev-sans-first:29819.10 12:22:04 INFO - PID 3163 | Values: 833.4 843.3 856.1 865.0 867.7 14030.5 14619.9 16445.9 16855.2 16932.7 16838.5 17244.2 17575.2 17607.9 17614.2 972.0 977.2 990.3 993.6 995.8 983.8 1004.5 1008.0 1011.1 1014.5 1054.1 1063.6 1064.1 1064.1 1068.7 1032.9 1049.5 1060.1 1061.0 1064.2 778.8 787.6 787.7 791.9 792.5 13537.5 13672.3 15684.8 16255.7 16515.3 16625.8 16879.1 17199.8 17358.6 17379.0 13752.2 14096.9 14134.0 14297.3 14299.4 3453.4 3456.9 3567.6 3580.0 3609.7 115744.0 118614.0 119109.4 119384.0 119760.4 11820.1 13137.8 13650.2 13690.2 13697.3 24975.9 25025.0 25460.4 25734.5 25896.1 6416.3 7348.4 7555.1 7630.3 7644.0 3856.9 3945.9 3947.9 3948.2 3948.4 4322.3 4683.3 4801.1 4857.1 4857.8 953.2 970.0 973.2 988.8 990.4 645.6 663.5 665.1 670.3 685.6 9788.0 10007.3 10693.5 10999.9 12067.4 648.8 651.2 660.3 665.1 668.3 4573.5 5104.2 5414.4 5473.0 5641.4 101924.0 104752.5 105719.5 105790.5 106748.5 93984.0 95805.0 96303.5 96439.5 96885.0 72011.6 73584.6 76260.0 76864.0 76941.0 11651.4 12153.0 12217.6 12281.3 12352.8 25985.9 38348.8 38947.0 39473.0 40518.2 42952.0 45016.5 49063.5 50287.5 50814.0 13482.0 15410.0 15691.3 15884.2 16426.9 17988.4 18018.1 18198.6 18229.7 18285.0 14404.4 15842.9 16256.9 16320.7 16324.8 15646.1 16137.0 16189.9 16223.8 16296.9 15849.6 16013.9 16240.0 16303.8 16408.9 10619.5 10626.1 10631.1 11171.8 11412.8 12488.7 12562.7 12574.2 12593.2 12629.2 12:22:04 INFO - PID 3163 | -------- Summary: end -------- 12:22:04 INFO - PID 3163 | 12:22:05 INFO - TEST-INFO | 3163: exit 0 12:22:05 INFO - TEST-OK | dromaeo_css | took 1116422ms 12:22:05 INFO - TEST-START | kraken 12:22:05 INFO - operating with platform_type : mac_ 12:22:05 INFO - Initialising browser for kraken test... 12:22:05 INFO - TEST-INFO | started process 3170 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpI9JlB5/profile http://localhost:64556/getInfo.html) 12:22:08 INFO - PID 3170 | 2017-04-16 12:22:08.435 plugin-container[3171:62930] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 12:22:08 INFO - PID 3170 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:22:08 INFO - PID 3170 | 2017-04-16 12:22:08.438 plugin-container[3171:62930] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 12:22:08 INFO - PID 3170 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:22:08 INFO - PID 3170 | 2017-04-16 12:22:08.439 plugin-container[3171:62930] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:22:08 INFO - PID 3170 | __metrics Screen width/height:1600/1200 12:22:08 INFO - PID 3170 | colorDepth:24 12:22:08 INFO - PID 3170 | Browser inner width/height: 1024/689 12:22:08 INFO - PID 3170 | __metrics 12:22:08 ERROR - PID 3170 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3374: TypeError: this.tabs is undefined 12:22:09 INFO - TEST-INFO | 3170: exit 0 12:22:09 INFO - Browser initialized. 12:22:09 INFO - Running cycle 1/1 for kraken test... 12:22:09 INFO - TEST-INFO | started process 3172 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/T/tmpI9JlB5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:22:12 INFO - PID 3172 | 2017-04-16 12:22:12.136 plugin-container[3173:63055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 12:22:12 INFO - PID 3172 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:22:12 INFO - PID 3172 | 2017-04-16 12:22:12.137 plugin-container[3173:63055] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 12:22:12 INFO - PID 3172 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:22:12 INFO - PID 3172 | 2017-04-16 12:22:12.137 plugin-container[3173:63055] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:22:22 INFO - PID 3172 | RSS: Main: 238170112 12:22:22 INFO - PID 3172 | 12:22:25 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64556/tests/kraken/driver.html?testName=audio-beat-detection) 12:22:25 INFO - PID 3172 | RSS: Main: 249655296 12:22:25 INFO - PID 3172 | 12:22:28 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64556/tests/kraken/driver.html?testName=audio-dft) 12:22:29 INFO - PID 3172 | RSS: Main: 258125824 12:22:29 INFO - PID 3172 | 12:22:32 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64556/tests/kraken/driver.html?testName=audio-fft) 12:22:33 INFO - PID 3172 | RSS: Main: 261025792 12:22:33 INFO - PID 3172 | 12:22:35 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64556/tests/kraken/driver.html?testName=audio-oscillator) 12:22:35 INFO - PID 3172 | RSS: Main: 262709248 12:22:35 INFO - PID 3172 | 12:22:37 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64556/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:22:38 INFO - PID 3172 | RSS: Main: 263385088 12:22:38 INFO - PID 3172 | 12:22:41 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64556/tests/kraken/driver.html?testName=imaging-darkroom) 12:22:42 INFO - PID 3172 | RSS: Main: 268382208 12:22:42 INFO - PID 3172 | 12:22:45 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64556/tests/kraken/driver.html?testName=imaging-desaturate) 12:22:46 INFO - PID 3172 | RSS: Main: 269733888 12:22:46 INFO - PID 3172 | 12:22:49 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64556/tests/kraken/driver.html?testName=json-parse-financial) 12:22:49 INFO - PID 3172 | RSS: Main: 269684736 12:22:49 INFO - PID 3172 | 12:22:51 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64556/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:22:51 INFO - PID 3172 | RSS: Main: 269373440 12:22:51 INFO - PID 3172 | 12:22:53 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:22:54 INFO - PID 3172 | RSS: Main: 269586432 12:22:54 INFO - PID 3172 | 12:22:56 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:22:57 INFO - PID 3172 | RSS: Main: 269090816 12:22:57 INFO - PID 3172 | 12:23:00 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:23:01 INFO - PID 3172 | RSS: Main: 269369344 12:23:01 INFO - PID 3172 | 12:23:04 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:23:04 INFO - PID 3172 | RSS: Main: 269185024 12:23:04 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | Cycle 1(1): loaded http://localhost:64556/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64556/tests/kraken/driver.html?testName=ai-astar) 12:23:06 INFO - PID 3172 | RSS: Main: 271020032 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | __start_tp_report 12:23:06 INFO - PID 3172 | _x_x_mozilla_page_load 12:23:06 INFO - PID 3172 | _x_x_mozilla_page_load_details 12:23:06 INFO - PID 3172 | |i|pagename|runs| 12:23:06 INFO - PID 3172 | |0;ai-astar;118;161;122;141;137;108;161;165;116;158 12:23:06 INFO - PID 3172 | |1;audio-beat-detection;148;108;113;153;112;111;145;132;145;115 12:23:06 INFO - PID 3172 | |2;audio-dft;253;266;261;253;286;203;200;196;200;203 12:23:06 INFO - PID 3172 | |3;audio-fft;84;58;58;90;59;60;57;57;74;58 12:23:06 INFO - PID 3172 | |4;audio-oscillator;85;70;84;72;72;70;89;71;72;90 12:23:06 INFO - PID 3172 | |5;imaging-gaussian-blur;86;92;133;98;122;135;90;104;104;119 12:23:06 INFO - PID 3172 | |6;imaging-darkroom;106;136;101;103;121;155;96;97;98;96 12:23:06 INFO - PID 3172 | |7;imaging-desaturate;93;94;91;93;91;91;92;92;89;91 12:23:06 INFO - PID 3172 | |8;json-parse-financial;51;51;52;52;48;50;50;48;47;49 12:23:06 INFO - PID 3172 | |9;json-stringify-tinderbox;63;78;64;58;62;60;81;85;87;83 12:23:06 INFO - PID 3172 | |10;stanford-crypto-aes;84;79;104;84;74;96;105;106;105;73 12:23:06 INFO - PID 3172 | |11;stanford-crypto-ccm;139;148;130;133;137;141;155;152;221;152 12:23:06 INFO - PID 3172 | |12;stanford-crypto-pbkdf2;187;189;189;188;185;189;187;188;184;188 12:23:06 INFO - PID 3172 | |13;stanford-crypto-sha256-iterative;71;72;70;69;83;96;96;69;71;68 12:23:06 INFO - PID 3172 | __end_tp_report 12:23:06 INFO - PID 3172 | __start_cc_report 12:23:06 INFO - PID 3172 | _x_x_mozilla_cycle_collect,992 12:23:06 INFO - PID 3172 | __end_cc_report 12:23:06 INFO - PID 3172 | __startTimestamp1492370586799__endTimestamp 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | ------- Summary: start ------- 12:23:06 INFO - PID 3172 | Number of tests: 14 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#0] ai-astar Cycles:10 Average:138.70 Median:149.50 stddev:21.68 (14.5%) stddev-sans-first:21.67 12:23:06 INFO - PID 3172 | Values: 118.0 161.0 122.0 141.0 137.0 108.0 161.0 165.0 116.0 158.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:138.50 stddev:18.13 (13.1%) stddev-sans-first:17.76 12:23:06 INFO - PID 3172 | Values: 148.0 108.0 113.0 153.0 112.0 111.0 145.0 132.0 145.0 115.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#2] audio-dft Cycles:10 Average:232.10 Median:253.00 stddev:34.67 (13.7%) stddev-sans-first:35.94 12:23:06 INFO - PID 3172 | Values: 253.0 266.0 261.0 253.0 286.0 203.0 200.0 196.0 200.0 203.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#3] audio-fft Cycles:10 Average:65.50 Median:59.50 stddev:12.47 (21.0%) stddev-sans-first:11.29 12:23:06 INFO - PID 3172 | Values: 84.0 58.0 58.0 90.0 59.0 60.0 57.0 57.0 74.0 58.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.00 stddev:8.38 (10.7%) stddev-sans-first:8.44 12:23:06 INFO - PID 3172 | Values: 85.0 70.0 84.0 72.0 72.0 70.0 89.0 71.0 72.0 90.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#5] imaging-gaussian-blur Cycles:10 Average:108.30 Median:110.50 stddev:17.85 (16.1%) stddev-sans-first:17.01 12:23:06 INFO - PID 3172 | Values: 86.0 92.0 133.0 98.0 122.0 135.0 90.0 104.0 104.0 119.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#6] imaging-darkroom Cycles:10 Average:110.90 Median:125.50 stddev:20.18 (16.1%) stddev-sans-first:21.33 12:23:06 INFO - PID 3172 | Values: 106.0 136.0 101.0 103.0 121.0 155.0 96.0 97.0 98.0 96.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:92.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 12:23:06 INFO - PID 3172 | Values: 93.0 94.0 91.0 93.0 91.0 91.0 92.0 92.0 89.0 91.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.50 stddev:1.75 (3.5%) stddev-sans-first:1.80 12:23:06 INFO - PID 3172 | Values: 51.0 51.0 52.0 52.0 48.0 50.0 50.0 48.0 47.0 49.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:79.50 stddev:11.63 (14.6%) stddev-sans-first:11.86 12:23:06 INFO - PID 3172 | Values: 63.0 78.0 64.0 58.0 62.0 60.0 81.0 85.0 87.0 83.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:76.50 stddev:13.61 (17.8%) stddev-sans-first:14.19 12:23:06 INFO - PID 3172 | Values: 84.0 79.0 104.0 84.0 74.0 96.0 105.0 106.0 105.0 73.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:150.00 stddev:26.10 (17.4%) stddev-sans-first:27.33 12:23:06 INFO - PID 3172 | Values: 139.0 148.0 130.0 133.0 137.0 141.0 155.0 152.0 221.0 152.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.40 Median:188.00 stddev:1.71 (0.9%) stddev-sans-first:1.81 12:23:06 INFO - PID 3172 | Values: 187.0 189.0 189.0 188.0 185.0 189.0 187.0 188.0 184.0 188.0 12:23:06 INFO - PID 3172 | 12:23:06 INFO - PID 3172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:71.50 stddev:11.11 (15.5%) stddev-sans-first:11.60 12:23:06 INFO - PID 3172 | Values: 71.0 72.0 70.0 69.0 83.0 96.0 96.0 69.0 71.0 68.0 12:23:06 INFO - PID 3172 | -------- Summary: end -------- 12:23:06 INFO - PID 3172 | 12:23:07 INFO - TEST-INFO | 3172: exit 0 12:23:08 INFO - TEST-OK | kraken | took 62527ms 12:23:08 INFO - SUITE-END | took 1178s 12:23:08 INFO - Completed test suite (00:19:39) 12:23:08 INFO - javascript benchmark 12:23:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7997.5443987014, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3516.2967406518687, 3533.0813988363025, 3539.1152211947015, 3565.0017994961404, 3574.535310409647, 5783.132530120479, 6027.638341699501, 6143.201383820103, 6188.535859810515, 6249.625022498653, 5369.24830523727, 5596.2165296858475, 6131.8660487576235, 6142.069075791497, 6240.344763799803, 5394.541463975547, 5408.864778380543, 5416.1063424534905, 5424.864378390552, 5515.090010148341, 5384.811531596395, 5471.671699698011, 5521.5306698930635, 5532.529734972532, 5542.722863856791, 4487.977560112211, 5375.6774593524515, 5379.946200537984, 5452.482014208644, 5493.285872836525, 5379.058664733656, 5383.838484845461, 5416.160495123262, 5430.864228394283, 5492.231087647732, 4646.651501137429, 4776.23580227162, 4846.39420072491, 5347.572194224453, 5373.194020896858, 5418.0, 5612.354579223401, 5974.581779275452, 6077.939220607782, 6205.627662340229, 5598.0, 6493.93506064938, 6507.609543427362, 6521.054447105191, 6620.966895165541, 6667.799966001027, 6682.665866706645, 6692.330766923269, 6699.899501507482, 6701.798946031627, 5085.95737873735, 6118.131909153847, 6169.907451388232, 6279.372062793684, 6316.147320111818, 6775.119234499483, 6840.794776156723, 6854.760083397057, 6857.177138743383, 6883.449324054063, 6195.535334849904, 6266.592671476339, 6444.903326450107, 6460.773872914426, 6525.608463492205, 6658.0, 6661.134052573135, 6680.3987641112535, 6686.933130668728, 6716.194056713128, 6218.751249949952, 6297.748090076438, 6587.275399706028, 6591.901121483182, 6624.735010599522, 6377.362263773678, 6493.70778314977, 6561.639109848908, 6595.208574971034, 6652.36802503771, 5352.812651557255, 5355.062863998784, 5369.40936496985, 5371.086915224421, 5380.0, 4751.881202969954, 4763.595094417014, 4771.9522804772205, 4783.560384204012, 4810.182269014276, 6106.603070800473, 6198.442140207403, 6277.811665650038, 6308.08532762756, 6309.0, 6749.797506074826, 6754.358335958076, 6758.864822703518, 6761.898571521431, 6772.187337519529, 6259.530535209787, 6279.843003924939, 6284.183056202756, 6306.463950564162, 6342.39747224013, 5711.314642242957, 5785.797497087666, 5794.362620111784, 5806.854828629233, 5927.851803704942, 6700.631465269359, 6777.796666099827, 6801.625910574966, 6829.419499342612, 6839.213490448463, 6667.0, 6700.061991321121, 6712.39588437043, 6732.225794033749, 6742.730290788313, 6506.089147519446, 6744.527883048139, 6769.830754231184, 6787.762428314985, 6817.0, 6385.808425747235, 6504.772332968512, 6567.868642627216, 6590.7693230736695, 6623.470122390294, 6708.563943343667, 6729.0579318894415, 6730.293319201609, 6735.62954037513, 6759.459243260429, 6165.106059621419, 6348.238211414475, 6361.777337793155, 6459.224893012869, 6475.255345635123, 6487.318831522811, 6519.7392104315295, 6544.3782840630065, 6554.082428459924, 6559.278479367361, 6119.44924956756, 6124.533510047256, 6257.468115210076, 6275.874482510416, 6298.338674439118, 6480.513961452815, 6549.967250163719, 6553.082568440327, 6553.4101930824545, 6581.6709164542535, 6360.236771587439, 6379.7129129190225, 6384.553081284265, 6395.264544577433, 6403.135576697273], "value": 6031.505474791924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.5915746339512, 796.4464697035561, 822.8148666550026, 1279.9168054076479, 1283.0, 37536.43695344572, 38598.807005965, 38599.0, 38607.22785544294, 38612.42081368775, 38984.22031559367, 39331.80334098333, 39359.606403935955, 39394.81815545531, 39403.605963940354, 7992.680292788282, 8109.472884262534, 8418.158184181593, 8707.651693932236, 8732.0, 7171.462140339469, 8523.318134549252, 8578.957105214466, 8650.394472386935, 8650.826983460327, 7417.332440080391, 8578.270846978014, 8658.87011694825, 8658.913410865905, 8679.262262707678, 8545.829083418328, 8598.699045533407, 8629.309655227567, 8632.56837158146, 8644.35167362444, 8448.408611397204, 8509.48943063412, 8510.361722870748, 8515.233628973423, 8535.0, 38381.61618383809, 38541.80729096365, 38545.421818672745, 38559.0, 38661.420078698844, 3597.568291805, 3622.1850083731215, 3639.8726044588575, 3640.7815531068222, 3642.1987162824134, 30903.845480772452, 31139.377212455624, 31272.843635781905, 31287.84356078228, 31331.216719581964, 3177.396294704022, 3216.083416226364, 3217.5495430639494, 3219.3078488125166, 3225.483922572377, 219257.51856203564, 231593.0, 286707.9999999979, 307222.0, 308918.0, 49956.50130496091, 50477.0, 50594.74702626463, 50655.0, 50839.695419797594, 52042.73978630082, 52293.47706522962, 52358.21462678063, 52426.737866310425, 52454.0, 14499.782503262459, 14518.491852785313, 14627.488037918622, 14635.853641463662, 14667.826573874065, 11800.055995520337, 12044.21712588679, 12056.21634593766, 12068.456919438646, 12072.698182545506, 14007.17906672126, 14008.509702160376, 14010.649733756738, 14013.5095271665, 14041.297935103408, 4840.588549973291, 5629.380768115504, 5886.3230728465915, 5924.437178468039, 6002.939970600238, 1000.9899901001043, 1023.3194925374543, 1028.8713910761155, 1044.9216308776872, 1056.1867362131115, 18888.71666924997, 19890.80655160695, 20253.49366265855, 24651.658092481186, 24726.876365618416, 1033.5452400943711, 1101.5979167603766, 1115.59838458155, 1139.2651739628059, 1140.863096428434, 12317.568885088978, 12596.370181490889, 12710.618681439571, 12734.554290599785, 12737.172083814523, 310655.0, 310897.0, 311597.0, 313873.0, 314153.0, 56517.717411413505, 56951.715241423524, 56956.86086278334, 57027.714861425426, 57110.85778284411, 1502.7971223884635, 1556.2918871913253, 1569.803774528184, 1574.2758331167563, 1582.8654564361927, 21059.0, 23387.5967441954, 24342.63486047746, 24450.388740281636, 24699.135530256353, 40264.59735402608, 40435.0, 40448.3932741015, 40555.59444405636, 40566.79716601516, 296330.0, 296779.0, 297417.0, 297499.5125024361, 298389.0, 35104.420301086, 35425.291494169454, 35659.10852228715, 35850.41495850394, 36255.81872090622, 31142.532862006636, 35664.10839729028, 43293.70118896438, 44884.77557612191, 46382.53617463782, 29541.0, 30849.845750772, 31580.210494737814, 31711.0, 31751.364972700878, 30734.0, 31105.066847994596, 31220.063398098093, 31553.36893262076, 31674.04977850668, 37416.81291593525, 37569.0, 37624.62375376211, 37642.623573765006, 37669.0, 30657.846710766302, 31423.214419638778, 31716.365672685955, 32312.030639080866, 32506.0, 18235.0, 22187.667184991915, 24455.633165502175, 24672.506549868544, 24850.875745621157], "value": 17691.11988441344, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.3186072631971, 421.23545764437523, 428.43874524373075, 436.30627302588886, 440.7377610321859, 17767.64464710705, 20883.0, 21648.99999999998, 21974.340769776933, 22136.225232116878, 21100.261490847824, 21872.01575929083, 22473.887630561865, 22553.661695074545, 22594.0, 5977.491913187384, 6257.155284036665, 6258.937410625904, 6266.780662676807, 6268.122462855204, 6123.418275263843, 6601.900971485432, 6983.68573414195, 7028.226895041541, 7046.224915259343, 6718.294579069201, 6967.1291088613925, 7010.6494675266285, 7011.719531218745, 7037.225905150455, 7092.6808293626655, 7140.892886606705, 7156.355927966508, 7166.426685865118, 7180.748673796418, 6660.467162626978, 6931.480138989596, 6990.6155161466095, 7010.0, 7010.123734533184, 29295.2676183095, 29316.853415732785, 29440.411191776046, 30117.548236776467, 30648.0, 2308.4690521180223, 2355.552445035455, 2374.6200607902824, 2376.7860892519757, 2377.655239990209, 17007.979521228764, 17345.91327043369, 18479.907600462047, 18715.064246787606, 18937.0, 2252.2117258959397, 2293.151533932439, 2359.445530300378, 2375.3705268103968, 2395.652630368604, 158314.0, 161851.0, 166731.0, 171410.28589714193, 172506.0, 19498.902505487382, 25253.494930101664, 25831.483370332488, 26202.737972620413, 26435.0, 33510.832445837616, 33956.1510962223, 40383.39424908629, 40613.79693101575, 40660.39009414861, 10685.305455145392, 11074.224804263624, 11254.15593830466, 11254.212205145725, 11450.083993280517, 8769.035406105324, 8793.0, 8856.0, 8903.510306933182, 9029.187373136449, 9461.49270443333, 11309.09527237819, 11324.603638872764, 11420.828687569694, 11524.423778811026, 3826.6747326477002, 4005.899852503711, 4195.622393984556, 4729.787159577827, 4742.340180936713, 892.794657228828, 913.2465715784505, 937.7514958535993, 952.79991201847, 978.7699890525721, 20592.58814823695, 21157.0, 21186.94065296729, 21232.150713971267, 21252.043658035425, 816.9175842009242, 989.3371441134457, 993.7614972406715, 1021.3463383434607, 1024.8616436781087, 10189.694309170589, 10198.694039178836, 10572.841407378895, 10768.946155269174, 10793.892061079447, 559432.0, 560202.0, 560686.0, 575229.0, 577924.0, 110939.0, 128705.0, 143140.0, 144157.0, 148094.25952870166, 1122.2200570603516, 1195.6413266106242, 1210.8910198082215, 1243.4839541590138, 1280.974380512366, 17734.0, 18264.543386415447, 20702.585948281252, 22141.77858221397, 22961.54076918419, 55185.37211847463, 56350.718246408505, 56956.0, 57138.14292785528, 58300.29546602025, 77165.07087322861, 77842.6107869457, 78074.0, 79984.8002279978, 80244.59877700574, 11867.881321186678, 12073.154879158727, 12590.685232868886, 12683.746325073262, 13266.734665306833, 14021.228832414316, 14061.437542498186, 14275.428982840986, 14311.856881431053, 14515.129092254498, 9522.23822094217, 11599.188056835941, 11838.112141589243, 12065.939670301592, 12311.015118790296, 9010.90989090127, 11035.944820276169, 11124.165687573626, 11388.54445822191, 11523.596674116367, 12231.877681223074, 12237.69405764863, 12240.755184896074, 12435.37823108859, 12455.0, 12995.805062923875, 13037.15258508194, 13136.27750473733, 13358.332083395986, 13465.39405726725, 9070.319726020707, 11870.169088163746, 11925.34410607425, 12076.45655945467, 12213.206141600767], "value": 11833.33556177264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.4972135170663, 1431.699343137941, 1434.9497767578137, 1454.6217983324345, 1462.9268536573168, 11277.37974411407, 11407.48666310016, 11587.304761714282, 11623.418829058544, 11797.941010294948, 11173.0, 11343.773124537503, 11361.204715669906, 11371.0, 11411.201215914889, 2481.206014075501, 2522.72250052495, 2526.734692857251, 2531.4177739119923, 2540.2252313044514, 2146.2488129154826, 2297.115610489965, 2490.7633774791366, 2497.4880149569385, 2509.2723110297993, 2449.2774631483667, 2457.9016839326405, 2474.307193985687, 2488.191337815217, 2497.213377786001, 2438.6829712137487, 2440.4752978109614, 2470.0613766768693, 2470.28361775085, 2487.490064536784, 2408.8072954163626, 2468.5680005999056, 2493.47636996231, 2494.052260141153, 2514.635377870217, 9132.954335228347, 11556.479958401893, 11572.24780389272, 11596.0, 11608.0, 5312.442193569658, 6597.175353080865, 6664.733410663568, 6671.86656266872, 6700.363465470772, 3613.7831730096013, 3918.8236529356245, 4209.494860616715, 4222.092250166198, 4239.830406783725, 1053.7260312318776, 1138.6356365962895, 1264.4120483974905, 1272.0, 1284.3963337231487, 12302.876971230353, 15230.46693365727, 15704.371825126982, 16089.758653620205, 16142.515724528283, 5541.833744987657, 5794.21778059965, 6091.573589848668, 6097.939020609826, 6098.26820781509, 13503.459861605623, 13571.389287482087, 13617.863821361858, 13625.931870340584, 13629.931850340685, 6758.290379510179, 6759.493038022168, 6759.662016899136, 6769.42459890905, 6777.3900348967845, 5960.5827592068135, 6148.9692551536955, 6178.41305076017, 6192.380761923771, 6230.59501132425, 4093.263212621697, 4284.700070995001, 4467.374567560544, 4516.23224051912, 4779.522047795263, 1406.92965351732, 1443.9061461005, 1447.8479759625297, 1468.324570697491, 1468.3686015013648, 805.8831469437016, 811.9769090945333, 829.8257365953217, 832.342449464928, 863.6070587882498, 6170.784022559189, 6183.0, 6291.6854157291955, 6449.355064493607, 6449.451796597248, 594.7710131599365, 606.2482521673094, 613.7913109542777, 617.305531277313, 620.385818040137, 3918.3534716771983, 4176.686748493875, 4367.816091954023, 4484.529124441952, 4577.771111444415, 13914.234717090454, 14473.27633618315, 14487.78268325976, 14490.0, 14504.854951450561, 13034.47862085506, 14357.56927292162, 14359.353829077716, 14390.0, 14401.99186056966, 7390.224026477143, 8303.792405189797, 8396.286315663116, 8446.197611226924, 8490.320774338039, 6160.353162918008, 6888.41448476885, 6936.445084393337, 7095.751648692271, 7109.466789990668, 12472.438740256528, 12493.375331233221, 12840.229586224856, 13113.475460981454, 13329.733405332034, 13245.940324773803, 13298.00264980111, 13354.931605471345, 13357.732845342844, 13505.729885402434, 9165.862512062191, 9406.623735050794, 9440.19758320523, 9543.522823858919, 9555.522223888916, 10510.211734119819, 10542.103921166787, 10659.89340106589, 10673.733156671145, 10675.359478431319, 8889.911100889167, 9077.636894524145, 9131.908680913106, 9139.908600914172, 9186.31102667316, 8874.29005679557, 8887.555622218733, 8962.507062111647, 9008.729738107868, 9079.818403632022, 8145.470544414594, 8180.14108518597, 8219.342452603896, 8237.917620823715, 8238.711645092393, 5149.253358263106, 6071.332153463027, 6130.01919692847, 6172.660503672341, 6244.562880598314, 6008.909866351921, 6027.75888964454, 6165.229346331708, 6203.937960620517, 6326.4622507087415], "value": 5307.386097076568, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.761081491623, 387.6375588824449, 390.46701252789944, 396.40737098038437, 410.71660554217607, 5582.972085139569, 5935.872184284988, 6245.437910588046, 6271.0, 6363.995341467435, 4671.042436300559, 4957.330760347352, 4970.602351811855, 5273.973630131844, 5935.821925342236, 4293.978530107345, 4557.886052848688, 4562.908741825178, 4568.269076947689, 4618.699784514012, 4379.824807007716, 4488.775561221926, 4551.816527702788, 4577.404937358138, 4590.2196626573395, 4409.911801763963, 4465.508794032654, 4471.105778844244, 4471.5081341052455, 4471.642268618502, 3925.470061541698, 4497.865064048084, 4507.57178068083, 4530.139273538017, 4531.818727250906, 3734.271816995687, 3833.367494363427, 3883.941740873889, 3906.648401643837, 3909.0032041829436, 5418.864528386783, 6022.066579680157, 6032.185654936615, 6036.597245465327, 6053.001254792954, 5141.254518094893, 5363.280313324289, 5384.300040994684, 5393.622446428752, 5404.405885175138, 6055.818325450244, 6136.7545298188015, 6361.2048493938255, 6543.705533251015, 6608.900866487006, 4394.8681539553545, 4405.801738921757, 4411.338299255105, 4416.911661766779, 4434.955650443519, 6027.216461859974, 6830.829229269259, 6854.68761709679, 6952.157678215277, 7065.576065436039, 4101.323281658552, 4464.0, 4471.754053527022, 4473.351364052194, 4482.103579284156, 4555.9772201138785, 4563.516857021481, 4569.588737013684, 4571.771411429415, 4573.885652858705, 5213.113770658997, 5311.28297679816, 5368.355797304349, 5370.8657283567445, 5410.48600382963, 6606.339366063451, 6647.268800431949, 6650.406341526808, 6667.366495208608, 6669.699863506154, 1420.7229590229806, 1473.9659270207046, 1511.9773203401958, 1537.8846586506056, 1571.8899677022728, 872.4983134697575, 1002.2082554781787, 1015.8831734350645, 1032.2464600841429, 1042.525650828871, 5064.797408103708, 6286.937130628727, 6304.369563043659, 6341.365863413622, 6385.393387628168, 6207.379262073757, 6500.9349906501275, 6838.418734407532, 6851.828704282333, 6878.518503704692, 6269.905951410732, 6386.584871983399, 6434.163558737334, 6441.452476539453, 6495.610263384212, 2854.986479799683, 3143.795653282575, 3560.6973407260675, 3609.566851977727, 3621.7102631789394, 5574.386817450078, 6650.0, 7009.2990700929495, 7038.612876291853, 7109.751158709524, 5915.881682366328, 5926.585139040226, 7012.649367531603, 7157.821054473576, 7170.494196218852, 5248.317718696545, 5711.914321285184, 6072.906876762137, 6082.026875699867, 7085.362317391459, 5593.804216852391, 6099.425430926805, 6198.6280823150755, 6531.542792004514, 6895.65573688573, 5948.048312270016, 6488.604949935598, 6592.604443733199, 6726.6972986216715, 6767.695453704693, 5587.69267690281, 6321.0834429008455, 6467.0, 6706.329367063255, 7064.633347828535, 3762.2099359133795, 4496.235639941153, 4521.954780452285, 4531.501534831232, 4538.568835960578, 6659.934410494491, 6728.865422691617, 6808.319168083152, 6851.0, 6878.896816547855, 6311.463525600192, 6636.2368327642935, 6643.202815662152, 6655.933440665532, 6672.232693240339, 5739.569532285179, 5742.655440673573, 6357.809265722036, 6402.295747467681, 6676.298988606127, 6045.425684559959, 6096.786612468542, 6460.967695161494, 6505.60966342002, 6527.988161834924, 6100.816975490742, 6332.905006425, 6627.204735431779, 6655.800325990228, 6681.318681318681, 5318.654287471302, 6524.380183882713, 6525.184351956005, 6555.2789193187755, 6575.178102737158], "value": 4749.181378957599, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [833.4415941319315, 843.2579330189428, 856.0925419055801, 865.0052439694351, 867.6876324523171, 14030.508932187375, 14619.853801461983, 16445.917770411146, 16855.241514131863, 16932.746008809878, 16838.494845154633, 17244.22400991955, 17575.209115589798, 17607.91196044018, 17614.20736066877, 972.0182615558266, 977.1889331854561, 990.301837204769, 993.5578667492969, 995.7659949911765, 983.7884854756226, 1004.4525733475238, 1007.9949600251988, 1011.1203253169753, 1014.467404612577, 1054.114543783222, 1063.6064656077224, 1064.1008347946013, 1064.1486810551567, 1068.6633710381243, 1032.8554002439664, 1049.5329578337644, 1060.0618452669444, 1060.9522571484301, 1064.1858977881927, 778.7858338956776, 787.6140691061339, 787.7124849429974, 791.8653828849109, 792.5482474989259, 13537.458501659921, 13672.316384180851, 15684.843151568452, 16255.674886502204, 16515.256813443422, 16625.7506137408, 16879.07165105919, 17199.828001720074, 17358.56603584908, 17379.044152571605, 13752.243626600533, 14096.859031409656, 14134.010619256656, 14297.285135743172, 14299.428022879072, 3453.3611281912927, 3456.913577160566, 3567.6432356764376, 3580.0154957386667, 3609.7292703047115, 115744.0, 118614.0, 119109.40445297718, 119384.0, 119760.40119799346, 11820.0543956485, 13137.802932956014, 13650.249236292098, 13690.247036412893, 13697.315134243248, 24975.875120624645, 25024.999000039796, 25460.363490912507, 25734.48531029369, 25896.093636723002, 6416.294207637156, 7348.375388092072, 7555.055618047744, 7630.2751238633355, 7643.9617801911745, 3856.8650097246464, 3945.861894833667, 3947.940780888289, 3948.230095131422, 3948.368261078271, 4322.330038843984, 4683.250679891201, 4801.087793319258, 4857.125717370907, 4857.80568777252, 953.1850268020881, 969.96120155193, 973.1679414100842, 988.7874107067015, 990.4206039466849, 645.602954183174, 663.465909942501, 665.1253601513994, 670.3497607320891, 685.6229074009375, 9787.972262912434, 10007.349522281029, 10693.465326733633, 10999.945000274947, 12067.405507815685, 648.8410339466861, 651.1567520061532, 660.3129005391271, 665.1286814273318, 668.3350066683681, 4573.474050484237, 5104.183330667075, 5414.35027796667, 5473.0, 5641.435856414408, 101924.0, 104752.47623761985, 105719.47140264403, 105790.47104764427, 106748.46625766977, 93984.0, 95805.0, 96303.51848240713, 96439.51780241194, 96885.0, 72011.63994179995, 73584.63207684034, 76260.0, 76864.0, 76941.0, 11651.41742912834, 12153.0, 12217.633470995885, 12281.263124212575, 12352.814707779211, 25985.870070649526, 38348.80825595854, 38947.02632434212, 39473.013174670865, 40518.18963620652, 42952.0, 45016.54983450124, 49063.509364907324, 50287.497125029746, 50813.98372032613, 13482.0, 15410.0, 15691.293891775125, 15884.205789710237, 16426.85012049145, 17988.37040703569, 18018.099095045458, 18198.636027279645, 18229.726554101435, 18285.0, 14404.42382304696, 15842.890997630517, 16256.91871540682, 16320.67358652844, 16324.755128673318, 15646.139462329225, 16137.0, 16189.919050404673, 16223.837761622233, 16296.918515407348, 15849.603759906095, 16013.91993040074, 16240.02559846413, 16303.755443668117, 16408.917955410147, 10619.469026548797, 10626.149908007495, 10631.096356809758, 11171.832422513506, 11412.828807567726, 12488.687782805502, 12562.748745024866, 12574.245545267313, 12593.244405335709, 12629.179103358252], "value": 8220.88854803221, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 161.0, 122.0, 141.0, 137.0, 108.0, 161.0, 165.0, 116.0, 158.0], "value": 138.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 108.0, 113.0, 153.0, 112.0, 111.0, 145.0, 132.0, 145.0, 115.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [253.0, 266.0, 261.0, 253.0, 286.0, 203.0, 200.0, 196.0, 200.0, 203.0], "value": 232.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 58.0, 58.0, 90.0, 59.0, 60.0, 57.0, 57.0, 74.0, 58.0], "value": 65.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 84.0, 72.0, 72.0, 70.0, 89.0, 71.0, 72.0, 90.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 133.0, 98.0, 122.0, 135.0, 90.0, 104.0, 104.0, 119.0], "value": 108.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 136.0, 101.0, 103.0, 121.0, 155.0, 96.0, 97.0, 98.0, 96.0], "value": 110.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 91.0, 93.0, 91.0, 91.0, 92.0, 92.0, 89.0, 91.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 48.0, 50.0, 50.0, 48.0, 47.0, 49.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 78.0, 64.0, 58.0, 62.0, 60.0, 81.0, 85.0, 87.0, 83.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 104.0, 84.0, 74.0, 96.0, 105.0, 106.0, 105.0, 73.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 148.0, 130.0, 133.0, 137.0, 141.0, 155.0, 152.0, 221.0, 152.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 189.0, 188.0, 185.0, 189.0, 187.0, 188.0, 184.0, 188.0], "value": 187.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 70.0, 69.0, 83.0, 96.0, 96.0, 69.0, 71.0, 68.0], "value": 76.5, "unit": "score"}]}]} 12:23:08 INFO - Return code: 0 12:23:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:23:08 ERROR - # TBPL SUCCESS # 12:23:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:23:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:23:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:23:08 INFO - 2017-04-16 12:23:08.621 screenresolution[3178:63445] starting screenresolution argv=screenresolution get 12:23:08 INFO - 2017-04-16 12:23:08.623 screenresolution[3178:63445] Display 0: 1600x1200x32@60 12:23:08 INFO - 2017-04-16 12:23:08.629 screenresolution[3179:63448] starting screenresolution argv=screenresolution list 12:23:08 INFO - Available Modes on Display 0 12:23:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:23:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:23:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:23:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:23:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:23:08 INFO - Intel Iris: 12:23:08 INFO - Chipset Model: Intel Iris 12:23:08 INFO - Type: GPU 12:23:08 INFO - Bus: Built-In 12:23:08 INFO - VRAM (Dynamic, Max): 1536 MB 12:23:08 INFO - Vendor: Intel (0x8086) 12:23:08 INFO - Device ID: 0x0a2e 12:23:08 INFO - Revision ID: 0x0009 12:23:08 INFO - Displays: 12:23:08 INFO - Display: 12:23:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:23:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:23:08 INFO - Display Serial Number: 1600x1200 60 12:23:08 INFO - Main Display: Yes 12:23:08 INFO - Mirror: Off 12:23:08 INFO - Online: Yes 12:23:08 INFO - Rotation: Supported 12:23:08 INFO - Return code: 0 12:23:08 INFO - Running post-action listener: _resource_record_post_action 12:23:08 INFO - [mozharness: 2017-04-16 19:23:08.866058Z] Finished run-tests step (success) 12:23:08 INFO - Running post-run listener: _resource_record_post_run 12:23:08 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 1176064; Write bytes: 520049152; Read time: 5; Write time: 1692 12:23:08 INFO - TinderboxPrint: CPU usage
54.3% 12:23:08 INFO - TinderboxPrint: I/O read bytes / time
1,176,064 / 5 12:23:08 INFO - TinderboxPrint: I/O write bytes / time
520,049,152 / 1,692 12:23:08 INFO - TinderboxPrint: CPU idle
2,194.6 (45.7%) 12:23:08 INFO - TinderboxPrint: CPU system
970.3 (20.2%) 12:23:08 INFO - TinderboxPrint: CPU user
1,632.8 (34.0%) 12:23:08 INFO - TinderboxPrint: Swap in / out
209,207,296 / 0 12:23:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209328640; Write bytes: 211167232; Read time: 16135; Write time: 493 12:23:08 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 233984; Write bytes: 307546624; Read time: 1; Write time: 1190 12:23:09 INFO - Running post-run listener: _upload_blobber_files 12:23:09 INFO - Blob upload gear active. 12:23:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:23:09 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:23:09 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:23:09 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:23:09 INFO - (blobuploader) - INFO - Open directory for files ... 12:23:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:23:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:23:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:10 INFO - (blobuploader) - INFO - Done attempting. 12:23:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:23:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:11 INFO - (blobuploader) - INFO - Done attempting. 12:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:12 INFO - (blobuploader) - INFO - Done attempting. 12:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:23:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:23:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:23:14 INFO - (blobuploader) - INFO - Done attempting. 12:23:14 INFO - (blobuploader) - INFO - Iteration through files over. 12:23:14 INFO - Return code: 0 12:23:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:23:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:23:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca51925411d9c65f108425a6ed996495fda730d291f5bcda6b5c6bf102a04045e6911c13537197b2bbfe11bccdb0b1d2fdea31c5e72f6679a0f8833ec194b656", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e96a0833f83c2df899c88278c41db841541316c2fb45b31cf9b1996174198d9dee70dad3e2850529b3950dac6d8bef312b0ed43e2e480ce5a8e0e7e01e67845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ecc6e767d5bf74a9a60b43cd9c38ad2eec65626c18a8f58a27185fecb5b1c9fbcf71c0fe02d8d799dd106a034bd1aea26ef1eb4470cbd992bf113bf6d9bfb00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/501ed2f37b421b56d2e14e528f3b219152ce0e66e7627abb70e03686f3f0a18c84f5b6223c338b044d87d30120fb8526e0d85ac041a8b304803e3ec3a5992112"} 12:23:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:23:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:23:14 INFO - Contents: 12:23:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca51925411d9c65f108425a6ed996495fda730d291f5bcda6b5c6bf102a04045e6911c13537197b2bbfe11bccdb0b1d2fdea31c5e72f6679a0f8833ec194b656", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e96a0833f83c2df899c88278c41db841541316c2fb45b31cf9b1996174198d9dee70dad3e2850529b3950dac6d8bef312b0ed43e2e480ce5a8e0e7e01e67845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ecc6e767d5bf74a9a60b43cd9c38ad2eec65626c18a8f58a27185fecb5b1c9fbcf71c0fe02d8d799dd106a034bd1aea26ef1eb4470cbd992bf113bf6d9bfb00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/501ed2f37b421b56d2e14e528f3b219152ce0e66e7627abb70e03686f3f0a18c84f5b6223c338b044d87d30120fb8526e0d85ac041a8b304803e3ec3a5992112"} 12:23:14 INFO - Running post-run listener: copy_logs_to_upload_dir 12:23:14 INFO - Copying logs to upload dir... 12:23:14 INFO - mkdir: /builds/slave/test/build/upload/logs 12:23:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.251122 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-16 12:23:14.448600) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-16 12:23:14.452383) ========= 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.DOOvRHNTk7/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.P6fWHkPM00/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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/ca51925411d9c65f108425a6ed996495fda730d291f5bcda6b5c6bf102a04045e6911c13537197b2bbfe11bccdb0b1d2fdea31c5e72f6679a0f8833ec194b656", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e96a0833f83c2df899c88278c41db841541316c2fb45b31cf9b1996174198d9dee70dad3e2850529b3950dac6d8bef312b0ed43e2e480ce5a8e0e7e01e67845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ecc6e767d5bf74a9a60b43cd9c38ad2eec65626c18a8f58a27185fecb5b1c9fbcf71c0fe02d8d799dd106a034bd1aea26ef1eb4470cbd992bf113bf6d9bfb00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/501ed2f37b421b56d2e14e528f3b219152ce0e66e7627abb70e03686f3f0a18c84f5b6223c338b044d87d30120fb8526e0d85ac041a8b304803e3ec3a5992112"} build_url:https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011370 build_url: 'https://queue.taskcluster.net/v1/task/b2J4cj8eTVCW_-4aWVsVgg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca51925411d9c65f108425a6ed996495fda730d291f5bcda6b5c6bf102a04045e6911c13537197b2bbfe11bccdb0b1d2fdea31c5e72f6679a0f8833ec194b656", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2e96a0833f83c2df899c88278c41db841541316c2fb45b31cf9b1996174198d9dee70dad3e2850529b3950dac6d8bef312b0ed43e2e480ce5a8e0e7e01e67845", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6ecc6e767d5bf74a9a60b43cd9c38ad2eec65626c18a8f58a27185fecb5b1c9fbcf71c0fe02d8d799dd106a034bd1aea26ef1eb4470cbd992bf113bf6d9bfb00", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/501ed2f37b421b56d2e14e528f3b219152ce0e66e7627abb70e03686f3f0a18c84f5b6223c338b044d87d30120fb8526e0d85ac041a8b304803e3ec3a5992112"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-16 12:23:14.487462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 12:23:14.487857) ========= 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.DOOvRHNTk7/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.P6fWHkPM00/Listeners TMPDIR=/var/folders/h3/20tcmn5d6x595zch842vg_xh00000w/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.005210 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-16 12:23:14.536520) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-16 12:23:14.536852) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-16 12:23:14.537154) ========= ========= Total master_lag: 0.22 =========