builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0292 starttime: 1468605138.05 results: success (0) buildid: 20160713141046 builduid: f56c373fb50a40f583c4b414d4dcca39 revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.054135) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.054693) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.055010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.135346) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.135607) ========= 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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-07-15 10:52:18 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106401 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.271208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.271525) ========= 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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.029045 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:18.320970) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:52:18.321297) ========= 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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:18,403 truncating revision to first 12 chars 2016-07-15 10:52:18,403 Setting DEBUG logging. 2016-07-15 10:52:18,403 attempt 1/10 2016-07-15 10:52:18,403 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:19,685 unpacking tar archive at: mozilla-central-5fd14a66be31/testing/mozharness/ program finished with exit code 0 elapsedTime=1.553724 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-15 10:52:19.896901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:19.897223) ========= script_repo_revision: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:19.897615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:19.897895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 10:52:19.916916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-07-15 10:52:19.917183) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8MrG0vH0Cs/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.ZapneCcTdF/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:20 INFO - MultiFileLogger online at 20160715 10:52:20 in /builds/slave/test 10:52:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:52:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:20 INFO - {'append_to_log': False, 10:52:20 INFO - 'base_work_dir': '/builds/slave/test', 10:52:20 INFO - 'blob_upload_branch': 'Firefox', 10:52:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:20 INFO - 'branch': 'Firefox', 10:52:20 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:20 INFO - 'config_files': ('talos/mac_config.py',), 10:52:20 INFO - 'default_actions': ('clobber', 10:52:20 INFO - 'read-buildbot-config', 10:52:20 INFO - 'download-and-extract', 10:52:20 INFO - 'populate-webroot', 10:52:20 INFO - 'create-virtualenv', 10:52:20 INFO - 'install', 10:52:20 INFO - 'run-tests'), 10:52:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:20 INFO - 'download_minidump_stackwalk': True, 10:52:20 INFO - 'download_symbols': 'ondemand', 10:52:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:20 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:20 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:20 INFO - 'installer_path': 'installer.exe', 10:52:20 INFO - 'log_level': 'info', 10:52:20 INFO - 'log_name': 'talos', 10:52:20 INFO - 'log_to_console': True, 10:52:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:52:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:52:20 INFO - 'opt_config_files': (), 10:52:20 INFO - 'pip_index': False, 10:52:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:20 INFO - 'cmd': ('bash', 10:52:20 INFO - '-c', 10:52:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:20 INFO - 'enabled': True, 10:52:20 INFO - 'halt_on_failure': False, 10:52:20 INFO - 'name': 'check_screen_resolution'},), 10:52:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:52:20 INFO - 'cmd': ('bash', 10:52:20 INFO - '-c', 10:52:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:52:20 INFO - 'enabled': True, 10:52:20 INFO - 'halt_on_failure': False, 10:52:20 INFO - 'name': 'check_screen_resolution'},), 10:52:20 INFO - 'run_cmd_checks_enabled': True, 10:52:20 INFO - 'sps_profile': False, 10:52:20 INFO - 'sps_profile_interval': 0, 10:52:20 INFO - 'suite': 'dromaeojs-e10s', 10:52:20 INFO - 'system_bits': '32', 10:52:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:20 INFO - 'title': 't-yosemite-r7-0292', 10:52:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:20 INFO - 'use_talos_json': True, 10:52:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:20 INFO - 'work_dir': 'build'} 10:52:20 INFO - ##### 10:52:20 INFO - ##### Running clobber step. 10:52:20 INFO - ##### 10:52:20 INFO - Running pre-action listener: _resource_record_pre_action 10:52:20 INFO - Running main action method: clobber 10:52:20 INFO - rmtree: /builds/slave/test/build 10:52:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:22 INFO - Running post-action listener: _resource_record_post_action 10:52:22 INFO - ##### 10:52:22 INFO - ##### Finished clobber step (success) 10:52:22 INFO - ##### 10:52:22 INFO - ##### 10:52:22 INFO - ##### Running read-buildbot-config step. 10:52:22 INFO - ##### 10:52:22 INFO - Running pre-action listener: _resource_record_pre_action 10:52:22 INFO - Running main action method: read_buildbot_config 10:52:22 INFO - Using buildbot properties: 10:52:22 INFO - { 10:52:22 INFO - "project": "", 10:52:22 INFO - "product": "firefox", 10:52:22 INFO - "script_repo_revision": "production", 10:52:22 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:52:22 INFO - "repository": "", 10:52:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:52:22 INFO - "buildid": "20160713141046", 10:52:22 INFO - "pgo_build": "False", 10:52:22 INFO - "basedir": "/builds/slave/test", 10:52:22 INFO - "buildnumber": 62, 10:52:22 INFO - "slavename": "t-yosemite-r7-0292", 10:52:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 10:52:22 INFO - "platform": "yosemite_r7", 10:52:22 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:52:22 INFO - "branch": "mozilla-central", 10:52:22 INFO - "repo_path": "mozilla-central", 10:52:22 INFO - "revision": "5fd14a66be3191e5628af3cfb0a456dd70f179b8", 10:52:22 INFO - "stage_platform": "macosx64", 10:52:22 INFO - "builduid": "f56c373fb50a40f583c4b414d4dcca39", 10:52:22 INFO - "slavebuilddir": "test" 10:52:22 INFO - } 10:52:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:52:22 INFO - Running post-action listener: _resource_record_post_action 10:52:22 INFO - ##### 10:52:22 INFO - ##### Finished read-buildbot-config step (success) 10:52:22 INFO - ##### 10:52:22 INFO - ##### 10:52:22 INFO - ##### Running download-and-extract step. 10:52:22 INFO - ##### 10:52:22 INFO - Running pre-action listener: _resource_record_pre_action 10:52:22 INFO - Running main action method: download_and_extract 10:52:22 INFO - mkdir: /builds/slave/test/build/tests 10:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:22 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:22 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:22 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:22 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:22 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:24 INFO - Downloaded 1199 bytes. 10:52:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:52:24 INFO - Using the following test package requirements: 10:52:24 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:52:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:52:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:52:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'jsshell-mac.zip'], 10:52:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:52:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:52:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:52:24 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:52:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:52:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:52:24 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:52:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:52:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:24 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:52:24 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:52:24 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:52:24 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:52:24 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:52:54 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.common.tests.zip: timed out 10:52:54 INFO - retry: attempt #1 caught exception: timed out 10:52:54 INFO - retry: Failed, sleeping 30 seconds before retrying 10:53:24 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 #2 10:53:26 INFO - Downloaded 18827271 bytes. 10:53:26 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:26 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:29 INFO - Return code: 0 10:53:29 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:29 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:29 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:29 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:29 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:29 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:29 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:38 INFO - Downloaded 18827271 bytes. 10:53:38 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:38 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:41 INFO - Return code: 0 10:53:41 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:41 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:53:41 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:53:41 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:53:41 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:53:41 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:53:43 INFO - Downloaded 14403317 bytes. 10:53:43 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:53:43 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:53:43 INFO - Return code: 0 10:53:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:43 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:53:43 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:53:43 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:53:43 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:53:43 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:53:47 INFO - Downloaded 112779863 bytes. 10:53:47 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:53:47 INFO - mkdir: /builds/slave/test/properties 10:53:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:53:47 INFO - Writing to file /builds/slave/test/properties/build_url 10:53:47 INFO - Contents: 10:53:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:53:47 INFO - Running post-action listener: _resource_record_post_action 10:53:47 INFO - Running post-action listener: set_extra_try_arguments 10:53:47 INFO - ##### 10:53:47 INFO - ##### Finished download-and-extract step (success) 10:53:47 INFO - ##### 10:53:47 INFO - ##### 10:53:47 INFO - ##### Running populate-webroot step. 10:53:47 INFO - ##### 10:53:47 INFO - Running pre-action listener: _resource_record_pre_action 10:53:47 INFO - Running main action method: populate_webroot 10:53:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:53:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:53:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:53:48 INFO - '--tppagecycles', 10:53:48 INFO - '7'], 10:53:48 INFO - 'tests': ['tsvgm']}}, 10:53:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:53:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:53:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:53:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:53:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:53:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['damp', 'tps']}, 10:53:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'tests': ['damp', 'tps']}, 10:53:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['dromaeo_dom']}, 10:53:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:53:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['basic_compositor_video']}, 10:53:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:53:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore', 10:53:48 INFO - 'tabpaint']}, 10:53:48 INFO - 'other-e10s': {'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore', 10:53:48 INFO - 'tabpaint']}, 10:53:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore', 10:53:48 INFO - 'tabpaint']}, 10:53:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore', 10:53:48 INFO - 'tabpaint']}, 10:53:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore', 10:53:48 INFO - 'tabpaint']}, 10:53:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['a11yr', 10:53:48 INFO - 'ts_paint', 10:53:48 INFO - 'tpaint', 10:53:48 INFO - 'sessionrestore', 10:53:48 INFO - 'sessionrestore_no_auto_restore', 10:53:48 INFO - 'tabpaint']}, 10:53:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['tsvgx', 10:53:48 INFO - 'tsvgr_opacity', 10:53:48 INFO - 'tart', 10:53:48 INFO - 'tscrollx', 10:53:48 INFO - 'cart']}, 10:53:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:53:48 INFO - 'tsvgr_opacity', 10:53:48 INFO - 'tart', 10:53:48 INFO - 'tscrollx', 10:53:48 INFO - 'cart']}, 10:53:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--disable-e10s'], 10:53:48 INFO - 'tests': ['tp5o']}, 10:53:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'tests': ['tp5o']}, 10:53:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--disable-e10s', 10:53:48 INFO - '--xperf_path', 10:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:48 INFO - 'tests': ['tp5n']}, 10:53:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:53:48 INFO - 'talos_options': ['--xperf_path', 10:53:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:53:48 INFO - 'tests': ['tp5n']}}, 10:53:48 INFO - 'talos.zip': {'path': '', 10:53:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:53:48 INFO - Running post-action listener: _resource_record_post_action 10:53:48 INFO - ##### 10:53:48 INFO - ##### Finished populate-webroot step (success) 10:53:48 INFO - ##### 10:53:48 INFO - ##### 10:53:48 INFO - ##### Running create-virtualenv step. 10:53:48 INFO - ##### 10:53:48 INFO - Running pre-action listener: _resource_record_pre_action 10:53:48 INFO - Running main action method: create_virtualenv 10:53:48 INFO - Creating virtualenv /builds/slave/test/build/venv 10:53:48 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:53:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:53:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:53:48 INFO - Using real prefix '/tools/python27' 10:53:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:53:48 INFO - Installing distribute.............................................................................................................................................................................................done. 10:53:51 INFO - Installing pip.................done. 10:53:51 INFO - Return code: 0 10:53:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:53:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:53:51 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:53:51 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:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:51 INFO - 'HOME': '/Users/cltbld', 10:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:51 INFO - 'LOGNAME': 'cltbld', 10:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:51 INFO - 'MOZ_NO_REMOTE': '1', 10:53:51 INFO - 'NO_EM_RESTART': '1', 10:53:51 INFO - 'PAGER': '/bin/cat', 10:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:51 INFO - 'PWD': '/builds/slave/test', 10:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:51 INFO - 'SHELL': '/bin/bash', 10:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:53:51 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:51 INFO - 'USER': 'cltbld', 10:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:51 INFO - 'XPC_FLAGS': '0x0', 10:53:51 INFO - 'XPC_SERVICE_NAME': '0', 10:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:51 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:53:51 INFO - Cleaning up... 10:53:51 INFO - Return code: 0 10:53:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:53:51 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:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:51 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:53:51 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:53:51 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:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:51 INFO - 'HOME': '/Users/cltbld', 10:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:51 INFO - 'LOGNAME': 'cltbld', 10:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:51 INFO - 'MOZ_NO_REMOTE': '1', 10:53:51 INFO - 'NO_EM_RESTART': '1', 10:53:51 INFO - 'PAGER': '/bin/cat', 10:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:51 INFO - 'PWD': '/builds/slave/test', 10:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:51 INFO - 'SHELL': '/bin/bash', 10:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:53:51 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:51 INFO - 'USER': 'cltbld', 10:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:51 INFO - 'XPC_FLAGS': '0x0', 10:53:51 INFO - 'XPC_SERVICE_NAME': '0', 10:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:52 INFO - Downloading/unpacking psutil>=3.1.1 10:53:52 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:53:52 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:53:52 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:53:52 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:53:52 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:53:52 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:53:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:53:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:55 INFO - Installing collected packages: psutil 10:53:55 INFO - Running setup.py install for psutil 10:53:55 INFO - building 'psutil._psutil_osx' extension 10:53:55 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:53:55 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:53:55 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:53:56 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:53:56 INFO - building 'psutil._psutil_posix' extension 10:53:56 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:53:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:53:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:53:56 INFO - ^ 10:53:56 INFO - 1 warning generated. 10:53:56 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:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:53:56 INFO - Successfully installed psutil 10:53:56 INFO - Cleaning up... 10:53:56 INFO - Return code: 0 10:53:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:56 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:53:56 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:53:56 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:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:56 INFO - 'HOME': '/Users/cltbld', 10:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:56 INFO - 'LOGNAME': 'cltbld', 10:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:56 INFO - 'MOZ_NO_REMOTE': '1', 10:53:56 INFO - 'NO_EM_RESTART': '1', 10:53:56 INFO - 'PAGER': '/bin/cat', 10:53:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:56 INFO - 'PWD': '/builds/slave/test', 10:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:56 INFO - 'SHELL': '/bin/bash', 10:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:53:56 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:56 INFO - 'USER': 'cltbld', 10:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:56 INFO - 'XPC_FLAGS': '0x0', 10:53:56 INFO - 'XPC_SERVICE_NAME': '0', 10:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:53:59 INFO - Installing collected packages: mozsystemmonitor 10:53:59 INFO - Running setup.py install for mozsystemmonitor 10:53:59 INFO - Successfully installed mozsystemmonitor 10:53:59 INFO - Cleaning up... 10:53:59 INFO - Return code: 0 10:53:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:53:59 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:53:59 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:53:59 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:53:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:53:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:53:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:53:59 INFO - 'HOME': '/Users/cltbld', 10:53:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:53:59 INFO - 'LOGNAME': 'cltbld', 10:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:59 INFO - 'MOZ_NO_REMOTE': '1', 10:53:59 INFO - 'NO_EM_RESTART': '1', 10:53:59 INFO - 'PAGER': '/bin/cat', 10:53:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:59 INFO - 'PWD': '/builds/slave/test', 10:53:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:53:59 INFO - 'SHELL': '/bin/bash', 10:53:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:53:59 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:53:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:53:59 INFO - 'USER': 'cltbld', 10:53:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:53:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:59 INFO - 'XPC_FLAGS': '0x0', 10:53:59 INFO - 'XPC_SERVICE_NAME': '0', 10:53:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:53:59 INFO - Downloading/unpacking jsonschema==2.5.1 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:54:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:54:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:54:02 INFO - warning: no files found matching '*.txt' 10:54:02 INFO - no previously-included directories found matching 'build' 10:54:02 INFO - no previously-included directories found matching 'dist' 10:54:02 INFO - no previously-included directories found matching '.git*' 10:54:02 INFO - Installing collected packages: jsonschema, functools32 10:54:02 INFO - Running setup.py install for functools32 10:54:02 INFO - warning: no files found matching '*.txt' 10:54:02 INFO - no previously-included directories found matching 'build' 10:54:02 INFO - no previously-included directories found matching 'dist' 10:54:02 INFO - no previously-included directories found matching '.git*' 10:54:02 INFO - Successfully installed jsonschema functools32 10:54:02 INFO - Cleaning up... 10:54:02 INFO - Return code: 0 10:54:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:02 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:02 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:02 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:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:54:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:02 INFO - 'HOME': '/Users/cltbld', 10:54:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:02 INFO - 'LOGNAME': 'cltbld', 10:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:02 INFO - 'MOZ_NO_REMOTE': '1', 10:54:02 INFO - 'NO_EM_RESTART': '1', 10:54:02 INFO - 'PAGER': '/bin/cat', 10:54:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:02 INFO - 'PWD': '/builds/slave/test', 10:54:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:02 INFO - 'SHELL': '/bin/bash', 10:54:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:54:02 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:54:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:02 INFO - 'USER': 'cltbld', 10:54:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:02 INFO - 'XPC_FLAGS': '0x0', 10:54:02 INFO - 'XPC_SERVICE_NAME': '0', 10:54:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:54:03 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:03 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:03 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:03 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:03 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:03 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:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:54:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:54:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:54:05 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:05 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:05 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:05 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:05 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:05 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:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:54:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:54:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:54:06 INFO - Downloading docopt-0.6.1.tar.gz 10:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:54:06 INFO - Installing collected packages: blobuploader, requests, docopt 10:54:06 INFO - Running setup.py install for blobuploader 10:54:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:54:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:54:07 INFO - Running setup.py install for requests 10:54:07 INFO - Running setup.py install for docopt 10:54:07 INFO - Successfully installed blobuploader requests docopt 10:54:07 INFO - Cleaning up... 10:54:07 INFO - Return code: 0 10:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:07 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:07 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:07 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:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:54:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:07 INFO - 'HOME': '/Users/cltbld', 10:54:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:07 INFO - 'LOGNAME': 'cltbld', 10:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:07 INFO - 'MOZ_NO_REMOTE': '1', 10:54:07 INFO - 'NO_EM_RESTART': '1', 10:54:07 INFO - 'PAGER': '/bin/cat', 10:54:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:07 INFO - 'PWD': '/builds/slave/test', 10:54:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:07 INFO - 'SHELL': '/bin/bash', 10:54:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:54:07 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:54:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:07 INFO - 'USER': 'cltbld', 10:54:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:07 INFO - 'XPC_FLAGS': '0x0', 10:54:07 INFO - 'XPC_SERVICE_NAME': '0', 10:54:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-hVVDhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-5QOXv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-AUpw3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-1hkoeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-uhfT12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-mEb0y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-hbl3mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-9Gs0da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:08 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-K7LUJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-zqQxDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-XJacWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ZMrCL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-TwvGWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-kKscjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-qQayFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-hdm2nB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:09 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-JzqxlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:54:09 INFO - Running setup.py install for manifestparser 10:54:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:54:10 INFO - Running setup.py install for mozcrash 10:54:10 INFO - Running setup.py install for mozdebug 10:54:10 INFO - Running setup.py install for mozdevice 10:54:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:54:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:54:10 INFO - Running setup.py install for mozfile 10:54:10 INFO - Running setup.py install for mozhttpd 10:54:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:54:10 INFO - Running setup.py install for mozinfo 10:54:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:54:10 INFO - Running setup.py install for mozInstall 10:54:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Running setup.py install for mozleak 10:54:11 INFO - Running setup.py install for mozlog 10:54:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Running setup.py install for moznetwork 10:54:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Running setup.py install for mozprocess 10:54:11 INFO - Running setup.py install for mozprofile 10:54:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Running setup.py install for mozrunner 10:54:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:54:11 INFO - Running setup.py install for mozscreenshot 10:54:12 INFO - Running setup.py install for moztest 10:54:12 INFO - Running setup.py install for mozversion 10:54:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:54:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:54:12 INFO - Cleaning up... 10:54:12 INFO - Return code: 0 10:54:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:12 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:12 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:12 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:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:54:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:12 INFO - 'HOME': '/Users/cltbld', 10:54:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:12 INFO - 'LOGNAME': 'cltbld', 10:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:12 INFO - 'MOZ_NO_REMOTE': '1', 10:54:12 INFO - 'NO_EM_RESTART': '1', 10:54:12 INFO - 'PAGER': '/bin/cat', 10:54:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:12 INFO - 'PWD': '/builds/slave/test', 10:54:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:12 INFO - 'SHELL': '/bin/bash', 10:54:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:54:12 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:54:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:12 INFO - 'USER': 'cltbld', 10:54:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:12 INFO - 'XPC_FLAGS': '0x0', 10:54:12 INFO - 'XPC_SERVICE_NAME': '0', 10:54:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:54:12 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-BolYAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:54:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:54:12 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Y6RIn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:54:12 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:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:54:12 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Y1yZbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-dUL2jQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-vsljLF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-9QIN1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-ZDjuD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-NyN8K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-1ZsYIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-srlrbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-RrKlSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-hRiqTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:54:13 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:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:54:13 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-79TWpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:54:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:54:14 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-IAygO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:54:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:14 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-gYoNG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:54:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:54:14 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-Im1sYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:54:14 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:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:54:14 INFO - Running setup.py (path:/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/pip-jXH36i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:54:14 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:14 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:14 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:14 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:14 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:14 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:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:54:14 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:14 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:14 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:14 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:14 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:14 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:16 INFO - Downloading blessings-1.6.tar.gz 10:54:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:54:17 INFO - Installing collected packages: blessings 10:54:17 INFO - Running setup.py install for blessings 10:54:17 INFO - Successfully installed blessings 10:54:17 INFO - Cleaning up... 10:54:17 INFO - Return code: 0 10:54:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:54:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:17 INFO - Reading from file tmpfile_stdout 10:54:17 INFO - Current package versions: 10:54:17 INFO - blessings == 1.6 10:54:17 INFO - blobuploader == 1.2.4 10:54:17 INFO - docopt == 0.6.1 10:54:17 INFO - functools32 == 3.2.3-2 10:54:17 INFO - jsonschema == 2.5.1 10:54:17 INFO - manifestparser == 1.1 10:54:17 INFO - mozInstall == 1.12 10:54:17 INFO - mozcrash == 0.17 10:54:17 INFO - mozdebug == 0.1 10:54:17 INFO - mozdevice == 0.48 10:54:17 INFO - mozfile == 1.2 10:54:17 INFO - mozhttpd == 0.7 10:54:17 INFO - mozinfo == 0.9 10:54:17 INFO - mozleak == 0.1 10:54:17 INFO - mozlog == 3.2 10:54:17 INFO - moznetwork == 0.27 10:54:17 INFO - mozprocess == 0.23 10:54:17 INFO - mozprofile == 0.28 10:54:17 INFO - mozrunner == 6.12 10:54:17 INFO - mozscreenshot == 0.1 10:54:17 INFO - mozsystemmonitor == 0.3 10:54:17 INFO - moztest == 0.7 10:54:17 INFO - mozversion == 1.4 10:54:17 INFO - psutil == 3.1.1 10:54:17 INFO - requests == 1.2.3 10:54:17 INFO - wsgiref == 0.1.2 10:54:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:54:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:17 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:17 INFO - 'HOME': '/Users/cltbld', 10:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:17 INFO - 'LOGNAME': 'cltbld', 10:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:17 INFO - 'MOZ_NO_REMOTE': '1', 10:54:17 INFO - 'NO_EM_RESTART': '1', 10:54:17 INFO - 'PAGER': '/bin/cat', 10:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:17 INFO - 'PWD': '/builds/slave/test', 10:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:17 INFO - 'SHELL': '/bin/bash', 10:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:54:17 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:17 INFO - 'USER': 'cltbld', 10:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:17 INFO - 'XPC_FLAGS': '0x0', 10:54:17 INFO - 'XPC_SERVICE_NAME': '0', 10:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 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:17 INFO - Cleaning up... 10:54:17 INFO - Return code: 0 10:54:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:54:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:54:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:54:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:54:17 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 0x106ad2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106b67618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fac0bc8a050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, '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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:54:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:17 INFO - 'HOME': '/Users/cltbld', 10:54:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:17 INFO - 'LOGNAME': 'cltbld', 10:54:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:17 INFO - 'MOZ_NO_REMOTE': '1', 10:54:17 INFO - 'NO_EM_RESTART': '1', 10:54:17 INFO - 'PAGER': '/bin/cat', 10:54:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:17 INFO - 'PWD': '/builds/slave/test', 10:54:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:17 INFO - 'SHELL': '/bin/bash', 10:54:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:54:17 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:54:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:17 INFO - 'USER': 'cltbld', 10:54:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:17 INFO - 'XPC_FLAGS': '0x0', 10:54:17 INFO - 'XPC_SERVICE_NAME': '0', 10:54:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:54:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:54:18 INFO - Cleaning up... 10:54:18 INFO - Return code: 0 10:54:18 INFO - Running post-action listener: _resource_record_post_action 10:54:18 INFO - Running post-action listener: _start_resource_monitoring 10:54:18 INFO - Starting resource monitoring. 10:54:18 INFO - ##### 10:54:18 INFO - ##### Finished create-virtualenv step (success) 10:54:18 INFO - ##### 10:54:18 INFO - ##### 10:54:18 INFO - ##### Running install step. 10:54:18 INFO - ##### 10:54:18 INFO - Running pre-action listener: _resource_record_pre_action 10:54:18 INFO - Running main action method: install 10:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:54:18 INFO - Reading from file tmpfile_stdout 10:54:18 INFO - Detecting whether we're running mozinstall >=1.0... 10:54:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:54:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:54:18 INFO - Reading from file tmpfile_stdout 10:54:18 INFO - Output received: 10:54:18 INFO - Usage: mozinstall [options] installer 10:54:18 INFO - Options: 10:54:18 INFO - -h, --help show this help message and exit 10:54:18 INFO - -d DEST, --destination=DEST 10:54:18 INFO - Directory to install application into. [default: 10:54:18 INFO - "/builds/slave/test"] 10:54:18 INFO - --app=APP Application being installed. [default: firefox] 10:54:18 INFO - mkdir: /builds/slave/test/build/application 10:54:18 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:18 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:54:53 INFO - Reading from file tmpfile_stdout 10:54:53 INFO - Output received: 10:54:53 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:54:53 INFO - Running post-action listener: _resource_record_post_action 10:54:53 INFO - ##### 10:54:53 INFO - ##### Finished install step (success) 10:54:53 INFO - ##### 10:54:53 INFO - ##### 10:54:53 INFO - ##### Running run-tests step. 10:54:53 INFO - ##### 10:54:53 INFO - Running pre-action listener: _resource_record_pre_action 10:54:53 INFO - Running main action method: run_tests 10:54:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:54:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:54:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:54:53 INFO - 2016-07-15 10:54:53.152 screenresolution[1665:14056] starting screenresolution argv=screenresolution get 10:54:53 INFO - 2016-07-15 10:54:53.154 screenresolution[1665:14056] Display 0: 1600x1200x32@60 10:54:53 INFO - 2016-07-15 10:54:53.161 screenresolution[1666:14059] starting screenresolution argv=screenresolution list 10:54:53 INFO - Available Modes on Display 0 10:54:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:54:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:54:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:54:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:54:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:54:53 INFO - Intel Iris: 10:54:53 INFO - Chipset Model: Intel Iris 10:54:53 INFO - Type: GPU 10:54:53 INFO - Bus: Built-In 10:54:53 INFO - VRAM (Dynamic, Max): 1536 MB 10:54:53 INFO - Vendor: Intel (0x8086) 10:54:53 INFO - Device ID: 0x0a2e 10:54:53 INFO - Revision ID: 0x0009 10:54:53 INFO - Displays: 10:54:53 INFO - Display: 10:54:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:54:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:54:53 INFO - Display Serial Number: 1600x1200 60 10:54:53 INFO - Main Display: Yes 10:54:53 INFO - Mirror: Off 10:54:53 INFO - Online: Yes 10:54:53 INFO - Rotation: Supported 10:54:53 INFO - Return code: 0 10:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:54:53 INFO - Python 2.7.3 10:54:53 INFO - Return code: 0 10:54:53 INFO - grabbing minidump binary from tooltool 10:54:53 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:53 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 0x106a36d30>, '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 0x10679bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106a2eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:54:53 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:54:53 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:54:53 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:54:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:54:53 INFO - Return code: 0 10:54:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:54:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:54:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:54:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:54:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0292 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:54:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8MrG0vH0Cs/Render', 10:54:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:54:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:54:53 INFO - 'HOME': '/Users/cltbld', 10:54:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:54:53 INFO - 'LOGNAME': 'cltbld', 10:54:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:54:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:54:53 INFO - 'MOZ_NO_REMOTE': '1', 10:54:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:54:53 INFO - 'NO_EM_RESTART': '1', 10:54:53 INFO - 'PAGER': '/bin/cat', 10:54:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:54:53 INFO - 'PWD': '/builds/slave/test', 10:54:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:54:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:54:53 INFO - 'SHELL': '/bin/bash', 10:54:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZapneCcTdF/Listeners', 10:54:53 INFO - 'TMPDIR': '/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/', 10:54:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:54:53 INFO - 'USER': 'cltbld', 10:54:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:54:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:54:53 INFO - 'XPC_FLAGS': '0x0', 10:54:53 INFO - 'XPC_SERVICE_NAME': '0', 10:54:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:54:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0292', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:54:53 INFO - mozversion application_buildid: 20160713141046 10:54:53 INFO - mozversion application_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:54:53 INFO - mozversion application_display_name: Nightly 10:54:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:54:53 INFO - mozversion application_name: Firefox 10:54:53 INFO - mozversion application_remotingname: firefox 10:54:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:54:53 INFO - mozversion application_vendor: Mozilla 10:54:53 INFO - mozversion application_version: 50.0a1 10:54:53 INFO - mozversion platform_buildid: 20160713141046 10:54:53 INFO - mozversion platform_changeset: 5fd14a66be3191e5628af3cfb0a456dd70f179b8 10:54:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:54:53 INFO - mozversion platform_version: 50.0a1 10:54:53 INFO - using testdate: 1468605293 10:54:53 INFO - actual date: 1468605293 10:54:53 INFO - starting webserver on 'localhost:49283' 10:54:53 INFO - SUITE-START | Running 2 tests 10:54:53 INFO - TEST-START | dromaeo_css 10:54:53 INFO - operating with platform_type : mac_ 10:54:53 INFO - Initialising browser for dromaeo_css test... 10:54:53 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpaIETBX/profile http://localhost:49283/getInfo.html) 10:54:56 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 10:54:56 INFO - PROCESS | 1676 | colorDepth:24 10:54:56 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 10:54:56 INFO - PROCESS | 1676 | __metrics 10:54:56 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 10:54:57 INFO - TEST-INFO | 1676: exit 0 10:54:57 INFO - Browser initialized. 10:54:57 INFO - Running cycle 1/1 for dromaeo_css test... 10:54:57 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmpaIETBX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:55:09 INFO - PROCESS | 1680 | RSS: Main: 253902848 10:55:09 INFO - PROCESS | 1680 | 10:55:59 INFO - PROCESS | 1680 | 1468605359195 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:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 10:58:11 INFO - PROCESS | 1680 | RSS: Main: 268328960 10:58:11 INFO - PROCESS | 1680 | 11:01:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 11:01:14 INFO - PROCESS | 1680 | RSS: Main: 277143552 11:01:14 INFO - PROCESS | 1680 | 11:04:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 11:04:16 INFO - PROCESS | 1680 | RSS: Main: 281468928 11:04:16 INFO - PROCESS | 1680 | 11:07:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 11:07:19 INFO - PROCESS | 1680 | RSS: Main: 280379392 11:07:19 INFO - PROCESS | 1680 | 11:10:22 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 11:10:22 INFO - PROCESS | 1680 | RSS: Main: 284037120 11:10:22 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 11:13:25 INFO - PROCESS | 1680 | RSS: Main: 284225536 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | __start_tp_report 11:13:25 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 11:13:25 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 11:13:25 INFO - PROCESS | 1680 | |i|pagename|runs| 11:13:25 INFO - PROCESS | 1680 | |0;dojo.html;2811.002094256539;3399.5580574525306;3413.7781044232124;3439.398105331567;3454;5732.627379220353;5754.74103665335;5845.849446892706;5846.678432686201;5849.532037437006;5615.971920140393;5734.340550836655;5745.224394706714;5763.9711801440935;5803.941960580393;5208;5231.659942103751;5275.657082289658;5316.9202461963105;5370.650907691007;5247.921281180786;5345.839624811242;5392.083345831198;5420.024395608789;5456;5142.97428512855;5196.662216955886;5240.554552863011;5271.683698978054;5310.468953104697;5277.683338999634;5302.257683924254;5304.045271851065;5309.0709125903195;5325.068113080234;5099.388073431212;5241.895162096736;5264.236685680555;5314.92027619586;5355.437679043722;4288.571142885687;4885.316055752198;5621.437856214387;5723.685197314146;5728.742206600713;6274.090256912722;6302.621842689453;6316.115743795872;6325.462335701471;6328.746850125989;6099.58217961314;6138.5723274837055;6274.403931626488;6294.685265736694;6306.211723534559;5856.7071646417935;5864.38423965486;5905.498032667271;5940.702964851784;6016.578839481238;6268.434381051618;6300.086487459293;6311.558190926683;6315.747370105236;6329.588576742497;6056.303525094582;6123.709696704001;6147.9548476759055;6252.718627661766;6255.280642726054;6277.619831413056;6287.49700023997;6317.747290108436;6330.778422755181;6347.714352854133;6143.262808463013;6207.068939659087;6247.5939063960695;6261.9373806262265;6269.122322874801;5070;6123.465646421124;6221.595596286227;6303.873922521524;6344;4953.108440480676;5038.269450929594;5041.168207245763;5056.292119103328;5060.949390506122;4332.59190762997;4472.217361961643;4507.504174540798;4510.819567217341;4534.818607255739;5266.368035835648;5309.522143007148;5660.122680984454;5743.195952566644;5863.853403664857;6235.282942461584;6284.874302513924;6286.528510361742;6311.968440157862;6317.6209427434505;5883.901736257782;5935.614185077956;5947.821565353046;5970.671613061323;6024;5424.728763561806;5462.180672899018;5526.889462210734;5556.083246264402;5577.9442205577425;6426.132472116298;6434;6443.4523065539015;6450.096986421999;6460.030995350547;5247.658902171346;6184.381561843779;6266.937330626818;6279.905801412891;6292;6164.938350616437;6228.283747369111;6280.246370435577;6317.115603815378;6431.067495213261;5084.923726144185;5182.948170518246;6197.752089916353;6205.379462053758;6245.875082498415;6328.557001009885;6332.240131184288;6340.9048864268;6341.873162536631;6343.524235682435;5659.405762395054;5666.405027472056;6133.457080270768;6156.876862462816;6261.4364707174755;6128.724207410588;6200.7519699211525;6209.534284928558;6230.968845155745;6231.784801963755;5851.1223316502865;5910.1134829774155;6073.240844894388;6129.172561704113;6138.662373569318;6109.192117491969;6111.682900513672;6180.969095154495;6196.721147548281;6234.096056071935;5997.190379298913;6001.159837622649;6025.397460253939;6028.4272994065495;6055.424734650202 11:13:25 INFO - PROCESS | 1680 | |1;ext.html;456.28591254686415;523.9502247286506;537.094994933537;546.366215190379;602.1359349333703;38381.697098174096;38899;38967;39103.21793564127;39320.21359572807;40051;40698.98252543688;40740.59259407405;40812.59187408125;40842.591574084254;9299.581518831652;9464.62141514342;9507.857382139273;9515;9575.90424095757;9666.178374838148;9760.4631745254;9763.072508111718;9772.755681107958;9793.657221997231;9682.757931051745;9742.464164470952;9755.707328780149;9789.461579613118;9798.853017204749;8255.999999999969;8754.69358572447;9444.102810233016;9670.613175472972;9696.951515242414;9615.567299471471;9683.90316096837;9713.368631039031;9744.95127524365;9765.121139097444;38678.806605967075;39110.804445977876;39295.60704392948;39484.21031579381;39526.60473395287;2773.362126710868;3339.081752518053;3371.900167847904;3555.5733312002467;3581.713462922986;30832;31262.68737312643;31661.05016849498;31951;31958.520622190685;2706.526357887362;3087.552304915797;3146.9055928322186;3175.412548678502;3208.839558022113;432489;432813;433758;438265.8086709578;438788;32787.836060820024;33286.66713332884;33313.3337333252;33372.99881003574;33464.665353346645;34878.82560587231;35189.94430167099;35680.82159589185;35794.105147371;35842.82078589591;16154.596135096717;16283.511494655178;16369.918150409172;16410.261538230807;16421.343146274015;12448.62654120378;12676.49294028247;12737.617871463872;12738.363081845871;12772.872271277354;19373.709394359095;19695.901520492305;19739.703904441445;19923.800761992195;19948;8336.916630833735;8369;8400.915990840136;8430.241278284984;8493.556095463786;947.5830634520789;1097.1168209591356;1130.6099395708468;1133.240728711765;1168.649405178443;27129.728702713113;30515.847420762755;30829.491248028684;31101.066967990995;31151.22121946924;1049.9842502362471;1073.5239046311322;1095.4522738630685;1115.3921112993437;1129.2885482146196;12850.986415353267;14912.850871491362;15333.31000104998;16132.354705811871;16488.114579948462;814748;840696;841753;845127;845918.4744839093;59888;60347.69826150841;61680;61694.38305616976;61935.07097393543;1294.501616877509;1431.9427222911174;1434.770436730139;1446.0456098974626;1454.70178613384;31022.53466198054;31485.527717083805;31905.361892762478;32021.013103227906;32201;51938.74030629823;52197.7390113047;52481.21278180754;52595.21107183319;52677.7366113167;582980;583633;587873;588955;589399;26941.595876062267;27230.455390892468;27298;27840.86079569589;28035.57946630843;48830;49338.506614933394;50026;50416.24375634442;50461.73845653888;39623.80188099041;40707.796461017504;41050.79474602608;41260.58739412567;41615.7919210402;40377.39433908553;40691.389629156176;40964.97587560335;41030.79484602558;41664;35383.469247960784;35730.64269357377;36206.732764353124;39352.60647393604;39903;31717;33680;34346.96959091231;35874.923752287476;36427.27145457129;19690.21239150418;23030.769692303533;24767.009319627014;26146.08488702886;26203 11:13:25 INFO - PROCESS | 1680 | |2;jquery.html;375.4106053496011;382.0734718308102;390.8241291418862;401.53422030444654;409.5740429952849;16332.673346533062;18908.810911890876;20904.477388065287;20931;21123;18353.082345882718;20570.794292057075;20802.89598552009;21294;21497;5338.599605029619;5528.612997090206;5765;6116.663583502906;6122.816315510519;5913;6013.428724271187;6069.605475644069;6087.543434242428;6096.725647345858;5306.124489459235;5356.0894647909945;5462.317210348707;5483.588730845183;5928.081147422135;5312.654677445954;5331.2003199519995;5340.25236466895;5442.12925931851;5444.673319600836;4799.904001919942;5108.131617625013;5355.812546560891;5420.214068960018;5434.755436005389;13341.199528028252;15655.68688626221;19925.800741992538;25969.480610387687;26321;2174.7825217478285;2407.1454633605167;2429.6234083717054;2605.5831067029185;2659.414928715699;10069;10229.897701022968;10241.334313269614;11024.944875275653;15972.920135399365;1795.9910200449044;1830.359374219026;1865.4963159946738;1903.2196799312353;1942.1926148848338;98904;111757;120899.39550302192;123486;123680.38159809234;11265.605703800327;11291.774164516664;11713.941430292964;11721.589744358907;11818.645440636794;12389.380530973416;14759.262036898112;14826.703465930621;14844.480443184437;14861.554153375417;8562.357823163287;8566.871496927552;8583.480772883087;8653.610587523577;8694.26098781598;7389.7413590524075;7929.603519823986;8592.882925219681;8634.740957771277;8663.393562450568;3960.7523630057017;4576.954230457719;4652.790624421909;4672.813087476463;4683.946112124745;1827.241694696686;1951.6389467948475;1989.0154373584878;2030.7258520099597;2039.4289598912328;818.9344852411792;902.5036230073433;922.3405265235255;1017.2777328096986;1034.0693375961694;20611.38165855027;21279.36161915114;21320.680189797167;21758.129674813146;21841.471097023055;665.7736369634348;989.7426669066094;995.7411073121041;1010.686687126993;1014.3812274512542;10735.141188704885;11132.721681957853;11190.608328708457;11203.663890083311;11213.102951764002;535652;536870;537541;587630;594779;99513;120391.79608203805;124180;139190.3040484791;140821;985.8126955878361;1004.7437903334749;1013.478058799704;1032.3238278927315;1037.725002874239;15795.842041579897;18469.076546172906;18872.811271887105;18875.451814004933;19031.714524282423;42737.57262427336;55025.72487137539;55800.441995581146;55930.99999999837;56405.153922692014;84009.57995209986;84712.30575388581;84772.57613711891;85623;85701.57149214215;7883.5664038478435;7972.1230664628;7980.561069141021;8106.83786324282;8179.0594081681365;10320;12530.937345313216;12560.43478043472;12581.685457863627;12603.810942836048;10538.525766340379;10721.41032243234;10760.3543787373;10810;10851.294665846695;10073.19414446857;10089;10406.687799366031;10491;10586.788264234827;10276.434796085989;10347.27569070158;10608.416537090534;10648.8935110651;10883.292585981886;7645.503042302233;7664.961675191588;7675.769726908202;7847.940528028643;7859.960700196462;9933.00669933001;10106.696799096038;10582.629607963685;10716.410597417216;10812.459377031275 11:13:25 INFO - PROCESS | 1680 | |3;mootools.html;1577.9999999999995;1601.9118948457835;1853.1197681101478;1924.5862139639992;1929.5369111413256;8113.472624279432;8592.785180370494;8678.609462574184;9049.45703257805;9076.682316118937;8725.171108744675;8765.123487651232;8898.822023559525;8927;8929.508877011762;2340.5903966805827;2355.6937598112263;2383.9284821455385;2384.844985075973;2392.3899405651623;2319.22306027481;2364.9763502364926;2384.654225137354;2403.6995375578053;2404.5311164322966;2329.8252631052655;2344.4724936889147;2385.034061205206;2394.365493144318;2400.459896523277;2288.164819840763;2317.6986991690974;2333.1600623775425;2353.752855950126;2355.8586484810967;2272.3864556569797;2278.327893271489;2280.851744636593;2280.931572052841;2287.9199228026937;8858.335624828163;8947.060558641315;8973.865392019125;9056.501892395916;9066.320025998077;5259.86850328741;5288.418273989858;5328.6269961102735;5372.382176049726;5440.537554307889;3313.867445302209;3391.6777906098882;3551.3607550640872;3693.765272010422;3698.2048859495067;1076.332673742277;1098.2147764348529;1102.8456016157745;1111.416506334173;1118.3569447567681;11760.353180575064;11801.29192248468;11936.522539098425;11947.402629868559;11957.820632690517;4624.26011838111;4635.235186194308;4816.831410900601;4849.709017458964;4853.19922212838;9973.60105595768;10169.644062457779;10194.286399951932;10207.183425325957;10217;5220.582353411718;5283.524482796567;5331.493508116722;5339;5377.677339359651;4065.9390109148385;4388.846390376385;4858.149823780825;4889.291052797395;4917.680350777188;3969.2656858480696;4010.1378203685763;4078.4494093297617;4096.897577560585;4126.546079931205;1303.3157592263947;1307.4966138036734;1308.4504508106618;1310.5740634293702;1314.822498962647;939.2204470289644;948.8244674735196;954.656323723459;955.5699935029264;990.7919336939179;4834.492378300298;5879.235699359056;6189.257289125334;6276.184096067482;6289.685515724195;430;435.0819770284697;452.678598195285;460.2153328574772;464.7536805493094;4136.73111247768;4149.398337241083;4209.873703788891;4217.472815898012;4279.272523670983;10467.94766026165;10911.399873006902;11006.559737610405;11013.394263315595;11083.002529772199;10682.679519614268;10949.397783122005;10958.397288149228;10961.56153753841;10988.120950323955;7945.12603613602;8318.45930014547;8441.19808618168;8475.364347673949;8623.396362254707;6121.47967422774;6345.3654634538025;6352.301246862934;6394.23269207698;6397.200349956255;9959.601615935282;9986.251031172545;10237.18102551809;10270.691879243335;10292.485375731334;10193.84709229377;10322.174226062047;10431.63489277902;10497.685069447929;10545.31455455393;7088.716451341888;7557.282058204682;7587.355074818703;7678.040244969379;7744.8451030980195;8436.95781521113;8508.489490630582;8661.177188167114;8700.521471319138;8729.91270087291;6580.473562114924;7492.550446973199;7698.191689872483;7723.884141737991;7746.109197442366;7461.813454663677;7528.849423011399;7545.962270188614;7598.582077985764;7662.387009039375;7069.151701795818;7071.151461824614;7180.964095179491;7222.349988501061;7239.312265334785;4343.5439278875265;5163.8192663256605;5245.449227831023;5281.841544753664;5322.802369466839;5225.216217567396;5277.472252774692;5298.4171741107675;5374.032674118696;5402.486763757437 11:13:25 INFO - PROCESS | 1680 | |4;prototype.html;316.06444923027834;316.29308495512527;317.66327692645797;318.6829105040484;323.98380080995946;5833.241678581784;5864.061750119977;5864.266966629171;5869.61847479914;5905.438983296591;4525.660575456837;4745.484893006712;5791.449812267839;5852.502537284336;5853.536615846038;3362.42838717418;4209.326507758759;4289.24938135825;4348.89127771805;4368.759718215497;4300;4342.761148136851;4362.956370436286;4371.344298355256;4384.693071484998;3560.893173204808;4125.628693417591;4333.544977777336;4357;4360.3430696335345;3593.802340871251;3693.4829123922673;4032.778197199138;4290.76400797956;4369.453818272716;3613.98808333667;3672.73290714703;3680.392735198689;3687.7418580699364;3689.24370504046;4916.942857285665;5625.943740562624;5654.293213348332;5694.177863083815;5723.713814309268;4497.335985685285;4532.9546704533195;4567.49272739995;4975.328330675385;5005.924911126336;6101.481374083208;6130.662813545253;6156.384361563808;6168.242051015439;6189.752409903644;4088.550259471456;4104.671626269891;4105.117399759066;4105.938410923838;4132.090939993197;5537.335519737658;5560.916586251209;5855.687003633583;6406.2953075161695;6418;4080.755154690728;4113.876583702494;4142.357934520154;4162.125953549788;4166.250074986531;4219.915601688011;4220.320096738593;4229.435109009686;4232.661387089087;4233.703640745119;4632.930506042412;4915.43472500667;4977.850664480072;4993.675411098267;5009.34691551787;5394.730263486888;6198.380161983766;6206.348333425016;6208.565400421927;6246.656433896179;1424.672325365172;1443.4226309476082;1448.7681970884607;1451.4411951398788;1452.4771082410534;795.8050277682005;829.6764261937849;839.4963022186639;916.9958895009953;943.4622265308845;5124.795008199705;5388.461153884658;5458.972705136449;5588.30146231721;5640.32316122068;4957.479464656231;5310.840674779763;5517.834464966058;6149.538784591084;6270.216222972129;5507.421720719347;5589.916151257735;5653.745581448845;5670;5690.516306113944;3022.9872992547744;3287.671232876693;3326.467765157563;3331.200511877132;3334.733221342287;5881.705914704247;6516.804495865132;6531.412172904366;6558.213014438298;6586.901196482057;5615.859603509945;6088.812681527148;6493.220813502316;6533.411992920564;6537.313582073909;5163.715995620127;5926.844265368298;6511.934880651228;6562.77030303937;6604.86790264192;4904.950950490592;5204.713740744295;6260.2718512562315;6406.679666016587;6458.580192287486;5106.412762532356;5662.745176467151;5769.230769230709;6336.9088200892675;6405.135306733718;5763.452472015152;5792.304923409218;6354.015127655221;6579.342065793382;6637.112855907696;4144.466547377369;4147.315692910636;4149.958500414958;4165.354370072643;4166.854115118245;6021.427964343556;6023.879522409615;6159.692015399122;6400.359964003748;6426.742930282736;5348.598855085962;5870.911936321044;6153.784617538365;6163.414475624809;6200.81397558074;6165.938340616536;6170.50635949114;6184.165137706352;6198.256209254918;6224.470919971853;5620.887582248414;6068;6084.847878803065;6088.756449741961;6105.786297479567;6110.455935557455;6140.692965351804;6166.4758495526585;6188.628682279078;6204.348543402878;4963.602911766978;5462.875528975598;5475.233467314659;5723.456271654186;6045 11:13:25 INFO - PROCESS | 1680 | |5;yui.html;693.9618320992347;739.3382922284555;742.485329926949;770.3682979956435;839.5004972041637;15359.84640153598;15532.068075915453;15828.604284892868;15875.761863572026;15877.285522151502;14437.35031923566;14481.493147739804;14530.418783248657;14594.05138665986;14615.415383384652;702.8313204830829;765.5291995422831;870.8867847179857;879.0286733159862;900.8513595256775;889.2485849457198;897.4346161917982;902.0979020979021;902.9458232506038;907.3557773980482;755.5353457623577;929.3494553812325;960.3373672166218;964.903509649033;967.632299726103;933.9112784285481;961.1925982174971;961.6730311694023;962.2398305338774;963.942163470194;690.3890057299326;701.0850839654249;714.8641758066003;716.5127713155052;716.7742161219252;15365.539033829004;15404.075755454596;15662.530124096294;15772.447964321194;15840;11439;15204.391824327015;15273.61815954599;15297.923510382489;15335.769963450557;12122.39388030595;12381.62855114348;12577.685557861036;12590;12630.74738505234;3672.9348488938176;3703.463062828923;3811.6569508744346;3851.711121665858;4173.123644034757;83372.16627833704;88497;110498.60761835253;111185.44407277992;111288.83912504512;9856.45789481571;9943.353682010646;11499.562554680664;11875.465604047838;12002.519899204108;20912.895435522725;24917;25060.498790024096;25114.497710046064;25126.246212613652;7904.644291006918;8116.431849770459;8204.917950820416;8210.507369557845;8218.5488984189;3991.560928297885;4053;4071.307877660805;4094.754314741125;4114.115465175002;3691.8154092295276;3697.131174174067;3814.599467055975;3821.407681809324;3821.7515861468914;577.2380457795754;634.9714262858182;658.8352911772057;662.8598810046711;665.088828305225;599.256921417448;628.6071205496564;631.5358211714387;646.8253571535753;660.7125900233318;7861.842763144819;8152.551609661407;9247.0752924707;9480.478573678376;9867;588.7733222709288;638.7349250061172;668.12809283885;673.5520878615665;678.1861765880864;4579.74811385377;4664.463586687507;4694.201985662446;4748.881277968009;4828.7102773833685;126235;141630;156007;157037;158857;140307;141839.2908035474;141922.2903885474;144336;144909;78705.21294787094;90981;118700.69095163429;119212;122924;7723.95726576905;8734.388592798698;9007.774805629911;9051.14014168653;9250.398724082914;56407.71796140993;66240;67490.32509675037;67561;67746;96147.55778663186;101619.85421312117;101755.49122254341;102370.97629023614;103862.4806875991;12557.93721031389;12615.87384126147;12642.55751048709;12838;13067.281299528617;13664.795028074388;13791.793123103362;13792.586222413343;14054.367553459915;14130.78803817964;10813.513391897226;10985.186507228182;11292.378919159197;12138.939305303416;12606.747865042464;11894.702632434259;12168.939155304166;12318.630441086782;12351.135420520477;12734.363281835685;11111.388873611706;12761.106722529334;13480.5281815136;13776.586702398945;13920;11453.541858325574;11457.312561246352;11562.768744624893;11600.245984011011;12030.27818330903;10720.517576709222;11041.889581104086;11334.546618135182;11405.429728513707;11571.256380113231 11:13:25 INFO - PROCESS | 1680 | __end_tp_report 11:13:25 INFO - PROCESS | 1680 | __start_cc_report 11:13:25 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,444 11:13:25 INFO - PROCESS | 1680 | __end_cc_report 11:13:25 INFO - PROCESS | 1680 | __startTimestamp1468606405664__endTimestamp 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | ------- Summary: start ------- 11:13:25 INFO - PROCESS | 1680 | Number of tests: 6 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | [#0] dojo.html Cycles:165 Average:5761.02 Median:6001.16 stddev:667.04 (11.1%) stddev-sans-first:627.66 11:13:25 INFO - PROCESS | 1680 | Values: 2811.0 3399.6 3413.8 3439.4 3454.0 5732.6 5754.7 5845.8 5846.7 5849.5 5616.0 5734.3 5745.2 5764.0 5803.9 5208.0 5231.7 5275.7 5316.9 5370.7 5247.9 5345.8 5392.1 5420.0 5456.0 5143.0 5196.7 5240.6 5271.7 5310.5 5277.7 5302.3 5304.0 5309.1 5325.1 5099.4 5241.9 5264.2 5314.9 5355.4 4288.6 4885.3 5621.4 5723.7 5728.7 6274.1 6302.6 6316.1 6325.5 6328.7 6099.6 6138.6 6274.4 6294.7 6306.2 5856.7 5864.4 5905.5 5940.7 6016.6 6268.4 6300.1 6311.6 6315.7 6329.6 6056.3 6123.7 6148.0 6252.7 6255.3 6277.6 6287.5 6317.7 6330.8 6347.7 6143.3 6207.1 6247.6 6261.9 6269.1 5070.0 6123.5 6221.6 6303.9 6344.0 4953.1 5038.3 5041.2 5056.3 5060.9 4332.6 4472.2 4507.5 4510.8 4534.8 5266.4 5309.5 5660.1 5743.2 5863.9 6235.3 6284.9 6286.5 6312.0 6317.6 5883.9 5935.6 5947.8 5970.7 6024.0 5424.7 5462.2 5526.9 5556.1 5577.9 6426.1 6434.0 6443.5 6450.1 6460.0 5247.7 6184.4 6266.9 6279.9 6292.0 6164.9 6228.3 6280.2 6317.1 6431.1 5084.9 5182.9 6197.8 6205.4 6245.9 6328.6 6332.2 6340.9 6341.9 6343.5 5659.4 5666.4 6133.5 6156.9 6261.4 6128.7 6200.8 6209.5 6231.0 6231.8 5851.1 5910.1 6073.2 6129.2 6138.7 6109.2 6111.7 6181.0 6196.7 6234.1 5997.2 6001.2 6025.4 6028.4 6055.4 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | [#1] ext.html Cycles:180 Average:73313.02 Median:39035.11 stddev:172850.01 (442.8%) stddev-sans-first:173248.34 11:13:25 INFO - PROCESS | 1680 | Values: 456.3 524.0 537.1 546.4 602.1 38381.7 38899.0 38967.0 39103.2 39320.2 40051.0 40699.0 40740.6 40812.6 40842.6 9299.6 9464.6 9507.9 9515.0 9575.9 9666.2 9760.5 9763.1 9772.8 9793.7 9682.8 9742.5 9755.7 9789.5 9798.9 8256.0 8754.7 9444.1 9670.6 9697.0 9615.6 9683.9 9713.4 9745.0 9765.1 38678.8 39110.8 39295.6 39484.2 39526.6 2773.4 3339.1 3371.9 3555.6 3581.7 30832.0 31262.7 31661.1 31951.0 31958.5 2706.5 3087.6 3146.9 3175.4 3208.8 432489.0 432813.0 433758.0 438265.8 438788.0 32787.8 33286.7 33313.3 33373.0 33464.7 34878.8 35189.9 35680.8 35794.1 35842.8 16154.6 16283.5 16369.9 16410.3 16421.3 12448.6 12676.5 12737.6 12738.4 12772.9 19373.7 19695.9 19739.7 19923.8 19948.0 8336.9 8369.0 8400.9 8430.2 8493.6 947.6 1097.1 1130.6 1133.2 1168.6 27129.7 30515.8 30829.5 31101.1 31151.2 1050.0 1073.5 1095.5 1115.4 1129.3 12851.0 14912.9 15333.3 16132.4 16488.1 814748.0 840696.0 841753.0 845127.0 845918.5 59888.0 60347.7 61680.0 61694.4 61935.1 1294.5 1431.9 1434.8 1446.0 1454.7 31022.5 31485.5 31905.4 32021.0 32201.0 51938.7 52197.7 52481.2 52595.2 52677.7 582980.0 583633.0 587873.0 588955.0 589399.0 26941.6 27230.5 27298.0 27840.9 28035.6 48830.0 49338.5 50026.0 50416.2 50461.7 39623.8 40707.8 41050.8 41260.6 41615.8 40377.4 40691.4 40965.0 41030.8 41664.0 35383.5 35730.6 36206.7 39352.6 39903.0 31717.0 33680.0 34347.0 35874.9 36427.3 19690.2 23030.8 24767.0 26146.1 26203.0 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | [#2] jquery.html Cycles:180 Average:33734.54 Median:11835.89 stddev:93760.78 (792.2%) stddev-sans-first:93990.35 11:13:25 INFO - PROCESS | 1680 | Values: 375.4 382.1 390.8 401.5 409.6 16332.7 18908.8 20904.5 20931.0 21123.0 18353.1 20570.8 20802.9 21294.0 21497.0 5338.6 5528.6 5765.0 6116.7 6122.8 5913.0 6013.4 6069.6 6087.5 6096.7 5306.1 5356.1 5462.3 5483.6 5928.1 5312.7 5331.2 5340.3 5442.1 5444.7 4799.9 5108.1 5355.8 5420.2 5434.8 13341.2 15655.7 19925.8 25969.5 26321.0 2174.8 2407.1 2429.6 2605.6 2659.4 10069.0 10229.9 10241.3 11024.9 15972.9 1796.0 1830.4 1865.5 1903.2 1942.2 98904.0 111757.0 120899.4 123486.0 123680.4 11265.6 11291.8 11713.9 11721.6 11818.6 12389.4 14759.3 14826.7 14844.5 14861.6 8562.4 8566.9 8583.5 8653.6 8694.3 7389.7 7929.6 8592.9 8634.7 8663.4 3960.8 4577.0 4652.8 4672.8 4683.9 1827.2 1951.6 1989.0 2030.7 2039.4 818.9 902.5 922.3 1017.3 1034.1 20611.4 21279.4 21320.7 21758.1 21841.5 665.8 989.7 995.7 1010.7 1014.4 10735.1 11132.7 11190.6 11203.7 11213.1 535652.0 536870.0 537541.0 587630.0 594779.0 99513.0 120391.8 124180.0 139190.3 140821.0 985.8 1004.7 1013.5 1032.3 1037.7 15795.8 18469.1 18872.8 18875.5 19031.7 42737.6 55025.7 55800.4 55931.0 56405.2 84009.6 84712.3 84772.6 85623.0 85701.6 7883.6 7972.1 7980.6 8106.8 8179.1 10320.0 12530.9 12560.4 12581.7 12603.8 10538.5 10721.4 10760.4 10810.0 10851.3 10073.2 10089.0 10406.7 10491.0 10586.8 10276.4 10347.3 10608.4 10648.9 10883.3 7645.5 7665.0 7675.8 7847.9 7860.0 9933.0 10106.7 10582.6 10716.4 10812.5 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | [#3] mootools.html Cycles:180 Average:5814.38 Median:2549.99 stddev:3288.28 (129.0%) stddev-sans-first:3282.10 11:13:25 INFO - PROCESS | 1680 | Values: 1578.0 1601.9 1853.1 1924.6 1929.5 8113.5 8592.8 8678.6 9049.5 9076.7 8725.2 8765.1 8898.8 8927.0 8929.5 2340.6 2355.7 2383.9 2384.8 2392.4 2319.2 2365.0 2384.7 2403.7 2404.5 2329.8 2344.5 2385.0 2394.4 2400.5 2288.2 2317.7 2333.2 2353.8 2355.9 2272.4 2278.3 2280.9 2280.9 2287.9 8858.3 8947.1 8973.9 9056.5 9066.3 5259.9 5288.4 5328.6 5372.4 5440.5 3313.9 3391.7 3551.4 3693.8 3698.2 1076.3 1098.2 1102.8 1111.4 1118.4 11760.4 11801.3 11936.5 11947.4 11957.8 4624.3 4635.2 4816.8 4849.7 4853.2 9973.6 10169.6 10194.3 10207.2 10217.0 5220.6 5283.5 5331.5 5339.0 5377.7 4065.9 4388.8 4858.1 4889.3 4917.7 3969.3 4010.1 4078.4 4096.9 4126.5 1303.3 1307.5 1308.5 1310.6 1314.8 939.2 948.8 954.7 955.6 990.8 4834.5 5879.2 6189.3 6276.2 6289.7 430.0 435.1 452.7 460.2 464.8 4136.7 4149.4 4209.9 4217.5 4279.3 10467.9 10911.4 11006.6 11013.4 11083.0 10682.7 10949.4 10958.4 10961.6 10988.1 7945.1 8318.5 8441.2 8475.4 8623.4 6121.5 6345.4 6352.3 6394.2 6397.2 9959.6 9986.3 10237.2 10270.7 10292.5 10193.8 10322.2 10431.6 10497.7 10545.3 7088.7 7557.3 7587.4 7678.0 7744.8 8437.0 8508.5 8661.2 8700.5 8729.9 6580.5 7492.6 7698.2 7723.9 7746.1 7461.8 7528.8 7546.0 7598.6 7662.4 7069.2 7071.2 7181.0 7222.3 7239.3 4343.5 5163.8 5245.4 5281.8 5322.8 5225.2 5277.5 5298.4 5374.0 5402.5 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | [#4] prototype.html Cycles:180 Average:4911.11 Median:5574.61 stddev:1539.13 (27.6%) stddev-sans-first:1504.31 11:13:25 INFO - PROCESS | 1680 | Values: 316.1 316.3 317.7 318.7 324.0 5833.2 5864.1 5864.3 5869.6 5905.4 4525.7 4745.5 5791.4 5852.5 5853.5 3362.4 4209.3 4289.2 4348.9 4368.8 4300.0 4342.8 4363.0 4371.3 4384.7 3560.9 4125.6 4333.5 4357.0 4360.3 3593.8 3693.5 4032.8 4290.8 4369.5 3614.0 3672.7 3680.4 3687.7 3689.2 4916.9 5625.9 5654.3 5694.2 5723.7 4497.3 4533.0 4567.5 4975.3 5005.9 6101.5 6130.7 6156.4 6168.2 6189.8 4088.6 4104.7 4105.1 4105.9 4132.1 5537.3 5560.9 5855.7 6406.3 6418.0 4080.8 4113.9 4142.4 4162.1 4166.3 4219.9 4220.3 4229.4 4232.7 4233.7 4632.9 4915.4 4977.9 4993.7 5009.3 5394.7 6198.4 6206.3 6208.6 6246.7 1424.7 1443.4 1448.8 1451.4 1452.5 795.8 829.7 839.5 917.0 943.5 5124.8 5388.5 5459.0 5588.3 5640.3 4957.5 5310.8 5517.8 6149.5 6270.2 5507.4 5589.9 5653.7 5670.0 5690.5 3023.0 3287.7 3326.5 3331.2 3334.7 5881.7 6516.8 6531.4 6558.2 6586.9 5615.9 6088.8 6493.2 6533.4 6537.3 5163.7 5926.8 6511.9 6562.8 6604.9 4905.0 5204.7 6260.3 6406.7 6458.6 5106.4 5662.7 5769.2 6336.9 6405.1 5763.5 5792.3 6354.0 6579.3 6637.1 4144.5 4147.3 4150.0 4165.4 4166.9 6021.4 6023.9 6159.7 6400.4 6426.7 5348.6 5870.9 6153.8 6163.4 6200.8 6165.9 6170.5 6184.2 6198.3 6224.5 5620.9 6068.0 6084.8 6088.8 6105.8 6110.5 6140.7 6166.5 6188.6 6204.3 4963.6 5462.9 5475.2 5723.5 6045.0 11:13:25 INFO - PROCESS | 1680 | 11:13:25 INFO - PROCESS | 1680 | [#5] yui.html Cycles:180 Average:25208.46 Median:3700.30 stddev:40628.36 (1098.0%) stddev-sans-first:40700.64 11:13:25 INFO - PROCESS | 1680 | Values: 694.0 739.3 742.5 770.4 839.5 15359.8 15532.1 15828.6 15875.8 15877.3 14437.4 14481.5 14530.4 14594.1 14615.4 702.8 765.5 870.9 879.0 900.9 889.2 897.4 902.1 902.9 907.4 755.5 929.3 960.3 964.9 967.6 933.9 961.2 961.7 962.2 963.9 690.4 701.1 714.9 716.5 716.8 15365.5 15404.1 15662.5 15772.4 15840.0 11439.0 15204.4 15273.6 15297.9 15335.8 12122.4 12381.6 12577.7 12590.0 12630.7 3672.9 3703.5 3811.7 3851.7 4173.1 83372.2 88497.0 110498.6 111185.4 111288.8 9856.5 9943.4 11499.6 11875.5 12002.5 20912.9 24917.0 25060.5 25114.5 25126.2 7904.6 8116.4 8204.9 8210.5 8218.5 3991.6 4053.0 4071.3 4094.8 4114.1 3691.8 3697.1 3814.6 3821.4 3821.8 577.2 635.0 658.8 662.9 665.1 599.3 628.6 631.5 646.8 660.7 7861.8 8152.6 9247.1 9480.5 9867.0 588.8 638.7 668.1 673.6 678.2 4579.7 4664.5 4694.2 4748.9 4828.7 126235.0 141630.0 156007.0 157037.0 158857.0 140307.0 141839.3 141922.3 144336.0 144909.0 78705.2 90981.0 118700.7 119212.0 122924.0 7724.0 8734.4 9007.8 9051.1 9250.4 56407.7 66240.0 67490.3 67561.0 67746.0 96147.6 101619.9 101755.5 102371.0 103862.5 12557.9 12615.9 12642.6 12838.0 13067.3 13664.8 13791.8 13792.6 14054.4 14130.8 10813.5 10985.2 11292.4 12138.9 12606.7 11894.7 12168.9 12318.6 12351.1 12734.4 11111.4 12761.1 13480.5 13776.6 13920.0 11453.5 11457.3 11562.8 11600.2 12030.3 10720.5 11041.9 11334.5 11405.4 11571.3 11:13:25 INFO - PROCESS | 1680 | -------- Summary: end -------- 11:13:25 INFO - PROCESS | 1680 | 11:13:26 INFO - TEST-INFO | 1680: exit 0 11:13:26 INFO - TEST-OK | dromaeo_css | took 1112521ms 11:13:26 INFO - TEST-START | kraken 11:13:26 INFO - operating with platform_type : mac_ 11:13:26 INFO - Initialising browser for kraken test... 11:13:26 INFO - TEST-INFO | started process 1689 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmplsQAuV/profile http://localhost:49283/getInfo.html) 11:13:29 INFO - PROCESS | 1689 | __metrics Screen width/height:1600/1200 11:13:29 INFO - PROCESS | 1689 | colorDepth:24 11:13:29 INFO - PROCESS | 1689 | Browser inner width/height: 1024/689 11:13:29 INFO - PROCESS | 1689 | __metrics 11:13:29 ERROR - PROCESS | 1689 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:13:30 INFO - TEST-INFO | 1689: exit 0 11:13:30 INFO - Browser initialized. 11:13:30 INFO - Running cycle 1/1 for kraken test... 11:13:30 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/tmplsQAuV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:42 INFO - PROCESS | 1691 | RSS: Main: 254214144 11:13:42 INFO - PROCESS | 1691 | 11:13:44 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 11:13:45 INFO - PROCESS | 1691 | RSS: Main: 266887168 11:13:45 INFO - PROCESS | 1691 | 11:13:48 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 11:13:49 INFO - PROCESS | 1691 | RSS: Main: 270917632 11:13:49 INFO - PROCESS | 1691 | 11:13:52 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 11:13:53 INFO - PROCESS | 1691 | RSS: Main: 271384576 11:13:53 INFO - PROCESS | 1691 | 11:13:55 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 11:13:55 INFO - PROCESS | 1691 | RSS: Main: 272302080 11:13:55 INFO - PROCESS | 1691 | 11:13:57 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:13:58 INFO - PROCESS | 1691 | RSS: Main: 273072128 11:13:58 INFO - PROCESS | 1691 | 11:14:01 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 11:14:02 INFO - PROCESS | 1691 | RSS: Main: 273473536 11:14:02 INFO - PROCESS | 1691 | 11:14:05 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 11:14:05 INFO - PROCESS | 1691 | RSS: Main: 273833984 11:14:05 INFO - PROCESS | 1691 | 11:14:09 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 11:14:09 INFO - PROCESS | 1691 | RSS: Main: 273883136 11:14:09 INFO - PROCESS | 1691 | 11:14:11 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:14:11 INFO - PROCESS | 1691 | RSS: Main: 273436672 11:14:11 INFO - PROCESS | 1691 | 11:14:13 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:14:14 INFO - PROCESS | 1691 | RSS: Main: 273543168 11:14:14 INFO - PROCESS | 1691 | 11:14:16 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:14:17 INFO - PROCESS | 1691 | RSS: Main: 273842176 11:14:17 INFO - PROCESS | 1691 | 11:14:20 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:14:20 INFO - PROCESS | 1691 | RSS: Main: 273997824 11:14:20 INFO - PROCESS | 1691 | 11:14:23 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:14:24 INFO - PROCESS | 1691 | RSS: Main: 273854464 11:14:24 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 11:14:26 INFO - PROCESS | 1691 | RSS: Main: 274771968 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | __start_tp_report 11:14:26 INFO - PROCESS | 1691 | _x_x_mozilla_page_load 11:14:26 INFO - PROCESS | 1691 | _x_x_mozilla_page_load_details 11:14:26 INFO - PROCESS | 1691 | |i|pagename|runs| 11:14:26 INFO - PROCESS | 1691 | |0;ai-astar;102;116;107;115;117;118;115;115;116;116 11:14:26 INFO - PROCESS | 1691 | |1;audio-beat-detection;148;111;129;179;143;137;144;141;195;111 11:14:26 INFO - PROCESS | 1691 | |2;audio-dft;196;194;199;240;270;270;198;202;192;192 11:14:26 INFO - PROCESS | 1691 | |3;audio-fft;70;85;74;173;58;59;57;60;125;59 11:14:26 INFO - PROCESS | 1691 | |4;audio-oscillator;70;73;131;70;71;76;112;68;72;116 11:14:26 INFO - PROCESS | 1691 | |5;imaging-gaussian-blur;91;88;76;128;135;87;106;89;99;132 11:14:26 INFO - PROCESS | 1691 | |6;imaging-darkroom;137;138;150;99;123;110;89;157;96;134 11:14:26 INFO - PROCESS | 1691 | |7;imaging-desaturate;91;120;149;120;90;90;94;115;144;136 11:14:26 INFO - PROCESS | 1691 | |8;json-parse-financial;56;55;57;56;57;58;55;58;57;55 11:14:26 INFO - PROCESS | 1691 | |9;json-stringify-tinderbox;66;72;74;72;83;80;77;106;103;84 11:14:26 INFO - PROCESS | 1691 | |10;stanford-crypto-aes;87;82;84;82;92;83;85;85;87;86 11:14:26 INFO - PROCESS | 1691 | |11;stanford-crypto-ccm;128;180;126;166;151;153;156;149;208;148 11:14:26 INFO - PROCESS | 1691 | |12;stanford-crypto-pbkdf2;170;194;153;193;229;169;169;161;198;223 11:14:26 INFO - PROCESS | 1691 | |13;stanford-crypto-sha256-iterative;68;74;65;65;67;66;67;87;87;85 11:14:26 INFO - PROCESS | 1691 | __end_tp_report 11:14:26 INFO - PROCESS | 1691 | __start_cc_report 11:14:26 INFO - PROCESS | 1691 | _x_x_mozilla_cycle_collect,1119 11:14:26 INFO - PROCESS | 1691 | __end_cc_report 11:14:26 INFO - PROCESS | 1691 | __startTimestamp1468606466620__endTimestamp 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | ------- Summary: start ------- 11:14:26 INFO - PROCESS | 1691 | Number of tests: 14 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#0] ai-astar Cycles:10 Average:113.70 Median:116.00 stddev:5.08 (4.4%) stddev-sans-first:3.16 11:14:26 INFO - PROCESS | 1691 | Values: 102.0 116.0 107.0 115.0 117.0 118.0 115.0 115.0 116.0 116.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:143.50 stddev:26.47 (18.4%) stddev-sans-first:28.03 11:14:26 INFO - PROCESS | 1691 | Values: 148.0 111.0 129.0 179.0 143.0 137.0 144.0 141.0 195.0 111.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#2] audio-dft Cycles:10 Average:215.30 Median:200.50 stddev:32.06 (16.0%) stddev-sans-first:33.23 11:14:26 INFO - PROCESS | 1691 | Values: 196.0 194.0 199.0 240.0 270.0 270.0 198.0 202.0 192.0 192.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#3] audio-fft Cycles:10 Average:82.00 Median:59.50 stddev:38.14 (64.1%) stddev-sans-first:40.20 11:14:26 INFO - PROCESS | 1691 | Values: 70.0 85.0 74.0 173.0 58.0 59.0 57.0 60.0 125.0 59.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:70.50 stddev:23.87 (33.9%) stddev-sans-first:24.61 11:14:26 INFO - PROCESS | 1691 | Values: 70.0 73.0 131.0 70.0 71.0 76.0 112.0 68.0 72.0 116.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:87.50 stddev:21.25 (24.3%) stddev-sans-first:22.09 11:14:26 INFO - PROCESS | 1691 | Values: 91.0 88.0 76.0 128.0 135.0 87.0 106.0 89.0 99.0 132.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#6] imaging-darkroom Cycles:10 Average:123.30 Median:153.50 stddev:23.70 (15.4%) stddev-sans-first:24.62 11:14:26 INFO - PROCESS | 1691 | Values: 137.0 138.0 150.0 99.0 123.0 110.0 89.0 157.0 96.0 134.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#7] imaging-desaturate Cycles:10 Average:114.90 Median:119.50 stddev:22.99 (19.2%) stddev-sans-first:22.69 11:14:26 INFO - PROCESS | 1691 | Values: 91.0 120.0 149.0 120.0 90.0 90.0 94.0 115.0 144.0 136.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:1.17 (2.1%) stddev-sans-first:1.24 11:14:26 INFO - PROCESS | 1691 | Values: 56.0 55.0 57.0 56.0 57.0 58.0 55.0 58.0 57.0 55.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:75.50 stddev:13.21 (17.5%) stddev-sans-first:12.73 11:14:26 INFO - PROCESS | 1691 | Values: 66.0 72.0 74.0 72.0 83.0 80.0 77.0 106.0 103.0 84.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:2.98 (3.5%) stddev-sans-first:3.10 11:14:26 INFO - PROCESS | 1691 | Values: 87.0 82.0 84.0 82.0 92.0 83.0 85.0 85.0 87.0 86.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#11] stanford-crypto-ccm Cycles:10 Average:156.50 Median:154.50 stddev:24.06 (15.6%) stddev-sans-first:23.20 11:14:26 INFO - PROCESS | 1691 | Values: 128.0 180.0 126.0 166.0 151.0 153.0 156.0 149.0 208.0 148.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.90 Median:193.50 stddev:25.87 (13.4%) stddev-sans-first:26.79 11:14:26 INFO - PROCESS | 1691 | Values: 170.0 194.0 153.0 193.0 229.0 169.0 169.0 161.0 198.0 223.0 11:14:26 INFO - PROCESS | 1691 | 11:14:26 INFO - PROCESS | 1691 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:71.00 stddev:9.49 (13.4%) stddev-sans-first:9.89 11:14:26 INFO - PROCESS | 1691 | Values: 68.0 74.0 65.0 65.0 67.0 66.0 67.0 87.0 87.0 85.0 11:14:26 INFO - PROCESS | 1691 | -------- Summary: end -------- 11:14:26 INFO - PROCESS | 1691 | 11:14:27 INFO - TEST-INFO | 1691: exit 0 11:14:27 INFO - TEST-OK | kraken | took 61259ms 11:14:27 INFO - SUITE-END | took 1173s 11:14:27 INFO - Completed test suite (00:19:34) 11:14:27 INFO - javascript benchmark 11:14:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7438.986970180822, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2811.002094256539, 3399.5580574525306, 3413.7781044232124, 3439.398105331567, 3454.0, 5732.627379220353, 5754.74103665335, 5845.849446892706, 5846.678432686201, 5849.532037437006, 5615.971920140393, 5734.340550836655, 5745.224394706714, 5763.9711801440935, 5803.941960580393, 5208.0, 5231.659942103751, 5275.657082289658, 5316.9202461963105, 5370.650907691007, 5247.921281180786, 5345.839624811242, 5392.083345831198, 5420.024395608789, 5456.0, 5142.97428512855, 5196.662216955886, 5240.554552863011, 5271.683698978054, 5310.468953104697, 5277.683338999634, 5302.257683924254, 5304.045271851065, 5309.0709125903195, 5325.068113080234, 5099.388073431212, 5241.895162096736, 5264.236685680555, 5314.92027619586, 5355.437679043722, 4288.571142885687, 4885.316055752198, 5621.437856214387, 5723.685197314146, 5728.742206600713, 6274.090256912722, 6302.621842689453, 6316.115743795872, 6325.462335701471, 6328.746850125989, 6099.58217961314, 6138.5723274837055, 6274.403931626488, 6294.685265736694, 6306.211723534559, 5856.7071646417935, 5864.38423965486, 5905.498032667271, 5940.702964851784, 6016.578839481238, 6268.434381051618, 6300.086487459293, 6311.558190926683, 6315.747370105236, 6329.588576742497, 6056.303525094582, 6123.709696704001, 6147.9548476759055, 6252.718627661766, 6255.280642726054, 6277.619831413056, 6287.49700023997, 6317.747290108436, 6330.778422755181, 6347.714352854133, 6143.262808463013, 6207.068939659087, 6247.5939063960695, 6261.9373806262265, 6269.122322874801, 5070.0, 6123.465646421124, 6221.595596286227, 6303.873922521524, 6344.0, 4953.108440480676, 5038.269450929594, 5041.168207245763, 5056.292119103328, 5060.949390506122, 4332.59190762997, 4472.217361961643, 4507.504174540798, 4510.819567217341, 4534.818607255739, 5266.368035835648, 5309.522143007148, 5660.122680984454, 5743.195952566644, 5863.853403664857, 6235.282942461584, 6284.874302513924, 6286.528510361742, 6311.968440157862, 6317.6209427434505, 5883.901736257782, 5935.614185077956, 5947.821565353046, 5970.671613061323, 6024.0, 5424.728763561806, 5462.180672899018, 5526.889462210734, 5556.083246264402, 5577.9442205577425, 6426.132472116298, 6434.0, 6443.4523065539015, 6450.096986421999, 6460.030995350547, 5247.658902171346, 6184.381561843779, 6266.937330626818, 6279.905801412891, 6292.0, 6164.938350616437, 6228.283747369111, 6280.246370435577, 6317.115603815378, 6431.067495213261, 5084.923726144185, 5182.948170518246, 6197.752089916353, 6205.379462053758, 6245.875082498415, 6328.557001009885, 6332.240131184288, 6340.9048864268, 6341.873162536631, 6343.524235682435, 5659.405762395054, 5666.405027472056, 6133.457080270768, 6156.876862462816, 6261.4364707174755, 6128.724207410588, 6200.7519699211525, 6209.534284928558, 6230.968845155745, 6231.784801963755, 5851.1223316502865, 5910.1134829774155, 6073.240844894388, 6129.172561704113, 6138.662373569318, 6109.192117491969, 6111.682900513672, 6180.969095154495, 6196.721147548281, 6234.096056071935, 5997.190379298913, 6001.159837622649, 6025.397460253939, 6028.4272994065495, 6055.424734650202], "value": 5718.787496592539, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.28591254686415, 523.9502247286506, 537.094994933537, 546.366215190379, 602.1359349333703, 38381.697098174096, 38899.0, 38967.0, 39103.21793564127, 39320.21359572807, 40051.0, 40698.98252543688, 40740.59259407405, 40812.59187408125, 40842.591574084254, 9299.581518831652, 9464.62141514342, 9507.857382139273, 9515.0, 9575.90424095757, 9666.178374838148, 9760.4631745254, 9763.072508111718, 9772.755681107958, 9793.657221997231, 9682.757931051745, 9742.464164470952, 9755.707328780149, 9789.461579613118, 9798.853017204749, 8255.999999999969, 8754.69358572447, 9444.102810233016, 9670.613175472972, 9696.951515242414, 9615.567299471471, 9683.90316096837, 9713.368631039031, 9744.95127524365, 9765.121139097444, 38678.806605967075, 39110.804445977876, 39295.60704392948, 39484.21031579381, 39526.60473395287, 2773.362126710868, 3339.081752518053, 3371.900167847904, 3555.5733312002467, 3581.713462922986, 30832.0, 31262.68737312643, 31661.05016849498, 31951.0, 31958.520622190685, 2706.526357887362, 3087.552304915797, 3146.9055928322186, 3175.412548678502, 3208.839558022113, 432489.0, 432813.0, 433758.0, 438265.8086709578, 438788.0, 32787.836060820024, 33286.66713332884, 33313.3337333252, 33372.99881003574, 33464.665353346645, 34878.82560587231, 35189.94430167099, 35680.82159589185, 35794.105147371, 35842.82078589591, 16154.596135096717, 16283.511494655178, 16369.918150409172, 16410.261538230807, 16421.343146274015, 12448.62654120378, 12676.49294028247, 12737.617871463872, 12738.363081845871, 12772.872271277354, 19373.709394359095, 19695.901520492305, 19739.703904441445, 19923.800761992195, 19948.0, 8336.916630833735, 8369.0, 8400.915990840136, 8430.241278284984, 8493.556095463786, 947.5830634520789, 1097.1168209591356, 1130.6099395708468, 1133.240728711765, 1168.649405178443, 27129.728702713113, 30515.847420762755, 30829.491248028684, 31101.066967990995, 31151.22121946924, 1049.9842502362471, 1073.5239046311322, 1095.4522738630685, 1115.3921112993437, 1129.2885482146196, 12850.986415353267, 14912.850871491362, 15333.31000104998, 16132.354705811871, 16488.114579948462, 814748.0, 840696.0, 841753.0, 845127.0, 845918.4744839093, 59888.0, 60347.69826150841, 61680.0, 61694.38305616976, 61935.07097393543, 1294.501616877509, 1431.9427222911174, 1434.770436730139, 1446.0456098974626, 1454.70178613384, 31022.53466198054, 31485.527717083805, 31905.361892762478, 32021.013103227906, 32201.0, 51938.74030629823, 52197.7390113047, 52481.21278180754, 52595.21107183319, 52677.7366113167, 582980.0, 583633.0, 587873.0, 588955.0, 589399.0, 26941.595876062267, 27230.455390892468, 27298.0, 27840.86079569589, 28035.57946630843, 48830.0, 49338.506614933394, 50026.0, 50416.24375634442, 50461.73845653888, 39623.80188099041, 40707.796461017504, 41050.79474602608, 41260.58739412567, 41615.7919210402, 40377.39433908553, 40691.389629156176, 40964.97587560335, 41030.79484602558, 41664.0, 35383.469247960784, 35730.64269357377, 36206.732764353124, 39352.60647393604, 39903.0, 31717.0, 33680.0, 34346.96959091231, 35874.923752287476, 36427.27145457129, 19690.21239150418, 23030.769692303533, 24767.009319627014, 26146.08488702886, 26203.0], "value": 19713.777292545332, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4106053496011, 382.0734718308102, 390.8241291418862, 401.53422030444654, 409.5740429952849, 16332.673346533062, 18908.810911890876, 20904.477388065287, 20931.0, 21123.0, 18353.082345882718, 20570.794292057075, 20802.89598552009, 21294.0, 21497.0, 5338.599605029619, 5528.612997090206, 5765.0, 6116.663583502906, 6122.816315510519, 5913.0, 6013.428724271187, 6069.605475644069, 6087.543434242428, 6096.725647345858, 5306.124489459235, 5356.0894647909945, 5462.317210348707, 5483.588730845183, 5928.081147422135, 5312.654677445954, 5331.2003199519995, 5340.25236466895, 5442.12925931851, 5444.673319600836, 4799.904001919942, 5108.131617625013, 5355.812546560891, 5420.214068960018, 5434.755436005389, 13341.199528028252, 15655.68688626221, 19925.800741992538, 25969.480610387687, 26321.0, 2174.7825217478285, 2407.1454633605167, 2429.6234083717054, 2605.5831067029185, 2659.414928715699, 10069.0, 10229.897701022968, 10241.334313269614, 11024.944875275653, 15972.920135399365, 1795.9910200449044, 1830.359374219026, 1865.4963159946738, 1903.2196799312353, 1942.1926148848338, 98904.0, 111757.0, 120899.39550302192, 123486.0, 123680.38159809234, 11265.605703800327, 11291.774164516664, 11713.941430292964, 11721.589744358907, 11818.645440636794, 12389.380530973416, 14759.262036898112, 14826.703465930621, 14844.480443184437, 14861.554153375417, 8562.357823163287, 8566.871496927552, 8583.480772883087, 8653.610587523577, 8694.26098781598, 7389.7413590524075, 7929.603519823986, 8592.882925219681, 8634.740957771277, 8663.393562450568, 3960.7523630057017, 4576.954230457719, 4652.790624421909, 4672.813087476463, 4683.946112124745, 1827.241694696686, 1951.6389467948475, 1989.0154373584878, 2030.7258520099597, 2039.4289598912328, 818.9344852411792, 902.5036230073433, 922.3405265235255, 1017.2777328096986, 1034.0693375961694, 20611.38165855027, 21279.36161915114, 21320.680189797167, 21758.129674813146, 21841.471097023055, 665.7736369634348, 989.7426669066094, 995.7411073121041, 1010.686687126993, 1014.3812274512542, 10735.141188704885, 11132.721681957853, 11190.608328708457, 11203.663890083311, 11213.102951764002, 535652.0, 536870.0, 537541.0, 587630.0, 594779.0, 99513.0, 120391.79608203805, 124180.0, 139190.3040484791, 140821.0, 985.8126955878361, 1004.7437903334749, 1013.478058799704, 1032.3238278927315, 1037.725002874239, 15795.842041579897, 18469.076546172906, 18872.811271887105, 18875.451814004933, 19031.714524282423, 42737.57262427336, 55025.72487137539, 55800.441995581146, 55930.99999999837, 56405.153922692014, 84009.57995209986, 84712.30575388581, 84772.57613711891, 85623.0, 85701.57149214215, 7883.5664038478435, 7972.1230664628, 7980.561069141021, 8106.83786324282, 8179.0594081681365, 10320.0, 12530.937345313216, 12560.43478043472, 12581.685457863627, 12603.810942836048, 10538.525766340379, 10721.41032243234, 10760.3543787373, 10810.0, 10851.294665846695, 10073.19414446857, 10089.0, 10406.687799366031, 10491.0, 10586.788264234827, 10276.434796085989, 10347.27569070158, 10608.416537090534, 10648.8935110651, 10883.292585981886, 7645.503042302233, 7664.961675191588, 7675.769726908202, 7847.940528028643, 7859.960700196462, 9933.00669933001, 10106.696799096038, 10582.629607963685, 10716.410597417216, 10812.459377031275], "value": 9434.28807847704, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1577.9999999999995, 1601.9118948457835, 1853.1197681101478, 1924.5862139639992, 1929.5369111413256, 8113.472624279432, 8592.785180370494, 8678.609462574184, 9049.45703257805, 9076.682316118937, 8725.171108744675, 8765.123487651232, 8898.822023559525, 8927.0, 8929.508877011762, 2340.5903966805827, 2355.6937598112263, 2383.9284821455385, 2384.844985075973, 2392.3899405651623, 2319.22306027481, 2364.9763502364926, 2384.654225137354, 2403.6995375578053, 2404.5311164322966, 2329.8252631052655, 2344.4724936889147, 2385.034061205206, 2394.365493144318, 2400.459896523277, 2288.164819840763, 2317.6986991690974, 2333.1600623775425, 2353.752855950126, 2355.8586484810967, 2272.3864556569797, 2278.327893271489, 2280.851744636593, 2280.931572052841, 2287.9199228026937, 8858.335624828163, 8947.060558641315, 8973.865392019125, 9056.501892395916, 9066.320025998077, 5259.86850328741, 5288.418273989858, 5328.6269961102735, 5372.382176049726, 5440.537554307889, 3313.867445302209, 3391.6777906098882, 3551.3607550640872, 3693.765272010422, 3698.2048859495067, 1076.332673742277, 1098.2147764348529, 1102.8456016157745, 1111.416506334173, 1118.3569447567681, 11760.353180575064, 11801.29192248468, 11936.522539098425, 11947.402629868559, 11957.820632690517, 4624.26011838111, 4635.235186194308, 4816.831410900601, 4849.709017458964, 4853.19922212838, 9973.60105595768, 10169.644062457779, 10194.286399951932, 10207.183425325957, 10217.0, 5220.582353411718, 5283.524482796567, 5331.493508116722, 5339.0, 5377.677339359651, 4065.9390109148385, 4388.846390376385, 4858.149823780825, 4889.291052797395, 4917.680350777188, 3969.2656858480696, 4010.1378203685763, 4078.4494093297617, 4096.897577560585, 4126.546079931205, 1303.3157592263947, 1307.4966138036734, 1308.4504508106618, 1310.5740634293702, 1314.822498962647, 939.2204470289644, 948.8244674735196, 954.656323723459, 955.5699935029264, 990.7919336939179, 4834.492378300298, 5879.235699359056, 6189.257289125334, 6276.184096067482, 6289.685515724195, 430.0, 435.0819770284697, 452.678598195285, 460.2153328574772, 464.7536805493094, 4136.73111247768, 4149.398337241083, 4209.873703788891, 4217.472815898012, 4279.272523670983, 10467.94766026165, 10911.399873006902, 11006.559737610405, 11013.394263315595, 11083.002529772199, 10682.679519614268, 10949.397783122005, 10958.397288149228, 10961.56153753841, 10988.120950323955, 7945.12603613602, 8318.45930014547, 8441.19808618168, 8475.364347673949, 8623.396362254707, 6121.47967422774, 6345.3654634538025, 6352.301246862934, 6394.23269207698, 6397.200349956255, 9959.601615935282, 9986.251031172545, 10237.18102551809, 10270.691879243335, 10292.485375731334, 10193.84709229377, 10322.174226062047, 10431.63489277902, 10497.685069447929, 10545.31455455393, 7088.716451341888, 7557.282058204682, 7587.355074818703, 7678.040244969379, 7744.8451030980195, 8436.95781521113, 8508.489490630582, 8661.177188167114, 8700.521471319138, 8729.91270087291, 6580.473562114924, 7492.550446973199, 7698.191689872483, 7723.884141737991, 7746.109197442366, 7461.813454663677, 7528.849423011399, 7545.962270188614, 7598.582077985764, 7662.387009039375, 7069.151701795818, 7071.151461824614, 7180.964095179491, 7222.349988501061, 7239.312265334785, 4343.5439278875265, 5163.8192663256605, 5245.449227831023, 5281.841544753664, 5322.802369466839, 5225.216217567396, 5277.472252774692, 5298.4171741107675, 5374.032674118696, 5402.486763757437], "value": 4591.056475542113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.06444923027834, 316.29308495512527, 317.66327692645797, 318.6829105040484, 323.98380080995946, 5833.241678581784, 5864.061750119977, 5864.266966629171, 5869.61847479914, 5905.438983296591, 4525.660575456837, 4745.484893006712, 5791.449812267839, 5852.502537284336, 5853.536615846038, 3362.42838717418, 4209.326507758759, 4289.24938135825, 4348.89127771805, 4368.759718215497, 4300.0, 4342.761148136851, 4362.956370436286, 4371.344298355256, 4384.693071484998, 3560.893173204808, 4125.628693417591, 4333.544977777336, 4357.0, 4360.3430696335345, 3593.802340871251, 3693.4829123922673, 4032.778197199138, 4290.76400797956, 4369.453818272716, 3613.98808333667, 3672.73290714703, 3680.392735198689, 3687.7418580699364, 3689.24370504046, 4916.942857285665, 5625.943740562624, 5654.293213348332, 5694.177863083815, 5723.713814309268, 4497.335985685285, 4532.9546704533195, 4567.49272739995, 4975.328330675385, 5005.924911126336, 6101.481374083208, 6130.662813545253, 6156.384361563808, 6168.242051015439, 6189.752409903644, 4088.550259471456, 4104.671626269891, 4105.117399759066, 4105.938410923838, 4132.090939993197, 5537.335519737658, 5560.916586251209, 5855.687003633583, 6406.2953075161695, 6418.0, 4080.755154690728, 4113.876583702494, 4142.357934520154, 4162.125953549788, 4166.250074986531, 4219.915601688011, 4220.320096738593, 4229.435109009686, 4232.661387089087, 4233.703640745119, 4632.930506042412, 4915.43472500667, 4977.850664480072, 4993.675411098267, 5009.34691551787, 5394.730263486888, 6198.380161983766, 6206.348333425016, 6208.565400421927, 6246.656433896179, 1424.672325365172, 1443.4226309476082, 1448.7681970884607, 1451.4411951398788, 1452.4771082410534, 795.8050277682005, 829.6764261937849, 839.4963022186639, 916.9958895009953, 943.4622265308845, 5124.795008199705, 5388.461153884658, 5458.972705136449, 5588.30146231721, 5640.32316122068, 4957.479464656231, 5310.840674779763, 5517.834464966058, 6149.538784591084, 6270.216222972129, 5507.421720719347, 5589.916151257735, 5653.745581448845, 5670.0, 5690.516306113944, 3022.9872992547744, 3287.671232876693, 3326.467765157563, 3331.200511877132, 3334.733221342287, 5881.705914704247, 6516.804495865132, 6531.412172904366, 6558.213014438298, 6586.901196482057, 5615.859603509945, 6088.812681527148, 6493.220813502316, 6533.411992920564, 6537.313582073909, 5163.715995620127, 5926.844265368298, 6511.934880651228, 6562.77030303937, 6604.86790264192, 4904.950950490592, 5204.713740744295, 6260.2718512562315, 6406.679666016587, 6458.580192287486, 5106.412762532356, 5662.745176467151, 5769.230769230709, 6336.9088200892675, 6405.135306733718, 5763.452472015152, 5792.304923409218, 6354.015127655221, 6579.342065793382, 6637.112855907696, 4144.466547377369, 4147.315692910636, 4149.958500414958, 4165.354370072643, 4166.854115118245, 6021.427964343556, 6023.879522409615, 6159.692015399122, 6400.359964003748, 6426.742930282736, 5348.598855085962, 5870.911936321044, 6153.784617538365, 6163.414475624809, 6200.81397558074, 6165.938340616536, 6170.50635949114, 6184.165137706352, 6198.256209254918, 6224.470919971853, 5620.887582248414, 6068.0, 6084.847878803065, 6088.756449741961, 6105.786297479567, 6110.455935557455, 6140.692965351804, 6166.4758495526585, 6188.628682279078, 6204.348543402878, 4963.602911766978, 5462.875528975598, 5475.233467314659, 5723.456271654186, 6045.0], "value": 4410.781246541287, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.9618320992347, 739.3382922284555, 742.485329926949, 770.3682979956435, 839.5004972041637, 15359.84640153598, 15532.068075915453, 15828.604284892868, 15875.761863572026, 15877.285522151502, 14437.35031923566, 14481.493147739804, 14530.418783248657, 14594.05138665986, 14615.415383384652, 702.8313204830829, 765.5291995422831, 870.8867847179857, 879.0286733159862, 900.8513595256775, 889.2485849457198, 897.4346161917982, 902.0979020979021, 902.9458232506038, 907.3557773980482, 755.5353457623577, 929.3494553812325, 960.3373672166218, 964.903509649033, 967.632299726103, 933.9112784285481, 961.1925982174971, 961.6730311694023, 962.2398305338774, 963.942163470194, 690.3890057299326, 701.0850839654249, 714.8641758066003, 716.5127713155052, 716.7742161219252, 15365.539033829004, 15404.075755454596, 15662.530124096294, 15772.447964321194, 15840.0, 11439.0, 15204.391824327015, 15273.61815954599, 15297.923510382489, 15335.769963450557, 12122.39388030595, 12381.62855114348, 12577.685557861036, 12590.0, 12630.74738505234, 3672.9348488938176, 3703.463062828923, 3811.6569508744346, 3851.711121665858, 4173.123644034757, 83372.16627833704, 88497.0, 110498.60761835253, 111185.44407277992, 111288.83912504512, 9856.45789481571, 9943.353682010646, 11499.562554680664, 11875.465604047838, 12002.519899204108, 20912.895435522725, 24917.0, 25060.498790024096, 25114.497710046064, 25126.246212613652, 7904.644291006918, 8116.431849770459, 8204.917950820416, 8210.507369557845, 8218.5488984189, 3991.560928297885, 4053.0, 4071.307877660805, 4094.754314741125, 4114.115465175002, 3691.8154092295276, 3697.131174174067, 3814.599467055975, 3821.407681809324, 3821.7515861468914, 577.2380457795754, 634.9714262858182, 658.8352911772057, 662.8598810046711, 665.088828305225, 599.256921417448, 628.6071205496564, 631.5358211714387, 646.8253571535753, 660.7125900233318, 7861.842763144819, 8152.551609661407, 9247.0752924707, 9480.478573678376, 9867.0, 588.7733222709288, 638.7349250061172, 668.12809283885, 673.5520878615665, 678.1861765880864, 4579.74811385377, 4664.463586687507, 4694.201985662446, 4748.881277968009, 4828.7102773833685, 126235.0, 141630.0, 156007.0, 157037.0, 158857.0, 140307.0, 141839.2908035474, 141922.2903885474, 144336.0, 144909.0, 78705.21294787094, 90981.0, 118700.69095163429, 119212.0, 122924.0, 7723.95726576905, 8734.388592798698, 9007.774805629911, 9051.14014168653, 9250.398724082914, 56407.71796140993, 66240.0, 67490.32509675037, 67561.0, 67746.0, 96147.55778663186, 101619.85421312117, 101755.49122254341, 102370.97629023614, 103862.4806875991, 12557.93721031389, 12615.87384126147, 12642.55751048709, 12838.0, 13067.281299528617, 13664.795028074388, 13791.793123103362, 13792.586222413343, 14054.367553459915, 14130.78803817964, 10813.513391897226, 10985.186507228182, 11292.378919159197, 12138.939305303416, 12606.747865042464, 11894.702632434259, 12168.939155304166, 12318.630441086782, 12351.135420520477, 12734.363281835685, 11111.388873611706, 12761.106722529334, 13480.5281815136, 13776.586702398945, 13920.0, 11453.541858325574, 11457.312561246352, 11562.768744624893, 11600.245984011011, 12030.27818330903, 10720.517576709222, 11041.889581104086, 11334.546618135182, 11405.429728513707, 11571.256380113231], "value": 7867.372734188068, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1620.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 116.0, 107.0, 115.0, 117.0, 118.0, 115.0, 115.0, 116.0, 116.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 111.0, 129.0, 179.0, 143.0, 137.0, 144.0, 141.0, 195.0, 111.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 194.0, 199.0, 240.0, 270.0, 270.0, 198.0, 202.0, 192.0, 192.0], "value": 215.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 85.0, 74.0, 173.0, 58.0, 59.0, 57.0, 60.0, 125.0, 59.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 131.0, 70.0, 71.0, 76.0, 112.0, 68.0, 72.0, 116.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 76.0, 128.0, 135.0, 87.0, 106.0, 89.0, 99.0, 132.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 138.0, 150.0, 99.0, 123.0, 110.0, 89.0, 157.0, 96.0, 134.0], "value": 123.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 120.0, 149.0, 120.0, 90.0, 90.0, 94.0, 115.0, 144.0, 136.0], "value": 114.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 56.0, 57.0, 58.0, 55.0, 58.0, 57.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 74.0, 72.0, 83.0, 80.0, 77.0, 106.0, 103.0, 84.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 82.0, 84.0, 82.0, 92.0, 83.0, 85.0, 85.0, 87.0, 86.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 180.0, 126.0, 166.0, 151.0, 153.0, 156.0, 149.0, 208.0, 148.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 194.0, 153.0, 193.0, 229.0, 169.0, 169.0, 161.0, 198.0, 223.0], "value": 185.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 65.0, 65.0, 67.0, 66.0, 67.0, 87.0, 87.0, 85.0], "value": 73.1, "unit": "score"}]}]} 11:14:27 INFO - Return code: 0 11:14:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:14:27 ERROR - # TBPL SUCCESS # 11:14:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:14:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:14:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:14:27 INFO - 2016-07-15 11:14:27.913 screenresolution[1696:16955] starting screenresolution argv=screenresolution get 11:14:27 INFO - 2016-07-15 11:14:27.915 screenresolution[1696:16955] Display 0: 1600x1200x32@60 11:14:27 INFO - 2016-07-15 11:14:27.922 screenresolution[1697:16958] starting screenresolution argv=screenresolution list 11:14:27 INFO - Available Modes on Display 0 11:14:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:14:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:14:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:14:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:14:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:14:28 INFO - Intel Iris: 11:14:28 INFO - Chipset Model: Intel Iris 11:14:28 INFO - Type: GPU 11:14:28 INFO - Bus: Built-In 11:14:28 INFO - VRAM (Dynamic, Max): 1536 MB 11:14:28 INFO - Vendor: Intel (0x8086) 11:14:28 INFO - Device ID: 0x0a2e 11:14:28 INFO - Revision ID: 0x0009 11:14:28 INFO - Displays: 11:14:28 INFO - Display: 11:14:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:14:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:14:28 INFO - Display Serial Number: 1600x1200 60 11:14:28 INFO - Main Display: Yes 11:14:28 INFO - Mirror: Off 11:14:28 INFO - Online: Yes 11:14:28 INFO - Rotation: Supported 11:14:28 INFO - Return code: 0 11:14:28 INFO - Running post-action listener: _resource_record_post_action 11:14:28 INFO - ##### 11:14:28 INFO - ##### Finished run-tests step (success) 11:14:28 INFO - ##### 11:14:28 INFO - Running post-run listener: _resource_record_post_run 11:14:28 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 31469056; Write bytes: 709738496; Read time: 193; Write time: 2004 11:14:28 INFO - TinderboxPrint: CPU usage
54.1% 11:14:28 INFO - TinderboxPrint: I/O read bytes / time
31,469,056 / 193 11:14:28 INFO - TinderboxPrint: I/O write bytes / time
709,738,496 / 2,004 11:14:28 INFO - TinderboxPrint: CPU idle
2,221.4 (45.9%) 11:14:28 INFO - TinderboxPrint: CPU system
974.6 (20.1%) 11:14:28 INFO - TinderboxPrint: CPU user
1,641.7 (33.9%) 11:14:28 INFO - TinderboxPrint: Swap in / out
434,339,840 / 0 11:14:28 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 237568; Write bytes: 410625024; Read time: 3; Write time: 861 11:14:28 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29228032; Write bytes: 297507840; Read time: 172; Write time: 1133 11:14:28 INFO - Running post-run listener: _upload_blobber_files 11:14:28 INFO - Blob upload gear active. 11:14:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:14:28 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:14:28 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:14:28 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:14:29 INFO - (blobuploader) - INFO - Open directory for files ... 11:14:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:14:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:30 INFO - (blobuploader) - INFO - Done attempting. 11:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:14:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:14:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:30 INFO - (blobuploader) - INFO - Done attempting. 11:14:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:14:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:14:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:14:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:14:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:14:33 INFO - (blobuploader) - INFO - Done attempting. 11:14:33 INFO - (blobuploader) - INFO - Iteration through files over. 11:14:33 INFO - Return code: 0 11:14:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:14:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:14:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef94c54d98109b8be486a894533b92141434ba611674ff720d08522cfbfd5a83e19f1fe2b51e4ebd689878a8108e85d19001c8050edd77dd311ecfd8bfed167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a010018d10f99d947bedde17ea42b3d87a2f092566bba0b7e1a9963c8aad63d9ec39a0dc7ca9cd5abb24fd2f280474c6230a79e2e74d13809cb3c42782628a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd99045c6bbd753731cabce9bce41ea88f347b2c98fac01bb256cf2d13fe925c8502a98b71f168e6f7426778ee851c8cb389efe8bd4ede8df9ae842c0be9c754"} 11:14:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:14:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:14:33 INFO - Contents: 11:14:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef94c54d98109b8be486a894533b92141434ba611674ff720d08522cfbfd5a83e19f1fe2b51e4ebd689878a8108e85d19001c8050edd77dd311ecfd8bfed167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a010018d10f99d947bedde17ea42b3d87a2f092566bba0b7e1a9963c8aad63d9ec39a0dc7ca9cd5abb24fd2f280474c6230a79e2e74d13809cb3c42782628a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd99045c6bbd753731cabce9bce41ea88f347b2c98fac01bb256cf2d13fe925c8502a98b71f168e6f7426778ee851c8cb389efe8bd4ede8df9ae842c0be9c754"} 11:14:33 INFO - Running post-run listener: copy_logs_to_upload_dir 11:14:33 INFO - Copying logs to upload dir... 11:14:33 INFO - mkdir: /builds/slave/test/build/upload/logs 11:14:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1333.395905 ========= master_lag: 0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 13 secs) (at 2016-07-15 11:14:33.569017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:33.572877) ========= 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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef94c54d98109b8be486a894533b92141434ba611674ff720d08522cfbfd5a83e19f1fe2b51e4ebd689878a8108e85d19001c8050edd77dd311ecfd8bfed167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a010018d10f99d947bedde17ea42b3d87a2f092566bba0b7e1a9963c8aad63d9ec39a0dc7ca9cd5abb24fd2f280474c6230a79e2e74d13809cb3c42782628a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd99045c6bbd753731cabce9bce41ea88f347b2c98fac01bb256cf2d13fe925c8502a98b71f168e6f7426778ee851c8cb389efe8bd4ede8df9ae842c0be9c754"} 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.011139 build_url: 'https://queue.taskcluster.net/v1/task/AbB3eD1KQ8qHxsobdL1-xA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef94c54d98109b8be486a894533b92141434ba611674ff720d08522cfbfd5a83e19f1fe2b51e4ebd689878a8108e85d19001c8050edd77dd311ecfd8bfed167c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7a010018d10f99d947bedde17ea42b3d87a2f092566bba0b7e1a9963c8aad63d9ec39a0dc7ca9cd5abb24fd2f280474c6230a79e2e74d13809cb3c42782628a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd99045c6bbd753731cabce9bce41ea88f347b2c98fac01bb256cf2d13fe925c8502a98b71f168e6f7426778ee851c8cb389efe8bd4ede8df9ae842c0be9c754"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:33.605213) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:33.605509) ========= 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.8MrG0vH0Cs/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.ZapneCcTdF/Listeners TMPDIR=/var/folders/9f/wvdy8f7j0_x3yrf4y9yg05cc00000w/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.005046 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 11:14:33.654127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:14:33.654437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 11:14:33.654749) ========= ========= Total master_lag: 0.39 =========