builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0101 starttime: 1467876487.75 results: success (0) buildid: 20160706220723 builduid: b12f4ba44f9140f891e177bb687b8991 revision: a2d888c74624106e976bec81a881cb97d737dd08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.745892) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.746349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.746624) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.772049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.772429) ========= 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.FM5Plj4AsL/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.doMothqd5P/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-07 00:28:07-- 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% 14.5M=0.001s 2016-07-07 00:28:07 (14.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.934035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.934345) ========= 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.FM5Plj4AsL/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.doMothqd5P/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.027632 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.982561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:07.982924) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a2d888c74624106e976bec81a881cb97d737dd08 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a2d888c74624106e976bec81a881cb97d737dd08 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FM5Plj4AsL/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.doMothqd5P/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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-07 00:28:08,066 truncating revision to first 12 chars 2016-07-07 00:28:08,066 Setting DEBUG logging. 2016-07-07 00:28:08,066 attempt 1/10 2016-07-07 00:28:08,066 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a2d888c74624?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 00:28:08,381 unpacking tar archive at: fx-team-a2d888c74624/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601650 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:08.607841) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:08.608181) ========= script_repo_revision: a2d888c74624106e976bec81a881cb97d737dd08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:08.608581) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:08.608866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:28:08.624921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 00:28:08.625313) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FM5Plj4AsL/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.doMothqd5P/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:08 INFO - MultiFileLogger online at 20160707 00:28:08 in /builds/slave/test 00:28:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:28:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:28:08 INFO - {'append_to_log': False, 00:28:08 INFO - 'base_work_dir': '/builds/slave/test', 00:28:08 INFO - 'blob_upload_branch': 'Fx-Team', 00:28:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:28:08 INFO - 'branch': 'Fx-Team', 00:28:08 INFO - 'buildbot_json_path': 'buildprops.json', 00:28:08 INFO - 'config_files': ('talos/mac_config.py',), 00:28:08 INFO - 'default_actions': ('clobber', 00:28:08 INFO - 'read-buildbot-config', 00:28:08 INFO - 'download-and-extract', 00:28:08 INFO - 'populate-webroot', 00:28:08 INFO - 'create-virtualenv', 00:28:08 INFO - 'install', 00:28:08 INFO - 'run-tests'), 00:28:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:28:08 INFO - 'download_minidump_stackwalk': True, 00:28:08 INFO - 'download_symbols': 'ondemand', 00:28:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:28:08 INFO - 'tooltool.py': '/tools/tooltool.py', 00:28:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:28:08 INFO - '/tools/misc-python/virtualenv.py')}, 00:28:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:28:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:28:08 INFO - 'installer_path': 'installer.exe', 00:28:08 INFO - 'log_level': 'info', 00:28:08 INFO - 'log_name': 'talos', 00:28:08 INFO - 'log_to_console': True, 00:28:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:28:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:28:08 INFO - 'opt_config_files': (), 00:28:08 INFO - 'pip_index': False, 00:28:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:28:08 INFO - 'cmd': ('bash', 00:28:08 INFO - '-c', 00:28:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:28:08 INFO - 'enabled': True, 00:28:08 INFO - 'halt_on_failure': False, 00:28:08 INFO - 'name': 'check_screen_resolution'},), 00:28:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:28:08 INFO - 'cmd': ('bash', 00:28:08 INFO - '-c', 00:28:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:28:08 INFO - 'enabled': True, 00:28:08 INFO - 'halt_on_failure': False, 00:28:08 INFO - 'name': 'check_screen_resolution'},), 00:28:08 INFO - 'run_cmd_checks_enabled': True, 00:28:08 INFO - 'sps_profile': False, 00:28:08 INFO - 'sps_profile_interval': 0, 00:28:08 INFO - 'suite': 'dromaeojs', 00:28:08 INFO - 'system_bits': '32', 00:28:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:28:08 INFO - 'title': 't-yosemite-r7-0101', 00:28:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:28:08 INFO - 'use_talos_json': True, 00:28:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:28:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:28:08 INFO - 'work_dir': 'build'} 00:28:08 INFO - ##### 00:28:08 INFO - ##### Running clobber step. 00:28:08 INFO - ##### 00:28:08 INFO - Running pre-action listener: _resource_record_pre_action 00:28:08 INFO - Running main action method: clobber 00:28:08 INFO - rmtree: /builds/slave/test/build 00:28:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:28:10 INFO - Running post-action listener: _resource_record_post_action 00:28:10 INFO - ##### 00:28:10 INFO - ##### Finished clobber step (success) 00:28:10 INFO - ##### 00:28:10 INFO - ##### 00:28:10 INFO - ##### Running read-buildbot-config step. 00:28:10 INFO - ##### 00:28:10 INFO - Running pre-action listener: _resource_record_pre_action 00:28:10 INFO - Running main action method: read_buildbot_config 00:28:10 INFO - Using buildbot properties: 00:28:10 INFO - { 00:28:10 INFO - "project": "", 00:28:10 INFO - "product": "firefox", 00:28:10 INFO - "script_repo_revision": "production", 00:28:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:28:10 INFO - "repository": "", 00:28:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:28:10 INFO - "buildid": "20160706220723", 00:28:10 INFO - "pgo_build": "False", 00:28:10 INFO - "basedir": "/builds/slave/test", 00:28:10 INFO - "buildnumber": 92, 00:28:10 INFO - "slavename": "t-yosemite-r7-0101", 00:28:10 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 00:28:10 INFO - "platform": "yosemite_r7", 00:28:10 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:28:10 INFO - "branch": "fx-team", 00:28:10 INFO - "repo_path": "integration/fx-team", 00:28:10 INFO - "revision": "a2d888c74624106e976bec81a881cb97d737dd08", 00:28:10 INFO - "stage_platform": "macosx64", 00:28:10 INFO - "builduid": "b12f4ba44f9140f891e177bb687b8991", 00:28:10 INFO - "slavebuilddir": "test" 00:28:10 INFO - } 00:28:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 00:28:10 INFO - Running post-action listener: _resource_record_post_action 00:28:10 INFO - ##### 00:28:10 INFO - ##### Finished read-buildbot-config step (success) 00:28:10 INFO - ##### 00:28:10 INFO - ##### 00:28:10 INFO - ##### Running download-and-extract step. 00:28:10 INFO - ##### 00:28:10 INFO - Running pre-action listener: _resource_record_pre_action 00:28:10 INFO - Running main action method: download_and_extract 00:28:10 INFO - mkdir: /builds/slave/test/build/tests 00:28:10 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')]} 00:28:10 INFO - https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 00:28:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 00:28:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 00:28:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:11 INFO - Downloaded 1199 bytes. 00:28:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 00:28:11 INFO - Using the following test package requirements: 00:28:11 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 00:28:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 00:28:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 00:28:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'jsshell-mac.zip'], 00:28:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 00:28:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 00:28:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 00:28:11 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 00:28:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 00:28:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 00:28:11 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 00:28:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:11 INFO - https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:28:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:28:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:28:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:12 INFO - Downloaded 18804827 bytes. 00:28:12 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'] 00:28:12 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 00:28:16 INFO - Return code: 0 00:28:16 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 00:28:16 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')]} 00:28:16 INFO - https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 00:28:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:28:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 00:28:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:18 INFO - Downloaded 18804827 bytes. 00:28:18 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'] 00:28:18 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 00:28:21 INFO - Return code: 0 00:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:21 INFO - https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 00:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 00:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 00:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:22 INFO - Downloaded 14403333 bytes. 00:28:22 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'] 00:28:22 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 00:28:23 INFO - Return code: 0 00:28:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:23 INFO - https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:28:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:28:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:28:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 00:28:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bqqqRQpaSmq3ksE3EPlnbw/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 00:28:26 INFO - Downloaded 112383957 bytes. 00:28:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:28:26 INFO - mkdir: /builds/slave/test/properties 00:28:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:28:26 INFO - Writing to file /builds/slave/test/properties/build_url 00:28:26 INFO - Contents: 00:28:26 INFO - build_url:https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 00:28:27 INFO - Running post-action listener: _resource_record_post_action 00:28:27 INFO - Running post-action listener: set_extra_try_arguments 00:28:27 INFO - ##### 00:28:27 INFO - ##### Finished download-and-extract step (success) 00:28:27 INFO - ##### 00:28:27 INFO - ##### 00:28:27 INFO - ##### Running populate-webroot step. 00:28:27 INFO - ##### 00:28:27 INFO - Running pre-action listener: _resource_record_pre_action 00:28:27 INFO - Running main action method: populate_webroot 00:28:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:28:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:28:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:28:27 INFO - '--tppagecycles', 00:28:27 INFO - '7'], 00:28:27 INFO - 'tests': ['tsvgm']}}, 00:28:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:28:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:28:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:28:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:28:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:28:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:28:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['damp', 'tps']}, 00:28:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'tests': ['damp', 'tps']}, 00:28:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['dromaeo_dom']}, 00:28:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:28:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['basic_compositor_video']}, 00:28:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:28:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['a11yr', 00:28:27 INFO - 'ts_paint', 00:28:27 INFO - 'tpaint', 00:28:27 INFO - 'sessionrestore', 00:28:27 INFO - 'sessionrestore_no_auto_restore', 00:28:27 INFO - 'tabpaint']}, 00:28:27 INFO - 'other-e10s': {'tests': ['a11yr', 00:28:27 INFO - 'ts_paint', 00:28:27 INFO - 'tpaint', 00:28:27 INFO - 'sessionrestore', 00:28:27 INFO - 'sessionrestore_no_auto_restore', 00:28:27 INFO - 'tabpaint']}, 00:28:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:28:27 INFO - 'ts_paint', 00:28:27 INFO - 'tpaint', 00:28:27 INFO - 'sessionrestore', 00:28:27 INFO - 'sessionrestore_no_auto_restore', 00:28:27 INFO - 'tabpaint']}, 00:28:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:28:27 INFO - 'ts_paint', 00:28:27 INFO - 'tpaint', 00:28:27 INFO - 'sessionrestore', 00:28:27 INFO - 'sessionrestore_no_auto_restore', 00:28:27 INFO - 'tabpaint']}, 00:28:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['a11yr', 00:28:27 INFO - 'ts_paint', 00:28:27 INFO - 'tpaint', 00:28:27 INFO - 'sessionrestore', 00:28:27 INFO - 'sessionrestore_no_auto_restore', 00:28:27 INFO - 'tabpaint']}, 00:28:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['a11yr', 00:28:27 INFO - 'ts_paint', 00:28:27 INFO - 'tpaint', 00:28:27 INFO - 'sessionrestore', 00:28:27 INFO - 'sessionrestore_no_auto_restore', 00:28:27 INFO - 'tabpaint']}, 00:28:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['tsvgx', 00:28:27 INFO - 'tsvgr_opacity', 00:28:27 INFO - 'tart', 00:28:27 INFO - 'tscrollx', 00:28:27 INFO - 'cart']}, 00:28:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:28:27 INFO - 'tsvgr_opacity', 00:28:27 INFO - 'tart', 00:28:27 INFO - 'tscrollx', 00:28:27 INFO - 'cart']}, 00:28:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'talos_options': ['--disable-e10s'], 00:28:27 INFO - 'tests': ['tp5o']}, 00:28:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'tests': ['tp5o']}, 00:28:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'talos_options': ['--disable-e10s', 00:28:27 INFO - '--xperf_path', 00:28:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:28:27 INFO - 'tests': ['tp5n']}, 00:28:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:28:27 INFO - 'talos_options': ['--xperf_path', 00:28:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:28:27 INFO - 'tests': ['tp5n']}}, 00:28:27 INFO - 'talos.zip': {'path': '', 00:28:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:28:27 INFO - Running post-action listener: _resource_record_post_action 00:28:27 INFO - ##### 00:28:27 INFO - ##### Finished populate-webroot step (success) 00:28:27 INFO - ##### 00:28:27 INFO - ##### 00:28:27 INFO - ##### Running create-virtualenv step. 00:28:27 INFO - ##### 00:28:27 INFO - Running pre-action listener: _resource_record_pre_action 00:28:27 INFO - Running main action method: create_virtualenv 00:28:27 INFO - Creating virtualenv /builds/slave/test/build/venv 00:28:27 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 00:28:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:28:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:28:27 INFO - Using real prefix '/tools/python27' 00:28:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:28:28 INFO - Installing distribute.............................................................................................................................................................................................done. 00:28:31 INFO - Installing pip.................done. 00:28:31 INFO - Return code: 0 00:28:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:28:31 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')]} 00:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:31 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')]} 00:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:31 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:31 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 00:28:31 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 00:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:31 INFO - 'HOME': '/Users/cltbld', 00:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:31 INFO - 'LOGNAME': 'cltbld', 00:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:31 INFO - 'MOZ_NO_REMOTE': '1', 00:28:31 INFO - 'NO_EM_RESTART': '1', 00:28:31 INFO - 'PAGER': '/bin/cat', 00:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:31 INFO - 'PWD': '/builds/slave/test', 00:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:31 INFO - 'SHELL': '/bin/bash', 00:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:31 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:31 INFO - 'USER': 'cltbld', 00:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:31 INFO - 'XPC_FLAGS': '0x0', 00:28:31 INFO - 'XPC_SERVICE_NAME': '0', 00:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:31 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 00:28:31 INFO - Cleaning up... 00:28:31 INFO - Return code: 0 00:28:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:28:31 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')]} 00:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:31 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')]} 00:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:31 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:31 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 00:28:31 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 00:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:31 INFO - 'HOME': '/Users/cltbld', 00:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:31 INFO - 'LOGNAME': 'cltbld', 00:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:31 INFO - 'MOZ_NO_REMOTE': '1', 00:28:31 INFO - 'NO_EM_RESTART': '1', 00:28:31 INFO - 'PAGER': '/bin/cat', 00:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:31 INFO - 'PWD': '/builds/slave/test', 00:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:31 INFO - 'SHELL': '/bin/bash', 00:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:31 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:31 INFO - 'USER': 'cltbld', 00:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:31 INFO - 'XPC_FLAGS': '0x0', 00:28:31 INFO - 'XPC_SERVICE_NAME': '0', 00:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:31 INFO - Downloading/unpacking psutil>=3.1.1 00:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:28:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:28:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:28:34 INFO - Installing collected packages: psutil 00:28:34 INFO - Running setup.py install for psutil 00:28:34 INFO - building 'psutil._psutil_osx' extension 00:28:34 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 00:28:35 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 00:28:35 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 00:28:35 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 00:28:35 INFO - building 'psutil._psutil_posix' extension 00:28:35 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 00:28:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:28:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:28:35 INFO - ^ 00:28:35 INFO - 1 warning generated. 00:28:35 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 00:28:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:28:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:28:35 INFO - Successfully installed psutil 00:28:35 INFO - Cleaning up... 00:28:35 INFO - Return code: 0 00:28:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:35 INFO - 'HOME': '/Users/cltbld', 00:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:35 INFO - 'LOGNAME': 'cltbld', 00:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:35 INFO - 'MOZ_NO_REMOTE': '1', 00:28:35 INFO - 'NO_EM_RESTART': '1', 00:28:35 INFO - 'PAGER': '/bin/cat', 00:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:35 INFO - 'PWD': '/builds/slave/test', 00:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:35 INFO - 'SHELL': '/bin/bash', 00:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:35 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:35 INFO - 'USER': 'cltbld', 00:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:35 INFO - 'XPC_FLAGS': '0x0', 00:28:35 INFO - 'XPC_SERVICE_NAME': '0', 00:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:28:36 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 00:28:36 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 00:28:36 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 00:28:36 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 00:28:36 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 00:28:36 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 00:28:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:28:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:28:38 INFO - Installing collected packages: mozsystemmonitor 00:28:38 INFO - Running setup.py install for mozsystemmonitor 00:28:38 INFO - Successfully installed mozsystemmonitor 00:28:38 INFO - Cleaning up... 00:28:38 INFO - Return code: 0 00:28:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:28:38 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')]} 00:28:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:38 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')]} 00:28:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:38 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:38 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 00:28:38 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 00:28:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:38 INFO - 'HOME': '/Users/cltbld', 00:28:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:38 INFO - 'LOGNAME': 'cltbld', 00:28:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:38 INFO - 'MOZ_NO_REMOTE': '1', 00:28:38 INFO - 'NO_EM_RESTART': '1', 00:28:38 INFO - 'PAGER': '/bin/cat', 00:28:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:38 INFO - 'PWD': '/builds/slave/test', 00:28:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:38 INFO - 'SHELL': '/bin/bash', 00:28:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:38 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:38 INFO - 'USER': 'cltbld', 00:28:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:38 INFO - 'XPC_FLAGS': '0x0', 00:28:38 INFO - 'XPC_SERVICE_NAME': '0', 00:28:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:39 INFO - Downloading/unpacking jsonschema==2.5.1 00:28:39 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 00:28:39 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 00:28:39 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 00:28:39 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 00:28:39 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 00:28:39 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 00:28:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:28:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:28:41 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 00:28:41 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 00:28:41 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 00:28:41 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 00:28:41 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 00:28:41 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 00:28:42 INFO - Downloading functools32-3.2.3-2.tar.gz 00:28:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:28:42 INFO - warning: no files found matching '*.txt' 00:28:42 INFO - no previously-included directories found matching 'build' 00:28:42 INFO - no previously-included directories found matching 'dist' 00:28:42 INFO - no previously-included directories found matching '.git*' 00:28:42 INFO - Installing collected packages: jsonschema, functools32 00:28:42 INFO - Running setup.py install for functools32 00:28:42 INFO - warning: no files found matching '*.txt' 00:28:42 INFO - no previously-included directories found matching 'build' 00:28:42 INFO - no previously-included directories found matching 'dist' 00:28:42 INFO - no previously-included directories found matching '.git*' 00:28:42 INFO - Successfully installed jsonschema functools32 00:28:42 INFO - Cleaning up... 00:28:42 INFO - Return code: 0 00:28:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:42 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:42 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 00:28:42 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 00:28:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:42 INFO - 'HOME': '/Users/cltbld', 00:28:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:42 INFO - 'LOGNAME': 'cltbld', 00:28:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:42 INFO - 'MOZ_NO_REMOTE': '1', 00:28:42 INFO - 'NO_EM_RESTART': '1', 00:28:42 INFO - 'PAGER': '/bin/cat', 00:28:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:42 INFO - 'PWD': '/builds/slave/test', 00:28:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:42 INFO - 'SHELL': '/bin/bash', 00:28:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:42 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:42 INFO - 'USER': 'cltbld', 00:28:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:42 INFO - 'XPC_FLAGS': '0x0', 00:28:42 INFO - 'XPC_SERVICE_NAME': '0', 00:28:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:42 INFO - Downloading/unpacking blobuploader==1.2.4 00:28:42 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 00:28:42 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 00:28:42 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 00:28:42 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 00:28:42 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 00:28:42 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 00:28:45 INFO - Downloading blobuploader-1.2.4.tar.gz 00:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:28:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:28:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:46 INFO - Downloading docopt-0.6.1.tar.gz 00:28:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:28:46 INFO - Installing collected packages: blobuploader, requests, docopt 00:28:46 INFO - Running setup.py install for blobuploader 00:28:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:28:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:28:46 INFO - Running setup.py install for requests 00:28:47 INFO - Running setup.py install for docopt 00:28:47 INFO - Successfully installed blobuploader requests docopt 00:28:47 INFO - Cleaning up... 00:28:47 INFO - Return code: 0 00:28:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:47 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:47 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 00:28:47 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 00:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:47 INFO - 'HOME': '/Users/cltbld', 00:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:47 INFO - 'LOGNAME': 'cltbld', 00:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:47 INFO - 'MOZ_NO_REMOTE': '1', 00:28:47 INFO - 'NO_EM_RESTART': '1', 00:28:47 INFO - 'PAGER': '/bin/cat', 00:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:47 INFO - 'PWD': '/builds/slave/test', 00:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:47 INFO - 'SHELL': '/bin/bash', 00:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:47 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:47 INFO - 'USER': 'cltbld', 00:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:47 INFO - 'XPC_FLAGS': '0x0', 00:28:47 INFO - 'XPC_SERVICE_NAME': '0', 00:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:28:47 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-eJLtTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:28:47 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-jCzGGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:28:47 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-YY8zQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:28:47 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-KZ1MDg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:28:47 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-MPmMNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-EgbWOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-s4lUb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-9Tb1za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bZ9_wP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-bd_ynF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-hco7gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-0XS6Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-hNoAX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-AOkicz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:28:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:48 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-f1ZZeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:28:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-VLjtaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:28:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:28:49 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-OQQjfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:28:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:28:49 INFO - Running setup.py install for manifestparser 00:28:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:28:49 INFO - Running setup.py install for mozcrash 00:28:49 INFO - Running setup.py install for mozdebug 00:28:49 INFO - Running setup.py install for mozdevice 00:28:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:28:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:28:49 INFO - Running setup.py install for mozfile 00:28:50 INFO - Running setup.py install for mozhttpd 00:28:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Running setup.py install for mozinfo 00:28:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Running setup.py install for mozInstall 00:28:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Running setup.py install for mozleak 00:28:50 INFO - Running setup.py install for mozlog 00:28:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Running setup.py install for moznetwork 00:28:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:28:50 INFO - Running setup.py install for mozprocess 00:28:51 INFO - Running setup.py install for mozprofile 00:28:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:28:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:28:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:28:51 INFO - Running setup.py install for mozrunner 00:28:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:28:51 INFO - Running setup.py install for mozscreenshot 00:28:51 INFO - Running setup.py install for moztest 00:28:51 INFO - Running setup.py install for mozversion 00:28:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:28:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:28:51 INFO - Cleaning up... 00:28:51 INFO - Return code: 0 00:28:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:28: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')]} 00:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28: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')]} 00:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:51 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:51 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 00:28:51 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 00:28:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:51 INFO - 'HOME': '/Users/cltbld', 00:28:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:51 INFO - 'LOGNAME': 'cltbld', 00:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:51 INFO - 'MOZ_NO_REMOTE': '1', 00:28:51 INFO - 'NO_EM_RESTART': '1', 00:28:51 INFO - 'PAGER': '/bin/cat', 00:28:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:51 INFO - 'PWD': '/builds/slave/test', 00:28:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:51 INFO - 'SHELL': '/bin/bash', 00:28:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:51 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:51 INFO - 'USER': 'cltbld', 00:28:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:51 INFO - 'XPC_FLAGS': '0x0', 00:28:51 INFO - 'XPC_SERVICE_NAME': '0', 00:28:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-1AYY5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-oE5Ulr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-vypJGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-7FbhZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-vZs1BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ft6XHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-grcpux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-JIfTPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:28:52 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)) 00:28:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:28:52 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-07ex9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-ENjKI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-Wee0F7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-0C9y4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-x4Do4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-pANfft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-xyATeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-J0asSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:28:53 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)) 00:28:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:28:53 INFO - Running setup.py (path:/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/pip-3QYWrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:28:53 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)) 00:28:53 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)) 00:28:53 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)) 00:28:53 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)) 00:28:53 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)) 00:28:53 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)) 00:28:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:28:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:28:56 INFO - Downloading blessings-1.6.tar.gz 00:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:28:56 INFO - Installing collected packages: blessings 00:28:56 INFO - Running setup.py install for blessings 00:28:56 INFO - Successfully installed blessings 00:28:56 INFO - Cleaning up... 00:28:56 INFO - Return code: 0 00:28:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:28:57 INFO - Reading from file tmpfile_stdout 00:28:57 INFO - Current package versions: 00:28:57 INFO - blessings == 1.6 00:28:57 INFO - blobuploader == 1.2.4 00:28:57 INFO - docopt == 0.6.1 00:28:57 INFO - functools32 == 3.2.3-2 00:28:57 INFO - jsonschema == 2.5.1 00:28:57 INFO - manifestparser == 1.1 00:28:57 INFO - mozInstall == 1.12 00:28:57 INFO - mozcrash == 0.17 00:28:57 INFO - mozdebug == 0.1 00:28:57 INFO - mozdevice == 0.48 00:28:57 INFO - mozfile == 1.2 00:28:57 INFO - mozhttpd == 0.7 00:28:57 INFO - mozinfo == 0.9 00:28:57 INFO - mozleak == 0.1 00:28:57 INFO - mozlog == 3.2 00:28:57 INFO - moznetwork == 0.27 00:28:57 INFO - mozprocess == 0.23 00:28:57 INFO - mozprofile == 0.28 00:28:57 INFO - mozrunner == 6.12 00:28:57 INFO - mozscreenshot == 0.1 00:28:57 INFO - mozsystemmonitor == 0.3 00:28:57 INFO - moztest == 0.7 00:28:57 INFO - mozversion == 1.4 00:28:57 INFO - psutil == 3.1.1 00:28:57 INFO - requests == 1.2.3 00:28:57 INFO - wsgiref == 0.1.2 00:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:57 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:57 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 00:28:57 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 00:28:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:57 INFO - 'HOME': '/Users/cltbld', 00:28:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:57 INFO - 'LOGNAME': 'cltbld', 00:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:57 INFO - 'MOZ_NO_REMOTE': '1', 00:28:57 INFO - 'NO_EM_RESTART': '1', 00:28:57 INFO - 'PAGER': '/bin/cat', 00:28:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:57 INFO - 'PWD': '/builds/slave/test', 00:28:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:57 INFO - 'SHELL': '/bin/bash', 00:28:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:57 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:57 INFO - 'USER': 'cltbld', 00:28:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:57 INFO - 'XPC_FLAGS': '0x0', 00:28:57 INFO - 'XPC_SERVICE_NAME': '0', 00:28:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 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)) 00:28:57 INFO - Cleaning up... 00:28:57 INFO - Return code: 0 00:28:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:28:57 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 0x102423a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b8618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff07a570f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, '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.FM5Plj4AsL/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.doMothqd5P/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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 00:28:57 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 00:28:57 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 00:28:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:28:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:28:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:28:57 INFO - 'HOME': '/Users/cltbld', 00:28:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:28:57 INFO - 'LOGNAME': 'cltbld', 00:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:28:57 INFO - 'MOZ_NO_REMOTE': '1', 00:28:57 INFO - 'NO_EM_RESTART': '1', 00:28:57 INFO - 'PAGER': '/bin/cat', 00:28:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:28:57 INFO - 'PWD': '/builds/slave/test', 00:28:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:28:57 INFO - 'SHELL': '/bin/bash', 00:28:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:28:57 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:28:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:28:57 INFO - 'USER': 'cltbld', 00:28:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:28:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:28:57 INFO - 'XPC_FLAGS': '0x0', 00:28:57 INFO - 'XPC_SERVICE_NAME': '0', 00:28:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:28:57 INFO - Cleaning up... 00:28:57 INFO - Return code: 0 00:28:57 INFO - Running post-action listener: _resource_record_post_action 00:28:57 INFO - Running post-action listener: _start_resource_monitoring 00:28:57 INFO - Starting resource monitoring. 00:28:57 INFO - ##### 00:28:57 INFO - ##### Finished create-virtualenv step (success) 00:28:57 INFO - ##### 00:28:57 INFO - ##### 00:28:57 INFO - ##### Running install step. 00:28:57 INFO - ##### 00:28:57 INFO - Running pre-action listener: _resource_record_pre_action 00:28:57 INFO - Running main action method: install 00:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:28:57 INFO - Reading from file tmpfile_stdout 00:28:57 INFO - Detecting whether we're running mozinstall >=1.0... 00:28:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:28:57 INFO - Reading from file tmpfile_stdout 00:28:57 INFO - Output received: 00:28:57 INFO - Usage: mozinstall [options] installer 00:28:57 INFO - Options: 00:28:57 INFO - -h, --help show this help message and exit 00:28:57 INFO - -d DEST, --destination=DEST 00:28:57 INFO - Directory to install application into. [default: 00:28:57 INFO - "/builds/slave/test"] 00:28:57 INFO - --app=APP Application being installed. [default: firefox] 00:28:57 INFO - mkdir: /builds/slave/test/build/application 00:28:57 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'] 00:28:57 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 00:29:31 INFO - Reading from file tmpfile_stdout 00:29:31 INFO - Output received: 00:29:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:29:31 INFO - Running post-action listener: _resource_record_post_action 00:29:31 INFO - ##### 00:29:31 INFO - ##### Finished install step (success) 00:29:31 INFO - ##### 00:29:31 INFO - ##### 00:29:31 INFO - ##### Running run-tests step. 00:29:31 INFO - ##### 00:29:31 INFO - Running pre-action listener: _resource_record_pre_action 00:29:31 INFO - Running main action method: run_tests 00:29:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:29:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:29:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:29:31 INFO - 2016-07-07 00:29:31.939 screenresolution[1641:7480] starting screenresolution argv=screenresolution get 00:29:31 INFO - 2016-07-07 00:29:31.941 screenresolution[1641:7480] Display 0: 1600x1200x32@60 00:29:31 INFO - 2016-07-07 00:29:31.948 screenresolution[1642:7482] starting screenresolution argv=screenresolution list 00:29:31 INFO - Available Modes on Display 0 00:29:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:29:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:29:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:29:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:29:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:29:32 INFO - Intel Iris: 00:29:32 INFO - Chipset Model: Intel Iris 00:29:32 INFO - Type: GPU 00:29:32 INFO - Bus: Built-In 00:29:32 INFO - VRAM (Dynamic, Max): 1536 MB 00:29:32 INFO - Vendor: Intel (0x8086) 00:29:32 INFO - Device ID: 0x0a2e 00:29:32 INFO - Revision ID: 0x0009 00:29:32 INFO - Displays: 00:29:32 INFO - Display: 00:29:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:29:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:29:32 INFO - Display Serial Number: 1600x1200 60 00:29:32 INFO - Main Display: Yes 00:29:32 INFO - Mirror: Off 00:29:32 INFO - Online: Yes 00:29:32 INFO - Rotation: Supported 00:29:32 INFO - Return code: 0 00:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:29:32 INFO - Python 2.7.3 00:29:32 INFO - Return code: 0 00:29:32 INFO - grabbing minidump binary from tooltool 00:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:29:32 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 0x102387d30>, '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 0x1020ecdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10237fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:29:32 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 00:29:32 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 00:29:32 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 00:29:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:29:32 INFO - Return code: 0 00:29:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:29:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:29:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:29:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:29:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0101 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:29:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FM5Plj4AsL/Render', 00:29:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:29:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:29:32 INFO - 'HOME': '/Users/cltbld', 00:29:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:29:32 INFO - 'LOGNAME': 'cltbld', 00:29:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:29:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:29:32 INFO - 'MOZ_NO_REMOTE': '1', 00:29:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:29:32 INFO - 'NO_EM_RESTART': '1', 00:29:32 INFO - 'PAGER': '/bin/cat', 00:29:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:29:32 INFO - 'PWD': '/builds/slave/test', 00:29:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:29:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:29:32 INFO - 'SHELL': '/bin/bash', 00:29:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.doMothqd5P/Listeners', 00:29:32 INFO - 'TMPDIR': '/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/', 00:29:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:29:32 INFO - 'USER': 'cltbld', 00:29:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:29:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:29:32 INFO - 'XPC_FLAGS': '0x0', 00:29:32 INFO - 'XPC_SERVICE_NAME': '0', 00:29:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:29:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0101', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:29:32 INFO - mozversion application_buildid: 20160706220723 00:29:32 INFO - mozversion application_changeset: a2d888c74624106e976bec81a881cb97d737dd08 00:29:32 INFO - mozversion application_display_name: Nightly 00:29:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:29:32 INFO - mozversion application_name: Firefox 00:29:32 INFO - mozversion application_remotingname: firefox 00:29:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:29:32 INFO - mozversion application_vendor: Mozilla 00:29:32 INFO - mozversion application_version: 50.0a1 00:29:32 INFO - mozversion platform_buildid: 20160706220723 00:29:32 INFO - mozversion platform_changeset: a2d888c74624106e976bec81a881cb97d737dd08 00:29:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:29:32 INFO - mozversion platform_version: 50.0a1 00:29:32 INFO - using testdate: 1467876572 00:29:32 INFO - actual date: 1467876572 00:29:32 INFO - starting webserver on 'localhost:49271' 00:29:32 INFO - SUITE-START | Running 2 tests 00:29:32 INFO - TEST-START | dromaeo_css 00:29:32 INFO - operating with platform_type : mac_ 00:29:32 INFO - Initialising browser for dromaeo_css test... 00:29:32 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp_uB9mS/profile http://localhost:49271/getInfo.html) 00:29:34 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 00:29:34 INFO - PROCESS | 1652 | colorDepth:24 00:29:34 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 00:29:34 INFO - PROCESS | 1652 | __metrics 00:29:35 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:29:35 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:29:35 INFO - TEST-INFO | 1652: exit 0 00:29:35 INFO - Browser initialized. 00:29:35 INFO - Running cycle 1/1 for dromaeo_css test... 00:29:35 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmp_uB9mS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:29:47 INFO - PROCESS | 1654 | RSS: Main: 243523584 00:29:47 INFO - PROCESS | 1654 | 00:30:38 INFO - PROCESS | 1654 | 1467876638545 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] 00:32:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 00:32:51 INFO - PROCESS | 1654 | RSS: Main: 374358016 00:32:51 INFO - PROCESS | 1654 | 00:35:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 00:35:55 INFO - PROCESS | 1654 | RSS: Main: 381362176 00:35:55 INFO - PROCESS | 1654 | 00:38:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 00:38:58 INFO - PROCESS | 1654 | RSS: Main: 372256768 00:38:58 INFO - PROCESS | 1654 | 00:42:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 00:42:00 INFO - PROCESS | 1654 | RSS: Main: 371064832 00:42:00 INFO - PROCESS | 1654 | 00:45:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 00:45:04 INFO - PROCESS | 1654 | RSS: Main: 333881344 00:45:04 INFO - PROCESS | 1654 | 00:48:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 00:48:08 INFO - PROCESS | 1654 | RSS: Main: 378535936 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | __start_tp_report 00:48:08 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 00:48:08 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 00:48:08 INFO - PROCESS | 1654 | |i|pagename|runs| 00:48:08 INFO - PROCESS | 1654 | |0;dojo.html;3083.398737246238;3355.4799006154044;3404.1829960809396;3412.6757957993996;3448.879289224876;5674.262345895033;5728.99742545054;5789.218455508516;5875.823725288243;5877.823665290043;5795.971020144904;5828.47543721065;5832.737526811293;5844.035734103868;5863.1205319202145;5232.6075544334235;5272.288241087462;5295;5303.65526240795;5362.7050512222;5330.147176451768;5331.067063263933;5357.169638705987;5359.785608575652;5363.061464243761;5221.71280579568;5223.895522089556;5235.424103348629;5243;5353.143497040474;5316.362036555638;5351.919721204185;5358.678479291255;5359.624826262163;5387.838364849022;5122.974385128051;5199.740012999335;5241.528262456359;5281.788728450857;5283.498067683564;5795.043817770063;5808.390119037483;5809.854753631151;5846.473817356416;5849.88300233993;6318.754897779008;6358.491320694333;6362.0456931460185;6362.840928976766;6369.6496692681885;6155.692215389257;6296.874062518724;6314.431701146918;6345.80962571119;6346.524010699216;5867.471927526543;5907.556933229982;5914.112883067574;6006.729697163638;6033.064874944391;6354.809355719336;6356.269029061625;6363.872722545523;6372.458341041063;6377.553571249968;6044.365341639153;6274.811755647338;6291.056341548804;6293.496520278367;6297.748090076438;6235.750569977241;6249;6283.5287353448675;6305.716242769086;6368.84077898047;6298.527610429236;6321.1150438938585;6330.651814150266;6336.271328797156;6347.047942808524;6160.661163635953;6288.27684816252;6340.112384266206;6363.681815909186;6365.904511432333;5002.499750025041;5011.5489605935645;5058.266551350107;5058.721770302669;5092.26162206478;3846.6345697158727;4504.752238626907;4522.88692782683;4528.864134075983;4548.044910568751;5794.246747922743;5796.942030579725;5797.884042319214;5812.738426770806;5856.502197313276;6203.627782333075;6244.2819075805955;6253.936830738785;6293.716782744787;6315.305316415191;5776;5796.681182535001;5813.680247586423;5820.621659592113;5842.415758424208;5500.862478438071;5517.144842549411;5528.861778455571;5545.584081193927;5547.861303467364;6239.844003899848;6247.312795592481;6293.779717709858;6309.684515774101;6379.234491861006;6338.01760727088;6343.3339499351905;6344.651044192614;6346.936530634634;6363.236411630634;6363.936360636334;6372.171617689671;6374;6376.9043464349;6389.8722025560155;6142.78500252489;6157.415045570664;6235.688215589294;6280.371962803683;6320.399562041599;6284.465820405134;6316.778912738032;6324.146240257506;6340.397662222082;6350.968245158745;5179.792808287777;6059.272887253558;6106.267247930099;6184.845378865384;6231.657258850807;6012.188354572077;6086.847828804315;6089.208402907594;6099.84750381244;6120.387961203844;5931.436513531207;5942.494887934574;5944.405559444021;5947.613405128653;5953.6725480097275;6017.157597936205;6104.664243466652;6124.162751174719;6149.569530132848;6160.537959653134;5965.015772397679;5969;5974.910376344272;5996.070609055603;6031.457168854824 00:48:08 INFO - PROCESS | 1654 | |1;ext.html;483.94918533553977;489.9461059283476;523.2752637596928;527.7334945852342;541.3098299667926;29973.850130749342;30265.243368915762;31756.364872702532;31757.841210793973;31803.36393272136;31992.040238792815;42714.35928461076;43720.56279437205;43873;46389.7680511597;9665.855012174805;9807.019298070172;9830.803383932318;9853.06395892389;9854.359466634645;8722.912770872274;9684;9808.11726944575;9811.705648830512;9816.460094694788;8800.647974081028;11839.881601184006;11986.400679966011;11987.220830646023;12197;11941.283522988606;11979.580714674945;11991.340476273801;12014.579489717818;12015.459304331325;8708.782280442976;11481.311121332663;11801.527938882435;11901.583444579399;11910.702232444171;40989;41335;41414.96462588429;41430.96422589429;41433.58566414328;3469.9653003469894;3558.839852206657;3691.427828686558;3973.562908080109;4163;30470.390592188254;30624.846875765703;30642.080737577908;31183.84408077945;33074.83462582696;3313.784604000756;3317.104381816896;3341.8830340938193;3361.09250502363;3400.9149771255916;534436;536599;536917;537883;538803;59661;60072.79854402975;60358.094628580606;60382.09426858601;60565.69717151386;63569.68215158987;63776.36223637797;63904.68047659732;63945.68027159834;63986;16195.919020404823;16779.748303775454;16785.664286714196;16790.24443900003;16804.159792010596;13100.868991309964;13134.014948878872;13159.210447373189;13164.473421063241;13166;14158.221297828512;14421.567352979428;15813.920930395274;15972.361105555648;16183.271752770917;7081.575105493687;7134.429245660334;7145.178304494945;7181.163440440997;7188.245234250328;939.2486011191156;945.924326053914;996.5864166371019;1032.5353590883983;1041.3699711674328;29297.41405171927;30433.847830761148;30719.846400767852;31141.8442907784;31446.685533144377;1059.9788004240027;1100.2958106811648;1128.3230061962756;1147.690123666622;1153.135148638521;14522.854771452361;16028.919855400649;16044.358225671076;16513.944920189802;16566.917165414336;677160;681630;681672;682430;683144;53095.203571946455;60445.466590005046;60885.391146088856;61146;65339.67330163414;1377.6073818961547;1377.8346598408054;1409.2530958591963;1409.6334952912111;1412.173878281217;30880.691193087783;31512.36975260528;31870.36259274755;32331.51502727508;32338.514922276656;51516.48483515117;51717.7414112927;51915.96168076693;52066.47933520768;52138.73930630323;630540;634027;634062;634569;635857;25547.36131596725;25927.22218333453;25959.870200648875;26784.464310713287;40694.38958415685;48583.75708121437;48745;49352.50647493479;49768.50231497639;49838;39737.80131099326;40557.59442405656;40876.79561602173;41860;41957.370639439825;40054.39918401168;40570.68947574405;40573.39139912845;40881.38677919893;41352.75941721753;38558.42162367623;39142.80428597839;39334.80332598319;39391.2121757569;39481.40777888276;33945.98162055142;34555;35137.47293790544;35330.470042948866;35362;24570.75429245756;25525.87237063803;25639.359016024748;25674.10140645143;26307.342316442242 00:48:08 INFO - PROCESS | 1654 | |2;jquery.html;360.0728125077925;381.78047622617;388.5609261534466;390.28772490205364;415.01848129174493;15296.694066118685;16594.585135371606;20395.184192632314;20965.999999999964;20966.26618068366;20807.27174548891;21058.789412105874;21113.94430278484;21118.472038199052;21124.788752112476;5714.085746280596;5832.912506312408;5980.132880732292;6100.969495152518;6109.725062372182;5557.416471270519;5596.664200147984;5638.548916086724;5639.182318563806;5658.745356458949;5424.240606315099;5590.86022849428;5593.776248950037;5913.733881975321;5922.851928701795;5901.085331773561;5901.321348044987;5910.231669882888;5922.763089476416;5949.613275137124;5108.182690769496;5169.974150129263;5432.837014889559;5437.429069947638;5454.318210223722;13201.27392993385;13361.732765344736;13456.865431345659;23423.531529369488;26278.343041424116;1793.757842691246;2127.106615221611;2182.0835249195375;2287.942801429961;2338.041403024769;9406.012368701324;9409.482478463682;9605.18355939746;9831.31180817343;9841.015898410173;1673.1383337581156;1688.7382455719383;1689.3158270900183;1762.286274059008;1783.5006198264507;104867;127358.3632081843;128195;131299.99999999904;131398.3430082853;11257.04315133223;11294.378809165575;11298.265612735311;11510.48202830858;11832.76334473323;14247.715045699028;14344;14363.281835908163;14383.993120481675;14388.568342949728;8718.825623487495;8745.606447709868;8747.606357713918;8784.868226976601;8829.293656507463;7174.820629484305;8843.60203790831;8867.246284065797;8985.820283594423;8989.685361012333;4567.1550763108935;4570.588647021784;4590.059037897223;4607.3319368691355;4643.233866412072;1898.240703718496;1931.3723040012053;1932.0919167991021;1934.1973081171438;1935.699966505194;730.4959577891238;772.9304362607393;855.951350113952;933.6965486217007;994.8607194992707;21280.467988300108;21725.13099476003;21750;21767.129314827547;21892.78107218939;921.7972046149837;954.4061417432904;962.3552220012608;968.3657204531044;1065.5098654618807;11064.723381915517;11231.494582743797;11346.375949322866;11365;11448.542058317575;595906;599161;603924;611845;613345;128351;129273;136024;138876;140680;914.995425022884;932.0353434195575;997.152420442618;1012.8025035118081;1012.9544170512345;14449.711005780036;19322.32371866978;19333.709994349814;19367.12847921875;19508.804911950698;44976.77511612421;56939;58143.709281453324;58709.70645146747;59258;85573;86806;87179.56410217908;87497.45033755012;88561.22877542542;7829.960850195713;8007.771633537402;8024.506276484954;8218.83562328762;8293.21214484623;9165.541722913695;12127.757444850877;13000.739985200433;13083.215007099605;13256.53602123921;11206.103511719206;11386.829197561878;11391;11440.599579014695;11449.370284634426;11094.223404361617;11100;11200.047995920439;11314.60398886035;11363;11586.13104017219;11614.30314181118;11652.708682283012;11839.526418943491;11898.76202475963;8071.394645401736;8156.755297341089;8160.5103693778565;8249.463784853966;8373.246407823082;10885.183611229348;11227.382493962583;11716.648500544998;11826.290422574673;12092.39538023113 00:48:08 INFO - PROCESS | 1654 | |3;mootools.html;1410.1186758276078;1549.7292220379286;1582.6122599963007;1806.8102849200834;1955.1397385150533;7743.845123097534;8624.482531048134;8829.735107946764;8841.690540831072;8912.598933048012;8564.229219370256;8776.64893404263;8794.252488538483;8795.868061979076;8886.24466920311;2365.645153227021;2388.7850093491584;2396.8681722505257;2399.5800734871327;2400.075970751265;2362.8582285062953;2381.476075263448;2405.5549723301247;2406.843555168917;2410.517896420714;2362.692849929507;2384.523095380922;2400.1839374612628;2400.435897564071;2400.759924007594;2056.763472200686;2267.4921177417;2359.162497313455;2363.633636786301;2366.266457398212;2273.3520946530325;2349.6710460535537;2354.3878591566317;2357.846739961897;2359.1035406545575;7144.9642751785905;7852.097008843999;8851.822963540757;8854.247388971946;8930.910690893073;5019.723915184663;5333.066713325192;5334.1732031535175;5339.145736682112;5362.785488580452;3450.3099380123826;3476.1657202271526;3546.7871927684423;3558.1104723819044;3568.80371579563;948.9134940493096;1060.512164404375;1077.7144056824948;1080.3140006096107;1088.7169335972703;10719.410432426213;11437.085033197323;11690.88309116915;11715.062794976468;11770.882291177064;4661.925443177821;4700.9059818803435;4873.829415970495;4877.5366340197625;4881.53625405593;10197.898021019695;10212.795744085077;10216.182705383551;10226.795464090677;10260.43567603774;5414.864628384322;5415.918761218585;5428.891422171534;5438.864028399322;5447.727613619303;4822.831200907952;4901.632377571696;4937;4960.47914968923;4969.403671559436;3200.407924533922;3915.1778126593736;3951.308521008812;3988.4216788565495;4019.437278780973;1261.5584545409033;1283.9743205135844;1290.6128161551496;1298.5455090718174;1300.0769453687988;931.9841372903568;934.3739694404765;944.4899754132829;954.9236061115095;1001.2890847498212;5801.7389217485315;5965.970170149209;6031.517478601701;6120.898238317146;6170.444659980623;436.6899501354074;447.6955670144268;456.915470637933;458.0038416444287;459.24912767625176;3737.4020156775327;3834.7123965702685;3856.6914646828186;3911.2959667259597;3922.5292964844402;10454.686359409077;10732.785344293226;10773.461326933779;10875.129989600813;10897.509612067475;10836.458177091114;10837.349759014485;10837.945810271056;10852.565897364175;10869.945650271857;7866.174051724601;8299.626516806637;8300.543470109082;8316.293115085286;8320.875186872201;5312.920306195488;5469.632591852037;5711.514521265739;5813.970930145322;5970.402959703995;9965.25260605472;9997.300188986701;10260.948695256477;10271.640492582725;10277.897221027994;9922.255830812574;10386.740331491774;10432.165426765992;10457.320274182153;10462.895371046192;7237.565746055254;7451.180370159386;7465.813354666177;7466.656001919489;7471.663775130023;8147.714829980922;8333.916660833314;8340.082590915115;8343.374246931626;8353.791155221168;7203.315685009916;7551.811204719926;7642.4650274480255;7696.538207707556;7734.99445072137;7346.926530734838;7435.330820226206;7455.6644950978425;7583.7724868254045;7589.848203036019;6940.930590694028;7004.019437278683;7007.264237255014;7020.262872398529;7029.191642961125;4921.876953076202;5055.9494405055475;5060.3168572242275;5135.768890400016;5145.7941682333785;5063.291139240583;5126.974605079074;5156.355455568054;5187.19598462239;5211.583073354198 00:48:08 INFO - PROCESS | 1654 | |4;prototype.html;301.67117841552704;307.10785169083806;317.5665216978823;319.40431096005955;321.20341552948685;5315.3423288355825;5624.128260119678;5649.265595472588;5728.367415286644;5731.971340143294;4319.330503771913;4875.463698993108;5460.907818436309;5481.656994036457;5507.339119305679;3672.926541469169;4221.029163292429;4237.8304867805255;4239.6396306313845;4248.511421186557;3487;3504.964950350502;3792.412176112693;4064;4114.083167804214;3660.5540811379487;4126.546079931205;4170.541240463562;4174;4185.246655601991;3271.689189526991;4142.420061191436;4178.8328466861285;4201.109500724656;4206.495220573551;3646.5259516262718;3671.0088276165284;3673.2837096766143;3680.411134218539;3682.263547290526;4684.859454216379;5492.830332018831;5535.280413546213;5595.63628364155;5670.234518340013;4244.61798438139;4499;4766.475687674388;4782.13921494131;4809.350737650408;4861.6353773467135;5551;5888.97055514724;5909.852253693649;5939.762409503614;3221.2717592869403;3912.139329347539;3941.467901833273;3956.3274243378696;3968.2460332536725;4598.724076555417;5915.467607915265;6028.819135425901;6072.848178795522;6105.603135796204;3834.5206849143856;3995.9400608990886;4002.7198096133575;4020;4061.817218225187;3543.379908516051;3966.781826999543;4078.776367089861;4079.755214687069;4098.200850834059;3864;4568;4688.2030054890065;4698.1778188816825;4706.529347065266;5888.263967004124;5893.998020336553;5894.498967587718;5908.350081491032;5950.434708702666;1191.2852288626755;1291.922484650924;1357.124654597779;1380.1925873363994;1386.7711827548544;827.8799574061727;832.6003518311245;841.7474757572826;842.5281842168405;843.696269343036;3941.915973107361;4077.918441631151;4495.21333766596;4514.638828893746;4574.9020235143325;4929.137400954819;4991.276264941635;5000.799968001312;5083.187609293031;5122.564582010496;3934.6655534279334;4126.277901367249;4503.819847206075;4532.886677833015;4583.610393116555;2244.7755224477423;2308.6451819144713;2374.833761636669;2470.827042107035;2664.8934042638466;4258.552851950562;4689.991651794812;4802;4981.455748717909;5211.5049070338255;4385.6052955233545;4390.495093064274;5049.2173713074535;5123.333966584395;5141.3830340358645;4404.405405270311;5450.672959622356;6344.509040375416;6355.30091689923;6438.645874476949;5310.99091172676;6056.878862422815;6100.847478813065;6120;6183.5671502994355;5154.7938082477785;5551.8896220755205;6007.90988135187;6094.360092190256;6133.60131591463;5959.344472107978;6092.725827337869;6118.847028824315;6136.32500424944;6182.7217775201125;3979.263836190314;3980.582038885991;3980.8009599520487;3996.760194388346;4004.6395824375945;6080;6096.079734883498;6098.725557349841;6153.584675524744;6163.845903852261;5301.522862942354;5519.834404967697;5532.450913744158;5642.210090587239;5939.821805345847;5821.155932389865;5829.795957141479;5891.528677705859;5894.6736984178215;5900.5512712223945;5216.713080780593;5402.432744561765;5466.508014278734;5737.311522617312;5756.625819321731;4766.237402015661;5493.187248208162;5845.824625261249;5848.824535263949;5888.205092312654;5047.570956468594;5199.818006369759;5300.80731835334;5454.154606036071;5682.914756278742 00:48:08 INFO - PROCESS | 1654 | |5;yui.html;725.3037084398977;799.6481548118827;801.943863929525;824.3899514359376;828.2793969246757;15267.847321526782;16401;16405.917970410163;16408;16423.917880410612;14869.256537173153;15024.248787560606;15048.924755376234;15090.54728358151;15114;711.1679335177841;738.3797610007592;892.7455675132588;922;930.6742640075987;893.2809088683607;904.2991681446898;919.3886065766258;919.3977944446399;920.4431319051978;937.6015193542751;938.8403971324891;939.0797018921461;939.572494514994;940.9576569054409;748.7753673897836;917.6879860847343;919.6137622198659;952.885653721551;952.9094736000069;702.8734827731006;703.3634560722554;703.6657587645878;704.0635954180979;705.0341032785066;12759.234445933274;15491.845081549152;15527.534173974798;15549.30028148736;15554.922225388913;14523.056001359877;14643.707125857423;14689.559313220621;14724.33740481681;14729.852701472955;13197.670058248525;13337.932965362748;13468.326583670876;13593.32033398336;13843.723125537434;4728.739919304437;4768.856934291976;4782.821854990077;4793.688410253322;4952.083864485082;109065;109679;110353.79292414107;110847.89152108456;112227;11500;11558.595449159238;11662.12534059932;12068;12178.634640960785;23318.3004509865;23328.416789580057;23331.88334058319;23332.950017248924;23334.2999710009;7975.609392767292;7976.601169941479;8013.439059265796;8042.437029407885;8111.8643389925455;4409.581089796464;4438.511763705989;4455.465344158722;4462.987483448724;4628.699134556243;3612.8735494257576;3683.8710645127294;3720.6837418819705;3730.4404339349317;3734.477173195755;581.6481028977493;690.3648643248123;690.5131882023162;694.2155364438153;697.1703672629554;560.1597603594608;588.3792598808299;619.9256089269317;630.2405601250482;652.1098700274092;9080.954595226982;9135.634574617074;9246.352755307063;9282.907170928203;9358.625654973861;556.3796367050709;566.8101186102701;634.6509419819081;639.1052526462989;672.5460314287836;4568.177728008924;4700.670953033323;4722.905541889212;4769.332293478916;4800.135975524439;144106;146949;148126;151249;151396;129528.70471295355;129890;133069;133087;135117;100593;101251.98748012572;113894.86105139174;114295;118252.8174718259;9365.438073715326;9369.531523423939;9385.577649005947;9485.193758530602;9552.665656701982;51190.97618047544;55024.44975550193;56053.719731401085;56080;56776.432235677115;80744.5962770206;86476;87806.5609671973;88235.55882220548;90245.0975490263;12083.516659333529;12187;12398;12411;12433.254004759743;13299.401526931118;13488.258145802076;13545.203629792879;13559.389827457591;13699.315034248048;12479.251244925334;12513.749725005267;12616.17994830333;12970;12983.805242921175;12352.62942111738;12508.499660013498;12516;12535.122541422377;12560.874391256337;12197.878021220029;12289.569865055038;12294.385280736105;12310.446029928853;12316.876831231573;10518.316309439862;10548.261621686408;10594.788104237718;10751;10967.451627418757;8804.119588041402;10583.94708026455;10786.676399708022;10945.726356841144;10989.670309890716 00:48:08 INFO - PROCESS | 1654 | __end_tp_report 00:48:08 INFO - PROCESS | 1654 | __start_cc_report 00:48:08 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1380 00:48:08 INFO - PROCESS | 1654 | __end_cc_report 00:48:08 INFO - PROCESS | 1654 | __startTimestamp1467877688102__endTimestamp 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | ------- Summary: start ------- 00:48:08 INFO - PROCESS | 1654 | Number of tests: 6 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5814.22 Median:5996.07 stddev:651.38 (10.9%) stddev-sans-first:617.15 00:48:08 INFO - PROCESS | 1654 | Values: 3083.4 3355.5 3404.2 3412.7 3448.9 5674.3 5729.0 5789.2 5875.8 5877.8 5796.0 5828.5 5832.7 5844.0 5863.1 5232.6 5272.3 5295.0 5303.7 5362.7 5330.1 5331.1 5357.2 5359.8 5363.1 5221.7 5223.9 5235.4 5243.0 5353.1 5316.4 5351.9 5358.7 5359.6 5387.8 5123.0 5199.7 5241.5 5281.8 5283.5 5795.0 5808.4 5809.9 5846.5 5849.9 6318.8 6358.5 6362.0 6362.8 6369.6 6155.7 6296.9 6314.4 6345.8 6346.5 5867.5 5907.6 5914.1 6006.7 6033.1 6354.8 6356.3 6363.9 6372.5 6377.6 6044.4 6274.8 6291.1 6293.5 6297.7 6235.8 6249.0 6283.5 6305.7 6368.8 6298.5 6321.1 6330.7 6336.3 6347.0 6160.7 6288.3 6340.1 6363.7 6365.9 5002.5 5011.5 5058.3 5058.7 5092.3 3846.6 4504.8 4522.9 4528.9 4548.0 5794.2 5796.9 5797.9 5812.7 5856.5 6203.6 6244.3 6253.9 6293.7 6315.3 5776.0 5796.7 5813.7 5820.6 5842.4 5500.9 5517.1 5528.9 5545.6 5547.9 6239.8 6247.3 6293.8 6309.7 6379.2 6338.0 6343.3 6344.7 6346.9 6363.2 6363.9 6372.2 6374.0 6376.9 6389.9 6142.8 6157.4 6235.7 6280.4 6320.4 6284.5 6316.8 6324.1 6340.4 6351.0 5179.8 6059.3 6106.3 6184.8 6231.7 6012.2 6086.8 6089.2 6099.8 6120.4 5931.4 5942.5 5944.4 5947.6 5953.7 6017.2 6104.7 6124.2 6149.6 6160.5 5965.0 5969.0 5974.9 5996.1 6031.5 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:74681.98 Median:39363.01 stddev:165984.48 (421.7%) stddev-sans-first:166356.62 00:48:08 INFO - PROCESS | 1654 | Values: 483.9 489.9 523.3 527.7 541.3 29973.9 30265.2 31756.4 31757.8 31803.4 31992.0 42714.4 43720.6 43873.0 46389.8 9665.9 9807.0 9830.8 9853.1 9854.4 8722.9 9684.0 9808.1 9811.7 9816.5 8800.6 11839.9 11986.4 11987.2 12197.0 11941.3 11979.6 11991.3 12014.6 12015.5 8708.8 11481.3 11801.5 11901.6 11910.7 40989.0 41335.0 41415.0 41431.0 41433.6 3470.0 3558.8 3691.4 3973.6 4163.0 30470.4 30624.8 30642.1 31183.8 33074.8 3313.8 3317.1 3341.9 3361.1 3400.9 534436.0 536599.0 536917.0 537883.0 538803.0 59661.0 60072.8 60358.1 60382.1 60565.7 63569.7 63776.4 63904.7 63945.7 63986.0 16195.9 16779.7 16785.7 16790.2 16804.2 13100.9 13134.0 13159.2 13164.5 13166.0 14158.2 14421.6 15813.9 15972.4 16183.3 7081.6 7134.4 7145.2 7181.2 7188.2 939.2 945.9 996.6 1032.5 1041.4 29297.4 30433.8 30719.8 31141.8 31446.7 1060.0 1100.3 1128.3 1147.7 1153.1 14522.9 16028.9 16044.4 16513.9 16566.9 677160.0 681630.0 681672.0 682430.0 683144.0 53095.2 60445.5 60885.4 61146.0 65339.7 1377.6 1377.8 1409.3 1409.6 1412.2 30880.7 31512.4 31870.4 32331.5 32338.5 51516.5 51717.7 51916.0 52066.5 52138.7 630540.0 634027.0 634062.0 634569.0 635857.0 25547.4 25927.2 25959.9 26784.5 40694.4 48583.8 48745.0 49352.5 49768.5 49838.0 39737.8 40557.6 40876.8 41860.0 41957.4 40054.4 40570.7 40573.4 40881.4 41352.8 38558.4 39142.8 39334.8 39391.2 39481.4 33946.0 34555.0 35137.5 35330.5 35362.0 24570.8 25525.9 25639.4 25674.1 26307.3 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35697.41 Median:24850.94 stddev:101411.79 (408.1%) stddev-sans-first:101661.56 00:48:08 INFO - PROCESS | 1654 | Values: 360.1 381.8 388.6 390.3 415.0 15296.7 16594.6 20395.2 20966.0 20966.3 20807.3 21058.8 21113.9 21118.5 21124.8 5714.1 5832.9 5980.1 6101.0 6109.7 5557.4 5596.7 5638.5 5639.2 5658.7 5424.2 5590.9 5593.8 5913.7 5922.9 5901.1 5901.3 5910.2 5922.8 5949.6 5108.2 5170.0 5432.8 5437.4 5454.3 13201.3 13361.7 13456.9 23423.5 26278.3 1793.8 2127.1 2182.1 2287.9 2338.0 9406.0 9409.5 9605.2 9831.3 9841.0 1673.1 1688.7 1689.3 1762.3 1783.5 104867.0 127358.4 128195.0 131300.0 131398.3 11257.0 11294.4 11298.3 11510.5 11832.8 14247.7 14344.0 14363.3 14384.0 14388.6 8718.8 8745.6 8747.6 8784.9 8829.3 7174.8 8843.6 8867.2 8985.8 8989.7 4567.2 4570.6 4590.1 4607.3 4643.2 1898.2 1931.4 1932.1 1934.2 1935.7 730.5 772.9 856.0 933.7 994.9 21280.5 21725.1 21750.0 21767.1 21892.8 921.8 954.4 962.4 968.4 1065.5 11064.7 11231.5 11346.4 11365.0 11448.5 595906.0 599161.0 603924.0 611845.0 613345.0 128351.0 129273.0 136024.0 138876.0 140680.0 915.0 932.0 997.2 1012.8 1013.0 14449.7 19322.3 19333.7 19367.1 19508.8 44976.8 56939.0 58143.7 58709.7 59258.0 85573.0 86806.0 87179.6 87497.5 88561.2 7830.0 8007.8 8024.5 8218.8 8293.2 9165.5 12127.8 13000.7 13083.2 13256.5 11206.1 11386.8 11391.0 11440.6 11449.4 11094.2 11100.0 11200.0 11314.6 11363.0 11586.1 11614.3 11652.7 11839.5 11898.8 8071.4 8156.8 8160.5 8249.5 8373.2 10885.2 11227.4 11716.6 11826.3 12092.4 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5726.11 Median:4875.68 stddev:3235.78 (66.4%) stddev-sans-first:3228.60 00:48:08 INFO - PROCESS | 1654 | Values: 1410.1 1549.7 1582.6 1806.8 1955.1 7743.8 8624.5 8829.7 8841.7 8912.6 8564.2 8776.6 8794.3 8795.9 8886.2 2365.6 2388.8 2396.9 2399.6 2400.1 2362.9 2381.5 2405.6 2406.8 2410.5 2362.7 2384.5 2400.2 2400.4 2400.8 2056.8 2267.5 2359.2 2363.6 2366.3 2273.4 2349.7 2354.4 2357.8 2359.1 7145.0 7852.1 8851.8 8854.2 8930.9 5019.7 5333.1 5334.2 5339.1 5362.8 3450.3 3476.2 3546.8 3558.1 3568.8 948.9 1060.5 1077.7 1080.3 1088.7 10719.4 11437.1 11690.9 11715.1 11770.9 4661.9 4700.9 4873.8 4877.5 4881.5 10197.9 10212.8 10216.2 10226.8 10260.4 5414.9 5415.9 5428.9 5438.9 5447.7 4822.8 4901.6 4937.0 4960.5 4969.4 3200.4 3915.2 3951.3 3988.4 4019.4 1261.6 1284.0 1290.6 1298.5 1300.1 932.0 934.4 944.5 954.9 1001.3 5801.7 5966.0 6031.5 6120.9 6170.4 436.7 447.7 456.9 458.0 459.2 3737.4 3834.7 3856.7 3911.3 3922.5 10454.7 10732.8 10773.5 10875.1 10897.5 10836.5 10837.3 10837.9 10852.6 10869.9 7866.2 8299.6 8300.5 8316.3 8320.9 5312.9 5469.6 5711.5 5814.0 5970.4 9965.3 9997.3 10260.9 10271.6 10277.9 9922.3 10386.7 10432.2 10457.3 10462.9 7237.6 7451.2 7465.8 7466.7 7471.7 8147.7 8333.9 8340.1 8343.4 8353.8 7203.3 7551.8 7642.5 7696.5 7735.0 7346.9 7435.3 7455.7 7583.8 7589.8 6940.9 7004.0 7007.3 7020.3 7029.2 4921.9 5055.9 5060.3 5135.8 5145.8 5063.3 5127.0 5156.4 5187.2 5211.6 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4547.94 Median:4868.55 stddev:1454.83 (29.9%) stddev-sans-first:1423.57 00:48:08 INFO - PROCESS | 1654 | Values: 301.7 307.1 317.6 319.4 321.2 5315.3 5624.1 5649.3 5728.4 5732.0 4319.3 4875.5 5460.9 5481.7 5507.3 3672.9 4221.0 4237.8 4239.6 4248.5 3487.0 3505.0 3792.4 4064.0 4114.1 3660.6 4126.5 4170.5 4174.0 4185.2 3271.7 4142.4 4178.8 4201.1 4206.5 3646.5 3671.0 3673.3 3680.4 3682.3 4684.9 5492.8 5535.3 5595.6 5670.2 4244.6 4499.0 4766.5 4782.1 4809.4 4861.6 5551.0 5889.0 5909.9 5939.8 3221.3 3912.1 3941.5 3956.3 3968.2 4598.7 5915.5 6028.8 6072.8 6105.6 3834.5 3995.9 4002.7 4020.0 4061.8 3543.4 3966.8 4078.8 4079.8 4098.2 3864.0 4568.0 4688.2 4698.2 4706.5 5888.3 5894.0 5894.5 5908.4 5950.4 1191.3 1291.9 1357.1 1380.2 1386.8 827.9 832.6 841.7 842.5 843.7 3941.9 4077.9 4495.2 4514.6 4574.9 4929.1 4991.3 5000.8 5083.2 5122.6 3934.7 4126.3 4503.8 4532.9 4583.6 2244.8 2308.6 2374.8 2470.8 2664.9 4258.6 4690.0 4802.0 4981.5 5211.5 4385.6 4390.5 5049.2 5123.3 5141.4 4404.4 5450.7 6344.5 6355.3 6438.6 5311.0 6056.9 6100.8 6120.0 6183.6 5154.8 5551.9 6007.9 6094.4 6133.6 5959.3 6092.7 6118.8 6136.3 6182.7 3979.3 3980.6 3980.8 3996.8 4004.6 6080.0 6096.1 6098.7 6153.6 6163.8 5301.5 5519.8 5532.5 5642.2 5939.8 5821.2 5829.8 5891.5 5894.7 5900.6 5216.7 5402.4 5466.5 5737.3 5756.6 4766.2 5493.2 5845.8 5848.8 5888.2 5047.6 5199.8 5300.8 5454.2 5682.9 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:24653.96 Median:3702.28 stddev:39402.12 (1064.3%) stddev-sans-first:39471.69 00:48:08 INFO - PROCESS | 1654 | Values: 725.3 799.6 801.9 824.4 828.3 15267.8 16401.0 16405.9 16408.0 16423.9 14869.3 15024.2 15048.9 15090.5 15114.0 711.2 738.4 892.7 922.0 930.7 893.3 904.3 919.4 919.4 920.4 937.6 938.8 939.1 939.6 941.0 748.8 917.7 919.6 952.9 952.9 702.9 703.4 703.7 704.1 705.0 12759.2 15491.8 15527.5 15549.3 15554.9 14523.1 14643.7 14689.6 14724.3 14729.9 13197.7 13337.9 13468.3 13593.3 13843.7 4728.7 4768.9 4782.8 4793.7 4952.1 109065.0 109679.0 110353.8 110847.9 112227.0 11500.0 11558.6 11662.1 12068.0 12178.6 23318.3 23328.4 23331.9 23333.0 23334.3 7975.6 7976.6 8013.4 8042.4 8111.9 4409.6 4438.5 4455.5 4463.0 4628.7 3612.9 3683.9 3720.7 3730.4 3734.5 581.6 690.4 690.5 694.2 697.2 560.2 588.4 619.9 630.2 652.1 9081.0 9135.6 9246.4 9282.9 9358.6 556.4 566.8 634.7 639.1 672.5 4568.2 4700.7 4722.9 4769.3 4800.1 144106.0 146949.0 148126.0 151249.0 151396.0 129528.7 129890.0 133069.0 133087.0 135117.0 100593.0 101252.0 113894.9 114295.0 118252.8 9365.4 9369.5 9385.6 9485.2 9552.7 51191.0 55024.4 56053.7 56080.0 56776.4 80744.6 86476.0 87806.6 88235.6 90245.1 12083.5 12187.0 12398.0 12411.0 12433.3 13299.4 13488.3 13545.2 13559.4 13699.3 12479.3 12513.7 12616.2 12970.0 12983.8 12352.6 12508.5 12516.0 12535.1 12560.9 12197.9 12289.6 12294.4 12310.4 12316.9 10518.3 10548.3 10594.8 10751.0 10967.5 8804.1 10583.9 10786.7 10945.7 10989.7 00:48:08 INFO - PROCESS | 1654 | -------- Summary: end -------- 00:48:08 INFO - PROCESS | 1654 | 00:48:08 INFO - TEST-INFO | 1654: exit 0 00:48:08 INFO - TEST-OK | dromaeo_css | took 1116201ms 00:48:08 INFO - TEST-START | kraken 00:48:08 INFO - operating with platform_type : mac_ 00:48:08 INFO - Initialising browser for kraken test... 00:48:08 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpHajWSg/profile http://localhost:49271/getInfo.html) 00:48:10 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 00:48:10 INFO - PROCESS | 1664 | colorDepth:24 00:48:10 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 00:48:10 INFO - PROCESS | 1664 | __metrics 00:48:10 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:48:10 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:48:11 INFO - TEST-INFO | 1664: exit 0 00:48:11 INFO - Browser initialized. 00:48:11 INFO - Running cycle 1/1 for kraken test... 00:48:11 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/tmpHajWSg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:48:23 INFO - PROCESS | 1665 | RSS: Main: 243466240 00:48:23 INFO - PROCESS | 1665 | 00:48:26 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 00:48:27 INFO - PROCESS | 1665 | RSS: Main: 294490112 00:48:27 INFO - PROCESS | 1665 | 00:48:29 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 00:48:30 INFO - PROCESS | 1665 | RSS: Main: 304738304 00:48:30 INFO - PROCESS | 1665 | 00:48:33 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 00:48:34 INFO - PROCESS | 1665 | RSS: Main: 389386240 00:48:34 INFO - PROCESS | 1665 | 00:48:36 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 00:48:37 INFO - PROCESS | 1665 | RSS: Main: 291930112 00:48:37 INFO - PROCESS | 1665 | 00:48:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:48:39 INFO - PROCESS | 1665 | RSS: Main: 296030208 00:48:39 INFO - PROCESS | 1665 | 00:48:42 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 00:48:43 INFO - PROCESS | 1665 | RSS: Main: 333053952 00:48:43 INFO - PROCESS | 1665 | 00:48:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 00:48:46 INFO - PROCESS | 1665 | RSS: Main: 334233600 00:48:46 INFO - PROCESS | 1665 | 00:48:49 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 00:48:50 INFO - PROCESS | 1665 | RSS: Main: 334995456 00:48:50 INFO - PROCESS | 1665 | 00:48:51 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:48:52 INFO - PROCESS | 1665 | RSS: Main: 313614336 00:48:52 INFO - PROCESS | 1665 | 00:48:54 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:48:55 INFO - PROCESS | 1665 | RSS: Main: 320389120 00:48:55 INFO - PROCESS | 1665 | 00:48:57 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:48:57 INFO - PROCESS | 1665 | RSS: Main: 317591552 00:48:57 INFO - PROCESS | 1665 | 00:49:00 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:49:01 INFO - PROCESS | 1665 | RSS: Main: 326881280 00:49:01 INFO - PROCESS | 1665 | 00:49:04 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:49:04 INFO - PROCESS | 1665 | RSS: Main: 328179712 00:49:04 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 00:49:06 INFO - PROCESS | 1665 | RSS: Main: 371798016 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | __start_tp_report 00:49:06 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 00:49:06 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 00:49:06 INFO - PROCESS | 1665 | |i|pagename|runs| 00:49:06 INFO - PROCESS | 1665 | |0;ai-astar;101;114;123;163;149;114;116;160;166;113 00:49:06 INFO - PROCESS | 1665 | |1;audio-beat-detection;140;107;106;157;105;108;124;107;139;105 00:49:06 INFO - PROCESS | 1665 | |2;audio-dft;183;187;185;184;183;185;182;185;183;184 00:49:06 INFO - PROCESS | 1665 | |3;audio-fft;79;72;58;107;67;77;85;92;82;57 00:49:06 INFO - PROCESS | 1665 | |4;audio-oscillator;88;88;89;72;69;68;96;70;68;98 00:49:06 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;85;87;84;86;84;87;84;87;84 00:49:06 INFO - PROCESS | 1665 | |6;imaging-darkroom;93;93;93;92;93;94;94;93;94;93 00:49:06 INFO - PROCESS | 1665 | |7;imaging-desaturate;96;130;88;87;91;87;88;88;88;89 00:49:06 INFO - PROCESS | 1665 | |8;json-parse-financial;52;55;55;54;54;55;53;53;56;55 00:49:06 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;66;75;77;73;74;71;69;72;69;71 00:49:06 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;83;86;84;82;82;84;83;84;86;83 00:49:06 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;134;135;163;152;155;146;142;144;176;152 00:49:06 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;164;171;162;168;161;165;162;164;162;161 00:49:06 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;66;67;67;67;63;66;66;66;65;66 00:49:06 INFO - PROCESS | 1665 | __end_tp_report 00:49:06 INFO - PROCESS | 1665 | __start_cc_report 00:49:06 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,2039 00:49:06 INFO - PROCESS | 1665 | __end_cc_report 00:49:06 INFO - PROCESS | 1665 | __startTimestamp1467877746808__endTimestamp 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | ------- Summary: start ------- 00:49:06 INFO - PROCESS | 1665 | Number of tests: 14 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:131.90 Median:136.00 stddev:24.71 (18.2%) stddev-sans-first:23.55 00:49:06 INFO - PROCESS | 1665 | Values: 101.0 114.0 123.0 163.0 149.0 114.0 116.0 160.0 166.0 113.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:119.80 Median:116.00 stddev:19.07 (16.4%) stddev-sans-first:18.78 00:49:06 INFO - PROCESS | 1665 | Values: 140.0 107.0 106.0 157.0 105.0 108.0 124.0 107.0 139.0 105.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.45 (0.8%) stddev-sans-first:1.48 00:49:06 INFO - PROCESS | 1665 | Values: 183.0 187.0 185.0 184.0 183.0 185.0 182.0 185.0 183.0 184.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:77.60 Median:78.00 stddev:15.28 (19.6%) stddev-sans-first:16.19 00:49:06 INFO - PROCESS | 1665 | Values: 79.0 72.0 58.0 107.0 67.0 77.0 85.0 92.0 82.0 57.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:80.60 Median:88.00 stddev:12.29 (14.0%) stddev-sans-first:12.74 00:49:06 INFO - PROCESS | 1665 | Values: 88.0 88.0 89.0 72.0 69.0 68.0 96.0 70.0 68.0 98.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:85.50 Median:86.50 stddev:1.43 (1.7%) stddev-sans-first:1.41 00:49:06 INFO - PROCESS | 1665 | Values: 87.0 85.0 87.0 84.0 86.0 84.0 87.0 84.0 87.0 84.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:93.20 Median:93.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 00:49:06 INFO - PROCESS | 1665 | Values: 93.0 93.0 93.0 92.0 93.0 94.0 94.0 93.0 94.0 93.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:93.20 Median:88.00 stddev:13.21 (15.0%) stddev-sans-first:13.97 00:49:06 INFO - PROCESS | 1665 | Values: 96.0 130.0 88.0 87.0 91.0 87.0 88.0 88.0 88.0 89.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.23 (2.2%) stddev-sans-first:1.01 00:49:06 INFO - PROCESS | 1665 | Values: 52.0 55.0 55.0 54.0 54.0 55.0 53.0 53.0 56.0 55.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:72.50 stddev:3.23 (4.5%) stddev-sans-first:2.69 00:49:06 INFO - PROCESS | 1665 | Values: 66.0 75.0 77.0 73.0 74.0 71.0 69.0 72.0 69.0 71.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.42 (1.7%) stddev-sans-first:1.48 00:49:06 INFO - PROCESS | 1665 | Values: 83.0 86.0 84.0 82.0 82.0 84.0 83.0 84.0 86.0 83.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:152.00 stddev:12.80 (8.4%) stddev-sans-first:12.22 00:49:06 INFO - PROCESS | 1665 | Values: 134.0 135.0 163.0 152.0 155.0 146.0 142.0 144.0 176.0 152.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:3.27 (2.0%) stddev-sans-first:3.46 00:49:06 INFO - PROCESS | 1665 | Values: 164.0 171.0 162.0 168.0 161.0 165.0 162.0 164.0 162.0 161.0 00:49:06 INFO - PROCESS | 1665 | 00:49:06 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 00:49:06 INFO - PROCESS | 1665 | Values: 66.0 67.0 67.0 67.0 63.0 66.0 66.0 66.0 65.0 66.0 00:49:06 INFO - PROCESS | 1665 | -------- Summary: end -------- 00:49:06 INFO - PROCESS | 1665 | 00:49:07 INFO - TEST-INFO | 1665: exit 0 00:49:07 INFO - TEST-OK | kraken | took 58893ms 00:49:07 INFO - SUITE-END | took 1175s 00:49:07 INFO - Completed test suite (00:19:35) 00:49:07 INFO - javascript benchmark 00:49:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.398737246238, 3355.4799006154044, 3404.1829960809396, 3412.6757957993996, 3448.879289224876, 5674.262345895033, 5728.99742545054, 5789.218455508516, 5875.823725288243, 5877.823665290043, 5795.971020144904, 5828.47543721065, 5832.737526811293, 5844.035734103868, 5863.1205319202145, 5232.6075544334235, 5272.288241087462, 5295.0, 5303.65526240795, 5362.7050512222, 5330.147176451768, 5331.067063263933, 5357.169638705987, 5359.785608575652, 5363.061464243761, 5221.71280579568, 5223.895522089556, 5235.424103348629, 5243.0, 5353.143497040474, 5316.362036555638, 5351.919721204185, 5358.678479291255, 5359.624826262163, 5387.838364849022, 5122.974385128051, 5199.740012999335, 5241.528262456359, 5281.788728450857, 5283.498067683564, 5795.043817770063, 5808.390119037483, 5809.854753631151, 5846.473817356416, 5849.88300233993, 6318.754897779008, 6358.491320694333, 6362.0456931460185, 6362.840928976766, 6369.6496692681885, 6155.692215389257, 6296.874062518724, 6314.431701146918, 6345.80962571119, 6346.524010699216, 5867.471927526543, 5907.556933229982, 5914.112883067574, 6006.729697163638, 6033.064874944391, 6354.809355719336, 6356.269029061625, 6363.872722545523, 6372.458341041063, 6377.553571249968, 6044.365341639153, 6274.811755647338, 6291.056341548804, 6293.496520278367, 6297.748090076438, 6235.750569977241, 6249.0, 6283.5287353448675, 6305.716242769086, 6368.84077898047, 6298.527610429236, 6321.1150438938585, 6330.651814150266, 6336.271328797156, 6347.047942808524, 6160.661163635953, 6288.27684816252, 6340.112384266206, 6363.681815909186, 6365.904511432333, 5002.499750025041, 5011.5489605935645, 5058.266551350107, 5058.721770302669, 5092.26162206478, 3846.6345697158727, 4504.752238626907, 4522.88692782683, 4528.864134075983, 4548.044910568751, 5794.246747922743, 5796.942030579725, 5797.884042319214, 5812.738426770806, 5856.502197313276, 6203.627782333075, 6244.2819075805955, 6253.936830738785, 6293.716782744787, 6315.305316415191, 5776.0, 5796.681182535001, 5813.680247586423, 5820.621659592113, 5842.415758424208, 5500.862478438071, 5517.144842549411, 5528.861778455571, 5545.584081193927, 5547.861303467364, 6239.844003899848, 6247.312795592481, 6293.779717709858, 6309.684515774101, 6379.234491861006, 6338.01760727088, 6343.3339499351905, 6344.651044192614, 6346.936530634634, 6363.236411630634, 6363.936360636334, 6372.171617689671, 6374.0, 6376.9043464349, 6389.8722025560155, 6142.78500252489, 6157.415045570664, 6235.688215589294, 6280.371962803683, 6320.399562041599, 6284.465820405134, 6316.778912738032, 6324.146240257506, 6340.397662222082, 6350.968245158745, 5179.792808287777, 6059.272887253558, 6106.267247930099, 6184.845378865384, 6231.657258850807, 6012.188354572077, 6086.847828804315, 6089.208402907594, 6099.84750381244, 6120.387961203844, 5931.436513531207, 5942.494887934574, 5944.405559444021, 5947.613405128653, 5953.6725480097275, 6017.157597936205, 6104.664243466652, 6124.162751174719, 6149.569530132848, 6160.537959653134, 5965.015772397679, 5969.0, 5974.910376344272, 5996.070609055603, 6031.457168854824], "value": 5771.207456402897, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.94918533553977, 489.9461059283476, 523.2752637596928, 527.7334945852342, 541.3098299667926, 29973.850130749342, 30265.243368915762, 31756.364872702532, 31757.841210793973, 31803.36393272136, 31992.040238792815, 42714.35928461076, 43720.56279437205, 43873.0, 46389.7680511597, 9665.855012174805, 9807.019298070172, 9830.803383932318, 9853.06395892389, 9854.359466634645, 8722.912770872274, 9684.0, 9808.11726944575, 9811.705648830512, 9816.460094694788, 8800.647974081028, 11839.881601184006, 11986.400679966011, 11987.220830646023, 12197.0, 11941.283522988606, 11979.580714674945, 11991.340476273801, 12014.579489717818, 12015.459304331325, 8708.782280442976, 11481.311121332663, 11801.527938882435, 11901.583444579399, 11910.702232444171, 40989.0, 41335.0, 41414.96462588429, 41430.96422589429, 41433.58566414328, 3469.9653003469894, 3558.839852206657, 3691.427828686558, 3973.562908080109, 4163.0, 30470.390592188254, 30624.846875765703, 30642.080737577908, 31183.84408077945, 33074.83462582696, 3313.784604000756, 3317.104381816896, 3341.8830340938193, 3361.09250502363, 3400.9149771255916, 534436.0, 536599.0, 536917.0, 537883.0, 538803.0, 59661.0, 60072.79854402975, 60358.094628580606, 60382.09426858601, 60565.69717151386, 63569.68215158987, 63776.36223637797, 63904.68047659732, 63945.68027159834, 63986.0, 16195.919020404823, 16779.748303775454, 16785.664286714196, 16790.24443900003, 16804.159792010596, 13100.868991309964, 13134.014948878872, 13159.210447373189, 13164.473421063241, 13166.0, 14158.221297828512, 14421.567352979428, 15813.920930395274, 15972.361105555648, 16183.271752770917, 7081.575105493687, 7134.429245660334, 7145.178304494945, 7181.163440440997, 7188.245234250328, 939.2486011191156, 945.924326053914, 996.5864166371019, 1032.5353590883983, 1041.3699711674328, 29297.41405171927, 30433.847830761148, 30719.846400767852, 31141.8442907784, 31446.685533144377, 1059.9788004240027, 1100.2958106811648, 1128.3230061962756, 1147.690123666622, 1153.135148638521, 14522.854771452361, 16028.919855400649, 16044.358225671076, 16513.944920189802, 16566.917165414336, 677160.0, 681630.0, 681672.0, 682430.0, 683144.0, 53095.203571946455, 60445.466590005046, 60885.391146088856, 61146.0, 65339.67330163414, 1377.6073818961547, 1377.8346598408054, 1409.2530958591963, 1409.6334952912111, 1412.173878281217, 30880.691193087783, 31512.36975260528, 31870.36259274755, 32331.51502727508, 32338.514922276656, 51516.48483515117, 51717.7414112927, 51915.96168076693, 52066.47933520768, 52138.73930630323, 630540.0, 634027.0, 634062.0, 634569.0, 635857.0, 25547.36131596725, 25927.22218333453, 25959.870200648875, 26784.464310713287, 40694.38958415685, 48583.75708121437, 48745.0, 49352.50647493479, 49768.50231497639, 49838.0, 39737.80131099326, 40557.59442405656, 40876.79561602173, 41860.0, 41957.370639439825, 40054.39918401168, 40570.68947574405, 40573.39139912845, 40881.38677919893, 41352.75941721753, 38558.42162367623, 39142.80428597839, 39334.80332598319, 39391.2121757569, 39481.40777888276, 33945.98162055142, 34555.0, 35137.47293790544, 35330.470042948866, 35362.0, 24570.75429245756, 25525.87237063803, 25639.359016024748, 25674.10140645143, 26307.342316442242], "value": 20621.142669978934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.0728125077925, 381.78047622617, 388.5609261534466, 390.28772490205364, 415.01848129174493, 15296.694066118685, 16594.585135371606, 20395.184192632314, 20965.999999999964, 20966.26618068366, 20807.27174548891, 21058.789412105874, 21113.94430278484, 21118.472038199052, 21124.788752112476, 5714.085746280596, 5832.912506312408, 5980.132880732292, 6100.969495152518, 6109.725062372182, 5557.416471270519, 5596.664200147984, 5638.548916086724, 5639.182318563806, 5658.745356458949, 5424.240606315099, 5590.86022849428, 5593.776248950037, 5913.733881975321, 5922.851928701795, 5901.085331773561, 5901.321348044987, 5910.231669882888, 5922.763089476416, 5949.613275137124, 5108.182690769496, 5169.974150129263, 5432.837014889559, 5437.429069947638, 5454.318210223722, 13201.27392993385, 13361.732765344736, 13456.865431345659, 23423.531529369488, 26278.343041424116, 1793.757842691246, 2127.106615221611, 2182.0835249195375, 2287.942801429961, 2338.041403024769, 9406.012368701324, 9409.482478463682, 9605.18355939746, 9831.31180817343, 9841.015898410173, 1673.1383337581156, 1688.7382455719383, 1689.3158270900183, 1762.286274059008, 1783.5006198264507, 104867.0, 127358.3632081843, 128195.0, 131299.99999999904, 131398.3430082853, 11257.04315133223, 11294.378809165575, 11298.265612735311, 11510.48202830858, 11832.76334473323, 14247.715045699028, 14344.0, 14363.281835908163, 14383.993120481675, 14388.568342949728, 8718.825623487495, 8745.606447709868, 8747.606357713918, 8784.868226976601, 8829.293656507463, 7174.820629484305, 8843.60203790831, 8867.246284065797, 8985.820283594423, 8989.685361012333, 4567.1550763108935, 4570.588647021784, 4590.059037897223, 4607.3319368691355, 4643.233866412072, 1898.240703718496, 1931.3723040012053, 1932.0919167991021, 1934.1973081171438, 1935.699966505194, 730.4959577891238, 772.9304362607393, 855.951350113952, 933.6965486217007, 994.8607194992707, 21280.467988300108, 21725.13099476003, 21750.0, 21767.129314827547, 21892.78107218939, 921.7972046149837, 954.4061417432904, 962.3552220012608, 968.3657204531044, 1065.5098654618807, 11064.723381915517, 11231.494582743797, 11346.375949322866, 11365.0, 11448.542058317575, 595906.0, 599161.0, 603924.0, 611845.0, 613345.0, 128351.0, 129273.0, 136024.0, 138876.0, 140680.0, 914.995425022884, 932.0353434195575, 997.152420442618, 1012.8025035118081, 1012.9544170512345, 14449.711005780036, 19322.32371866978, 19333.709994349814, 19367.12847921875, 19508.804911950698, 44976.77511612421, 56939.0, 58143.709281453324, 58709.70645146747, 59258.0, 85573.0, 86806.0, 87179.56410217908, 87497.45033755012, 88561.22877542542, 7829.960850195713, 8007.771633537402, 8024.506276484954, 8218.83562328762, 8293.21214484623, 9165.541722913695, 12127.757444850877, 13000.739985200433, 13083.215007099605, 13256.53602123921, 11206.103511719206, 11386.829197561878, 11391.0, 11440.599579014695, 11449.370284634426, 11094.223404361617, 11100.0, 11200.047995920439, 11314.60398886035, 11363.0, 11586.13104017219, 11614.30314181118, 11652.708682283012, 11839.526418943491, 11898.76202475963, 8071.394645401736, 8156.755297341089, 8160.5103693778565, 8249.463784853966, 8373.246407823082, 10885.183611229348, 11227.382493962583, 11716.648500544998, 11826.290422574673, 12092.39538023113], "value": 9504.696340457573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1410.1186758276078, 1549.7292220379286, 1582.6122599963007, 1806.8102849200834, 1955.1397385150533, 7743.845123097534, 8624.482531048134, 8829.735107946764, 8841.690540831072, 8912.598933048012, 8564.229219370256, 8776.64893404263, 8794.252488538483, 8795.868061979076, 8886.24466920311, 2365.645153227021, 2388.7850093491584, 2396.8681722505257, 2399.5800734871327, 2400.075970751265, 2362.8582285062953, 2381.476075263448, 2405.5549723301247, 2406.843555168917, 2410.517896420714, 2362.692849929507, 2384.523095380922, 2400.1839374612628, 2400.435897564071, 2400.759924007594, 2056.763472200686, 2267.4921177417, 2359.162497313455, 2363.633636786301, 2366.266457398212, 2273.3520946530325, 2349.6710460535537, 2354.3878591566317, 2357.846739961897, 2359.1035406545575, 7144.9642751785905, 7852.097008843999, 8851.822963540757, 8854.247388971946, 8930.910690893073, 5019.723915184663, 5333.066713325192, 5334.1732031535175, 5339.145736682112, 5362.785488580452, 3450.3099380123826, 3476.1657202271526, 3546.7871927684423, 3558.1104723819044, 3568.80371579563, 948.9134940493096, 1060.512164404375, 1077.7144056824948, 1080.3140006096107, 1088.7169335972703, 10719.410432426213, 11437.085033197323, 11690.88309116915, 11715.062794976468, 11770.882291177064, 4661.925443177821, 4700.9059818803435, 4873.829415970495, 4877.5366340197625, 4881.53625405593, 10197.898021019695, 10212.795744085077, 10216.182705383551, 10226.795464090677, 10260.43567603774, 5414.864628384322, 5415.918761218585, 5428.891422171534, 5438.864028399322, 5447.727613619303, 4822.831200907952, 4901.632377571696, 4937.0, 4960.47914968923, 4969.403671559436, 3200.407924533922, 3915.1778126593736, 3951.308521008812, 3988.4216788565495, 4019.437278780973, 1261.5584545409033, 1283.9743205135844, 1290.6128161551496, 1298.5455090718174, 1300.0769453687988, 931.9841372903568, 934.3739694404765, 944.4899754132829, 954.9236061115095, 1001.2890847498212, 5801.7389217485315, 5965.970170149209, 6031.517478601701, 6120.898238317146, 6170.444659980623, 436.6899501354074, 447.6955670144268, 456.915470637933, 458.0038416444287, 459.24912767625176, 3737.4020156775327, 3834.7123965702685, 3856.6914646828186, 3911.2959667259597, 3922.5292964844402, 10454.686359409077, 10732.785344293226, 10773.461326933779, 10875.129989600813, 10897.509612067475, 10836.458177091114, 10837.349759014485, 10837.945810271056, 10852.565897364175, 10869.945650271857, 7866.174051724601, 8299.626516806637, 8300.543470109082, 8316.293115085286, 8320.875186872201, 5312.920306195488, 5469.632591852037, 5711.514521265739, 5813.970930145322, 5970.402959703995, 9965.25260605472, 9997.300188986701, 10260.948695256477, 10271.640492582725, 10277.897221027994, 9922.255830812574, 10386.740331491774, 10432.165426765992, 10457.320274182153, 10462.895371046192, 7237.565746055254, 7451.180370159386, 7465.813354666177, 7466.656001919489, 7471.663775130023, 8147.714829980922, 8333.916660833314, 8340.082590915115, 8343.374246931626, 8353.791155221168, 7203.315685009916, 7551.811204719926, 7642.4650274480255, 7696.538207707556, 7734.99445072137, 7346.926530734838, 7435.330820226206, 7455.6644950978425, 7583.7724868254045, 7589.848203036019, 6940.930590694028, 7004.019437278683, 7007.264237255014, 7020.262872398529, 7029.191642961125, 4921.876953076202, 5055.9494405055475, 5060.3168572242275, 5135.768890400016, 5145.7941682333785, 5063.291139240583, 5126.974605079074, 5156.355455568054, 5187.19598462239, 5211.583073354198], "value": 4524.019867645876, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.67117841552704, 307.10785169083806, 317.5665216978823, 319.40431096005955, 321.20341552948685, 5315.3423288355825, 5624.128260119678, 5649.265595472588, 5728.367415286644, 5731.971340143294, 4319.330503771913, 4875.463698993108, 5460.907818436309, 5481.656994036457, 5507.339119305679, 3672.926541469169, 4221.029163292429, 4237.8304867805255, 4239.6396306313845, 4248.511421186557, 3487.0, 3504.964950350502, 3792.412176112693, 4064.0, 4114.083167804214, 3660.5540811379487, 4126.546079931205, 4170.541240463562, 4174.0, 4185.246655601991, 3271.689189526991, 4142.420061191436, 4178.8328466861285, 4201.109500724656, 4206.495220573551, 3646.5259516262718, 3671.0088276165284, 3673.2837096766143, 3680.411134218539, 3682.263547290526, 4684.859454216379, 5492.830332018831, 5535.280413546213, 5595.63628364155, 5670.234518340013, 4244.61798438139, 4499.0, 4766.475687674388, 4782.13921494131, 4809.350737650408, 4861.6353773467135, 5551.0, 5888.97055514724, 5909.852253693649, 5939.762409503614, 3221.2717592869403, 3912.139329347539, 3941.467901833273, 3956.3274243378696, 3968.2460332536725, 4598.724076555417, 5915.467607915265, 6028.819135425901, 6072.848178795522, 6105.603135796204, 3834.5206849143856, 3995.9400608990886, 4002.7198096133575, 4020.0, 4061.817218225187, 3543.379908516051, 3966.781826999543, 4078.776367089861, 4079.755214687069, 4098.200850834059, 3864.0, 4568.0, 4688.2030054890065, 4698.1778188816825, 4706.529347065266, 5888.263967004124, 5893.998020336553, 5894.498967587718, 5908.350081491032, 5950.434708702666, 1191.2852288626755, 1291.922484650924, 1357.124654597779, 1380.1925873363994, 1386.7711827548544, 827.8799574061727, 832.6003518311245, 841.7474757572826, 842.5281842168405, 843.696269343036, 3941.915973107361, 4077.918441631151, 4495.21333766596, 4514.638828893746, 4574.9020235143325, 4929.137400954819, 4991.276264941635, 5000.799968001312, 5083.187609293031, 5122.564582010496, 3934.6655534279334, 4126.277901367249, 4503.819847206075, 4532.886677833015, 4583.610393116555, 2244.7755224477423, 2308.6451819144713, 2374.833761636669, 2470.827042107035, 2664.8934042638466, 4258.552851950562, 4689.991651794812, 4802.0, 4981.455748717909, 5211.5049070338255, 4385.6052955233545, 4390.495093064274, 5049.2173713074535, 5123.333966584395, 5141.3830340358645, 4404.405405270311, 5450.672959622356, 6344.509040375416, 6355.30091689923, 6438.645874476949, 5310.99091172676, 6056.878862422815, 6100.847478813065, 6120.0, 6183.5671502994355, 5154.7938082477785, 5551.8896220755205, 6007.90988135187, 6094.360092190256, 6133.60131591463, 5959.344472107978, 6092.725827337869, 6118.847028824315, 6136.32500424944, 6182.7217775201125, 3979.263836190314, 3980.582038885991, 3980.8009599520487, 3996.760194388346, 4004.6395824375945, 6080.0, 6096.079734883498, 6098.725557349841, 6153.584675524744, 6163.845903852261, 5301.522862942354, 5519.834404967697, 5532.450913744158, 5642.210090587239, 5939.821805345847, 5821.155932389865, 5829.795957141479, 5891.528677705859, 5894.6736984178215, 5900.5512712223945, 5216.713080780593, 5402.432744561765, 5466.508014278734, 5737.311522617312, 5756.625819321731, 4766.237402015661, 5493.187248208162, 5845.824625261249, 5848.824535263949, 5888.205092312654, 5047.570956468594, 5199.818006369759, 5300.80731835334, 5454.154606036071, 5682.914756278742], "value": 4084.8271597336634, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.3037084398977, 799.6481548118827, 801.943863929525, 824.3899514359376, 828.2793969246757, 15267.847321526782, 16401.0, 16405.917970410163, 16408.0, 16423.917880410612, 14869.256537173153, 15024.248787560606, 15048.924755376234, 15090.54728358151, 15114.0, 711.1679335177841, 738.3797610007592, 892.7455675132588, 922.0, 930.6742640075987, 893.2809088683607, 904.2991681446898, 919.3886065766258, 919.3977944446399, 920.4431319051978, 937.6015193542751, 938.8403971324891, 939.0797018921461, 939.572494514994, 940.9576569054409, 748.7753673897836, 917.6879860847343, 919.6137622198659, 952.885653721551, 952.9094736000069, 702.8734827731006, 703.3634560722554, 703.6657587645878, 704.0635954180979, 705.0341032785066, 12759.234445933274, 15491.845081549152, 15527.534173974798, 15549.30028148736, 15554.922225388913, 14523.056001359877, 14643.707125857423, 14689.559313220621, 14724.33740481681, 14729.852701472955, 13197.670058248525, 13337.932965362748, 13468.326583670876, 13593.32033398336, 13843.723125537434, 4728.739919304437, 4768.856934291976, 4782.821854990077, 4793.688410253322, 4952.083864485082, 109065.0, 109679.0, 110353.79292414107, 110847.89152108456, 112227.0, 11500.0, 11558.595449159238, 11662.12534059932, 12068.0, 12178.634640960785, 23318.3004509865, 23328.416789580057, 23331.88334058319, 23332.950017248924, 23334.2999710009, 7975.609392767292, 7976.601169941479, 8013.439059265796, 8042.437029407885, 8111.8643389925455, 4409.581089796464, 4438.511763705989, 4455.465344158722, 4462.987483448724, 4628.699134556243, 3612.8735494257576, 3683.8710645127294, 3720.6837418819705, 3730.4404339349317, 3734.477173195755, 581.6481028977493, 690.3648643248123, 690.5131882023162, 694.2155364438153, 697.1703672629554, 560.1597603594608, 588.3792598808299, 619.9256089269317, 630.2405601250482, 652.1098700274092, 9080.954595226982, 9135.634574617074, 9246.352755307063, 9282.907170928203, 9358.625654973861, 556.3796367050709, 566.8101186102701, 634.6509419819081, 639.1052526462989, 672.5460314287836, 4568.177728008924, 4700.670953033323, 4722.905541889212, 4769.332293478916, 4800.135975524439, 144106.0, 146949.0, 148126.0, 151249.0, 151396.0, 129528.70471295355, 129890.0, 133069.0, 133087.0, 135117.0, 100593.0, 101251.98748012572, 113894.86105139174, 114295.0, 118252.8174718259, 9365.438073715326, 9369.531523423939, 9385.577649005947, 9485.193758530602, 9552.665656701982, 51190.97618047544, 55024.44975550193, 56053.719731401085, 56080.0, 56776.432235677115, 80744.5962770206, 86476.0, 87806.5609671973, 88235.55882220548, 90245.0975490263, 12083.516659333529, 12187.0, 12398.0, 12411.0, 12433.254004759743, 13299.401526931118, 13488.258145802076, 13545.203629792879, 13559.389827457591, 13699.315034248048, 12479.251244925334, 12513.749725005267, 12616.17994830333, 12970.0, 12983.805242921175, 12352.62942111738, 12508.499660013498, 12516.0, 12535.122541422377, 12560.874391256337, 12197.878021220029, 12289.569865055038, 12294.385280736105, 12310.446029928853, 12316.876831231573, 10518.316309439862, 10548.261621686408, 10594.788104237718, 10751.0, 10967.451627418757, 8804.119588041402, 10583.94708026455, 10786.676399708022, 10945.726356841144, 10989.670309890716], "value": 7886.904496982322, "unit": "score"}], "name": "dromaeo_css", "value": 7405.055519047181, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 114.0, 123.0, 163.0, 149.0, 114.0, 116.0, 160.0, 166.0, 113.0], "value": 131.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 107.0, 106.0, 157.0, 105.0, 108.0, 124.0, 107.0, 139.0, 105.0], "value": 119.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 185.0, 184.0, 183.0, 185.0, 182.0, 185.0, 183.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 72.0, 58.0, 107.0, 67.0, 77.0, 85.0, 92.0, 82.0, 57.0], "value": 77.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 89.0, 72.0, 69.0, 68.0, 96.0, 70.0, 68.0, 98.0], "value": 80.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 84.0, 86.0, 84.0, 87.0, 84.0, 87.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 92.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0], "value": 93.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 130.0, 88.0, 87.0, 91.0, 87.0, 88.0, 88.0, 88.0, 89.0], "value": 93.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 55.0, 54.0, 54.0, 55.0, 53.0, 53.0, 56.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 75.0, 77.0, 73.0, 74.0, 71.0, 69.0, 72.0, 69.0, 71.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 82.0, 82.0, 84.0, 83.0, 84.0, 86.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 163.0, 152.0, 155.0, 146.0, 142.0, 144.0, 176.0, 152.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 162.0, 168.0, 161.0, 165.0, 162.0, 164.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 63.0, 66.0, 66.0, 66.0, 65.0, 66.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1455.3000000000004, "alertThreshold": 2.0}]} 00:49:08 INFO - Return code: 0 00:49:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:49:08 INFO - # TBPL SUCCESS # 00:49:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:49:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:49:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:49:08 INFO - 2016-07-07 00:49:08.088 screenresolution[1669:9672] starting screenresolution argv=screenresolution get 00:49:08 INFO - 2016-07-07 00:49:08.091 screenresolution[1669:9672] Display 0: 1600x1200x32@60 00:49:08 INFO - 2016-07-07 00:49:08.097 screenresolution[1670:9675] starting screenresolution argv=screenresolution list 00:49:08 INFO - Available Modes on Display 0 00:49:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:49:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:49:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:49:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:49:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:49:08 INFO - Intel Iris: 00:49:08 INFO - Chipset Model: Intel Iris 00:49:08 INFO - Type: GPU 00:49:08 INFO - Bus: Built-In 00:49:08 INFO - VRAM (Dynamic, Max): 1536 MB 00:49:08 INFO - Vendor: Intel (0x8086) 00:49:08 INFO - Device ID: 0x0a2e 00:49:08 INFO - Revision ID: 0x0009 00:49:08 INFO - Displays: 00:49:08 INFO - Display: 00:49:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:49:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:49:08 INFO - Display Serial Number: 1600x1200 60 00:49:08 INFO - Main Display: Yes 00:49:08 INFO - Mirror: Off 00:49:08 INFO - Online: Yes 00:49:08 INFO - Rotation: Supported 00:49:08 INFO - Return code: 0 00:49:08 INFO - Running post-action listener: _resource_record_post_action 00:49:08 INFO - ##### 00:49:08 INFO - ##### Finished run-tests step (success) 00:49:08 INFO - ##### 00:49:08 INFO - Running post-run listener: _resource_record_post_run 00:49:08 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 36836864; Write bytes: 704507904; Read time: 387; Write time: 2049 00:49:08 INFO - TinderboxPrint: CPU usage
53.4% 00:49:08 INFO - TinderboxPrint: I/O read bytes / time
36,836,864 / 387 00:49:08 INFO - TinderboxPrint: I/O write bytes / time
704,507,904 / 2,049 00:49:08 INFO - TinderboxPrint: CPU idle
2,255.3 (46.6%) 00:49:08 INFO - TinderboxPrint: CPU system
962.7 (19.9%) 00:49:08 INFO - TinderboxPrint: CPU user
1,623.6 (33.5%) 00:49:08 INFO - TinderboxPrint: Swap in / out
443,293,696 / 0 00:49:08 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402614784; Write bytes: 396691456; Read time: 29647; Write time: 938 00:49:08 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 34739712; Write bytes: 293115904; Read time: 362; Write time: 1075 00:49:08 INFO - Running post-run listener: _upload_blobber_files 00:49:08 INFO - Blob upload gear active. 00:49:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:49:08 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 00:49:08 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:49:08 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:49:09 INFO - (blobuploader) - INFO - Open directory for files ... 00:49:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:49:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:49:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:10 INFO - (blobuploader) - INFO - Done attempting. 00:49:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:49:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:49:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:11 INFO - (blobuploader) - INFO - Done attempting. 00:49:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:49:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:49:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:49:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:49:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:49:13 INFO - (blobuploader) - INFO - Done attempting. 00:49:13 INFO - (blobuploader) - INFO - Iteration through files over. 00:49:13 INFO - Return code: 0 00:49:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:49:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:49:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1f963becd8fe09ba05db3aa268407c3f0a97b80ef268295e94d5295a48331e4b15dd0af40c9457f1281baeb34033206faab6e27f1bd5032dbe17acfbba32b88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/164996dda86692335de9f479acdb727cde9fe334688fdd0afca75e54ba8a6ae4444ba9074b99bbb903ba548852f2b9aa17b68adcfcaf037083794dd94756a376", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46f31efe11b2f907811715916220e91549fc321ed31f4b57eefbceb7e92001d11181a737b53b89cf7d2bafab572e36531d5b5beecce57f495cea866eb08c8ba3"} 00:49:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:49:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:49:13 INFO - Contents: 00:49:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1f963becd8fe09ba05db3aa268407c3f0a97b80ef268295e94d5295a48331e4b15dd0af40c9457f1281baeb34033206faab6e27f1bd5032dbe17acfbba32b88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/164996dda86692335de9f479acdb727cde9fe334688fdd0afca75e54ba8a6ae4444ba9074b99bbb903ba548852f2b9aa17b68adcfcaf037083794dd94756a376", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46f31efe11b2f907811715916220e91549fc321ed31f4b57eefbceb7e92001d11181a737b53b89cf7d2bafab572e36531d5b5beecce57f495cea866eb08c8ba3"} 00:49:13 INFO - Running post-run listener: copy_logs_to_upload_dir 00:49:13 INFO - Copying logs to upload dir... 00:49:13 INFO - mkdir: /builds/slave/test/build/upload/logs 00:49:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.310291 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 00:49:13.972923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:49:13.976160) ========= 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.FM5Plj4AsL/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.doMothqd5P/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1f963becd8fe09ba05db3aa268407c3f0a97b80ef268295e94d5295a48331e4b15dd0af40c9457f1281baeb34033206faab6e27f1bd5032dbe17acfbba32b88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/164996dda86692335de9f479acdb727cde9fe334688fdd0afca75e54ba8a6ae4444ba9074b99bbb903ba548852f2b9aa17b68adcfcaf037083794dd94756a376", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46f31efe11b2f907811715916220e91549fc321ed31f4b57eefbceb7e92001d11181a737b53b89cf7d2bafab572e36531d5b5beecce57f495cea866eb08c8ba3"} build_url:https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010852 build_url: 'https://queue.taskcluster.net/v1/task/bqqqRQpaSmq3ksE3EPlnbw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1f963becd8fe09ba05db3aa268407c3f0a97b80ef268295e94d5295a48331e4b15dd0af40c9457f1281baeb34033206faab6e27f1bd5032dbe17acfbba32b88", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/164996dda86692335de9f479acdb727cde9fe334688fdd0afca75e54ba8a6ae4444ba9074b99bbb903ba548852f2b9aa17b68adcfcaf037083794dd94756a376", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46f31efe11b2f907811715916220e91549fc321ed31f4b57eefbceb7e92001d11181a737b53b89cf7d2bafab572e36531d5b5beecce57f495cea866eb08c8ba3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:49:14.007822) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:49:14.008130) ========= 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.FM5Plj4AsL/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.doMothqd5P/Listeners TMPDIR=/var/folders/hr/szhjjxc16kx9yf5ff1qqhnn400000w/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.004998 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:49:14.056363) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:49:14.056683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:49:14.057002) ========= ========= Total master_lag: 0.17 =========