builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0312 starttime: 1468605129.88 results: success (0) buildid: 20160713141046 builduid: f56c373fb50a40f583c4b414d4dcca39 revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:09.885224) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:09.885643) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:09.885932) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.014290) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.014536) ========= 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.CgibK8ett2/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.AqMlZrDhiz/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 --2016-07-15 10:52:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 148M=0s 2016-07-15 10:52:10 (148 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158473 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.199501) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.199768) ========= 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.CgibK8ett2/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.AqMlZrDhiz/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.021227 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.248348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.248645) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --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 5fd14a66be3191e5628af3cfb0a456dd70f179b8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgibK8ett2/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.AqMlZrDhiz/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 2016-07-15 10:52:10,332 truncating revision to first 12 chars 2016-07-15 10:52:10,332 Setting DEBUG logging. 2016-07-15 10:52:10,332 attempt 1/10 2016-07-15 10:52:10,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5fd14a66be31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 10:52:10,677 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.604467 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.878848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.879187) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.879563) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.879856) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:10.899204) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 0 secs) (at 2016-07-15 10:52:10.899633) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--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.CgibK8ett2/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.AqMlZrDhiz/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:52:11 INFO - MultiFileLogger online at 20160715 10:52:11 in /builds/slave/test 10:52:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:52:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:11 INFO - {'append_to_log': False, 10:52:11 INFO - 'base_work_dir': '/builds/slave/test', 10:52:11 INFO - 'blob_upload_branch': 'Firefox', 10:52:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:11 INFO - 'branch': 'Firefox', 10:52:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:11 INFO - 'config_files': ('talos/mac_config.py',), 10:52:11 INFO - 'default_actions': ('clobber', 10:52:11 INFO - 'read-buildbot-config', 10:52:11 INFO - 'download-and-extract', 10:52:11 INFO - 'populate-webroot', 10:52:11 INFO - 'create-virtualenv', 10:52:11 INFO - 'install', 10:52:11 INFO - 'run-tests'), 10:52:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:11 INFO - 'download_minidump_stackwalk': True, 10:52:11 INFO - 'download_symbols': 'ondemand', 10:52:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:11 INFO - 'installer_path': 'installer.exe', 10:52:11 INFO - 'log_level': 'info', 10:52:11 INFO - 'log_name': 'talos', 10:52:11 INFO - 'log_to_console': True, 10:52:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:52:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:52:11 INFO - 'opt_config_files': (), 10:52:11 INFO - 'pip_index': False, 10:52:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:11 INFO - 'cmd': ('bash', 10:52:11 INFO - '-c', 10:52:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:11 INFO - 'enabled': True, 10:52:11 INFO - 'halt_on_failure': False, 10:52:11 INFO - 'name': 'check_screen_resolution'},), 10:52:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:11 INFO - 'cmd': ('bash', 10:52:11 INFO - '-c', 10:52:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:11 INFO - 'enabled': True, 10:52:11 INFO - 'halt_on_failure': False, 10:52:11 INFO - 'name': 'check_screen_resolution'},), 10:52:11 INFO - 'run_cmd_checks_enabled': True, 10:52:11 INFO - 'sps_profile': False, 10:52:11 INFO - 'sps_profile_interval': 0, 10:52:11 INFO - 'suite': 'dromaeojs', 10:52:11 INFO - 'system_bits': '32', 10:52:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:11 INFO - 'title': 't-yosemite-r7-0312', 10:52:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:11 INFO - 'use_talos_json': True, 10:52:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:11 INFO - 'work_dir': 'build'} 10:52:11 INFO - ##### 10:52:11 INFO - ##### Running clobber step. 10:52:11 INFO - ##### 10:52:11 INFO - Running pre-action listener: _resource_record_pre_action 10:52:11 INFO - Running main action method: clobber 10:52:11 INFO - rmtree: /builds/slave/test/build 10:52:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:13 INFO - Running post-action listener: _resource_record_post_action 10:52:13 INFO - ##### 10:52:13 INFO - ##### Finished clobber step (success) 10:52:13 INFO - ##### 10:52:13 INFO - ##### 10:52:13 INFO - ##### Running read-buildbot-config step. 10:52:13 INFO - ##### 10:52:13 INFO - Running pre-action listener: _resource_record_pre_action 10:52:13 INFO - Running main action method: read_buildbot_config 10:52:13 INFO - Using buildbot properties: 10:52:13 INFO - { 10:52:13 INFO - "project": "", 10:52:13 INFO - "product": "firefox", 10:52:13 INFO - "script_repo_revision": "production", 10:52:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 10:52:13 INFO - "repository": "", 10:52:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 10:52:13 INFO - "buildid": "20160713141046", 10:52:13 INFO - "pgo_build": "False", 10:52:13 INFO - "basedir": "/builds/slave/test", 10:52:13 INFO - "buildnumber": 13, 10:52:13 INFO - "slavename": "t-yosemite-r7-0312", 10:52:13 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 10:52:13 INFO - "platform": "yosemite_r7", 10:52:13 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:52:13 INFO - "branch": "mozilla-central", 10:52:13 INFO - "repo_path": "mozilla-central", 10:52:13 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 10:52:13 INFO - "stage_platform": "macosx64", 10:52:13 INFO - "builduid": "f56c373fb50a40f583c4b414d4dcca39", 10:52:13 INFO - "slavebuilddir": "test" 10:52:13 INFO - } 10:52:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:52:13 INFO - Running post-action listener: _resource_record_post_action 10:52:13 INFO - ##### 10:52:13 INFO - ##### Finished read-buildbot-config step (success) 10:52:13 INFO - ##### 10:52:13 INFO - ##### 10:52:13 INFO - ##### Running download-and-extract step. 10:52:13 INFO - ##### 10:52:13 INFO - Running pre-action listener: _resource_record_pre_action 10:52:13 INFO - Running main action method: download_and_extract 10:52:13 INFO - mkdir: /builds/slave/test/build/tests 10:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:52:13 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:52:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:52:43 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 10:52:43 INFO - retry: attempt #1 caught exception: timed out 10:52:43 INFO - retry: Failed, sleeping 30 seconds before retrying 10:53:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 10:53:34 INFO - Downloaded 1199 bytes. 10:53:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:53:34 INFO - Using the following test package requirements: 10:53:34 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:53:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:53:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:53:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'jsshell-mac.zip'], 10:53:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:53:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:53:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:53:34 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:53:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:53:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:53:34 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:53:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:34 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:53:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:53:44 INFO - Downloaded 18827271 bytes. 10:53:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:53:47 INFO - Return code: 0 10:53:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:53:47 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:54:08 INFO - Downloaded 18827271 bytes. 10:54:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:54:12 INFO - Return code: 0 10:54:12 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:12 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:54:13 INFO - Downloaded 14403317 bytes. 10:54:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:54:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:54:13 INFO - Return code: 0 10:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:13 INFO - https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:54:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:54:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:54:16 INFO - Downloaded 112779863 bytes. 10:54:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:16 INFO - mkdir: /builds/slave/test/properties 10:54:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:54:16 INFO - Writing to file /builds/slave/test/properties/build_url 10:54:16 INFO - Contents: 10:54:16 INFO - build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:54:17 INFO - Running post-action listener: _resource_record_post_action 10:54:17 INFO - Running post-action listener: set_extra_try_arguments 10:54:17 INFO - ##### 10:54:17 INFO - ##### Finished download-and-extract step (success) 10:54:17 INFO - ##### 10:54:17 INFO - ##### 10:54:17 INFO - ##### Running populate-webroot step. 10:54:17 INFO - ##### 10:54:17 INFO - Running pre-action listener: _resource_record_pre_action 10:54:17 INFO - Running main action method: populate_webroot 10:54:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:54:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:54:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:54:17 INFO - '--tppagecycles', 10:54:17 INFO - '7'], 10:54:17 INFO - 'tests': ['tsvgm']}}, 10:54:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:54:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:54:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:54:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:54:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:54:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['damp', 'tps']}, 10:54:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'tests': ['damp', 'tps']}, 10:54:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['dromaeo_dom']}, 10:54:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:54:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['basic_compositor_video']}, 10:54:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:54:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['a11yr', 10:54:17 INFO - 'ts_paint', 10:54:17 INFO - 'tpaint', 10:54:17 INFO - 'sessionrestore', 10:54:17 INFO - 'sessionrestore_no_auto_restore', 10:54:17 INFO - 'tabpaint']}, 10:54:17 INFO - 'other-e10s': {'tests': ['a11yr', 10:54:17 INFO - 'ts_paint', 10:54:17 INFO - 'tpaint', 10:54:17 INFO - 'sessionrestore', 10:54:17 INFO - 'sessionrestore_no_auto_restore', 10:54:17 INFO - 'tabpaint']}, 10:54:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:54:17 INFO - 'ts_paint', 10:54:17 INFO - 'tpaint', 10:54:17 INFO - 'sessionrestore', 10:54:17 INFO - 'sessionrestore_no_auto_restore', 10:54:17 INFO - 'tabpaint']}, 10:54:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:54:17 INFO - 'ts_paint', 10:54:17 INFO - 'tpaint', 10:54:17 INFO - 'sessionrestore', 10:54:17 INFO - 'sessionrestore_no_auto_restore', 10:54:17 INFO - 'tabpaint']}, 10:54:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['a11yr', 10:54:17 INFO - 'ts_paint', 10:54:17 INFO - 'tpaint', 10:54:17 INFO - 'sessionrestore', 10:54:17 INFO - 'sessionrestore_no_auto_restore', 10:54:17 INFO - 'tabpaint']}, 10:54:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['a11yr', 10:54:17 INFO - 'ts_paint', 10:54:17 INFO - 'tpaint', 10:54:17 INFO - 'sessionrestore', 10:54:17 INFO - 'sessionrestore_no_auto_restore', 10:54:17 INFO - 'tabpaint']}, 10:54:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['tsvgx', 10:54:17 INFO - 'tsvgr_opacity', 10:54:17 INFO - 'tart', 10:54:17 INFO - 'tscrollx', 10:54:17 INFO - 'cart']}, 10:54:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:54:17 INFO - 'tsvgr_opacity', 10:54:17 INFO - 'tart', 10:54:17 INFO - 'tscrollx', 10:54:17 INFO - 'cart']}, 10:54:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'talos_options': ['--disable-e10s'], 10:54:17 INFO - 'tests': ['tp5o']}, 10:54:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'tests': ['tp5o']}, 10:54:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'talos_options': ['--disable-e10s', 10:54:17 INFO - '--xperf_path', 10:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:17 INFO - 'tests': ['tp5n']}, 10:54:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:54:17 INFO - 'talos_options': ['--xperf_path', 10:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:54:17 INFO - 'tests': ['tp5n']}}, 10:54:17 INFO - 'talos.zip': {'path': '', 10:54:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:54:17 INFO - Running post-action listener: _resource_record_post_action 10:54:17 INFO - ##### 10:54:17 INFO - ##### Finished populate-webroot step (success) 10:54:17 INFO - ##### 10:54:17 INFO - ##### 10:54:17 INFO - ##### Running create-virtualenv step. 10:54:17 INFO - ##### 10:54:17 INFO - Running pre-action listener: _resource_record_pre_action 10:54:17 INFO - Running main action method: create_virtualenv 10:54:17 INFO - Creating virtualenv /builds/slave/test/build/venv 10:54:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:54:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:54:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:54:17 INFO - Using real prefix '/tools/python27' 10:54:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:54:18 INFO - Installing distribute.............................................................................................................................................................................................done. 10:54:21 INFO - Installing pip.................done. 10:54:21 INFO - Return code: 0 10:54:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:21 INFO - 'HOME': '/Users/cltbld', 10:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:21 INFO - 'LOGNAME': 'cltbld', 10:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:21 INFO - 'MOZ_NO_REMOTE': '1', 10:54:21 INFO - 'NO_EM_RESTART': '1', 10:54:21 INFO - 'PAGER': '/bin/cat', 10:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:21 INFO - 'PWD': '/builds/slave/test', 10:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:21 INFO - 'SHELL': '/bin/bash', 10:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:21 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:21 INFO - 'USER': 'cltbld', 10:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:21 INFO - 'XPC_FLAGS': '0x0', 10:54:21 INFO - 'XPC_SERVICE_NAME': '0', 10:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:54:21 INFO - Cleaning up... 10:54:21 INFO - Return code: 0 10:54:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:54:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:54:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:21 INFO - 'HOME': '/Users/cltbld', 10:54:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:21 INFO - 'LOGNAME': 'cltbld', 10:54:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:21 INFO - 'MOZ_NO_REMOTE': '1', 10:54:21 INFO - 'NO_EM_RESTART': '1', 10:54:21 INFO - 'PAGER': '/bin/cat', 10:54:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:21 INFO - 'PWD': '/builds/slave/test', 10:54:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:21 INFO - 'SHELL': '/bin/bash', 10:54:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:21 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:21 INFO - 'USER': 'cltbld', 10:54:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:21 INFO - 'XPC_FLAGS': '0x0', 10:54:21 INFO - 'XPC_SERVICE_NAME': '0', 10:54:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:21 INFO - Downloading/unpacking psutil>=3.1.1 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:54:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:24 INFO - Installing collected packages: psutil 10:54:24 INFO - Running setup.py install for psutil 10:54:25 INFO - building 'psutil._psutil_osx' extension 10:54:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:54:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:54:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:54:25 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:54:25 INFO - building 'psutil._psutil_posix' extension 10:54:25 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 10:54:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:54:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:54:25 INFO - ^ 10:54:25 INFO - 1 warning generated. 10:54:25 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 10:54:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:54:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:54:25 INFO - Successfully installed psutil 10:54:25 INFO - Cleaning up... 10:54:25 INFO - Return code: 0 10:54:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:25 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 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:25 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 10:54:25 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 10:54:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:25 INFO - 'HOME': '/Users/cltbld', 10:54:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:25 INFO - 'LOGNAME': 'cltbld', 10:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:25 INFO - 'MOZ_NO_REMOTE': '1', 10:54:25 INFO - 'NO_EM_RESTART': '1', 10:54:25 INFO - 'PAGER': '/bin/cat', 10:54:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:25 INFO - 'PWD': '/builds/slave/test', 10:54:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:25 INFO - 'SHELL': '/bin/bash', 10:54:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:25 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:25 INFO - 'USER': 'cltbld', 10:54:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:25 INFO - 'XPC_FLAGS': '0x0', 10:54:25 INFO - 'XPC_SERVICE_NAME': '0', 10:54:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 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 10:54:26 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 10:54:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:54:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:54:28 INFO - Installing collected packages: mozsystemmonitor 10:54:28 INFO - Running setup.py install for mozsystemmonitor 10:54:28 INFO - Successfully installed mozsystemmonitor 10:54:28 INFO - Cleaning up... 10:54:28 INFO - Return code: 0 10:54:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:28 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 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:28 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 10:54:28 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 10:54:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:28 INFO - 'HOME': '/Users/cltbld', 10:54:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:28 INFO - 'LOGNAME': 'cltbld', 10:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:28 INFO - 'MOZ_NO_REMOTE': '1', 10:54:28 INFO - 'NO_EM_RESTART': '1', 10:54:28 INFO - 'PAGER': '/bin/cat', 10:54:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:28 INFO - 'PWD': '/builds/slave/test', 10:54:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:28 INFO - 'SHELL': '/bin/bash', 10:54:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:28 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:28 INFO - 'USER': 'cltbld', 10:54:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:28 INFO - 'XPC_FLAGS': '0x0', 10:54:28 INFO - 'XPC_SERVICE_NAME': '0', 10:54:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:29 INFO - Downloading/unpacking jsonschema==2.5.1 10:54:29 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 10:54:29 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 10:54:29 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 10:54:29 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 10:54:29 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 10:54:29 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 10:54:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:31 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:32 INFO - warning: no files found matching '*.txt' 10:54:32 INFO - no previously-included directories found matching 'build' 10:54:32 INFO - no previously-included directories found matching 'dist' 10:54:32 INFO - no previously-included directories found matching '.git*' 10:54:32 INFO - Installing collected packages: jsonschema, functools32 10:54:32 INFO - Running setup.py install for functools32 10:54:32 INFO - warning: no files found matching '*.txt' 10:54:32 INFO - no previously-included directories found matching 'build' 10:54:32 INFO - no previously-included directories found matching 'dist' 10:54:32 INFO - no previously-included directories found matching '.git*' 10:54:32 INFO - Successfully installed jsonschema functools32 10:54:32 INFO - Cleaning up... 10:54:32 INFO - Return code: 0 10:54:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:32 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 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:32 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 10:54:32 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 10:54:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:32 INFO - 'HOME': '/Users/cltbld', 10:54:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:32 INFO - 'LOGNAME': 'cltbld', 10:54:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:32 INFO - 'MOZ_NO_REMOTE': '1', 10:54:32 INFO - 'NO_EM_RESTART': '1', 10:54:32 INFO - 'PAGER': '/bin/cat', 10:54:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:32 INFO - 'PWD': '/builds/slave/test', 10:54:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:32 INFO - 'SHELL': '/bin/bash', 10:54:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:32 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:32 INFO - 'USER': 'cltbld', 10:54:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:32 INFO - 'XPC_FLAGS': '0x0', 10:54:32 INFO - 'XPC_SERVICE_NAME': '0', 10:54:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:32 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:32 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 10:54:32 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 10:54:32 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 10:54:32 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 10:54:32 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 10:54:32 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 10:54:35 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:36 INFO - Downloading docopt-0.6.1.tar.gz 10:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:36 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:36 INFO - Running setup.py install for blobuploader 10:54:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:36 INFO - Running setup.py install for requests 10:54:36 INFO - Running setup.py install for docopt 10:54:37 INFO - Successfully installed blobuploader requests docopt 10:54:37 INFO - Cleaning up... 10:54:37 INFO - Return code: 0 10:54:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:37 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:37 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 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:37 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 10:54:37 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 10:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:37 INFO - 'HOME': '/Users/cltbld', 10:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:37 INFO - 'LOGNAME': 'cltbld', 10:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:37 INFO - 'MOZ_NO_REMOTE': '1', 10:54:37 INFO - 'NO_EM_RESTART': '1', 10:54:37 INFO - 'PAGER': '/bin/cat', 10:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:37 INFO - 'PWD': '/builds/slave/test', 10:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:37 INFO - 'SHELL': '/bin/bash', 10:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:37 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:37 INFO - 'USER': 'cltbld', 10:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:37 INFO - 'XPC_FLAGS': '0x0', 10:54:37 INFO - 'XPC_SERVICE_NAME': '0', 10:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:37 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lai7un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gF1WMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-hWSm1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5ECEZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-dt3t8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-UjUlzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-9kxq1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-upsnqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lp_GqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:38 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NOPZMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MCJkRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VQ_Xg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VY2Gxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gNTiap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-b_rNiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EDScgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:39 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-97IGzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:39 INFO - Running setup.py install for manifestparser 10:54:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:39 INFO - Running setup.py install for mozcrash 10:54:40 INFO - Running setup.py install for mozdebug 10:54:40 INFO - Running setup.py install for mozdevice 10:54:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Running setup.py install for mozfile 10:54:40 INFO - Running setup.py install for mozhttpd 10:54:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Running setup.py install for mozinfo 10:54:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Running setup.py install for mozInstall 10:54:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:40 INFO - Running setup.py install for mozleak 10:54:41 INFO - Running setup.py install for mozlog 10:54:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:41 INFO - Running setup.py install for moznetwork 10:54:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:41 INFO - Running setup.py install for mozprocess 10:54:41 INFO - Running setup.py install for mozprofile 10:54:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:41 INFO - Running setup.py install for mozrunner 10:54:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:41 INFO - Running setup.py install for mozscreenshot 10:54:42 INFO - Running setup.py install for moztest 10:54:42 INFO - Running setup.py install for mozversion 10:54:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:42 INFO - Cleaning up... 10:54:42 INFO - Return code: 0 10:54:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:42 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 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:42 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 10:54:42 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 10:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:42 INFO - 'HOME': '/Users/cltbld', 10:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:42 INFO - 'LOGNAME': 'cltbld', 10:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:42 INFO - 'MOZ_NO_REMOTE': '1', 10:54:42 INFO - 'NO_EM_RESTART': '1', 10:54:42 INFO - 'PAGER': '/bin/cat', 10:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:42 INFO - 'PWD': '/builds/slave/test', 10:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:42 INFO - 'SHELL': '/bin/bash', 10:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:42 INFO - 'USER': 'cltbld', 10:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:42 INFO - 'XPC_FLAGS': '0x0', 10:54:42 INFO - 'XPC_SERVICE_NAME': '0', 10:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:42 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NoUBUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:42 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)) 10:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:42 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cNHiLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 10:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:42 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-brmaXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:42 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)) 10:54:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:42 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-j_flOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-_SJd6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:43 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-FLH5iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:43 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uoX2Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:43 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-OnJKJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:43 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Qjl1tE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:43 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4aZI8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-B3Ywgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:43 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)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-7UAuHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:54:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:43 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-IuxTtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:44 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)) 10:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:44 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PT8BrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:44 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-LqV5Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:44 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)) 10:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:44 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-yefNuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 10:54:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:44 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-IAjNuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:44 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)) 10:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:54:44 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)) 10:54:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:44 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:54:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:44 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 10:54:44 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 10:54:44 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 10:54:44 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 10:54:44 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 10:54:44 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 10:54:46 INFO - Downloading blessings-1.6.tar.gz 10:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:46 INFO - Installing collected packages: blessings 10:54:46 INFO - Running setup.py install for blessings 10:54:47 INFO - Successfully installed blessings 10:54:47 INFO - Cleaning up... 10:54:47 INFO - Return code: 0 10:54:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:47 INFO - Reading from file tmpfile_stdout 10:54:47 INFO - Current package versions: 10:54:47 INFO - blessings == 1.6 10:54:47 INFO - blobuploader == 1.2.4 10:54:47 INFO - docopt == 0.6.1 10:54:47 INFO - functools32 == 3.2.3-2 10:54:47 INFO - jsonschema == 2.5.1 10:54:47 INFO - manifestparser == 1.1 10:54:47 INFO - mozInstall == 1.12 10:54:47 INFO - mozcrash == 0.17 10:54:47 INFO - mozdebug == 0.1 10:54:47 INFO - mozdevice == 0.48 10:54:47 INFO - mozfile == 1.2 10:54:47 INFO - mozhttpd == 0.7 10:54:47 INFO - mozinfo == 0.9 10:54:47 INFO - mozleak == 0.1 10:54:47 INFO - mozlog == 3.2 10:54:47 INFO - moznetwork == 0.27 10:54:47 INFO - mozprocess == 0.23 10:54:47 INFO - mozprofile == 0.28 10:54:47 INFO - mozrunner == 6.12 10:54:47 INFO - mozscreenshot == 0.1 10:54:47 INFO - mozsystemmonitor == 0.3 10:54:47 INFO - moztest == 0.7 10:54:47 INFO - mozversion == 1.4 10:54:47 INFO - psutil == 3.1.1 10:54:47 INFO - requests == 1.2.3 10:54:47 INFO - wsgiref == 0.1.2 10:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:47 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 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:47 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 10:54:47 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 10:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:47 INFO - 'HOME': '/Users/cltbld', 10:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:47 INFO - 'LOGNAME': 'cltbld', 10:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:47 INFO - 'MOZ_NO_REMOTE': '1', 10:54:47 INFO - 'NO_EM_RESTART': '1', 10:54:47 INFO - 'PAGER': '/bin/cat', 10:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:47 INFO - 'PWD': '/builds/slave/test', 10:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:47 INFO - 'SHELL': '/bin/bash', 10:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:47 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:47 INFO - 'USER': 'cltbld', 10:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:47 INFO - 'XPC_FLAGS': '0x0', 10:54:47 INFO - 'XPC_SERVICE_NAME': '0', 10:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 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)) 10:54:47 INFO - Cleaning up... 10:54:47 INFO - Return code: 0 10:54:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b458618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f947254cfc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, '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.CgibK8ett2/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.AqMlZrDhiz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 10:54:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:54:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:47 INFO - 'HOME': '/Users/cltbld', 10:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:47 INFO - 'LOGNAME': 'cltbld', 10:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:47 INFO - 'MOZ_NO_REMOTE': '1', 10:54:47 INFO - 'NO_EM_RESTART': '1', 10:54:47 INFO - 'PAGER': '/bin/cat', 10:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:47 INFO - 'PWD': '/builds/slave/test', 10:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:47 INFO - 'SHELL': '/bin/bash', 10:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:54:47 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:47 INFO - 'USER': 'cltbld', 10:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:47 INFO - 'XPC_FLAGS': '0x0', 10:54:47 INFO - 'XPC_SERVICE_NAME': '0', 10:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:54:48 INFO - Cleaning up... 10:54:48 INFO - Return code: 0 10:54:48 INFO - Running post-action listener: _resource_record_post_action 10:54:48 INFO - Running post-action listener: _start_resource_monitoring 10:54:48 INFO - Starting resource monitoring. 10:54:48 INFO - ##### 10:54:48 INFO - ##### Finished create-virtualenv step (success) 10:54:48 INFO - ##### 10:54:48 INFO - ##### 10:54:48 INFO - ##### Running install step. 10:54:48 INFO - ##### 10:54:48 INFO - Running pre-action listener: _resource_record_pre_action 10:54:48 INFO - Running main action method: install 10:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:48 INFO - Reading from file tmpfile_stdout 10:54:48 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:48 INFO - Reading from file tmpfile_stdout 10:54:48 INFO - Output received: 10:54:48 INFO - Usage: mozinstall [options] installer 10:54:48 INFO - Options: 10:54:48 INFO - -h, --help show this help message and exit 10:54:48 INFO - -d DEST, --destination=DEST 10:54:48 INFO - Directory to install application into. [default: 10:54:48 INFO - "/builds/slave/test"] 10:54:48 INFO - --app=APP Application being installed. [default: firefox] 10:54:48 INFO - mkdir: /builds/slave/test/build/application 10:54:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:55:22 INFO - Reading from file tmpfile_stdout 10:55:22 INFO - Output received: 10:55:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:55:22 INFO - Running post-action listener: _resource_record_post_action 10:55:22 INFO - ##### 10:55:22 INFO - ##### Finished install step (success) 10:55:22 INFO - ##### 10:55:22 INFO - ##### 10:55:22 INFO - ##### Running run-tests step. 10:55:22 INFO - ##### 10:55:22 INFO - Running pre-action listener: _resource_record_pre_action 10:55:22 INFO - Running main action method: run_tests 10:55:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:55:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:55:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:55:23 INFO - 2016-07-15 10:55:23.006 screenresolution[1961:23574] starting screenresolution argv=screenresolution get 10:55:23 INFO - 2016-07-15 10:55:23.008 screenresolution[1961:23574] Display 0: 1600x1200x32@60 10:55:23 INFO - 2016-07-15 10:55:23.014 screenresolution[1962:23576] starting screenresolution argv=screenresolution list 10:55:23 INFO - Available Modes on Display 0 10:55:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:55:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:55:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:55:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:55:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:55:23 INFO - Intel Iris: 10:55:23 INFO - Chipset Model: Intel Iris 10:55:23 INFO - Type: GPU 10:55:23 INFO - Bus: Built-In 10:55:23 INFO - VRAM (Dynamic, Max): 1536 MB 10:55:23 INFO - Vendor: Intel (0x8086) 10:55:23 INFO - Device ID: 0x0a2e 10:55:23 INFO - Revision ID: 0x0009 10:55:23 INFO - Displays: 10:55:23 INFO - Display: 10:55:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:55:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:55:23 INFO - Display Serial Number: 1600x1200 60 10:55:23 INFO - Main Display: Yes 10:55:23 INFO - Mirror: Off 10:55:23 INFO - Online: Yes 10:55:23 INFO - Rotation: Supported 10:55:23 INFO - Return code: 0 10:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:55:23 INFO - Python 2.7.3 10:55:23 INFO - Return code: 0 10:55:23 INFO - grabbing minidump binary from tooltool 10:55:23 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:55:23 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 0x10b327d30>, '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 0x10b08cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b31fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:55:23 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 10:55:23 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 10:55:23 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 10:55:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:55:23 INFO - Return code: 0 10:55:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:55:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:55:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:55:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:55:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:55:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:55:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:55:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgibK8ett2/Render', 10:55:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:55:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:55:23 INFO - 'HOME': '/Users/cltbld', 10:55:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:55:23 INFO - 'LOGNAME': 'cltbld', 10:55:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:55:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:55:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:55:23 INFO - 'MOZ_NO_REMOTE': '1', 10:55:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:55:23 INFO - 'NO_EM_RESTART': '1', 10:55:23 INFO - 'PAGER': '/bin/cat', 10:55:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:55:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:55:23 INFO - 'PWD': '/builds/slave/test', 10:55:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:55:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:55:23 INFO - 'SHELL': '/bin/bash', 10:55:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AqMlZrDhiz/Listeners', 10:55:23 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 10:55:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:55:23 INFO - 'USER': 'cltbld', 10:55:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:55:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:55:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:55:23 INFO - 'XPC_FLAGS': '0x0', 10:55:23 INFO - 'XPC_SERVICE_NAME': '0', 10:55:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:55:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:55:23 INFO - mozversion application_buildid: 20160713141046 10:55:23 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:55:23 INFO - mozversion application_display_name: Nightly 10:55:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:55:23 INFO - mozversion application_name: Firefox 10:55:23 INFO - mozversion application_remotingname: firefox 10:55:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:55:23 INFO - mozversion application_vendor: Mozilla 10:55:23 INFO - mozversion application_version: 50.0a1 10:55:23 INFO - mozversion platform_buildid: 20160713141046 10:55:23 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:55:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:55:23 INFO - mozversion platform_version: 50.0a1 10:55:23 INFO - using testdate: 1468605323 10:55:23 INFO - actual date: 1468605323 10:55:23 INFO - starting webserver on 'localhost:56051' 10:55:23 INFO - SUITE-START | Running 2 tests 10:55:23 INFO - TEST-START | dromaeo_css 10:55:23 INFO - operating with platform_type : mac_ 10:55:23 INFO - Initialising browser for dromaeo_css test... 10:55:23 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpy5apke/profile http://localhost:56051/getInfo.html) 10:55:26 INFO - PROCESS | 1972 | __metrics Screen width/height:1600/1200 10:55:26 INFO - PROCESS | 1972 | colorDepth:24 10:55:26 INFO - PROCESS | 1972 | Browser inner width/height: 1024/689 10:55:26 INFO - PROCESS | 1972 | __metrics 10:55:26 INFO - PROCESS | 1972 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:55:26 INFO - PROCESS | 1972 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:55:26 INFO - TEST-INFO | 1972: exit 0 10:55:26 INFO - Browser initialized. 10:55:26 INFO - Running cycle 1/1 for dromaeo_css test... 10:55:26 INFO - TEST-INFO | started process 1974 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpy5apke/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:38 INFO - PROCESS | 1974 | RSS: Main: 243691520 10:55:38 INFO - PROCESS | 1974 | 10:56:30 INFO - PROCESS | 1974 | 1468605390028 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 10:58:40 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:56051/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56051/tests/dromaeo/cssquery-ext.html) 10:58:42 INFO - PROCESS | 1974 | RSS: Main: 357945344 10:58:42 INFO - PROCESS | 1974 | 11:01:45 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:56051/tests/dromaeo/cssquery-ext.html (next: http://localhost:56051/tests/dromaeo/cssquery-jquery.html) 11:01:46 INFO - PROCESS | 1974 | RSS: Main: 378019840 11:01:46 INFO - PROCESS | 1974 | 11:04:48 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:56051/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56051/tests/dromaeo/cssquery-mootools.html) 11:04:49 INFO - PROCESS | 1974 | RSS: Main: 372391936 11:04:49 INFO - PROCESS | 1974 | 11:07:51 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:56051/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56051/tests/dromaeo/cssquery-prototype.html) 11:07:51 INFO - PROCESS | 1974 | RSS: Main: 373854208 11:07:51 INFO - PROCESS | 1974 | 11:10:55 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:56051/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56051/tests/dromaeo/cssquery-yui.html) 11:10:56 INFO - PROCESS | 1974 | RSS: Main: 345702400 11:10:56 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | Cycle 1(1): loaded http://localhost:56051/tests/dromaeo/cssquery-yui.html (next: http://localhost:56051/tests/dromaeo/cssquery-dojo.html) 11:13:59 INFO - PROCESS | 1974 | RSS: Main: 427425792 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | __start_tp_report 11:13:59 INFO - PROCESS | 1974 | _x_x_mozilla_page_load 11:13:59 INFO - PROCESS | 1974 | _x_x_mozilla_page_load_details 11:13:59 INFO - PROCESS | 1974 | |i|pagename|runs| 11:13:59 INFO - PROCESS | 1974 | |0;dojo.html;2776.916692499225;2784.7076057014006;3343.6656334366553;3347.6484969078233;3371.8651253949843;5529.3364796224405;5622.184783206443;5644.8024319148835;5651.2370829937945;5684.232628595144;5657.094864821629;5662.292213473316;5727.42725727427;5782.421757824226;5784.508316793067;5125.103106956268;5141.640085194038;5169.870753231162;5189.481051894818;5273.242128208065;5287.339082614673;5292.36491621006;5293.682379057269;5308.495692909168;5370.8925821483745;5095.898082038376;5097.108006098955;5143.04853602081;5159.071367153911;5255.86860328491;5163.922541161885;5178.093833579109;5179.585633149339;5199.324087868553;5255.684658920477;5141.408737995103;5174.249733788617;5180.844574662766;5228.947710522884;5256.369235691704;5574.637648552831;5610.49505544503;5704.20141180231;5712.857178570569;5761.9135712964335;6193.473554747852;6199.256089269316;6228.128062071313;6241.563090583661;6260.780872669435;6223.315435302113;6269.3730626937395;6280.654563998978;6293.118963345135;6305.653189074599;5657.32112146545;5726.828195154152;5814.6220495668495;5891.911621325684;5896.911546326808;6237.750489980441;6240.032794916795;6248.218972628421;6248.656323902138;6248.812535623848;6111.052786818051;6122.602030867979;6123.785667501616;6143.354947730513;6149.96925015381;6099.512039036867;6136.243373036804;6226.128342032119;6241.407066328691;6247.2815626202655;6134.478569321657;6192.256929168439;6203;6208.534359923024;6221.035739460391;6202.1937148171355;6239.656818875005;6243.219597550306;6264.968675156686;6265.561410701298;4889.608831293488;4941.901161976813;4949.7772600233075;4981.227909674007;4983.27742477346;4447.177272204653;4483.417155769729;4511.954880451219;4516.254817955;4525.705829121097;5643.717814109278;5654.660720356792;5665.461781130786;5666.858328541737;5680.261565996394;6131.790568703149;6144.757163635241;6169.5064394848305;6212.316645169028;6231.158793562811;5671.432856714378;5677.602567820296;5690.231818704422;5698.886022279531;5717.42825717425;5390.649607775482;5402.945970540323;5409.810656626999;5424.891502169935;5425.403205647375;5378.677279363329;6211.503079753609;6256.124142620037;6303.684815759286;6345.777897773556;6194.194754681863;6197.101420293942;6237.282712488122;6249.406306400884;6292.968535157295;6247.562670613013;6253.468455181361;6261.812145635638;6264;6268.341824108403;6024.9397506026135;6094.969525152346;6104.511639068775;6159.599626024294;6161.322254552086;5181.896362072662;6146.231721034871;6151.784687535915;6156.476699480594;6162.383761623802;4888.315635810918;5939.46544810969;6026.186464827192;6043.486303664238;6100.664463454553;5965.582409231312;6024.33732289439;6035.728392222272;6046.183765191643;6060.060690592965;5752.741126649227;5818.127280907897;5841.824745257649;5905.261842269716;5944.167816505779;6069;6079.756809727562;6113.266408031065;6127.877442451215;6137.447629713347;5803.104680918811;5886.323072846678;5909.054551271776;5911.822645320647;5933.732982015906 11:13:59 INFO - PROCESS | 1974 | |1;ext.html;457.6018863588677;491.9300521366028;506.74156180348024;532.7868852459019;568.5536853569948;30048.699513004864;30444.934427295047;30514.694853051464;31455.842720786364;31527;42688.573114268846;44043.77978110113;44104.3384349235;46096.308555371696;46167.30749038759;9376;9919.504024798767;9921;9927.354721943087;9937.602495900155;8712.390132690714;8937.55312234389;9750.804983900318;9862.802743945116;9863.26025548083;11788.997935175521;11944.283342999404;11951.103667224992;12169.2698438094;12222.93888530556;12028.278303301786;12087.697807554794;12094.455749491293;12095.213811102338;12096.971757400632;8693.913060869374;11719.238249513839;11825.408729563487;12076.818847717292;12080.637580872588;41528.37707434391;42090.57909420928;42127.946801329905;42200;42226.36660450096;3558.3061303045915;3587.282543491312;3625.474306225609;3874.341361968472;3890.260850438436;32184.356312873613;32504.349913001843;32595.348093038243;34008;34043.978680639375;3260.208709172646;3304.9173770655684;3319.468884978416;3436.055084851661;3441.9655803441897;443484;551494;551502.242488789;551532.2423387897;552532;70077.2992270081;71070.93393599101;71080.64459677669;71187;71282.64358678173;52739.472605274226;52866;52871.735641321546;53011.73494132582;53029;17274.740878886827;17448.302067917393;17493.475195744148;17524.91237543804;17552.824471755375;12055.397230138458;12302.07734419922;12312.199707019015;12483.375831208403;12505.124641275206;15083.702069156789;19938.60122797536;20744.48138796542;20804;20823.854687992305;7337.816554586178;8688.348373871984;8695.30437565006;8727.301815854717;8750.47497150173;884.1644645809777;932.3520153493257;1006.5470538257813;1147.913906457019;1162.3026184289358;30478.695213048028;30542.083737487912;30764.73067102965;30985.535216971763;31002.844985775377;1088.9455527223606;1090.1714696830466;1118.3737107219983;1144.8111061674897;1182.3851597169423;15732.92133539325;15791.447299344467;15895.443659471863;15954.28205730745;16305.918470407809;684851;685263;688134;689790;690346;61935.69032154811;62622;62825;62840.685796570724;62859;1285.8328417305877;1330.3680751643085;1404.56458497866;1414.731201071793;1450.7678771396527;25289.62065568981;28114;28459.573106403008;29031.838726450704;29729.85135074311;51224;51776.482235177165;51800;51846.74076629593;51977.480225197265;566011;585955.0702246461;586407;586804;586944;34499.96500105001;35906.46140307845;39843.402348964206;44031;44557;40047;48927.26609100938;50561.24158137704;50817.745911270205;51003.72490687762;38265;40388.1922361557;40508.189836202524;41385.58614413817;41457.79271103746;31140;39260.80369598134;40284.194316112924;40768.3884741735;40971;38866.222675546895;39072.2185556293;39288.803555982035;39910;40174.79912600418;28769.56845647359;33555;34037.65962340345;34925;35685.46471802873;23045;25076.37309067215;25869.870650646626;26221.475570488103;26252.081177158707 11:13:59 INFO - PROCESS | 1974 | |2;jquery.html;359.06821797435646;380.26229115515895;388.764797297635;388.91249468869506;411.34801339876293;15565.766513502293;17053.658926821456;20854.37436876896;21238.575228495458;21262;20272;20938.16247350108;20970.056347464364;20981.370558883256;21028.789712102873;5737.913931291034;5791.594588378815;5984.3716409777;6056.727447264861;6061.787837425691;5863.296404431474;5912.142739302799;5975.342712301644;5980.820575382745;5983.700814959257;5747.728077128245;5917.52659787216;5919.526437884959;5920.733566989496;5922.2005029321135;5831.766729330821;5915.319738230072;5916.852078698024;5917.289925209003;5964.552658550604;5110.488951104897;5452.890942181174;5455.399906010336;5456.045192091368;5473.7263136843;13148.737025259537;13514.459421623123;16804.74792878108;24917.003319867366;25526;2136.4552039230052;2446.156076153724;2492.264781889347;2617.227917764245;2890.6531216254184;9960.900390996143;10020.34867733595;10034.849477257847;10340.844887326695;10460.476976151162;1815.1650240889207;1856.6193930244267;1865.6548538520417;1920.7022911448748;1988.9104990275473;117886;124562;125284;125595.3720231393;127762;9446.716598502057;11552.364619945984;11563;11661.475233614508;11820.936115749624;14294.571162864922;14434.566962991126;14457;14458.20479873596;14492.565223043326;7008.719651213894;8519.74440766778;8618.569071546397;8685.305175585938;8711.47731136134;8487.193716596914;8495.27790137833;8517.44636598619;8627.43921645091;8639.740807775777;4426.645868330525;4528.615067719281;4557.08858228349;4561.817527298937;4574.885627859264;1895.1383411049414;1933.2073849721546;1942.9902850485657;1944.105711372756;1945.6206039822098;734.1887214627866;886.2909672262165;891.6879092317637;986.1913231150388;990.3067852503276;20384.490387740425;20963.371098867057;21039.94800259981;21056.26303079385;21058.78941210599;952.9857052144223;1005.6932635546083;1009.4649835587151;1026.3687831983425;1029.2383636109225;10723.83914241287;10998.780024399468;11050.447477626087;11085;11143.721406964729;581082;603199;605285;616496;629202;133773;135766.32116839354;135967;138526;139261;955.1165172215673;958.769895225141;977.5845265762023;979.5836769372988;1006.0191313469455;17893.015884126497;18403.447896563124;18581.535461613566;18616.720749189044;18882.905585471985;50612.74693626508;56804;57893.710531447075;58151.41848581629;58584.41415585789;81323;82569.17430825614;84212;85402.1459785419;93016;7732.613369331399;7846.489978151402;7924.603769811371;8335.708250211213;8340.708075217339;9098.36311458218;12124.27254364741;12619.747605047663;12729.236245825281;12840.935795320964;10890.509927053143;11174.720631984266;11189.776204475702;11206.49570769301;11215.43922803873;11067.778644426906;11103.722406939569;11114.88885111171;11278.492467838803;11406.771864562828;11364.886351136383;11387;11399.715007124889;11421.600243991752;11431;5950.851228719317;7971.282584567417;8092.6762929482165;8264.545450000307;8290.502569845587;9408.43549387039;9914.206863450763;10837.807841137626;11086.667399978014;11107.944460277648 11:13:59 INFO - PROCESS | 1974 | |3;mootools.html;1534.647031182828;1565.7239349929807;1615.7253266944626;1945.8832470051789;1946.5717542140733;8649.221570058702;8894.644214231423;9100.317476189279;9117.452952822836;9120.635174593017;7929.603519824014;8134.308583770387;8702.042775294713;8909.910900891005;8934.776630584238;2090.2266161520183;2392.28231530541;2431.222008957134;2431.404305945046;2435.512897420514;2151.752548456924;2410.4094496848297;2412.155745489082;2453;2458.50829834033;1843.787964384093;2203.2508946958033;2223.3330000999717;2225.410266279437;2352;2388.2477019738812;2397.6043952747686;2398.052769156191;2399.8320117591775;2399.928002159938;2360.8701521416315;2374.3945293950105;2383.4637206628545;2391.354334329739;2393.892274847636;9078.682246121354;9153.130452606993;9154.679586214517;9167.495787731672;9175.174234318876;5241.737913104368;5471.398146203915;5474.671519708831;5476.726163691839;5503;3573.285342931424;3587.157018100744;3607.7835329880027;3684.6315368463206;3705.6109108543756;1077.2459278505;1083.3578117765337;1086.6414083352474;1106.3085571517802;1106.4025426269804;11903.285802851857;11931.284122952564;11947.462364193545;11954.402279885971;12018.759624807542;4682.672212945061;4734.431868175772;4750.928736068961;4831.130396528659;4869.050535145683;10144.391336519833;10155.238357123246;10164.542595583216;10167.389956602627;10177.44024078668;5211.244369566468;5215.947840521622;5220.869478263074;5225.268462415265;5226.425093239741;4720.362751028636;4727.196376615983;4729.054189162112;4739.95260047402;4985.52637499437;4014.2774300625583;4031.798410079543;4121.835126594962;4123.134141830189;4158.189153115113;1290.6386211860695;1292.2182079841562;1294.8964082873536;1308.9149205301626;1313.5862203405898;944.1219665710818;948.9525523723786;951.7335146158948;962.9374090684223;992.5730204204782;6046.848828779316;6062.545309101835;6087.482563982023;6096.603720758137;6132.325444201134;435.5318033114415;444.7998400719624;448.63884572919113;448.8630967554862;466.56143225368044;3815.809209539512;3983.203359328146;4099.282625540519;4159.500859896832;4170.061736109351;9246.76883077915;10595.894041059491;10926.016658500774;11069.05912997388;11079.002889739962;11022.338659680445;11026.614068507564;11027.283226590245;11047.171462140372;11067.50196241171;7896.486728362638;8203.917960820434;8266.586670666564;8294.419390642717;8348.165183481724;6181.1655426516845;6231.096491008688;6301.275353334425;6313.305536391085;6492.285848556749;9925;10138.594456221668;10404.219683523615;10415.68752937413;10464.162866970471;10170.745731356776;10559.155267578422;10559.472026398804;10573;10602.575896964343;7636.694532218649;7690.423218258765;7776.455648104578;7981.960090199512;8343.666253349798;8360.749177524684;8534.487930724177;8549.572521373782;8561.01548321926;8569.057403685465;7532.54804711719;7610.657520411484;7643.312101910855;7664.233576642291;7689.730859419893;7440.404767618469;7441.627918604157;7474.439417043634;7535.73624923125;7556.282153195438;7085.114360704912;7134.785956421316;7185.964070179615;7186.281371862772;7194.820129496595;4654.6741728078705;5018.84943451697;5106.157484015096;5203.921941170961;5231.215317702375;5094.388673359221;5168.896622067462;5191.428942816363;5272.578193744414;5363.597730170331 11:13:59 INFO - PROCESS | 1974 | |4;prototype.html;308.1464343767763;313.9607549056368;316.6674991259178;321.81013202210676;325.70198268584244;4542.727436353821;4956.5291297326785;5190.961807638478;5358.544523715484;5386.973065134674;4618.930716039262;5305.363356397238;5314.707691076999;5324.467553244684;5334.41280978726;3190.8404579770977;3259.788113772609;3762.887113386603;3769.4157405602177;3846.9613204434927;4027.6777857771453;4039.5556488786356;4061.6547593454443;4176.331786914079;4223.788810559475;4130.070734084837;4131.29767939451;4137.234611596864;4159.086820062775;4169.478815148106;3808.0860593457646;3813.6652171739947;3849.615038496156;4117.649999750025;4153.605407486284;3600.8297303376244;3611.6207798181076;3614.259076889258;3620.1673615068416;3624.3542214183794;4166.8749937501925;4428.446444194476;4662.650301227388;4943.950560494385;5215.452377500345;3990.6009399060154;4199.286121359346;4559.4072770539615;4764.428268607755;4781.8087276508895;4410.478384957185;5063.670861393997;5651.011073062197;5714.399988001242;5769.903718293511;3285;3393.6436674149104;3670.743047986642;3734.3838266685966;4034.1931613677384;5275;5612.691301978431;5973.313068997034;6021.42796434338;6029.306629737593;3899.1226973931207;3912.2199399273263;3928.253631809947;3933.7246392752804;3952.6245006724316;3513.7364697647777;4008.4788977432745;4008.6793056555407;4014.759114453142;4024.1348110156455;4294.334378171388;4688.507706690816;4697.6241900647865;4702.3416721659;4720.80482575604;5410.5642916747365;5744.167095771173;5752.325168796529;5762;5783.195150352076;1232.4761976160096;1266.2718936611486;1273.9108262421541;1425.5794540610545;1437.9143746471348;778.9406407286086;829.593838443844;859.9011113721876;883.9469631822111;902.2962089570145;4961.479044700327;4964.907720301528;4980.950190498121;5296.179092240709;5325.748449114455;4760.595349395271;5231.927454871742;5492.340919089655;5859.246154307469;5873.559483038704;5002.774875130628;5293.973530132324;5311.920321195185;5323.520883120537;5328.92006619901;2638.5382558052265;2958.6449626045014;3049.420610084077;3056.9541456878164;3059.2046068022473;5793.928123297119;5824.941750582525;5956;6036.909446358308;6037.849053773691;4783.378160839069;5673.574481913873;5930;5968.9701551492835;6044.909326360108;5076.0863044652315;5575.69333686643;5617.93822366811;5933.804492337863;6069.787557435645;5281.920771188358;5424.267723857387;5784.913226301524;5810.414365607264;5866.970665146647;4789.515250272427;5297.54970827484;5382.461753824587;5725.742341594721;5769.59612827098;5963.0459126539545;5991.591975885751;5998.610090344114;6028.276606807036;6044.758209671564;3381.2780711527457;3390.1694084949345;3660.3411385950785;4003.459532963013;4024.8390064397095;4924.876878077934;5853.770708151336;5890.705464726832;5894.793682221101;5926.170336152856;4785.688930219525;4859.740220797346;5745.224394706661;5762.789814139078;5785.27684039495;4612.838550650711;5469.507744303032;5656.040771460077;5743.971280143573;5802.5783682997935;4734.289856521412;4946.950530494649;5437.048516509674;5601.551875850004;5618.353889302619;4991.575716064175;5594.964931487688;5615.803446879339;5702.230198923092;5763.904858076952;4609.838655647036;5627.465390787868;5631.267935168402;5641;5642.407547207484 11:13:59 INFO - PROCESS | 1974 | |5;yui.html;795.296162895837;799.1089934722784;802.1176705623811;820.7742870710554;833.5290560833125;14757.631059223511;15530.611734706637;16063.83936160638;16084.919575402122;16554.917225413858;14911.254437278147;14936.626584335398;15101;15117.848821511781;15222.574920642877;721.2535026247834;744.7840126363349;893.0979710492417;902.2962089570145;925.4632313258328;916.7066538707617;919.0487845080344;919.062556192683;921.272194965976;923.0123767568704;979.9608015679399;984.3060642247234;987.2595553334999;987.5802783816885;988.367444835306;748.0611832150644;937.3344925103185;966.0050148347143;969.3214749675255;980.8577756225343;714.4962801225124;716.6201912986126;717.2253965717013;717.6555253478307;717.9876374312195;14899.925500372537;14931.328090235966;14951.850481495154;14970.17664028489;14970.62573435662;13090;13220.603381898558;13351.065425420224;13366.331683415887;13525.323733813368;12949.611511654666;12969.546065887744;13024.804627930494;13081.476740930351;13520.053596248266;4167.458230430055;4632.814687412533;4640.907181856378;4823.662343635947;4835.6131509479155;114676.42661786638;117644;117681.41159294148;118154.4092279533;118776;9683.661071862593;9712.02879712023;9777.022297770309;9838.212942964547;9992.390823233301;19466.31867884617;19474.415767526996;19517.804821951882;19528.31650892212;19536.70694939577;7565.243475652501;7871.48835325702;7989.680412783424;7998;8218;4491.640668746558;4531.252343363374;4588.059447813191;4714.481407045222;4757.167495688241;3443.500692399588;3578.3380074686265;3583.211693427442;3583.5341405617105;3587.0852932502044;644.1979735229669;667.7729571945562;672.4452326830384;673.71030456904;675.7499725101744;610.4140025575497;683.5588713837906;706.4842664854685;710.435204012811;710.6553321639001;9235.261179105655;9515.107877945202;9567.968579533106;9749.951250243703;9978;530.6020484636523;626.6929204689669;632.9810105696745;697.9336962988508;716.5056111283197;4593.06006270966;4613.446386433582;4715.764211789466;4770.642201834877;4771.642126840501;126143.47713045687;130938;138961;143780;150311.24844375928;123393.38303308426;125182.3740881308;125369.74630253763;127332;129361;73733.26266737371;84122.15877841144;109916;111657.88342116638;113385;9192.540372981457;9205.217556507772;9240.907590924005;9265.027172147096;9287.370444501683;57156.71421642865;63057.423564411256;63707.04439433505;64499;65892.68214635777;71374;85442;85856.1414385873;86252.56873715592;88077.94578719648;13456.394462249027;13471.595852124452;13915.095518791246;14071.788923166365;14211.502597409455;15047.924760376129;15564.377424902877;15579.143147127017;15988.440404585785;15999.520014399586;14065;14325.64185895361;14375.137491750529;14380.712385752435;14809.111453312837;13699.726005479635;13963.720725585228;14215.573532794033;14230.430782768573;14252.216128113054;13657.931710341385;13820.792688109485;13981.231032292915;14122.364493598017;14420.567382978528;11350.432478375884;11383.373914434786;11541.82687259675;11794.705132371759;12130.393480326125;11449.713757156138;11483;11509.194356394972;11713.414329283672;11719.296842189497 11:13:59 INFO - PROCESS | 1974 | __end_tp_report 11:13:59 INFO - PROCESS | 1974 | __start_cc_report 11:13:59 INFO - PROCESS | 1974 | _x_x_mozilla_cycle_collect,1620 11:13:59 INFO - PROCESS | 1974 | __end_cc_report 11:13:59 INFO - PROCESS | 1974 | __startTimestamp1468606439448__endTimestamp 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | ------- Summary: start ------- 11:13:59 INFO - PROCESS | 1974 | Number of tests: 6 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | [#0] dojo.html Cycles:165 Average:5702.96 Median:5896.91 stddev:653.90 (11.1%) stddev-sans-first:614.30 11:13:59 INFO - PROCESS | 1974 | Values: 2776.9 2784.7 3343.7 3347.6 3371.9 5529.3 5622.2 5644.8 5651.2 5684.2 5657.1 5662.3 5727.4 5782.4 5784.5 5125.1 5141.6 5169.9 5189.5 5273.2 5287.3 5292.4 5293.7 5308.5 5370.9 5095.9 5097.1 5143.0 5159.1 5255.9 5163.9 5178.1 5179.6 5199.3 5255.7 5141.4 5174.2 5180.8 5228.9 5256.4 5574.6 5610.5 5704.2 5712.9 5761.9 6193.5 6199.3 6228.1 6241.6 6260.8 6223.3 6269.4 6280.7 6293.1 6305.7 5657.3 5726.8 5814.6 5891.9 5896.9 6237.8 6240.0 6248.2 6248.7 6248.8 6111.1 6122.6 6123.8 6143.4 6150.0 6099.5 6136.2 6226.1 6241.4 6247.3 6134.5 6192.3 6203.0 6208.5 6221.0 6202.2 6239.7 6243.2 6265.0 6265.6 4889.6 4941.9 4949.8 4981.2 4983.3 4447.2 4483.4 4512.0 4516.3 4525.7 5643.7 5654.7 5665.5 5666.9 5680.3 6131.8 6144.8 6169.5 6212.3 6231.2 5671.4 5677.6 5690.2 5698.9 5717.4 5390.6 5402.9 5409.8 5424.9 5425.4 5378.7 6211.5 6256.1 6303.7 6345.8 6194.2 6197.1 6237.3 6249.4 6293.0 6247.6 6253.5 6261.8 6264.0 6268.3 6024.9 6095.0 6104.5 6159.6 6161.3 5181.9 6146.2 6151.8 6156.5 6162.4 4888.3 5939.5 6026.2 6043.5 6100.7 5965.6 6024.3 6035.7 6046.2 6060.1 5752.7 5818.1 5841.8 5905.3 5944.2 6069.0 6079.8 6113.3 6127.9 6137.4 5803.1 5886.3 5909.1 5911.8 5933.7 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | [#1] ext.html Cycles:180 Average:73673.09 Median:21378.24 stddev:161508.98 (755.5%) stddev-sans-first:161868.50 11:13:59 INFO - PROCESS | 1974 | Values: 457.6 491.9 506.7 532.8 568.6 30048.7 30444.9 30514.7 31455.8 31527.0 42688.6 44043.8 44104.3 46096.3 46167.3 9376.0 9919.5 9921.0 9927.4 9937.6 8712.4 8937.6 9750.8 9862.8 9863.3 11789.0 11944.3 11951.1 12169.3 12222.9 12028.3 12087.7 12094.5 12095.2 12097.0 8693.9 11719.2 11825.4 12076.8 12080.6 41528.4 42090.6 42127.9 42200.0 42226.4 3558.3 3587.3 3625.5 3874.3 3890.3 32184.4 32504.3 32595.3 34008.0 34044.0 3260.2 3304.9 3319.5 3436.1 3442.0 443484.0 551494.0 551502.2 551532.2 552532.0 70077.3 71070.9 71080.6 71187.0 71282.6 52739.5 52866.0 52871.7 53011.7 53029.0 17274.7 17448.3 17493.5 17524.9 17552.8 12055.4 12302.1 12312.2 12483.4 12505.1 15083.7 19938.6 20744.5 20804.0 20823.9 7337.8 8688.3 8695.3 8727.3 8750.5 884.2 932.4 1006.5 1147.9 1162.3 30478.7 30542.1 30764.7 30985.5 31002.8 1088.9 1090.2 1118.4 1144.8 1182.4 15732.9 15791.4 15895.4 15954.3 16305.9 684851.0 685263.0 688134.0 689790.0 690346.0 61935.7 62622.0 62825.0 62840.7 62859.0 1285.8 1330.4 1404.6 1414.7 1450.8 25289.6 28114.0 28459.6 29031.8 29729.9 51224.0 51776.5 51800.0 51846.7 51977.5 566011.0 585955.1 586407.0 586804.0 586944.0 34500.0 35906.5 39843.4 44031.0 44557.0 40047.0 48927.3 50561.2 50817.7 51003.7 38265.0 40388.2 40508.2 41385.6 41457.8 31140.0 39260.8 40284.2 40768.4 40971.0 38866.2 39072.2 39288.8 39910.0 40174.8 28769.6 33555.0 34037.7 34925.0 35685.5 23045.0 25076.4 25869.9 26221.5 26252.1 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | [#2] jquery.html Cycles:180 Average:35736.56 Median:13704.63 stddev:101803.77 (742.8%) stddev-sans-first:102054.70 11:13:59 INFO - PROCESS | 1974 | Values: 359.1 380.3 388.8 388.9 411.3 15565.8 17053.7 20854.4 21238.6 21262.0 20272.0 20938.2 20970.1 20981.4 21028.8 5737.9 5791.6 5984.4 6056.7 6061.8 5863.3 5912.1 5975.3 5980.8 5983.7 5747.7 5917.5 5919.5 5920.7 5922.2 5831.8 5915.3 5916.9 5917.3 5964.6 5110.5 5452.9 5455.4 5456.0 5473.7 13148.7 13514.5 16804.7 24917.0 25526.0 2136.5 2446.2 2492.3 2617.2 2890.7 9960.9 10020.3 10034.8 10340.8 10460.5 1815.2 1856.6 1865.7 1920.7 1988.9 117886.0 124562.0 125284.0 125595.4 127762.0 9446.7 11552.4 11563.0 11661.5 11820.9 14294.6 14434.6 14457.0 14458.2 14492.6 7008.7 8519.7 8618.6 8685.3 8711.5 8487.2 8495.3 8517.4 8627.4 8639.7 4426.6 4528.6 4557.1 4561.8 4574.9 1895.1 1933.2 1943.0 1944.1 1945.6 734.2 886.3 891.7 986.2 990.3 20384.5 20963.4 21039.9 21056.3 21058.8 953.0 1005.7 1009.5 1026.4 1029.2 10723.8 10998.8 11050.4 11085.0 11143.7 581082.0 603199.0 605285.0 616496.0 629202.0 133773.0 135766.3 135967.0 138526.0 139261.0 955.1 958.8 977.6 979.6 1006.0 17893.0 18403.4 18581.5 18616.7 18882.9 50612.7 56804.0 57893.7 58151.4 58584.4 81323.0 82569.2 84212.0 85402.1 93016.0 7732.6 7846.5 7924.6 8335.7 8340.7 9098.4 12124.3 12619.7 12729.2 12840.9 10890.5 11174.7 11189.8 11206.5 11215.4 11067.8 11103.7 11114.9 11278.5 11406.8 11364.9 11387.0 11399.7 11421.6 11431.0 5950.9 7971.3 8092.7 8264.5 8290.5 9408.4 9914.2 10837.8 11086.7 11107.9 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | [#3] mootools.html Cycles:180 Average:5829.09 Median:4723.78 stddev:3300.97 (69.9%) stddev-sans-first:3294.46 11:13:59 INFO - PROCESS | 1974 | Values: 1534.6 1565.7 1615.7 1945.9 1946.6 8649.2 8894.6 9100.3 9117.5 9120.6 7929.6 8134.3 8702.0 8909.9 8934.8 2090.2 2392.3 2431.2 2431.4 2435.5 2151.8 2410.4 2412.2 2453.0 2458.5 1843.8 2203.3 2223.3 2225.4 2352.0 2388.2 2397.6 2398.1 2399.8 2399.9 2360.9 2374.4 2383.5 2391.4 2393.9 9078.7 9153.1 9154.7 9167.5 9175.2 5241.7 5471.4 5474.7 5476.7 5503.0 3573.3 3587.2 3607.8 3684.6 3705.6 1077.2 1083.4 1086.6 1106.3 1106.4 11903.3 11931.3 11947.5 11954.4 12018.8 4682.7 4734.4 4750.9 4831.1 4869.1 10144.4 10155.2 10164.5 10167.4 10177.4 5211.2 5215.9 5220.9 5225.3 5226.4 4720.4 4727.2 4729.1 4740.0 4985.5 4014.3 4031.8 4121.8 4123.1 4158.2 1290.6 1292.2 1294.9 1308.9 1313.6 944.1 949.0 951.7 962.9 992.6 6046.8 6062.5 6087.5 6096.6 6132.3 435.5 444.8 448.6 448.9 466.6 3815.8 3983.2 4099.3 4159.5 4170.1 9246.8 10595.9 10926.0 11069.1 11079.0 11022.3 11026.6 11027.3 11047.2 11067.5 7896.5 8203.9 8266.6 8294.4 8348.2 6181.2 6231.1 6301.3 6313.3 6492.3 9925.0 10138.6 10404.2 10415.7 10464.2 10170.7 10559.2 10559.5 10573.0 10602.6 7636.7 7690.4 7776.5 7982.0 8343.7 8360.7 8534.5 8549.6 8561.0 8569.1 7532.5 7610.7 7643.3 7664.2 7689.7 7440.4 7441.6 7474.4 7535.7 7556.3 7085.1 7134.8 7186.0 7186.3 7194.8 4654.7 5018.8 5106.2 5203.9 5231.2 5094.4 5168.9 5191.4 5272.6 5363.6 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | [#4] prototype.html Cycles:180 Average:4546.67 Median:4986.26 stddev:1413.79 (28.4%) stddev-sans-first:1381.50 11:13:59 INFO - PROCESS | 1974 | Values: 308.1 314.0 316.7 321.8 325.7 4542.7 4956.5 5191.0 5358.5 5387.0 4618.9 5305.4 5314.7 5324.5 5334.4 3190.8 3259.8 3762.9 3769.4 3847.0 4027.7 4039.6 4061.7 4176.3 4223.8 4130.1 4131.3 4137.2 4159.1 4169.5 3808.1 3813.7 3849.6 4117.6 4153.6 3600.8 3611.6 3614.3 3620.2 3624.4 4166.9 4428.4 4662.7 4944.0 5215.5 3990.6 4199.3 4559.4 4764.4 4781.8 4410.5 5063.7 5651.0 5714.4 5769.9 3285.0 3393.6 3670.7 3734.4 4034.2 5275.0 5612.7 5973.3 6021.4 6029.3 3899.1 3912.2 3928.3 3933.7 3952.6 3513.7 4008.5 4008.7 4014.8 4024.1 4294.3 4688.5 4697.6 4702.3 4720.8 5410.6 5744.2 5752.3 5762.0 5783.2 1232.5 1266.3 1273.9 1425.6 1437.9 778.9 829.6 859.9 883.9 902.3 4961.5 4964.9 4981.0 5296.2 5325.7 4760.6 5231.9 5492.3 5859.2 5873.6 5002.8 5294.0 5311.9 5323.5 5328.9 2638.5 2958.6 3049.4 3057.0 3059.2 5793.9 5824.9 5956.0 6036.9 6037.8 4783.4 5673.6 5930.0 5969.0 6044.9 5076.1 5575.7 5617.9 5933.8 6069.8 5281.9 5424.3 5784.9 5810.4 5867.0 4789.5 5297.5 5382.5 5725.7 5769.6 5963.0 5991.6 5998.6 6028.3 6044.8 3381.3 3390.2 3660.3 4003.5 4024.8 4924.9 5853.8 5890.7 5894.8 5926.2 4785.7 4859.7 5745.2 5762.8 5785.3 4612.8 5469.5 5656.0 5744.0 5802.6 4734.3 4947.0 5437.0 5601.6 5618.4 4991.6 5595.0 5615.8 5702.2 5763.9 4609.8 5627.5 5631.3 5641.0 5642.4 11:13:59 INFO - PROCESS | 1974 | 11:13:59 INFO - PROCESS | 1974 | [#5] yui.html Cycles:180 Average:24291.00 Median:4559.66 stddev:37991.49 (833.2%) stddev-sans-first:38057.10 11:13:59 INFO - PROCESS | 1974 | Values: 795.3 799.1 802.1 820.8 833.5 14757.6 15530.6 16063.8 16084.9 16554.9 14911.3 14936.6 15101.0 15117.8 15222.6 721.3 744.8 893.1 902.3 925.5 916.7 919.0 919.1 921.3 923.0 980.0 984.3 987.3 987.6 988.4 748.1 937.3 966.0 969.3 980.9 714.5 716.6 717.2 717.7 718.0 14899.9 14931.3 14951.9 14970.2 14970.6 13090.0 13220.6 13351.1 13366.3 13525.3 12949.6 12969.5 13024.8 13081.5 13520.1 4167.5 4632.8 4640.9 4823.7 4835.6 114676.4 117644.0 117681.4 118154.4 118776.0 9683.7 9712.0 9777.0 9838.2 9992.4 19466.3 19474.4 19517.8 19528.3 19536.7 7565.2 7871.5 7989.7 7998.0 8218.0 4491.6 4531.3 4588.1 4714.5 4757.2 3443.5 3578.3 3583.2 3583.5 3587.1 644.2 667.8 672.4 673.7 675.7 610.4 683.6 706.5 710.4 710.7 9235.3 9515.1 9568.0 9750.0 9978.0 530.6 626.7 633.0 697.9 716.5 4593.1 4613.4 4715.8 4770.6 4771.6 126143.5 130938.0 138961.0 143780.0 150311.2 123393.4 125182.4 125369.7 127332.0 129361.0 73733.3 84122.2 109916.0 111657.9 113385.0 9192.5 9205.2 9240.9 9265.0 9287.4 57156.7 63057.4 63707.0 64499.0 65892.7 71374.0 85442.0 85856.1 86252.6 88077.9 13456.4 13471.6 13915.1 14071.8 14211.5 15047.9 15564.4 15579.1 15988.4 15999.5 14065.0 14325.6 14375.1 14380.7 14809.1 13699.7 13963.7 14215.6 14230.4 14252.2 13657.9 13820.8 13981.2 14122.4 14420.6 11350.4 11383.4 11541.8 11794.7 12130.4 11449.7 11483.0 11509.2 11713.4 11719.3 11:13:59 INFO - PROCESS | 1974 | -------- Summary: end -------- 11:13:59 INFO - PROCESS | 1974 | 11:14:00 INFO - TEST-INFO | 1974: exit 0 11:14:00 INFO - TEST-OK | dromaeo_css | took 1116547ms 11:14:00 INFO - TEST-START | kraken 11:14:00 INFO - operating with platform_type : mac_ 11:14:00 INFO - Initialising browser for kraken test... 11:14:00 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpeAA6Wv/profile http://localhost:56051/getInfo.html) 11:14:02 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 11:14:02 INFO - PROCESS | 1977 | colorDepth:24 11:14:02 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 11:14:02 INFO - PROCESS | 1977 | __metrics 11:14:02 INFO - PROCESS | 1977 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:14:02 INFO - PROCESS | 1977 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:14:03 INFO - TEST-INFO | 1977: exit 0 11:14:03 INFO - Browser initialized. 11:14:03 INFO - Running cycle 1/1 for kraken test... 11:14:03 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpeAA6Wv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:14:15 INFO - PROCESS | 1978 | RSS: Main: 243826688 11:14:15 INFO - PROCESS | 1978 | 11:14:18 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56051/tests/kraken/driver.html?testName=audio-beat-detection) 11:14:19 INFO - PROCESS | 1978 | RSS: Main: 295288832 11:14:19 INFO - PROCESS | 1978 | 11:14:21 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56051/tests/kraken/driver.html?testName=audio-dft) 11:14:22 INFO - PROCESS | 1978 | RSS: Main: 304570368 11:14:22 INFO - PROCESS | 1978 | 11:14:25 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56051/tests/kraken/driver.html?testName=audio-fft) 11:14:26 INFO - PROCESS | 1978 | RSS: Main: 393641984 11:14:26 INFO - PROCESS | 1978 | 11:14:28 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56051/tests/kraken/driver.html?testName=audio-oscillator) 11:14:29 INFO - PROCESS | 1978 | RSS: Main: 293892096 11:14:29 INFO - PROCESS | 1978 | 11:14:31 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56051/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:14:32 INFO - PROCESS | 1978 | RSS: Main: 297353216 11:14:32 INFO - PROCESS | 1978 | 11:14:34 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56051/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:35 INFO - PROCESS | 1978 | RSS: Main: 335835136 11:14:35 INFO - PROCESS | 1978 | 11:14:38 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56051/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:38 INFO - PROCESS | 1978 | RSS: Main: 336908288 11:14:38 INFO - PROCESS | 1978 | 11:14:41 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56051/tests/kraken/driver.html?testName=json-parse-financial) 11:14:42 INFO - PROCESS | 1978 | RSS: Main: 335986688 11:14:42 INFO - PROCESS | 1978 | 11:14:43 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56051/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:44 INFO - PROCESS | 1978 | RSS: Main: 311967744 11:14:44 INFO - PROCESS | 1978 | 11:14:46 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:47 INFO - PROCESS | 1978 | RSS: Main: 318754816 11:14:47 INFO - PROCESS | 1978 | 11:14:49 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:50 INFO - PROCESS | 1978 | RSS: Main: 321925120 11:14:50 INFO - PROCESS | 1978 | 11:14:52 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:53 INFO - PROCESS | 1978 | RSS: Main: 325009408 11:14:53 INFO - PROCESS | 1978 | 11:14:56 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:57 INFO - PROCESS | 1978 | RSS: Main: 324313088 11:14:57 INFO - PROCESS | 1978 | 11:14:58 INFO - PROCESS | 1978 | Cycle 1(1): loaded http://localhost:56051/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56051/tests/kraken/driver.html?testName=ai-astar) 11:14:59 INFO - PROCESS | 1978 | RSS: Main: 368148480 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | __start_tp_report 11:14:59 INFO - PROCESS | 1978 | _x_x_mozilla_page_load 11:14:59 INFO - PROCESS | 1978 | _x_x_mozilla_page_load_details 11:14:59 INFO - PROCESS | 1978 | |i|pagename|runs| 11:14:59 INFO - PROCESS | 1978 | |0;ai-astar;102;119;165;164;115;113;114;114;113;114 11:14:59 INFO - PROCESS | 1978 | |1;audio-beat-detection;147;111;102;159;107;107;129;105;137;107 11:14:59 INFO - PROCESS | 1978 | |2;audio-dft;186;186;186;181;186;186;181;231;186;187 11:14:59 INFO - PROCESS | 1978 | |3;audio-fft;79;75;58;109;56;56;60;51;132;78 11:14:59 INFO - PROCESS | 1978 | |4;audio-oscillator;82;93;124;100;101;69;100;99;98;130 11:14:59 INFO - PROCESS | 1978 | |5;imaging-gaussian-blur;88;85;89;86;88;84;89;87;90;85 11:14:59 INFO - PROCESS | 1978 | |6;imaging-darkroom;94;93;94;94;94;94;95;95;98;91 11:14:59 INFO - PROCESS | 1978 | |7;imaging-desaturate;84;84;86;85;83;85;86;83;83;84 11:14:59 INFO - PROCESS | 1978 | |8;json-parse-financial;53;54;54;53;55;54;55;54;54;55 11:14:59 INFO - PROCESS | 1978 | |9;json-stringify-tinderbox;68;76;68;78;70;69;69;70;70;72 11:14:59 INFO - PROCESS | 1978 | |10;stanford-crypto-aes;85;85;84;82;84;84;84;86;86;149 11:14:59 INFO - PROCESS | 1978 | |11;stanford-crypto-ccm;137;136;151;146;138;123;122;146;188;148 11:14:59 INFO - PROCESS | 1978 | |12;stanford-crypto-pbkdf2;163;165;165;165;162;163;166;165;162;170 11:14:59 INFO - PROCESS | 1978 | |13;stanford-crypto-sha256-iterative;69;67;68;65;66;66;67;68;66;67 11:14:59 INFO - PROCESS | 1978 | __end_tp_report 11:14:59 INFO - PROCESS | 1978 | __start_cc_report 11:14:59 INFO - PROCESS | 1978 | _x_x_mozilla_cycle_collect,2021 11:14:59 INFO - PROCESS | 1978 | __end_cc_report 11:14:59 INFO - PROCESS | 1978 | __startTimestamp1468606499025__endTimestamp 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | ------- Summary: start ------- 11:14:59 INFO - PROCESS | 1978 | Number of tests: 14 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#0] ai-astar Cycles:10 Average:123.30 Median:114.50 stddev:22.13 (19.3%) stddev-sans-first:22.09 11:14:59 INFO - PROCESS | 1978 | Values: 102.0 119.0 165.0 164.0 115.0 113.0 114.0 114.0 113.0 114.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#1] audio-beat-detection Cycles:10 Average:121.10 Median:120.00 stddev:20.40 (17.0%) stddev-sans-first:19.36 11:14:59 INFO - PROCESS | 1978 | Values: 147.0 111.0 102.0 159.0 107.0 107.0 129.0 105.0 137.0 107.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#2] audio-dft Cycles:10 Average:189.60 Median:186.00 stddev:14.71 (7.9%) stddev-sans-first:15.54 11:14:59 INFO - PROCESS | 1978 | Values: 186.0 186.0 186.0 181.0 186.0 186.0 181.0 231.0 186.0 187.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#3] audio-fft Cycles:10 Average:75.40 Median:59.00 stddev:26.33 (44.6%) stddev-sans-first:27.90 11:14:59 INFO - PROCESS | 1978 | Values: 79.0 75.0 58.0 109.0 56.0 56.0 60.0 51.0 132.0 78.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#4] audio-oscillator Cycles:10 Average:99.60 Median:75.50 stddev:17.68 (23.4%) stddev-sans-first:17.57 11:14:59 INFO - PROCESS | 1978 | Values: 82.0 93.0 124.0 100.0 101.0 69.0 100.0 99.0 98.0 130.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:88.00 stddev:2.02 (2.3%) stddev-sans-first:2.12 11:14:59 INFO - PROCESS | 1978 | Values: 88.0 85.0 89.0 86.0 88.0 84.0 89.0 87.0 90.0 85.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#6] imaging-darkroom Cycles:10 Average:94.20 Median:94.00 stddev:1.75 (1.9%) stddev-sans-first:1.86 11:14:59 INFO - PROCESS | 1978 | Values: 94.0 93.0 94.0 94.0 94.0 94.0 95.0 95.0 98.0 91.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.50 stddev:1.16 (1.4%) stddev-sans-first:1.22 11:14:59 INFO - PROCESS | 1978 | Values: 84.0 84.0 86.0 85.0 83.0 85.0 86.0 83.0 83.0 84.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.67 11:14:59 INFO - PROCESS | 1978 | Values: 53.0 54.0 54.0 53.0 55.0 54.0 55.0 54.0 54.0 55.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:70.00 stddev:3.40 (4.9%) stddev-sans-first:3.43 11:14:59 INFO - PROCESS | 1978 | Values: 68.0 76.0 68.0 78.0 70.0 69.0 69.0 70.0 70.0 72.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:84.50 stddev:20.45 (24.2%) stddev-sans-first:21.58 11:14:59 INFO - PROCESS | 1978 | Values: 85.0 85.0 84.0 82.0 84.0 84.0 84.0 86.0 86.0 149.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:146.00 stddev:18.50 (12.7%) stddev-sans-first:19.47 11:14:59 INFO - PROCESS | 1978 | Values: 137.0 136.0 151.0 146.0 138.0 123.0 122.0 146.0 188.0 148.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:165.00 stddev:2.37 (1.4%) stddev-sans-first:2.44 11:14:59 INFO - PROCESS | 1978 | Values: 163.0 165.0 165.0 165.0 162.0 163.0 166.0 165.0 162.0 170.0 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - PROCESS | 1978 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.00 11:14:59 INFO - PROCESS | 1978 | Values: 69.0 67.0 68.0 65.0 66.0 66.0 67.0 68.0 66.0 67.0 11:14:59 INFO - PROCESS | 1978 | -------- Summary: end -------- 11:14:59 INFO - PROCESS | 1978 | 11:14:59 INFO - TEST-INFO | 1978: exit 0 11:14:59 INFO - TEST-OK | kraken | took 59727ms 11:14:59 INFO - SUITE-END | took 1176s 11:15:00 INFO - Completed test suite (00:19:36) 11:15:00 INFO - javascript benchmark 11:15:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2776.916692499225, 2784.7076057014006, 3343.6656334366553, 3347.6484969078233, 3371.8651253949843, 5529.3364796224405, 5622.184783206443, 5644.8024319148835, 5651.2370829937945, 5684.232628595144, 5657.094864821629, 5662.292213473316, 5727.42725727427, 5782.421757824226, 5784.508316793067, 5125.103106956268, 5141.640085194038, 5169.870753231162, 5189.481051894818, 5273.242128208065, 5287.339082614673, 5292.36491621006, 5293.682379057269, 5308.495692909168, 5370.8925821483745, 5095.898082038376, 5097.108006098955, 5143.04853602081, 5159.071367153911, 5255.86860328491, 5163.922541161885, 5178.093833579109, 5179.585633149339, 5199.324087868553, 5255.684658920477, 5141.408737995103, 5174.249733788617, 5180.844574662766, 5228.947710522884, 5256.369235691704, 5574.637648552831, 5610.49505544503, 5704.20141180231, 5712.857178570569, 5761.9135712964335, 6193.473554747852, 6199.256089269316, 6228.128062071313, 6241.563090583661, 6260.780872669435, 6223.315435302113, 6269.3730626937395, 6280.654563998978, 6293.118963345135, 6305.653189074599, 5657.32112146545, 5726.828195154152, 5814.6220495668495, 5891.911621325684, 5896.911546326808, 6237.750489980441, 6240.032794916795, 6248.218972628421, 6248.656323902138, 6248.812535623848, 6111.052786818051, 6122.602030867979, 6123.785667501616, 6143.354947730513, 6149.96925015381, 6099.512039036867, 6136.243373036804, 6226.128342032119, 6241.407066328691, 6247.2815626202655, 6134.478569321657, 6192.256929168439, 6203.0, 6208.534359923024, 6221.035739460391, 6202.1937148171355, 6239.656818875005, 6243.219597550306, 6264.968675156686, 6265.561410701298, 4889.608831293488, 4941.901161976813, 4949.7772600233075, 4981.227909674007, 4983.27742477346, 4447.177272204653, 4483.417155769729, 4511.954880451219, 4516.254817955, 4525.705829121097, 5643.717814109278, 5654.660720356792, 5665.461781130786, 5666.858328541737, 5680.261565996394, 6131.790568703149, 6144.757163635241, 6169.5064394848305, 6212.316645169028, 6231.158793562811, 5671.432856714378, 5677.602567820296, 5690.231818704422, 5698.886022279531, 5717.42825717425, 5390.649607775482, 5402.945970540323, 5409.810656626999, 5424.891502169935, 5425.403205647375, 5378.677279363329, 6211.503079753609, 6256.124142620037, 6303.684815759286, 6345.777897773556, 6194.194754681863, 6197.101420293942, 6237.282712488122, 6249.406306400884, 6292.968535157295, 6247.562670613013, 6253.468455181361, 6261.812145635638, 6264.0, 6268.341824108403, 6024.9397506026135, 6094.969525152346, 6104.511639068775, 6159.599626024294, 6161.322254552086, 5181.896362072662, 6146.231721034871, 6151.784687535915, 6156.476699480594, 6162.383761623802, 4888.315635810918, 5939.46544810969, 6026.186464827192, 6043.486303664238, 6100.664463454553, 5965.582409231312, 6024.33732289439, 6035.728392222272, 6046.183765191643, 6060.060690592965, 5752.741126649227, 5818.127280907897, 5841.824745257649, 5905.261842269716, 5944.167816505779, 6069.0, 6079.756809727562, 6113.266408031065, 6127.877442451215, 6137.447629713347, 5803.104680918811, 5886.323072846678, 5909.054551271776, 5911.822645320647, 5933.732982015906], "value": 5658.81993829591, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.6018863588677, 491.9300521366028, 506.74156180348024, 532.7868852459019, 568.5536853569948, 30048.699513004864, 30444.934427295047, 30514.694853051464, 31455.842720786364, 31527.0, 42688.573114268846, 44043.77978110113, 44104.3384349235, 46096.308555371696, 46167.30749038759, 9376.0, 9919.504024798767, 9921.0, 9927.354721943087, 9937.602495900155, 8712.390132690714, 8937.55312234389, 9750.804983900318, 9862.802743945116, 9863.26025548083, 11788.997935175521, 11944.283342999404, 11951.103667224992, 12169.2698438094, 12222.93888530556, 12028.278303301786, 12087.697807554794, 12094.455749491293, 12095.213811102338, 12096.971757400632, 8693.913060869374, 11719.238249513839, 11825.408729563487, 12076.818847717292, 12080.637580872588, 41528.37707434391, 42090.57909420928, 42127.946801329905, 42200.0, 42226.36660450096, 3558.3061303045915, 3587.282543491312, 3625.474306225609, 3874.341361968472, 3890.260850438436, 32184.356312873613, 32504.349913001843, 32595.348093038243, 34008.0, 34043.978680639375, 3260.208709172646, 3304.9173770655684, 3319.468884978416, 3436.055084851661, 3441.9655803441897, 443484.0, 551494.0, 551502.242488789, 551532.2423387897, 552532.0, 70077.2992270081, 71070.93393599101, 71080.64459677669, 71187.0, 71282.64358678173, 52739.472605274226, 52866.0, 52871.735641321546, 53011.73494132582, 53029.0, 17274.740878886827, 17448.302067917393, 17493.475195744148, 17524.91237543804, 17552.824471755375, 12055.397230138458, 12302.07734419922, 12312.199707019015, 12483.375831208403, 12505.124641275206, 15083.702069156789, 19938.60122797536, 20744.48138796542, 20804.0, 20823.854687992305, 7337.816554586178, 8688.348373871984, 8695.30437565006, 8727.301815854717, 8750.47497150173, 884.1644645809777, 932.3520153493257, 1006.5470538257813, 1147.913906457019, 1162.3026184289358, 30478.695213048028, 30542.083737487912, 30764.73067102965, 30985.535216971763, 31002.844985775377, 1088.9455527223606, 1090.1714696830466, 1118.3737107219983, 1144.8111061674897, 1182.3851597169423, 15732.92133539325, 15791.447299344467, 15895.443659471863, 15954.28205730745, 16305.918470407809, 684851.0, 685263.0, 688134.0, 689790.0, 690346.0, 61935.69032154811, 62622.0, 62825.0, 62840.685796570724, 62859.0, 1285.8328417305877, 1330.3680751643085, 1404.56458497866, 1414.731201071793, 1450.7678771396527, 25289.62065568981, 28114.0, 28459.573106403008, 29031.838726450704, 29729.85135074311, 51224.0, 51776.482235177165, 51800.0, 51846.74076629593, 51977.480225197265, 566011.0, 585955.0702246461, 586407.0, 586804.0, 586944.0, 34499.96500105001, 35906.46140307845, 39843.402348964206, 44031.0, 44557.0, 40047.0, 48927.26609100938, 50561.24158137704, 50817.745911270205, 51003.72490687762, 38265.0, 40388.1922361557, 40508.189836202524, 41385.58614413817, 41457.79271103746, 31140.0, 39260.80369598134, 40284.194316112924, 40768.3884741735, 40971.0, 38866.222675546895, 39072.2185556293, 39288.803555982035, 39910.0, 40174.79912600418, 28769.56845647359, 33555.0, 34037.65962340345, 34925.0, 35685.46471802873, 23045.0, 25076.37309067215, 25869.870650646626, 26221.475570488103, 26252.081177158707], "value": 20954.664962555522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.06821797435646, 380.26229115515895, 388.764797297635, 388.91249468869506, 411.34801339876293, 15565.766513502293, 17053.658926821456, 20854.37436876896, 21238.575228495458, 21262.0, 20272.0, 20938.16247350108, 20970.056347464364, 20981.370558883256, 21028.789712102873, 5737.913931291034, 5791.594588378815, 5984.3716409777, 6056.727447264861, 6061.787837425691, 5863.296404431474, 5912.142739302799, 5975.342712301644, 5980.820575382745, 5983.700814959257, 5747.728077128245, 5917.52659787216, 5919.526437884959, 5920.733566989496, 5922.2005029321135, 5831.766729330821, 5915.319738230072, 5916.852078698024, 5917.289925209003, 5964.552658550604, 5110.488951104897, 5452.890942181174, 5455.399906010336, 5456.045192091368, 5473.7263136843, 13148.737025259537, 13514.459421623123, 16804.74792878108, 24917.003319867366, 25526.0, 2136.4552039230052, 2446.156076153724, 2492.264781889347, 2617.227917764245, 2890.6531216254184, 9960.900390996143, 10020.34867733595, 10034.849477257847, 10340.844887326695, 10460.476976151162, 1815.1650240889207, 1856.6193930244267, 1865.6548538520417, 1920.7022911448748, 1988.9104990275473, 117886.0, 124562.0, 125284.0, 125595.3720231393, 127762.0, 9446.716598502057, 11552.364619945984, 11563.0, 11661.475233614508, 11820.936115749624, 14294.571162864922, 14434.566962991126, 14457.0, 14458.20479873596, 14492.565223043326, 7008.719651213894, 8519.74440766778, 8618.569071546397, 8685.305175585938, 8711.47731136134, 8487.193716596914, 8495.27790137833, 8517.44636598619, 8627.43921645091, 8639.740807775777, 4426.645868330525, 4528.615067719281, 4557.08858228349, 4561.817527298937, 4574.885627859264, 1895.1383411049414, 1933.2073849721546, 1942.9902850485657, 1944.105711372756, 1945.6206039822098, 734.1887214627866, 886.2909672262165, 891.6879092317637, 986.1913231150388, 990.3067852503276, 20384.490387740425, 20963.371098867057, 21039.94800259981, 21056.26303079385, 21058.78941210599, 952.9857052144223, 1005.6932635546083, 1009.4649835587151, 1026.3687831983425, 1029.2383636109225, 10723.83914241287, 10998.780024399468, 11050.447477626087, 11085.0, 11143.721406964729, 581082.0, 603199.0, 605285.0, 616496.0, 629202.0, 133773.0, 135766.32116839354, 135967.0, 138526.0, 139261.0, 955.1165172215673, 958.769895225141, 977.5845265762023, 979.5836769372988, 1006.0191313469455, 17893.015884126497, 18403.447896563124, 18581.535461613566, 18616.720749189044, 18882.905585471985, 50612.74693626508, 56804.0, 57893.710531447075, 58151.41848581629, 58584.41415585789, 81323.0, 82569.17430825614, 84212.0, 85402.1459785419, 93016.0, 7732.613369331399, 7846.489978151402, 7924.603769811371, 8335.708250211213, 8340.708075217339, 9098.36311458218, 12124.27254364741, 12619.747605047663, 12729.236245825281, 12840.935795320964, 10890.509927053143, 11174.720631984266, 11189.776204475702, 11206.49570769301, 11215.43922803873, 11067.778644426906, 11103.722406939569, 11114.88885111171, 11278.492467838803, 11406.771864562828, 11364.886351136383, 11387.0, 11399.715007124889, 11421.600243991752, 11431.0, 5950.851228719317, 7971.282584567417, 8092.6762929482165, 8264.545450000307, 8290.502569845587, 9408.43549387039, 9914.206863450763, 10837.807841137626, 11086.667399978014, 11107.944460277648], "value": 9549.21993495043, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1534.647031182828, 1565.7239349929807, 1615.7253266944626, 1945.8832470051789, 1946.5717542140733, 8649.221570058702, 8894.644214231423, 9100.317476189279, 9117.452952822836, 9120.635174593017, 7929.603519824014, 8134.308583770387, 8702.042775294713, 8909.910900891005, 8934.776630584238, 2090.2266161520183, 2392.28231530541, 2431.222008957134, 2431.404305945046, 2435.512897420514, 2151.752548456924, 2410.4094496848297, 2412.155745489082, 2453.0, 2458.50829834033, 1843.787964384093, 2203.2508946958033, 2223.3330000999717, 2225.410266279437, 2352.0, 2388.2477019738812, 2397.6043952747686, 2398.052769156191, 2399.8320117591775, 2399.928002159938, 2360.8701521416315, 2374.3945293950105, 2383.4637206628545, 2391.354334329739, 2393.892274847636, 9078.682246121354, 9153.130452606993, 9154.679586214517, 9167.495787731672, 9175.174234318876, 5241.737913104368, 5471.398146203915, 5474.671519708831, 5476.726163691839, 5503.0, 3573.285342931424, 3587.157018100744, 3607.7835329880027, 3684.6315368463206, 3705.6109108543756, 1077.2459278505, 1083.3578117765337, 1086.6414083352474, 1106.3085571517802, 1106.4025426269804, 11903.285802851857, 11931.284122952564, 11947.462364193545, 11954.402279885971, 12018.759624807542, 4682.672212945061, 4734.431868175772, 4750.928736068961, 4831.130396528659, 4869.050535145683, 10144.391336519833, 10155.238357123246, 10164.542595583216, 10167.389956602627, 10177.44024078668, 5211.244369566468, 5215.947840521622, 5220.869478263074, 5225.268462415265, 5226.425093239741, 4720.362751028636, 4727.196376615983, 4729.054189162112, 4739.95260047402, 4985.52637499437, 4014.2774300625583, 4031.798410079543, 4121.835126594962, 4123.134141830189, 4158.189153115113, 1290.6386211860695, 1292.2182079841562, 1294.8964082873536, 1308.9149205301626, 1313.5862203405898, 944.1219665710818, 948.9525523723786, 951.7335146158948, 962.9374090684223, 992.5730204204782, 6046.848828779316, 6062.545309101835, 6087.482563982023, 6096.603720758137, 6132.325444201134, 435.5318033114415, 444.7998400719624, 448.63884572919113, 448.8630967554862, 466.56143225368044, 3815.809209539512, 3983.203359328146, 4099.282625540519, 4159.500859896832, 4170.061736109351, 9246.76883077915, 10595.894041059491, 10926.016658500774, 11069.05912997388, 11079.002889739962, 11022.338659680445, 11026.614068507564, 11027.283226590245, 11047.171462140372, 11067.50196241171, 7896.486728362638, 8203.917960820434, 8266.586670666564, 8294.419390642717, 8348.165183481724, 6181.1655426516845, 6231.096491008688, 6301.275353334425, 6313.305536391085, 6492.285848556749, 9925.0, 10138.594456221668, 10404.219683523615, 10415.68752937413, 10464.162866970471, 10170.745731356776, 10559.155267578422, 10559.472026398804, 10573.0, 10602.575896964343, 7636.694532218649, 7690.423218258765, 7776.455648104578, 7981.960090199512, 8343.666253349798, 8360.749177524684, 8534.487930724177, 8549.572521373782, 8561.01548321926, 8569.057403685465, 7532.54804711719, 7610.657520411484, 7643.312101910855, 7664.233576642291, 7689.730859419893, 7440.404767618469, 7441.627918604157, 7474.439417043634, 7535.73624923125, 7556.282153195438, 7085.114360704912, 7134.785956421316, 7185.964070179615, 7186.281371862772, 7194.820129496595, 4654.6741728078705, 5018.84943451697, 5106.157484015096, 5203.921941170961, 5231.215317702375, 5094.388673359221, 5168.896622067462, 5191.428942816363, 5272.578193744414, 5363.597730170331], "value": 4594.602869421277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.1464343767763, 313.9607549056368, 316.6674991259178, 321.81013202210676, 325.70198268584244, 4542.727436353821, 4956.5291297326785, 5190.961807638478, 5358.544523715484, 5386.973065134674, 4618.930716039262, 5305.363356397238, 5314.707691076999, 5324.467553244684, 5334.41280978726, 3190.8404579770977, 3259.788113772609, 3762.887113386603, 3769.4157405602177, 3846.9613204434927, 4027.6777857771453, 4039.5556488786356, 4061.6547593454443, 4176.331786914079, 4223.788810559475, 4130.070734084837, 4131.29767939451, 4137.234611596864, 4159.086820062775, 4169.478815148106, 3808.0860593457646, 3813.6652171739947, 3849.615038496156, 4117.649999750025, 4153.605407486284, 3600.8297303376244, 3611.6207798181076, 3614.259076889258, 3620.1673615068416, 3624.3542214183794, 4166.8749937501925, 4428.446444194476, 4662.650301227388, 4943.950560494385, 5215.452377500345, 3990.6009399060154, 4199.286121359346, 4559.4072770539615, 4764.428268607755, 4781.8087276508895, 4410.478384957185, 5063.670861393997, 5651.011073062197, 5714.399988001242, 5769.903718293511, 3285.0, 3393.6436674149104, 3670.743047986642, 3734.3838266685966, 4034.1931613677384, 5275.0, 5612.691301978431, 5973.313068997034, 6021.42796434338, 6029.306629737593, 3899.1226973931207, 3912.2199399273263, 3928.253631809947, 3933.7246392752804, 3952.6245006724316, 3513.7364697647777, 4008.4788977432745, 4008.6793056555407, 4014.759114453142, 4024.1348110156455, 4294.334378171388, 4688.507706690816, 4697.6241900647865, 4702.3416721659, 4720.80482575604, 5410.5642916747365, 5744.167095771173, 5752.325168796529, 5762.0, 5783.195150352076, 1232.4761976160096, 1266.2718936611486, 1273.9108262421541, 1425.5794540610545, 1437.9143746471348, 778.9406407286086, 829.593838443844, 859.9011113721876, 883.9469631822111, 902.2962089570145, 4961.479044700327, 4964.907720301528, 4980.950190498121, 5296.179092240709, 5325.748449114455, 4760.595349395271, 5231.927454871742, 5492.340919089655, 5859.246154307469, 5873.559483038704, 5002.774875130628, 5293.973530132324, 5311.920321195185, 5323.520883120537, 5328.92006619901, 2638.5382558052265, 2958.6449626045014, 3049.420610084077, 3056.9541456878164, 3059.2046068022473, 5793.928123297119, 5824.941750582525, 5956.0, 6036.909446358308, 6037.849053773691, 4783.378160839069, 5673.574481913873, 5930.0, 5968.9701551492835, 6044.909326360108, 5076.0863044652315, 5575.69333686643, 5617.93822366811, 5933.804492337863, 6069.787557435645, 5281.920771188358, 5424.267723857387, 5784.913226301524, 5810.414365607264, 5866.970665146647, 4789.515250272427, 5297.54970827484, 5382.461753824587, 5725.742341594721, 5769.59612827098, 5963.0459126539545, 5991.591975885751, 5998.610090344114, 6028.276606807036, 6044.758209671564, 3381.2780711527457, 3390.1694084949345, 3660.3411385950785, 4003.459532963013, 4024.8390064397095, 4924.876878077934, 5853.770708151336, 5890.705464726832, 5894.793682221101, 5926.170336152856, 4785.688930219525, 4859.740220797346, 5745.224394706661, 5762.789814139078, 5785.27684039495, 4612.838550650711, 5469.507744303032, 5656.040771460077, 5743.971280143573, 5802.5783682997935, 4734.289856521412, 4946.950530494649, 5437.048516509674, 5601.551875850004, 5618.353889302619, 4991.575716064175, 5594.964931487688, 5615.803446879339, 5702.230198923092, 5763.904858076952, 4609.838655647036, 5627.465390787868, 5631.267935168402, 5641.0, 5642.407547207484], "value": 4098.312091146154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [795.296162895837, 799.1089934722784, 802.1176705623811, 820.7742870710554, 833.5290560833125, 14757.631059223511, 15530.611734706637, 16063.83936160638, 16084.919575402122, 16554.917225413858, 14911.254437278147, 14936.626584335398, 15101.0, 15117.848821511781, 15222.574920642877, 721.2535026247834, 744.7840126363349, 893.0979710492417, 902.2962089570145, 925.4632313258328, 916.7066538707617, 919.0487845080344, 919.062556192683, 921.272194965976, 923.0123767568704, 979.9608015679399, 984.3060642247234, 987.2595553334999, 987.5802783816885, 988.367444835306, 748.0611832150644, 937.3344925103185, 966.0050148347143, 969.3214749675255, 980.8577756225343, 714.4962801225124, 716.6201912986126, 717.2253965717013, 717.6555253478307, 717.9876374312195, 14899.925500372537, 14931.328090235966, 14951.850481495154, 14970.17664028489, 14970.62573435662, 13090.0, 13220.603381898558, 13351.065425420224, 13366.331683415887, 13525.323733813368, 12949.611511654666, 12969.546065887744, 13024.804627930494, 13081.476740930351, 13520.053596248266, 4167.458230430055, 4632.814687412533, 4640.907181856378, 4823.662343635947, 4835.6131509479155, 114676.42661786638, 117644.0, 117681.41159294148, 118154.4092279533, 118776.0, 9683.661071862593, 9712.02879712023, 9777.022297770309, 9838.212942964547, 9992.390823233301, 19466.31867884617, 19474.415767526996, 19517.804821951882, 19528.31650892212, 19536.70694939577, 7565.243475652501, 7871.48835325702, 7989.680412783424, 7998.0, 8218.0, 4491.640668746558, 4531.252343363374, 4588.059447813191, 4714.481407045222, 4757.167495688241, 3443.500692399588, 3578.3380074686265, 3583.211693427442, 3583.5341405617105, 3587.0852932502044, 644.1979735229669, 667.7729571945562, 672.4452326830384, 673.71030456904, 675.7499725101744, 610.4140025575497, 683.5588713837906, 706.4842664854685, 710.435204012811, 710.6553321639001, 9235.261179105655, 9515.107877945202, 9567.968579533106, 9749.951250243703, 9978.0, 530.6020484636523, 626.6929204689669, 632.9810105696745, 697.9336962988508, 716.5056111283197, 4593.06006270966, 4613.446386433582, 4715.764211789466, 4770.642201834877, 4771.642126840501, 126143.47713045687, 130938.0, 138961.0, 143780.0, 150311.24844375928, 123393.38303308426, 125182.3740881308, 125369.74630253763, 127332.0, 129361.0, 73733.26266737371, 84122.15877841144, 109916.0, 111657.88342116638, 113385.0, 9192.540372981457, 9205.217556507772, 9240.907590924005, 9265.027172147096, 9287.370444501683, 57156.71421642865, 63057.423564411256, 63707.04439433505, 64499.0, 65892.68214635777, 71374.0, 85442.0, 85856.1414385873, 86252.56873715592, 88077.94578719648, 13456.394462249027, 13471.595852124452, 13915.095518791246, 14071.788923166365, 14211.502597409455, 15047.924760376129, 15564.377424902877, 15579.143147127017, 15988.440404585785, 15999.520014399586, 14065.0, 14325.64185895361, 14375.137491750529, 14380.712385752435, 14809.111453312837, 13699.726005479635, 13963.720725585228, 14215.573532794033, 14230.430782768573, 14252.216128113054, 13657.931710341385, 13820.792688109485, 13981.231032292915, 14122.364493598017, 14420.567382978528, 11350.432478375884, 11383.373914434786, 11541.82687259675, 11794.705132371759, 12130.393480326125, 11449.713757156138, 11483.0, 11509.194356394972, 11713.414329283672, 11719.296842189497], "value": 7989.965709817806, "unit": "score"}], "name": "dromaeo_css", "value": 7445.662930080365, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 119.0, 165.0, 164.0, 115.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 123.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 111.0, 102.0, 159.0, 107.0, 107.0, 129.0, 105.0, 137.0, 107.0], "value": 121.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 186.0, 181.0, 186.0, 186.0, 181.0, 231.0, 186.0, 187.0], "value": 189.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 58.0, 109.0, 56.0, 56.0, 60.0, 51.0, 132.0, 78.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 93.0, 124.0, 100.0, 101.0, 69.0, 100.0, 99.0, 98.0, 130.0], "value": 99.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 84.0, 89.0, 87.0, 90.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0, 98.0, 91.0], "value": 94.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 85.0, 83.0, 85.0, 86.0, 83.0, 83.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 53.0, 55.0, 54.0, 55.0, 54.0, 54.0, 55.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 68.0, 78.0, 70.0, 69.0, 69.0, 70.0, 70.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 82.0, 84.0, 84.0, 84.0, 86.0, 86.0, 149.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 151.0, 146.0, 138.0, 123.0, 122.0, 146.0, 188.0, 148.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 165.0, 165.0, 162.0, 163.0, 166.0, 165.0, 162.0, 170.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 65.0, 66.0, 66.0, 67.0, 68.0, 66.0, 67.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1465.6000000000001, "alertThreshold": 2.0}]} 11:15:00 INFO - Return code: 0 11:15:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:15:00 INFO - # TBPL SUCCESS # 11:15:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:15:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:15:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:15:00 INFO - 2016-07-15 11:15:00.368 screenresolution[1982:25660] starting screenresolution argv=screenresolution get 11:15:00 INFO - 2016-07-15 11:15:00.371 screenresolution[1982:25660] Display 0: 1600x1200x32@60 11:15:00 INFO - 2016-07-15 11:15:00.377 screenresolution[1983:25663] starting screenresolution argv=screenresolution list 11:15:00 INFO - Available Modes on Display 0 11:15:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:15:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:15:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:15:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:15:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:15:00 INFO - Intel Iris: 11:15:00 INFO - Chipset Model: Intel Iris 11:15:00 INFO - Type: GPU 11:15:00 INFO - Bus: Built-In 11:15:00 INFO - VRAM (Dynamic, Max): 1536 MB 11:15:00 INFO - Vendor: Intel (0x8086) 11:15:00 INFO - Device ID: 0x0a2e 11:15:00 INFO - Revision ID: 0x0009 11:15:00 INFO - Displays: 11:15:00 INFO - Display: 11:15:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:15:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:15:00 INFO - Display Serial Number: 1600x1200 60 11:15:00 INFO - Main Display: Yes 11:15:00 INFO - Mirror: Off 11:15:00 INFO - Online: Yes 11:15:00 INFO - Rotation: Supported 11:15:00 INFO - Return code: 0 11:15:00 INFO - Running post-action listener: _resource_record_post_action 11:15:00 INFO - ##### 11:15:00 INFO - ##### Finished run-tests step (success) 11:15:00 INFO - ##### 11:15:00 INFO - Running post-run listener: _resource_record_post_run 11:15:00 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 294912; Write bytes: 706577408; Read time: 6; Write time: 1951 11:15:00 INFO - TinderboxPrint: CPU usage
53.7% 11:15:00 INFO - TinderboxPrint: I/O read bytes / time
294,912 / 6 11:15:00 INFO - TinderboxPrint: I/O write bytes / time
706,577,408 / 1,951 11:15:00 INFO - TinderboxPrint: CPU idle
2,245.7 (46.3%) 11:15:00 INFO - TinderboxPrint: CPU system
971.9 (20.0%) 11:15:00 INFO - TinderboxPrint: CPU user
1,632.1 (33.7%) 11:15:00 INFO - TinderboxPrint: Swap in / out
406,552,576 / 0 11:15:00 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390298112; Write bytes: 384407040; Read time: 28882; Write time: 784 11:15:00 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 294912; Write bytes: 297008640; Read time: 6; Write time: 1108 11:15:01 INFO - Running post-run listener: _upload_blobber_files 11:15:01 INFO - Blob upload gear active. 11:15:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:15:01 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 11:15:01 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'] 11:15:01 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 11:15:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:15:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:03 INFO - (blobuploader) - INFO - Done attempting. 11:15:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:15:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:15:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:04 INFO - (blobuploader) - INFO - Done attempting. 11:15:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:15:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:15:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:15:09 INFO - (blobuploader) - INFO - Done attempting. 11:15:09 INFO - (blobuploader) - INFO - Iteration through files over. 11:15:09 INFO - Return code: 0 11:15:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:15:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:15:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2cd68134c56dcf70d4fa09fafab313d4614347f2da178ae6453858397bc3ae249ff18524b9a80e17ff122df87b97ee67aed0e05d99082bb39acc6733db711e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce668e77ac600f19c88c89cc83652c7b85a54520bb1b7153b60b5070063cc044f08f211cd670f6ac771b59c2c11c281bfe424f779d84314959e44b74cfb58e26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/147df5baeaff110fd2c34cb06918232b98a1ca1b53bfdd0e870bff980c7bb56ae8ee2addb24faee9633a07e62d225c9eb1542227fd77073d3f519659ea62826b"} 11:15:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:15:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:15:09 INFO - Contents: 11:15:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2cd68134c56dcf70d4fa09fafab313d4614347f2da178ae6453858397bc3ae249ff18524b9a80e17ff122df87b97ee67aed0e05d99082bb39acc6733db711e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce668e77ac600f19c88c89cc83652c7b85a54520bb1b7153b60b5070063cc044f08f211cd670f6ac771b59c2c11c281bfe424f779d84314959e44b74cfb58e26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/147df5baeaff110fd2c34cb06918232b98a1ca1b53bfdd0e870bff980c7bb56ae8ee2addb24faee9633a07e62d225c9eb1542227fd77073d3f519659ea62826b"} 11:15:09 INFO - Running post-run listener: copy_logs_to_upload_dir 11:15:09 INFO - Copying logs to upload dir... 11:15:09 INFO - mkdir: /builds/slave/test/build/upload/logs 11:15:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1378.675829 ========= master_lag: 1.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 0 secs) (at 2016-07-15 11:15:11.021609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:11.029499) ========= 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.CgibK8ett2/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.AqMlZrDhiz/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2cd68134c56dcf70d4fa09fafab313d4614347f2da178ae6453858397bc3ae249ff18524b9a80e17ff122df87b97ee67aed0e05d99082bb39acc6733db711e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce668e77ac600f19c88c89cc83652c7b85a54520bb1b7153b60b5070063cc044f08f211cd670f6ac771b59c2c11c281bfe424f779d84314959e44b74cfb58e26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/147df5baeaff110fd2c34cb06918232b98a1ca1b53bfdd0e870bff980c7bb56ae8ee2addb24faee9633a07e62d225c9eb1542227fd77073d3f519659ea62826b"} build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b2cd68134c56dcf70d4fa09fafab313d4614347f2da178ae6453858397bc3ae249ff18524b9a80e17ff122df87b97ee67aed0e05d99082bb39acc6733db711e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce668e77ac600f19c88c89cc83652c7b85a54520bb1b7153b60b5070063cc044f08f211cd670f6ac771b59c2c11c281bfe424f779d84314959e44b74cfb58e26", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/147df5baeaff110fd2c34cb06918232b98a1ca1b53bfdd0e870bff980c7bb56ae8ee2addb24faee9633a07e62d225c9eb1542227fd77073d3f519659ea62826b"}' ========= master_lag: 0.61 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:11.647680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:11.648038) ========= 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.CgibK8ett2/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.AqMlZrDhiz/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005107 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:15:11.674478) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:15:11.674783) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:15:11.678151) ========= ========= Total master_lag: 2.15 =========