builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0300 starttime: 1468522147.59 results: success (0) buildid: 20160714100842 builduid: 8a87eb819479419b894911b49723b5fb revision: 62265fa9b7d384891a8730bf5e09e33c951af0bb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.593365) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.593826) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.594102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.619226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.619624) ========= 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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-14 11:49: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% 31.0M=0s 2016-07-14 11:49:07 (31.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124699 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.767354) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:07.767758) ========= 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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.025068 ========= master_lag: 0.27 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:08.065507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 11:49:08.065819) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62265fa9b7d384891a8730bf5e09e33c951af0bb --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 62265fa9b7d384891a8730bf5e09e33c951af0bb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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-14 11:49:08,152 truncating revision to first 12 chars 2016-07-14 11:49:08,152 Setting DEBUG logging. 2016-07-14 11:49:08,152 attempt 1/10 2016-07-14 11:49:08,152 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62265fa9b7d3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 11:49:09,214 unpacking tar archive at: fx-team-62265fa9b7d3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.330566 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 11:49:09.419241) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:09.419619) ========= script_repo_revision: 62265fa9b7d384891a8730bf5e09e33c951af0bb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:09.420099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:09.420365) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 11:49:09.438954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-14 11:49:09.439258) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:09 INFO - MultiFileLogger online at 20160714 11:49:09 in /builds/slave/test 11:49:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:49:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:09 INFO - {'append_to_log': False, 11:49:09 INFO - 'base_work_dir': '/builds/slave/test', 11:49:09 INFO - 'blob_upload_branch': 'Fx-Team', 11:49:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:09 INFO - 'branch': 'Fx-Team', 11:49:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:09 INFO - 'config_files': ('talos/mac_config.py',), 11:49:09 INFO - 'default_actions': ('clobber', 11:49:09 INFO - 'read-buildbot-config', 11:49:09 INFO - 'download-and-extract', 11:49:09 INFO - 'populate-webroot', 11:49:09 INFO - 'create-virtualenv', 11:49:09 INFO - 'install', 11:49:09 INFO - 'run-tests'), 11:49:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:09 INFO - 'download_minidump_stackwalk': True, 11:49:09 INFO - 'download_symbols': 'ondemand', 11:49:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:09 INFO - 'installer_path': 'installer.exe', 11:49:09 INFO - 'log_level': 'info', 11:49:09 INFO - 'log_name': 'talos', 11:49:09 INFO - 'log_to_console': True, 11:49:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:49:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:49:09 INFO - 'opt_config_files': (), 11:49:09 INFO - 'pip_index': False, 11:49:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:09 INFO - 'cmd': ('bash', 11:49:09 INFO - '-c', 11:49:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:09 INFO - 'enabled': True, 11:49:09 INFO - 'halt_on_failure': False, 11:49:09 INFO - 'name': 'check_screen_resolution'},), 11:49:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:49:09 INFO - 'cmd': ('bash', 11:49:09 INFO - '-c', 11:49:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:49:09 INFO - 'enabled': True, 11:49:09 INFO - 'halt_on_failure': False, 11:49:09 INFO - 'name': 'check_screen_resolution'},), 11:49:09 INFO - 'run_cmd_checks_enabled': True, 11:49:09 INFO - 'sps_profile': False, 11:49:09 INFO - 'sps_profile_interval': 0, 11:49:09 INFO - 'suite': 'dromaeojs-e10s', 11:49:09 INFO - 'system_bits': '32', 11:49:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:09 INFO - 'title': 't-yosemite-r7-0300', 11:49:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:09 INFO - 'use_talos_json': True, 11:49:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:09 INFO - 'work_dir': 'build'} 11:49:09 INFO - ##### 11:49:09 INFO - ##### Running clobber step. 11:49:09 INFO - ##### 11:49:09 INFO - Running pre-action listener: _resource_record_pre_action 11:49:09 INFO - Running main action method: clobber 11:49:09 INFO - rmtree: /builds/slave/test/build 11:49:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:11 INFO - Running post-action listener: _resource_record_post_action 11:49:11 INFO - ##### 11:49:11 INFO - ##### Finished clobber step (success) 11:49:11 INFO - ##### 11:49:11 INFO - ##### 11:49:11 INFO - ##### Running read-buildbot-config step. 11:49:11 INFO - ##### 11:49:11 INFO - Running pre-action listener: _resource_record_pre_action 11:49:11 INFO - Running main action method: read_buildbot_config 11:49:11 INFO - Using buildbot properties: 11:49:11 INFO - { 11:49:11 INFO - "project": "", 11:49:11 INFO - "product": "firefox", 11:49:11 INFO - "script_repo_revision": "production", 11:49:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:49:11 INFO - "repository": "", 11:49:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:49:11 INFO - "buildid": "20160714100842", 11:49:11 INFO - "pgo_build": "False", 11:49:11 INFO - "basedir": "/builds/slave/test", 11:49:11 INFO - "buildnumber": 52, 11:49:11 INFO - "slavename": "t-yosemite-r7-0300", 11:49:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 11:49:11 INFO - "platform": "yosemite_r7", 11:49:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:49:11 INFO - "branch": "fx-team", 11:49:11 INFO - "repo_path": "integration/fx-team", 11:49:11 INFO - "revision": "62265fa9b7d384891a8730bf5e09e33c951af0bb", 11:49:11 INFO - "stage_platform": "macosx64", 11:49:11 INFO - "builduid": "8a87eb819479419b894911b49723b5fb", 11:49:11 INFO - "slavebuilddir": "test" 11:49:11 INFO - } 11:49:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 11:49:11 INFO - Running post-action listener: _resource_record_post_action 11:49:11 INFO - ##### 11:49:11 INFO - ##### Finished read-buildbot-config step (success) 11:49:11 INFO - ##### 11:49:11 INFO - ##### 11:49:11 INFO - ##### Running download-and-extract step. 11:49:11 INFO - ##### 11:49:11 INFO - Running pre-action listener: _resource_record_pre_action 11:49:11 INFO - Running main action method: download_and_extract 11:49:11 INFO - mkdir: /builds/slave/test/build/tests 11:49: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')]} 11:49:11 INFO - https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 11:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:12 INFO - Downloaded 1199 bytes. 11:49:12 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 11:49:12 INFO - Using the following test package requirements: 11:49:12 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:49:12 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 11:49:12 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 11:49:12 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'jsshell-mac.zip'], 11:49:12 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 11:49:12 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 11:49:12 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 11:49:12 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 11:49:12 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 11:49:12 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 11:49:12 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 11:49:12 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:12 INFO - https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:49:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:49:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:16 INFO - Downloaded 18827981 bytes. 11:49:16 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'] 11:49:16 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 11:49:19 INFO - Return code: 0 11:49:19 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 11:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:19 INFO - https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:49:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:49:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 11:49:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:20 INFO - Downloaded 18827981 bytes. 11:49:20 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'] 11:49:20 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 11:49:24 INFO - Return code: 0 11:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:24 INFO - https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:49:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:49:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 11:49:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:25 INFO - Downloaded 14403317 bytes. 11:49:25 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'] 11:49:25 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 11:49:25 INFO - Return code: 0 11:49:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:25 INFO - https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:49:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:49:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:49:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 11:49:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fMEMX79cRLqfOZs0hx7K6w/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 11:49:29 INFO - Downloaded 112740731 bytes. 11:49:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:49:29 INFO - mkdir: /builds/slave/test/properties 11:49:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:29 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:29 INFO - Contents: 11:49:29 INFO - build_url:https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 11:49:30 INFO - Running post-action listener: _resource_record_post_action 11:49:30 INFO - Running post-action listener: set_extra_try_arguments 11:49:30 INFO - ##### 11:49:30 INFO - ##### Finished download-and-extract step (success) 11:49:30 INFO - ##### 11:49:30 INFO - ##### 11:49:30 INFO - ##### Running populate-webroot step. 11:49:30 INFO - ##### 11:49:30 INFO - Running pre-action listener: _resource_record_pre_action 11:49:30 INFO - Running main action method: populate_webroot 11:49:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:30 INFO - '--tppagecycles', 11:49:30 INFO - '7'], 11:49:30 INFO - 'tests': ['tsvgm']}}, 11:49:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['damp', 'tps']}, 11:49:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'tests': ['damp', 'tps']}, 11:49:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['dromaeo_dom']}, 11:49:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['basic_compositor_video']}, 11:49:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['a11yr', 11:49:30 INFO - 'ts_paint', 11:49:30 INFO - 'tpaint', 11:49:30 INFO - 'sessionrestore', 11:49:30 INFO - 'sessionrestore_no_auto_restore', 11:49:30 INFO - 'tabpaint']}, 11:49:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tsvgx', 11:49:30 INFO - 'tsvgr_opacity', 11:49:30 INFO - 'tart', 11:49:30 INFO - 'tscrollx', 11:49:30 INFO - 'cart']}, 11:49:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:30 INFO - 'tsvgr_opacity', 11:49:30 INFO - 'tart', 11:49:30 INFO - 'tscrollx', 11:49:30 INFO - 'cart']}, 11:49:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s'], 11:49:30 INFO - 'tests': ['tp5o']}, 11:49:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'tests': ['tp5o']}, 11:49:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'talos_options': ['--disable-e10s', 11:49:30 INFO - '--xperf_path', 11:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:30 INFO - 'tests': ['tp5n']}, 11:49:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:49:30 INFO - 'talos_options': ['--xperf_path', 11:49:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:30 INFO - 'tests': ['tp5n']}}, 11:49:30 INFO - 'talos.zip': {'path': '', 11:49:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:30 INFO - Running post-action listener: _resource_record_post_action 11:49:30 INFO - ##### 11:49:30 INFO - ##### Finished populate-webroot step (success) 11:49:30 INFO - ##### 11:49:30 INFO - ##### 11:49:30 INFO - ##### Running create-virtualenv step. 11:49:30 INFO - ##### 11:49:30 INFO - Running pre-action listener: _resource_record_pre_action 11:49:30 INFO - Running main action method: create_virtualenv 11:49:30 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:30 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 11:49:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:30 INFO - Using real prefix '/tools/python27' 11:49:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:30 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:33 INFO - Installing pip.................done. 11:49:33 INFO - Return code: 0 11:49:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:33 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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:33 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 11:49:33 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 11:49:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:33 INFO - 'HOME': '/Users/cltbld', 11:49:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:33 INFO - 'LOGNAME': 'cltbld', 11:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:33 INFO - 'MOZ_NO_REMOTE': '1', 11:49:33 INFO - 'NO_EM_RESTART': '1', 11:49:33 INFO - 'PAGER': '/bin/cat', 11:49:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:33 INFO - 'PWD': '/builds/slave/test', 11:49:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:33 INFO - 'SHELL': '/bin/bash', 11:49:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:33 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:33 INFO - 'USER': 'cltbld', 11:49:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:33 INFO - 'XPC_FLAGS': '0x0', 11:49:33 INFO - 'XPC_SERVICE_NAME': '0', 11:49:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:34 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 11:49:34 INFO - Cleaning up... 11:49:34 INFO - Return code: 0 11:49:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:49:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:34 INFO - 'HOME': '/Users/cltbld', 11:49:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:34 INFO - 'LOGNAME': 'cltbld', 11:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:34 INFO - 'MOZ_NO_REMOTE': '1', 11:49:34 INFO - 'NO_EM_RESTART': '1', 11:49:34 INFO - 'PAGER': '/bin/cat', 11:49:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:34 INFO - 'PWD': '/builds/slave/test', 11:49:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:34 INFO - 'SHELL': '/bin/bash', 11:49:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:34 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:34 INFO - 'USER': 'cltbld', 11:49:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:34 INFO - 'XPC_FLAGS': '0x0', 11:49:34 INFO - 'XPC_SERVICE_NAME': '0', 11:49:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:34 INFO - Downloading/unpacking psutil>=3.1.1 11:49:34 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 11:49:34 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 11:49:34 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 11:49:34 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 11:49:34 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 11:49:34 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 11:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:37 INFO - Installing collected packages: psutil 11:49:37 INFO - Running setup.py install for psutil 11:49:37 INFO - building 'psutil._psutil_osx' extension 11:49:37 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 11:49:37 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 11:49:38 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 11:49:38 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 11:49:38 INFO - building 'psutil._psutil_posix' extension 11:49:38 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 11:49:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:49:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:49:38 INFO - ^ 11:49:38 INFO - 1 warning generated. 11:49:38 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 11:49:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:38 INFO - Successfully installed psutil 11:49:38 INFO - Cleaning up... 11:49:38 INFO - Return code: 0 11:49:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:49: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')]} 11:49:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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')]} 11:49:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:49: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 mozsystemmonitor==0.3 11:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:38 INFO - 'HOME': '/Users/cltbld', 11:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:38 INFO - 'LOGNAME': 'cltbld', 11:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:38 INFO - 'MOZ_NO_REMOTE': '1', 11:49:38 INFO - 'NO_EM_RESTART': '1', 11:49:38 INFO - 'PAGER': '/bin/cat', 11:49:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:38 INFO - 'PWD': '/builds/slave/test', 11:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:38 INFO - 'SHELL': '/bin/bash', 11:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:38 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:38 INFO - 'USER': 'cltbld', 11:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:38 INFO - 'XPC_FLAGS': '0x0', 11:49:38 INFO - 'XPC_SERVICE_NAME': '0', 11:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:49:38 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 11:49:38 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 11:49:38 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 11:49:38 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 11:49:38 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 11:49:38 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 11:49:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:49:41 INFO - Installing collected packages: mozsystemmonitor 11:49:41 INFO - Running setup.py install for mozsystemmonitor 11:49:41 INFO - Successfully installed mozsystemmonitor 11:49:41 INFO - Cleaning up... 11:49:41 INFO - Return code: 0 11:49:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:41 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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:41 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 11:49:41 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 11:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:41 INFO - 'HOME': '/Users/cltbld', 11:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:41 INFO - 'LOGNAME': 'cltbld', 11:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:41 INFO - 'MOZ_NO_REMOTE': '1', 11:49:41 INFO - 'NO_EM_RESTART': '1', 11:49:41 INFO - 'PAGER': '/bin/cat', 11:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:41 INFO - 'PWD': '/builds/slave/test', 11:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:41 INFO - 'SHELL': '/bin/bash', 11:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:41 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:41 INFO - 'USER': 'cltbld', 11:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:41 INFO - 'XPC_FLAGS': '0x0', 11:49:41 INFO - 'XPC_SERVICE_NAME': '0', 11:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:41 INFO - Downloading/unpacking jsonschema==2.5.1 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:49:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:44 INFO - Downloading functools32-3.2.3-2.tar.gz 11:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:49:44 INFO - warning: no files found matching '*.txt' 11:49:44 INFO - no previously-included directories found matching 'build' 11:49:44 INFO - no previously-included directories found matching 'dist' 11:49:44 INFO - no previously-included directories found matching '.git*' 11:49:44 INFO - Installing collected packages: jsonschema, functools32 11:49:44 INFO - Running setup.py install for functools32 11:49:44 INFO - warning: no files found matching '*.txt' 11:49:45 INFO - no previously-included directories found matching 'build' 11:49:45 INFO - no previously-included directories found matching 'dist' 11:49:45 INFO - no previously-included directories found matching '.git*' 11:49:45 INFO - Successfully installed jsonschema functools32 11:49:45 INFO - Cleaning up... 11:49:45 INFO - Return code: 0 11:49:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:49:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:45 INFO - 'HOME': '/Users/cltbld', 11:49:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:45 INFO - 'LOGNAME': 'cltbld', 11:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:45 INFO - 'MOZ_NO_REMOTE': '1', 11:49:45 INFO - 'NO_EM_RESTART': '1', 11:49:45 INFO - 'PAGER': '/bin/cat', 11:49:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:45 INFO - 'PWD': '/builds/slave/test', 11:49:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:45 INFO - 'SHELL': '/bin/bash', 11:49:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:45 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:45 INFO - 'USER': 'cltbld', 11:49:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:45 INFO - 'XPC_FLAGS': '0x0', 11:49:45 INFO - 'XPC_SERVICE_NAME': '0', 11:49:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:45 INFO - Downloading/unpacking blobuploader==1.2.4 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49: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 11:49:47 INFO - Downloading blobuploader-1.2.4.tar.gz 11:49:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:49:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:47 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 11:49:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:49:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:48 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 11:49:49 INFO - Downloading docopt-0.6.1.tar.gz 11:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:49:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:49:49 INFO - Running setup.py install for blobuploader 11:49:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:49:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:49:49 INFO - Running setup.py install for requests 11:49:49 INFO - Running setup.py install for docopt 11:49:49 INFO - Successfully installed blobuploader requests docopt 11:49:49 INFO - Cleaning up... 11:49:50 INFO - Return code: 0 11:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:50 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')]} 11:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 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')]} 11:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:50 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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:50 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 11:49:50 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 11:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:50 INFO - 'HOME': '/Users/cltbld', 11:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:50 INFO - 'LOGNAME': 'cltbld', 11:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:50 INFO - 'MOZ_NO_REMOTE': '1', 11:49:50 INFO - 'NO_EM_RESTART': '1', 11:49:50 INFO - 'PAGER': '/bin/cat', 11:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:50 INFO - 'PWD': '/builds/slave/test', 11:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:50 INFO - 'SHELL': '/bin/bash', 11:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:50 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:50 INFO - 'USER': 'cltbld', 11:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:50 INFO - 'XPC_FLAGS': '0x0', 11:49:50 INFO - 'XPC_SERVICE_NAME': '0', 11:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-weYYid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-2D9Rm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-taaoQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-qW96ES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-xw9o3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-NSSfxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:50 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-HeS8vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-Gu4YBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-G4xiEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-rhxVyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-qqNHXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-PT3fT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-td0WNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-mENLvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-r1IwzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-vLlI9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:51 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-l8dxKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:49:52 INFO - Running setup.py install for manifestparser 11:49:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Running setup.py install for mozcrash 11:49:52 INFO - Running setup.py install for mozdebug 11:49:52 INFO - Running setup.py install for mozdevice 11:49:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Running setup.py install for mozfile 11:49:52 INFO - Running setup.py install for mozhttpd 11:49:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:49:52 INFO - Running setup.py install for mozinfo 11:49:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Running setup.py install for mozInstall 11:49:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Running setup.py install for mozleak 11:49:53 INFO - Running setup.py install for mozlog 11:49:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Running setup.py install for moznetwork 11:49:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:49:53 INFO - Running setup.py install for mozprocess 11:49:53 INFO - Running setup.py install for mozprofile 11:49:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Running setup.py install for mozrunner 11:49:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Running setup.py install for mozscreenshot 11:49:54 INFO - Running setup.py install for moztest 11:49:54 INFO - Running setup.py install for mozversion 11:49:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:49:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:49:54 INFO - Cleaning up... 11:49:54 INFO - Return code: 0 11:49:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:54 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')]} 11:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 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')]} 11:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:54 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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:54 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 11:49:54 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 11:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:54 INFO - 'HOME': '/Users/cltbld', 11:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:54 INFO - 'LOGNAME': 'cltbld', 11:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:54 INFO - 'MOZ_NO_REMOTE': '1', 11:49:54 INFO - 'NO_EM_RESTART': '1', 11:49:54 INFO - 'PAGER': '/bin/cat', 11:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:54 INFO - 'PWD': '/builds/slave/test', 11:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:54 INFO - 'SHELL': '/bin/bash', 11:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:54 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:54 INFO - 'USER': 'cltbld', 11:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:54 INFO - 'XPC_FLAGS': '0x0', 11:49:54 INFO - 'XPC_SERVICE_NAME': '0', 11:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:49:54 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-u1yI1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ag9sX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-6s7km2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-aqi9e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-ctoa2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-TPGuZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-3QXk0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-12vQ1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-8A9W0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:49:55 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)) 11:49:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:49:55 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-dv5Rq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-dJ83re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-J7TA8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-bCn4oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-bK8awV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-g5a3ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-lWmJsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:49:56 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)) 11:49:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:49:56 INFO - Running setup.py (path:/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/pip-O5lUph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:49:56 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)) 11:49:56 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)) 11:49:56 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)) 11:49:56 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)) 11:49:56 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)) 11:49:56 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)) 11:49:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:59 INFO - Downloading blessings-1.6.tar.gz 11:49:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:49:59 INFO - Installing collected packages: blessings 11:49:59 INFO - Running setup.py install for blessings 11:49:59 INFO - Successfully installed blessings 11:49:59 INFO - Cleaning up... 11:49:59 INFO - Return code: 0 11:49:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:49:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:49:59 INFO - Reading from file tmpfile_stdout 11:49:59 INFO - Current package versions: 11:49:59 INFO - blessings == 1.6 11:49:59 INFO - blobuploader == 1.2.4 11:49:59 INFO - docopt == 0.6.1 11:49:59 INFO - functools32 == 3.2.3-2 11:49:59 INFO - jsonschema == 2.5.1 11:49:59 INFO - manifestparser == 1.1 11:49:59 INFO - mozInstall == 1.12 11:49:59 INFO - mozcrash == 0.17 11:49:59 INFO - mozdebug == 0.1 11:49:59 INFO - mozdevice == 0.48 11:49:59 INFO - mozfile == 1.2 11:49:59 INFO - mozhttpd == 0.7 11:49:59 INFO - mozinfo == 0.9 11:49:59 INFO - mozleak == 0.1 11:49:59 INFO - mozlog == 3.2 11:49:59 INFO - moznetwork == 0.27 11:49:59 INFO - mozprocess == 0.23 11:49:59 INFO - mozprofile == 0.28 11:49:59 INFO - mozrunner == 6.12 11:49:59 INFO - mozscreenshot == 0.1 11:49:59 INFO - mozsystemmonitor == 0.3 11:49:59 INFO - moztest == 0.7 11:49:59 INFO - mozversion == 1.4 11:49:59 INFO - psutil == 3.1.1 11:49:59 INFO - requests == 1.2.3 11:49:59 INFO - wsgiref == 0.1.2 11:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:49:59 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 11:49:59 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 11:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:49:59 INFO - 'HOME': '/Users/cltbld', 11:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:49:59 INFO - 'LOGNAME': 'cltbld', 11:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:59 INFO - 'MOZ_NO_REMOTE': '1', 11:49:59 INFO - 'NO_EM_RESTART': '1', 11:49:59 INFO - 'PAGER': '/bin/cat', 11:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:59 INFO - 'PWD': '/builds/slave/test', 11:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:49:59 INFO - 'SHELL': '/bin/bash', 11:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:49:59 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:49:59 INFO - 'USER': 'cltbld', 11:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:59 INFO - 'XPC_FLAGS': '0x0', 11:49:59 INFO - 'XPC_SERVICE_NAME': '0', 11:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 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)) 11:50:00 INFO - Cleaning up... 11:50:00 INFO - Return code: 0 11:50:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50:00 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')]} 11:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 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')]} 11:50:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:00 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 0x10f4d2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f567618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8cc84a1dc0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, '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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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 11:50:00 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 11:50:00 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 11:50:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:50:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:00 INFO - 'HOME': '/Users/cltbld', 11:50:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:00 INFO - 'LOGNAME': 'cltbld', 11:50:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:00 INFO - 'MOZ_NO_REMOTE': '1', 11:50:00 INFO - 'NO_EM_RESTART': '1', 11:50:00 INFO - 'PAGER': '/bin/cat', 11:50:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:00 INFO - 'PWD': '/builds/slave/test', 11:50:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:00 INFO - 'SHELL': '/bin/bash', 11:50:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:50:00 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:50:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:00 INFO - 'USER': 'cltbld', 11:50:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:00 INFO - 'XPC_FLAGS': '0x0', 11:50:00 INFO - 'XPC_SERVICE_NAME': '0', 11:50:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:50:00 INFO - Cleaning up... 11:50:00 INFO - Return code: 0 11:50:00 INFO - Running post-action listener: _resource_record_post_action 11:50:00 INFO - Running post-action listener: _start_resource_monitoring 11:50:00 INFO - Starting resource monitoring. 11:50:00 INFO - ##### 11:50:00 INFO - ##### Finished create-virtualenv step (success) 11:50:00 INFO - ##### 11:50:00 INFO - ##### 11:50:00 INFO - ##### Running install step. 11:50:00 INFO - ##### 11:50:00 INFO - Running pre-action listener: _resource_record_pre_action 11:50:00 INFO - Running main action method: install 11:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:00 INFO - Reading from file tmpfile_stdout 11:50:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:00 INFO - Reading from file tmpfile_stdout 11:50:00 INFO - Output received: 11:50:00 INFO - Usage: mozinstall [options] installer 11:50:00 INFO - Options: 11:50:00 INFO - -h, --help show this help message and exit 11:50:00 INFO - -d DEST, --destination=DEST 11:50:00 INFO - Directory to install application into. [default: 11:50:00 INFO - "/builds/slave/test"] 11:50:00 INFO - --app=APP Application being installed. [default: firefox] 11:50:00 INFO - mkdir: /builds/slave/test/build/application 11:50:00 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'] 11:50:00 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 11:50:35 INFO - Reading from file tmpfile_stdout 11:50:35 INFO - Output received: 11:50:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:50:35 INFO - Running post-action listener: _resource_record_post_action 11:50:35 INFO - ##### 11:50:35 INFO - ##### Finished install step (success) 11:50:35 INFO - ##### 11:50:35 INFO - ##### 11:50:35 INFO - ##### Running run-tests step. 11:50:35 INFO - ##### 11:50:35 INFO - Running pre-action listener: _resource_record_pre_action 11:50:35 INFO - Running main action method: run_tests 11:50:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:50:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:50:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:50:35 INFO - 2016-07-14 11:50:35.507 screenresolution[1641:7567] starting screenresolution argv=screenresolution get 11:50:35 INFO - 2016-07-14 11:50:35.510 screenresolution[1641:7567] Display 0: 1600x1200x32@60 11:50:35 INFO - 2016-07-14 11:50:35.515 screenresolution[1642:7569] starting screenresolution argv=screenresolution list 11:50:35 INFO - Available Modes on Display 0 11:50:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:50:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:50:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:50:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:50:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:50:35 INFO - Intel Iris: 11:50:35 INFO - Chipset Model: Intel Iris 11:50:35 INFO - Type: GPU 11:50:35 INFO - Bus: Built-In 11:50:35 INFO - VRAM (Dynamic, Max): 1536 MB 11:50:35 INFO - Vendor: Intel (0x8086) 11:50:35 INFO - Device ID: 0x0a2e 11:50:35 INFO - Revision ID: 0x0009 11:50:35 INFO - Displays: 11:50:35 INFO - Display: 11:50:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:50:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:50:35 INFO - Display Serial Number: 1600x1200 60 11:50:35 INFO - Main Display: Yes 11:50:35 INFO - Mirror: Off 11:50:35 INFO - Online: Yes 11:50:35 INFO - Rotation: Supported 11:50:35 INFO - Return code: 0 11:50:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:35 INFO - Python 2.7.3 11:50:35 INFO - Return code: 0 11:50:35 INFO - grabbing minidump binary from tooltool 11:50: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')]} 11:50:35 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 0x10f436d30>, '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 0x10f19bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f42eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:35 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 11:50:35 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 11:50:35 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 11:50:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:35 INFO - Return code: 0 11:50:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:50:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:50:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:35 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:50:35 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0300 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:50:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3hgBW8HyrW/Render', 11:50:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:50:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:50:35 INFO - 'HOME': '/Users/cltbld', 11:50:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:50:35 INFO - 'LOGNAME': 'cltbld', 11:50:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:50:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:35 INFO - 'MOZ_NO_REMOTE': '1', 11:50:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:35 INFO - 'NO_EM_RESTART': '1', 11:50:35 INFO - 'PAGER': '/bin/cat', 11:50:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:50:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:35 INFO - 'PWD': '/builds/slave/test', 11:50:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:50:35 INFO - 'SHELL': '/bin/bash', 11:50:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gDrxNhyJ6v/Listeners', 11:50:35 INFO - 'TMPDIR': '/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/', 11:50:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:50:35 INFO - 'USER': 'cltbld', 11:50:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:50:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:50:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:35 INFO - 'XPC_FLAGS': '0x0', 11:50:35 INFO - 'XPC_SERVICE_NAME': '0', 11:50:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:50:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0300', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:50:36 INFO - mozversion application_buildid: 20160714100842 11:50:36 INFO - mozversion application_changeset: 62265fa9b7d384891a8730bf5e09e33c951af0bb 11:50:36 INFO - mozversion application_display_name: Nightly 11:50:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:36 INFO - mozversion application_name: Firefox 11:50:36 INFO - mozversion application_remotingname: firefox 11:50:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:50:36 INFO - mozversion application_vendor: Mozilla 11:50:36 INFO - mozversion application_version: 50.0a1 11:50:36 INFO - mozversion platform_buildid: 20160714100842 11:50:36 INFO - mozversion platform_changeset: 62265fa9b7d384891a8730bf5e09e33c951af0bb 11:50:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:50:36 INFO - mozversion platform_version: 50.0a1 11:50:36 INFO - using testdate: 1468522236 11:50:36 INFO - actual date: 1468522236 11:50:36 INFO - starting webserver on 'localhost:49271' 11:50:36 INFO - SUITE-START | Running 2 tests 11:50:36 INFO - TEST-START | dromaeo_css 11:50:36 INFO - operating with platform_type : mac_ 11:50:36 INFO - Initialising browser for dromaeo_css test... 11:50:36 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpMS7zaJ/profile http://localhost:49271/getInfo.html) 11:50:39 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 11:50:39 INFO - PROCESS | 1652 | colorDepth:24 11:50:39 INFO - PROCESS | 1652 | Browser inner width/height: 1024/663 11:50:39 INFO - PROCESS | 1652 | __metrics 11:50:39 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 11:50:40 INFO - TEST-INFO | 1652: exit 0 11:50:40 INFO - Browser initialized. 11:50:40 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:40 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmpMS7zaJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:52 INFO - PROCESS | 1655 | RSS: Main: 269864960 11:50:52 INFO - PROCESS | 1655 | 11:51:41 INFO - PROCESS | 1655 | 1468522301656 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] 11:53:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 11:53:53 INFO - PROCESS | 1655 | RSS: Main: 282370048 11:53:53 INFO - PROCESS | 1655 | 11:56:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 11:56:56 INFO - PROCESS | 1655 | RSS: Main: 290734080 11:56:56 INFO - PROCESS | 1655 | 11:59:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 11:59:58 INFO - PROCESS | 1655 | RSS: Main: 295247872 11:59:58 INFO - PROCESS | 1655 | 12:03:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 12:03:01 INFO - PROCESS | 1655 | RSS: Main: 294166528 12:03:01 INFO - PROCESS | 1655 | 12:06:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 12:06:04 INFO - PROCESS | 1655 | RSS: Main: 297844736 12:06:04 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 12:09:07 INFO - PROCESS | 1655 | RSS: Main: 298000384 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | __start_tp_report 12:09:07 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 12:09:07 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 12:09:07 INFO - PROCESS | 1655 | |i|pagename|runs| 12:09:07 INFO - PROCESS | 1655 | |0;dojo.html;3383.9830800845994;3399.915002124948;3424.7602667813253;3434.965650343496;3453.274812289421;4903.092927808358;5737.225474560938;5765.9999999999945;5808.1578171165265;5837.562182836288;5548.833534993946;5722.027255366587;5759.82720518384;5768.480836724694;5812.883742325162;5149.30484384608;5207.375114986188;5264.8157314494;5293.15309550472;5316.308879845634;57.04486555296699;5163.690178589278;5164.6384753067305;5264.973675131619;5278.445763194867;5160.251763494272;5161.483851614846;5190.169572868323;5194.246834209038;5227.059129356733;5196.324477817897;5235.110031294651;5243.475652434764;5244.370675518924;5259.395169555473;5111.488851114896;5154.407243167008;5188.792448302063;5201.037808005531;5248.81629142982;5575.721213939328;5730.68481233532;5741.62679425836;5771.220885180489;5820.650760954314;5466.644668096561;6125.052321061979;6273.341299163613;6298.4646305064125;6308.337624549448;6210.347913469066;6246.562740608159;6283.183186185766;6344.555881088326;6393.296737358887;5847.181394604759;5869.178315035899;5889.293284805851;5894.322152952423;5930.347661757246;6248.28144763349;6272.1219029335925;6302.936970630235;6344.68276586178;6350.206224221973;6113.385090542009;6131.774283661951;6195.039768835838;6196.535259855529;6224.875502489925;6273.9372606273355;6299.653519056405;6317.5893566918;6348.555601107878;6360.809175724736;5955.940440595626;6164.599301045418;6175.44421002103;6189.876202475925;6302.65335406557;6273.278572964076;6290.150829638032;6294.0558916162945;6294.559380843297;6303.873922521524;4849.539293767087;4898.9712160446;4907.3620429343955;4913.263010548446;4924.482929292372;3721.2743515014313;4147.605977432199;4273.572642735764;4352.129574085196;4430.601245887886;4896.3389942358035;5882.470577648032;5897.911531327033;5951.047832346891;6029.547783916224;6289.088082228142;6298.275698294755;6310.242770867525;6316.336784637639;6322.336154703782;5781.88436231273;5957.523398128139;5988.790392336335;6026.939730602726;6047.516198704093;5436.537894278951;5462.289902312674;5464.1257398816;5478.616496845262;5481.972590137024;6229.0967809668255;6433.035044743232;6434.099226108348;6440.227172739395;6447.1618689571;6177.722002509988;6247.718852651551;6271.059341098871;6288.591241569284;6290.622562646256;6378.712957916998;6412.038194270896;6422.839429014312;6439.3238709934785;6482.546221764431;6103.307364981803;6139.921477737097;6257.155284036597;6277;6283.434490895658;5790.160426738184;6209.503239740719;6282.4974002080635;6298.842528936813;6324.905126423199;6150.477209437069;6176.166217560752;6183.227096612924;6192.256929168529;6196.225471816023;5990.820275391745;6062.969685151723;6078.300995385587;6154.815355539341;6190.907136392868;5735.455131762643;5851.268591426072;5872.412758724094;5911.231539899785;5923.141144533933;6105.186826067751;6147.862645410613;6185.226846644169;6211.751529938751;6241.126242326169;6032.366601506778;6045.365236650088;6071.574989750675;6107.358727333566;6136.048912418582 12:09:07 INFO - PROCESS | 1655 | |1;ext.html;497.38572862514786;522.9869253268669;540.4271472239426;569.1661715586667;577.780443431496;36847.81576092119;38792.806035969814;38881.611183888155;38888.80555597225;38918.027049323784;39866.202675946464;39873.40189897154;40513.189736205255;40632;40666;9213.447193168415;9424.151826335628;9446.102620251066;9469.384490008128;9487.051294870493;9489.240860731124;9555.761105972337;9581.904180958205;9587.90412095877;9607.711768646917;9612.615495380176;9623.326367154303;9632.422054676741;9640.276979226552;9668.323217374787;8041.477303975252;8077.919220807805;9485.47829869357;9658.034196580356;9803.607855685765;9473.952630236805;9485.241180705527;9499.620015199453;9603.855942160873;9633.940266570671;28335.716642833515;38402.42396364057;38917.41623875644;38945;39451.21097578061;2907.7092290770966;3088.4903990841485;3548.946765798515;3706.2031663192543;4310;23174.884125579432;28541;30587.62355693999;30732.8463357684;31308;3141.2303985523463;3247.886323978673;3280.1963518937773;3291.2759192977746;3295.242094318296;363769;485052.72420913714;488293;488746;489303.99999999645;32837;32853.17867053295;33116.33767324688;33438;34407;33685.326293474485;33897.15257118543;33943.660563394544;33987.83006084954;34122;14961.625959351104;15087;15091.471798487;15107.169105699291;15108.54674359771;12715.55495557651;12792.488300467878;12816.166949148275;12821.102522823312;12831.743365132645;7425.9628701856145;7591.278828511283;7604.8479030419085;7678.232176782389;7678.308952194217;2897.5508796136633;3268.2809781847955;3300.4586468419184;3303.8678452862096;3352.094934367707;916.8808054952814;927.3879239701764;928.8653145293895;967.3180407812475;1062.937062937063;30191.698083019328;30280.84859575688;31015.844920775704;32206.516902246483;32556.674433255837;938.5776400619749;1005.3010412403015;1029.994850025745;1065.1265961911158;1067.962621308266;15512.673099035235;15678.294476748573;15737.370505179664;15856.841431585537;16062.75905861413;735724.2496512596;1020738;1040174;1050334;1050870;59873.70063149656;59909.70045149746;60405.697971509864;60528;62301.75396492045;1388.6042477893752;1391.8329800423812;1410.1398147130242;1414.8443671196367;1418.865207805257;24335.634965475885;24850;25353.366165846;25472.617910730984;25710.485790283714;51484.22773658473;58260.83478330494;59536.51158721067;59541.70229148826;61943.76112477815;487753;584214;589845;590201;591101;44381;44772.77613612042;44886.65340039804;45280.547194528954;45585.77207113943;48513.27230091481;48769.512304876494;49053.509464906325;50068.24215215297;50078.74960625174;37948;41171.38242926419;41738.79130604328;41772.79113604413;42261.57738422576;40692.38961415522;40961;40981;42121.78939105285;42195;39148;39388;39566.20867582575;39603.80198098991;39807.40288895611;35263.64736352603;35496.935091947285;35928.101797455274;36366.27267454689;36466.8176659115;22765.08939642396;26054.60918086268;26342.585477818124;26493.60259596146;27097 12:09:07 INFO - PROCESS | 1655 | |2;jquery.html;313.87445021991186;371.6525049079111;386.3875756925273;391.64556076750534;408.6873541740569;16866.56634186096;20328.491787705316;21332.89333553332;21991.34025979221;22015.889920550373;21157.365279041653;21217.151313947423;21619.45951351213;22336.776632233672;22549.872506374657;5537.418571050042;5948.40515948406;6147.262328520584;6149.877002459948;6197.721102550374;5962.314333851619;5964.701764911759;5991.310999235078;5998.700064996733;6052.122442245872;5863.149843272723;5906.822795316148;5966.8806623867495;6060.2424696912885;6073.331933487335;5942.61373010753;5958.821235362946;5986.132010858423;6040.275166979968;6044.335123136451;5187.559057480119;5222.451642577513;5295.602829787781;5320.920186197211;5323.574114070865;22800.31599052031;26896.924123035056;27949.441011179864;28092.297692557644;28370.716292837013;2075.57450722603;2151.698762173297;2160.4922843131853;2477.690288713911;2666.973330266692;7096.574205547632;7195.244499327548;9078.77303067422;10519;10946.616868409646;1886.4717878993904;1916.1281616864433;1932.5651728361006;1944.3777991042873;1960.9411717648493;126415;129793;131905.34047329798;131989;132133;11714.88285117155;11816.172867899337;12004;12073.396330183456;12215.938920305342;14699.26503674812;14722.63193420173;14800;14831.70336593262;14844.109353438827;8649.308055355683;8797.780055498664;8826.42628229163;8850.20348168668;8952.8657070144;8842.823143537093;8873.778155546162;8948.373613847098;8973.05782892787;8980.281577473786;4657.930131048037;4671.416072990876;4681.836135735233;4712.410948631421;4744.217204161344;1721.9397321093702;1752.0188694331216;1906.8379187768917;2003.1686849957105;2008.4878356019121;856.2678909532385;868.5345471568396;959.472290240365;1043.9269251152346;1053.394298278493;18151.546211344823;20522.56342056042;22255.998480068436;22578.54842903133;22804.885975570018;830.4145577367941;944.2681921510747;957.8132264208413;960.490939801906;976.9316147869581;9872.96333884946;11733.237339572901;11914.523419063315;12013.15907886457;12049.216800907912;546271;594543;600926;611976;613763;130835.34582327218;131998;139413;140970;143436;929.6699671616614;948.8945378633953;991.9702408927744;1026.1226651213403;1026.4508487959056;19372.515687107934;19392.321268755524;19676.90161549183;19722.704159437333;19751.802481974995;37573.81213093917;56295;56623;57696;58615.82768344524;77904.61047694726;83258;83690.58154709188;84703.15296846953;85571;7142.607156606437;8301;8341.582920854054;8415.831683366176;8681.522516261666;12357.25856448616;13551.983601230144;13583.52457663977;13824.654383640489;13850.930745346208;11673.182877198515;11686.123540734308;11698.76602467929;11720.06239500855;11983.520659173884;11284;11461.713457163638;11535.653930382103;11721.765564688489;11768.411579420823;11681.824772628248;11722.882771172179;12020.879791202326;12048.939755301168;12119.818202727143;8364.707235246737;8385.119562445856;8517.74446766598;8609.741707748777;8635.870461943201;10683.198760093179;11043.282186657842;11462.369569673749;11505.079593632321;11580.6525804226 12:09:07 INFO - PROCESS | 1655 | |3;mootools.html;1400.7813202513814;1581.351645825211;1821.4262507310204;1939.3406241877758;1958.7551556055494;8033.357331413473;8653.134686531344;8657.567121643908;9198.98811130775;9229.815403691922;8744.038155802857;8803.251723603502;8920.330975176856;8948.955255223731;8962.41744286621;2360.327306717586;2385.9284221473386;2386.2364043506086;2391.2467572714627;2399.256230568529;2371.4427109629223;2382.4163080045414;2394.1261439574605;2404.7354790972977;2413.78275955164;2351.600227961242;2369.727481339642;2385.940351491209;2391.234804862445;2395.4131237846664;2066.71066050753;2285.7257129144527;2355.458244603742;2363.09021026905;2376.2989917974237;2351.130081869719;2359.4691194481275;2364.881755912215;2368.6447032945025;2382.29722231942;9052.230560402373;9113.726588202298;9141.497217653094;9156.725298240997;9168.495732734697;5236.764345604457;5308.92036619451;5313.44208858072;5342.091844386464;5377.784888604451;3246.253361726816;3319.668033196685;3694.3350196964534;3745.9438108428394;3761.8307176177136;1100.499272830868;1119.8936101070467;1121.9326840389522;1131.7906187355366;1133.1161693878787;10450.843237351446;11786.469608867535;11991.441112655299;12004.819927701092;12006.459709313101;4415.2935530315;4486.775661216926;4669.369635099286;4674.415698037746;4698.647601429906;9083;9292.16370526656;9307.813843723088;9319.580618872167;9328.160465558132;5249.895002099936;5265.8156964506825;5275.050490911596;5277;5278.392984806719;4404.669649776216;4768.976155119271;4938.678985865908;4945.901081978413;4963.156263435225;3731.6828069614385;3789.7536660117003;3831.1571454280015;3853.0174805424435;3907;1163.4299193395345;1170.2510393348093;1171.6485054483621;1174.8061569841052;1182.8994535464583;787.7833595761211;893.5041052216083;920.7191806498948;940.5438362394233;963.3112324687742;5408.59435542328;5981;6140.662263575547;6140.938590614126;6229;425.38107054236013;434.6913691279164;443.1668463288996;445.4876891574715;447.9674350621848;3192.2498212919945;4055.8174882130374;4151.8546850860075;4221.746695198298;4247.660187185018;10507.894921050845;10782.838257426145;10957.01386875185;11005.724856878482;11010.614628487965;10868.130549556017;10987.230893837355;11013.889861101447;11014;11034.117270618332;7937.206279372017;8352.24829765312;8359;8388.119247478928;8458.915410845935;5255.421903590525;6156.78451254204;6287.245530536182;6323.430891219812;6413;8401.873971890303;9915.30592858493;10304.278700490893;10343.84484232722;10351.171906247331;10437.791244175225;10479.68560943173;10535.947320263349;10604.840927385942;10688.091512221548;7123;7542.585157816373;7763.4953728007495;7794.766157015299;7897.1707970662255;8628.827423451621;8688.565571721516;8712;8730;8731.214190722865;6287.591306565241;7683.34691551202;7689.9615501922135;7735.806604834924;7814.0623125223065;6529;6872.725090996304;7558;7585.127710313384;7666.156722760604;7224.277572242734;7233.095863017123;7272.490925635367;7282.0533330668795;7294.63526823646;5050.898982020265;5122.615803814654;5191.870203244949;5283.630145889904;5294.100002999577;5107.463716309734;5166.4316925137455;5235.738213089407;5345.33183352081;5368.221607866915 12:09:07 INFO - PROCESS | 1655 | |4;prototype.html;252.57062992912049;313.33260155868;316.439901374567;316.9825659588723;320.06221770213267;5559.471850174232;5656.208130861683;5672.234248376468;5677.744501497432;5704.600677952534;4558.817647294104;5518.696471694066;5536.889262214753;5558.943191019329;5560.888782224353;3992.840286388541;4123.381652650559;4187.874363769077;4198.496180458349;4204.222218889515;3581.8209089545417;4135.979320103395;4199.9580004200025;4206.1377417629465;4224.936625950613;3605.5673319201733;4036.9302134934264;4182.769947652878;4206.569766279465;4206.936895946563;4039.152397559728;4179.519355274152;4181.142865712522;4214.726042807208;4221.472315960505;3618.4851528187655;3623.0942264433893;3629.836657350399;3664.3770559005034;3669.8165091745304;4608.723476591382;4653.697509661895;4868.318435419044;5222.746540830173;5397.54120899724;4446.688731788776;4754.215554433515;4790.8323208687525;4815.975920120412;4834.226523756217;5887.761731047949;5895.882082358329;5903;5924.792632257893;5942.762289508414;3918.902027449308;3927.8625248116177;3940.940885886714;3946.763194208328;3948.447217389568;5065.746712664352;5109.565686916617;5807.709614519299;5938.565188272831;6235.844103897393;3962.187751510933;3999.560048394674;4002.699797515198;4017.738846974996;4046.3121269384274;3651.908702282464;3885.251636763411;4085.1216988347055;4088.6115818997146;4103.199876024147;3739.495168152319;3943.38877473992;4011.9799401002806;4431.119772148065;4822.961534233481;5945.286565612154;5965.313988891333;5966.254218222723;5968.492678122321;5985.191999080155;1206.324458303353;1208.079154144914;1403.326403326409;1403.6561042544643;1405.4027038508798;761.6191904047976;829.4820478524287;858.4677499950071;861.8362511122866;898.8067565473455;5413.566914646819;5463.535599474009;5487.478689524489;5493.395726470085;5495.697736624524;4576.931346029813;5054.368203974504;5973.761049557969;6101.542384321194;6128.509719222451;4296.892577685583;5433.5329461046085;5457.263269458652;5472.124460086367;5513.724313784295;2670.626112344273;2909.3744844858034;2987.6414830220515;3029.7879148459397;3155.9053228403186;5162.045021671003;5690.3456102548735;5974.364437221584;6173.753049878044;6198.822223777468;6018.368071352533;6046.727897244635;6123.3363486883345;6159.012878753801;6190.347694859965;5812.0119579671555;6186.7317199973895;6206.658633775005;6232.136075633137;6236.563440559117;5745.638801301118;5972.671503067199;5997.520198384206;6187.12298781069;6237.438630523275;5024.799008039784;5129.05079579236;6109.694515274307;6110.694465276807;6165;5827.79602713903;6135.815925522063;6425.742970281136;6468.288488266193;6471.417572418505;4013.15723698015;4019.4677353268426;4025.698072644622;4025.9130034891;4038.7778672172135;5811.4479124483105;6194.5354098443695;6205.789870975116;6206.968965155145;6211.223597050369;5385.434529374516;5469.441209255343;5522.502974732293;5759.617691754032;6011.7595296187665;4874.390701162355;5140.665856719302;5470.781168753205;5931.1992880960515;5964.940350596438;4773.904521909473;5423.457654234545;5522.282103326542;5598.1602759586385;5876.1773351729935;4961.875953101057;5387.407385187705;5873.060310350324;5924.644521328734;5943.355206932873;5134.97300539901;5760.675044739817;5796.521886918808;5837.970810145922;5838.649681019152 12:09:07 INFO - PROCESS | 1655 | |5;yui.html;735.922728113548;757.4886951307866;797.4139007829244;813.731468615357;855.4525103933483;13147.605571832837;15349.616259593502;15759.054456732603;15966;16059.919700401497;13035.41340639671;13072.673183170426;13103.148295360796;13105.54130605429;13192.472301107944;707.4163814852767;876.8903887014123;896.2068569316169;897.1118592593351;898.993127696977;875.1991927386434;892.4020905993;905.597009330848;907.6233363154283;911;942.4157022645969;946.1248345280623;961.528850863079;963.8216929867962;967.632299726103;935.3732998890725;950.5722424908785;955.5174636808437;955.7276176289724;963.2486660404895;702.5328156775789;706.0010085728687;707.5542408282749;710.1868360726991;715.5206011971991;14719.264036798224;14919.403223871032;15017.474388396353;15071.020383675026;15134;14793.408263669548;14842.183679897602;14879.47921822731;14976.625584360369;15010.324535395934;11968;12227.205231660002;12426.068044896578;12451.564195253122;12459.003279737599;3870.825812838429;3896.7856767877756;4062.4109504122034;4091.40674602184;4093.5087789465456;115454;115972;116319.83680163174;116582.41708791486;119516.40241798735;11579.826302605468;11586.304821710724;11596.536138554533;11622.360770157553;12162.939185304194;23987.640185397235;24294.514109717707;24295.757042429705;24376.390590235387;24433.877830610734;8274.13121622221;8423.410361274651;8448.366372522085;8483.024452188078;8558.82882342362;4126.216018956448;4602.470715867651;4649.422190288017;4650.6046986005895;4676.929846052312;3629.364861149288;3744.3260213161893;3753.6246375362243;3758.699304055669;3763.7741735495956;654.2508827392609;667.002830768005;669.2370697404962;677.5054210426317;685.1948959972013;515.6132900324757;540.664787831547;580.7734983356494;671.1275342055309;673.7978606418055;8569.10024447424;9181.81636367269;9567.712968610953;9632.229421646252;9658.034196580425;628.0516420205522;634.8002275698933;646.5958775765147;652.3020368206069;663.2637772072995;3962.583928687446;4536.251518499476;4672.2057250267535;4688.367070445514;4691.483936766953;117242;122343;127709;144639;146992;123818;125833;127137.72862271444;128337.07494387592;131131.68868311387;93723;104282.47858760657;112568;114895.42552287353;117496.41251793857;8258.42191046621;8456.873146902679;8846.513441760764;8973.192412682629;9104.271658267191;59657;60282.69858650678;61117.69441152766;62446.375536245876;66310.66844665745;74866.62566687132;76317.23682763102;78887.60556197182;90798.63802043107;91578;13623.046386752832;13641.249731264876;13672.453101875813;13889.374978125807;14126.081804683074;15353.462628807938;15465.226738663247;15609.985350952153;15623.375064997274;15920.52238432849;14219.502317419254;14329.713405732036;14368.640783980483;14555;14757.188354640597;14072.085314454527;14326.426942922584;14570.635734106732;14876.256187190813;14887.627809304853;12173.69565760863;13794.37925293344;13991.860081399056;14161.079529830527;14252.358643860844;11528.481218345027;11545.538178472767;11547.13396495283;11675.474603643026;11922.284662920252;11408.600698975495;11544.711382215512;11582.942085289857;11735.530578776754;11766.235194712317 12:09:07 INFO - PROCESS | 1655 | __end_tp_report 12:09:07 INFO - PROCESS | 1655 | __start_cc_report 12:09:07 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,438 12:09:07 INFO - PROCESS | 1655 | __end_cc_report 12:09:07 INFO - PROCESS | 1655 | __startTimestamp1468523347658__endTimestamp 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | ------- Summary: start ------- 12:09:07 INFO - PROCESS | 1655 | Number of tests: 6 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5740.82 Median:6029.55 stddev:807.08 (13.4%) stddev-sans-first:788.09 12:09:07 INFO - PROCESS | 1655 | Values: 3384.0 3399.9 3424.8 3435.0 3453.3 4903.1 5737.2 5766.0 5808.2 5837.6 5548.8 5722.0 5759.8 5768.5 5812.9 5149.3 5207.4 5264.8 5293.2 5316.3 57.0 5163.7 5164.6 5265.0 5278.4 5160.3 5161.5 5190.2 5194.2 5227.1 5196.3 5235.1 5243.5 5244.4 5259.4 5111.5 5154.4 5188.8 5201.0 5248.8 5575.7 5730.7 5741.6 5771.2 5820.7 5466.6 6125.1 6273.3 6298.5 6308.3 6210.3 6246.6 6283.2 6344.6 6393.3 5847.2 5869.2 5889.3 5894.3 5930.3 6248.3 6272.1 6302.9 6344.7 6350.2 6113.4 6131.8 6195.0 6196.5 6224.9 6273.9 6299.7 6317.6 6348.6 6360.8 5955.9 6164.6 6175.4 6189.9 6302.7 6273.3 6290.2 6294.1 6294.6 6303.9 4849.5 4899.0 4907.4 4913.3 4924.5 3721.3 4147.6 4273.6 4352.1 4430.6 4896.3 5882.5 5897.9 5951.0 6029.5 6289.1 6298.3 6310.2 6316.3 6322.3 5781.9 5957.5 5988.8 6026.9 6047.5 5436.5 5462.3 5464.1 5478.6 5482.0 6229.1 6433.0 6434.1 6440.2 6447.2 6177.7 6247.7 6271.1 6288.6 6290.6 6378.7 6412.0 6422.8 6439.3 6482.5 6103.3 6139.9 6257.2 6277.0 6283.4 5790.2 6209.5 6282.5 6298.8 6324.9 6150.5 6176.2 6183.2 6192.3 6196.2 5990.8 6063.0 6078.3 6154.8 6190.9 5735.5 5851.3 5872.4 5911.2 5923.1 6105.2 6147.9 6185.2 6211.8 6241.1 6032.4 6045.4 6071.6 6107.4 6136.0 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:77450.04 Median:39419.61 stddev:192690.11 (488.8%) stddev-sans-first:193144.04 12:09:07 INFO - PROCESS | 1655 | Values: 497.4 523.0 540.4 569.2 577.8 36847.8 38792.8 38881.6 38888.8 38918.0 39866.2 39873.4 40513.2 40632.0 40666.0 9213.4 9424.2 9446.1 9469.4 9487.1 9489.2 9555.8 9581.9 9587.9 9607.7 9612.6 9623.3 9632.4 9640.3 9668.3 8041.5 8077.9 9485.5 9658.0 9803.6 9474.0 9485.2 9499.6 9603.9 9633.9 28335.7 38402.4 38917.4 38945.0 39451.2 2907.7 3088.5 3548.9 3706.2 4310.0 23174.9 28541.0 30587.6 30732.8 31308.0 3141.2 3247.9 3280.2 3291.3 3295.2 363769.0 485052.7 488293.0 488746.0 489304.0 32837.0 32853.2 33116.3 33438.0 34407.0 33685.3 33897.2 33943.7 33987.8 34122.0 14961.6 15087.0 15091.5 15107.2 15108.5 12715.6 12792.5 12816.2 12821.1 12831.7 7426.0 7591.3 7604.8 7678.2 7678.3 2897.6 3268.3 3300.5 3303.9 3352.1 916.9 927.4 928.9 967.3 1062.9 30191.7 30280.8 31015.8 32206.5 32556.7 938.6 1005.3 1030.0 1065.1 1068.0 15512.7 15678.3 15737.4 15856.8 16062.8 735724.2 1020738.0 1040174.0 1050334.0 1050870.0 59873.7 59909.7 60405.7 60528.0 62301.8 1388.6 1391.8 1410.1 1414.8 1418.9 24335.6 24850.0 25353.4 25472.6 25710.5 51484.2 58260.8 59536.5 59541.7 61943.8 487753.0 584214.0 589845.0 590201.0 591101.0 44381.0 44772.8 44886.7 45280.5 45585.8 48513.3 48769.5 49053.5 50068.2 50078.7 37948.0 41171.4 41738.8 41772.8 42261.6 40692.4 40961.0 40981.0 42121.8 42195.0 39148.0 39388.0 39566.2 39603.8 39807.4 35263.6 35496.9 35928.1 36366.3 36466.8 22765.1 26054.6 26342.6 26493.6 27097.0 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35901.54 Median:14781.95 stddev:99780.04 (675.0%) stddev-sans-first:100024.17 12:09:07 INFO - PROCESS | 1655 | Values: 313.9 371.7 386.4 391.6 408.7 16866.6 20328.5 21332.9 21991.3 22015.9 21157.4 21217.2 21619.5 22336.8 22549.9 5537.4 5948.4 6147.3 6149.9 6197.7 5962.3 5964.7 5991.3 5998.7 6052.1 5863.1 5906.8 5966.9 6060.2 6073.3 5942.6 5958.8 5986.1 6040.3 6044.3 5187.6 5222.5 5295.6 5320.9 5323.6 22800.3 26896.9 27949.4 28092.3 28370.7 2075.6 2151.7 2160.5 2477.7 2667.0 7096.6 7195.2 9078.8 10519.0 10946.6 1886.5 1916.1 1932.6 1944.4 1960.9 126415.0 129793.0 131905.3 131989.0 132133.0 11714.9 11816.2 12004.0 12073.4 12215.9 14699.3 14722.6 14800.0 14831.7 14844.1 8649.3 8797.8 8826.4 8850.2 8952.9 8842.8 8873.8 8948.4 8973.1 8980.3 4657.9 4671.4 4681.8 4712.4 4744.2 1721.9 1752.0 1906.8 2003.2 2008.5 856.3 868.5 959.5 1043.9 1053.4 18151.5 20522.6 22256.0 22578.5 22804.9 830.4 944.3 957.8 960.5 976.9 9873.0 11733.2 11914.5 12013.2 12049.2 546271.0 594543.0 600926.0 611976.0 613763.0 130835.3 131998.0 139413.0 140970.0 143436.0 929.7 948.9 992.0 1026.1 1026.5 19372.5 19392.3 19676.9 19722.7 19751.8 37573.8 56295.0 56623.0 57696.0 58615.8 77904.6 83258.0 83690.6 84703.2 85571.0 7142.6 8301.0 8341.6 8415.8 8681.5 12357.3 13552.0 13583.5 13824.7 13850.9 11673.2 11686.1 11698.8 11720.1 11983.5 11284.0 11461.7 11535.7 11721.8 11768.4 11681.8 11722.9 12020.9 12048.9 12119.8 8364.7 8385.1 8517.7 8609.7 8635.9 10683.2 11043.3 11462.4 11505.1 11580.7 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5763.94 Median:4942.29 stddev:3266.18 (66.1%) stddev-sans-first:3258.88 12:09:07 INFO - PROCESS | 1655 | Values: 1400.8 1581.4 1821.4 1939.3 1958.8 8033.4 8653.1 8657.6 9199.0 9229.8 8744.0 8803.3 8920.3 8949.0 8962.4 2360.3 2385.9 2386.2 2391.2 2399.3 2371.4 2382.4 2394.1 2404.7 2413.8 2351.6 2369.7 2385.9 2391.2 2395.4 2066.7 2285.7 2355.5 2363.1 2376.3 2351.1 2359.5 2364.9 2368.6 2382.3 9052.2 9113.7 9141.5 9156.7 9168.5 5236.8 5308.9 5313.4 5342.1 5377.8 3246.3 3319.7 3694.3 3745.9 3761.8 1100.5 1119.9 1121.9 1131.8 1133.1 10450.8 11786.5 11991.4 12004.8 12006.5 4415.3 4486.8 4669.4 4674.4 4698.6 9083.0 9292.2 9307.8 9319.6 9328.2 5249.9 5265.8 5275.1 5277.0 5278.4 4404.7 4769.0 4938.7 4945.9 4963.2 3731.7 3789.8 3831.2 3853.0 3907.0 1163.4 1170.3 1171.6 1174.8 1182.9 787.8 893.5 920.7 940.5 963.3 5408.6 5981.0 6140.7 6140.9 6229.0 425.4 434.7 443.2 445.5 448.0 3192.2 4055.8 4151.9 4221.7 4247.7 10507.9 10782.8 10957.0 11005.7 11010.6 10868.1 10987.2 11013.9 11014.0 11034.1 7937.2 8352.2 8359.0 8388.1 8458.9 5255.4 6156.8 6287.2 6323.4 6413.0 8401.9 9915.3 10304.3 10343.8 10351.2 10437.8 10479.7 10535.9 10604.8 10688.1 7123.0 7542.6 7763.5 7794.8 7897.2 8628.8 8688.6 8712.0 8730.0 8731.2 6287.6 7683.3 7690.0 7735.8 7814.1 6529.0 6872.7 7558.0 7585.1 7666.2 7224.3 7233.1 7272.5 7282.1 7294.6 5050.9 5122.6 5191.9 5283.6 5294.1 5107.5 5166.4 5235.7 5345.3 5368.2 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4725.44 Median:5405.55 stddev:1490.06 (27.6%) stddev-sans-first:1455.93 12:09:07 INFO - PROCESS | 1655 | Values: 252.6 313.3 316.4 317.0 320.1 5559.5 5656.2 5672.2 5677.7 5704.6 4558.8 5518.7 5536.9 5558.9 5560.9 3992.8 4123.4 4187.9 4198.5 4204.2 3581.8 4136.0 4200.0 4206.1 4224.9 3605.6 4036.9 4182.8 4206.6 4206.9 4039.2 4179.5 4181.1 4214.7 4221.5 3618.5 3623.1 3629.8 3664.4 3669.8 4608.7 4653.7 4868.3 5222.7 5397.5 4446.7 4754.2 4790.8 4816.0 4834.2 5887.8 5895.9 5903.0 5924.8 5942.8 3918.9 3927.9 3940.9 3946.8 3948.4 5065.7 5109.6 5807.7 5938.6 6235.8 3962.2 3999.6 4002.7 4017.7 4046.3 3651.9 3885.3 4085.1 4088.6 4103.2 3739.5 3943.4 4012.0 4431.1 4823.0 5945.3 5965.3 5966.3 5968.5 5985.2 1206.3 1208.1 1403.3 1403.7 1405.4 761.6 829.5 858.5 861.8 898.8 5413.6 5463.5 5487.5 5493.4 5495.7 4576.9 5054.4 5973.8 6101.5 6128.5 4296.9 5433.5 5457.3 5472.1 5513.7 2670.6 2909.4 2987.6 3029.8 3155.9 5162.0 5690.3 5974.4 6173.8 6198.8 6018.4 6046.7 6123.3 6159.0 6190.3 5812.0 6186.7 6206.7 6232.1 6236.6 5745.6 5972.7 5997.5 6187.1 6237.4 5024.8 5129.1 6109.7 6110.7 6165.0 5827.8 6135.8 6425.7 6468.3 6471.4 4013.2 4019.5 4025.7 4025.9 4038.8 5811.4 6194.5 6205.8 6207.0 6211.2 5385.4 5469.4 5522.5 5759.6 6011.8 4874.4 5140.7 5470.8 5931.2 5964.9 4773.9 5423.5 5522.3 5598.2 5876.2 4961.9 5387.4 5873.1 5924.6 5943.4 5135.0 5760.7 5796.5 5838.0 5838.6 12:09:07 INFO - PROCESS | 1655 | 12:09:07 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24472.92 Median:3748.98 stddev:38004.26 (1013.7%) stddev-sans-first:38069.08 12:09:07 INFO - PROCESS | 1655 | Values: 735.9 757.5 797.4 813.7 855.5 13147.6 15349.6 15759.1 15966.0 16059.9 13035.4 13072.7 13103.1 13105.5 13192.5 707.4 876.9 896.2 897.1 899.0 875.2 892.4 905.6 907.6 911.0 942.4 946.1 961.5 963.8 967.6 935.4 950.6 955.5 955.7 963.2 702.5 706.0 707.6 710.2 715.5 14719.3 14919.4 15017.5 15071.0 15134.0 14793.4 14842.2 14879.5 14976.6 15010.3 11968.0 12227.2 12426.1 12451.6 12459.0 3870.8 3896.8 4062.4 4091.4 4093.5 115454.0 115972.0 116319.8 116582.4 119516.4 11579.8 11586.3 11596.5 11622.4 12162.9 23987.6 24294.5 24295.8 24376.4 24433.9 8274.1 8423.4 8448.4 8483.0 8558.8 4126.2 4602.5 4649.4 4650.6 4676.9 3629.4 3744.3 3753.6 3758.7 3763.8 654.3 667.0 669.2 677.5 685.2 515.6 540.7 580.8 671.1 673.8 8569.1 9181.8 9567.7 9632.2 9658.0 628.1 634.8 646.6 652.3 663.3 3962.6 4536.3 4672.2 4688.4 4691.5 117242.0 122343.0 127709.0 144639.0 146992.0 123818.0 125833.0 127137.7 128337.1 131131.7 93723.0 104282.5 112568.0 114895.4 117496.4 8258.4 8456.9 8846.5 8973.2 9104.3 59657.0 60282.7 61117.7 62446.4 66310.7 74866.6 76317.2 78887.6 90798.6 91578.0 13623.0 13641.2 13672.5 13889.4 14126.1 15353.5 15465.2 15610.0 15623.4 15920.5 14219.5 14329.7 14368.6 14555.0 14757.2 14072.1 14326.4 14570.6 14876.3 14887.6 12173.7 13794.4 13991.9 14161.1 14252.4 11528.5 11545.5 11547.1 11675.5 11922.3 11408.6 11544.7 11582.9 11735.5 11766.2 12:09:07 INFO - PROCESS | 1655 | -------- Summary: end -------- 12:09:07 INFO - PROCESS | 1655 | 12:09:08 INFO - TEST-INFO | 1655: exit 0 12:09:08 INFO - TEST-OK | dromaeo_css | took 1112280ms 12:09:08 INFO - TEST-START | kraken 12:09:08 INFO - operating with platform_type : mac_ 12:09:08 INFO - Initialising browser for kraken test... 12:09:08 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmp9pEA8w/profile http://localhost:49271/getInfo.html) 12:09:11 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 12:09:11 INFO - PROCESS | 1665 | colorDepth:24 12:09:11 INFO - PROCESS | 1665 | Browser inner width/height: 1024/663 12:09:11 INFO - PROCESS | 1665 | __metrics 12:09:11 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 12:09:12 INFO - TEST-INFO | 1665: exit 0 12:09:12 INFO - Browser initialized. 12:09:12 INFO - Running cycle 1/1 for kraken test... 12:09:12 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/tmp9pEA8w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:23 INFO - PROCESS | 1667 | RSS: Main: 268062720 12:09:23 INFO - PROCESS | 1667 | 12:09:26 INFO - PROCESS | 1667 | 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) 12:09:27 INFO - PROCESS | 1667 | RSS: Main: 278634496 12:09:27 INFO - PROCESS | 1667 | 12:09:30 INFO - PROCESS | 1667 | 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) 12:09:30 INFO - PROCESS | 1667 | RSS: Main: 282447872 12:09:30 INFO - PROCESS | 1667 | 12:09:34 INFO - PROCESS | 1667 | 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) 12:09:34 INFO - PROCESS | 1667 | RSS: Main: 282660864 12:09:34 INFO - PROCESS | 1667 | 12:09:36 INFO - PROCESS | 1667 | 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) 12:09:37 INFO - PROCESS | 1667 | RSS: Main: 283639808 12:09:37 INFO - PROCESS | 1667 | 12:09:39 INFO - PROCESS | 1667 | 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) 12:09:40 INFO - PROCESS | 1667 | RSS: Main: 284172288 12:09:40 INFO - PROCESS | 1667 | 12:09:43 INFO - PROCESS | 1667 | 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) 12:09:43 INFO - PROCESS | 1667 | RSS: Main: 284426240 12:09:43 INFO - PROCESS | 1667 | 12:09:46 INFO - PROCESS | 1667 | 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) 12:09:47 INFO - PROCESS | 1667 | RSS: Main: 284647424 12:09:47 INFO - PROCESS | 1667 | 12:09:50 INFO - PROCESS | 1667 | 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) 12:09:50 INFO - PROCESS | 1667 | RSS: Main: 285061120 12:09:50 INFO - PROCESS | 1667 | 12:09:52 INFO - PROCESS | 1667 | 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) 12:09:53 INFO - PROCESS | 1667 | RSS: Main: 284811264 12:09:53 INFO - PROCESS | 1667 | 12:09:55 INFO - PROCESS | 1667 | 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) 12:09:55 INFO - PROCESS | 1667 | RSS: Main: 284827648 12:09:55 INFO - PROCESS | 1667 | 12:09:57 INFO - PROCESS | 1667 | 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) 12:09:58 INFO - PROCESS | 1667 | RSS: Main: 284749824 12:09:58 INFO - PROCESS | 1667 | 12:10:01 INFO - PROCESS | 1667 | 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) 12:10:02 INFO - PROCESS | 1667 | RSS: Main: 284950528 12:10:02 INFO - PROCESS | 1667 | 12:10:05 INFO - PROCESS | 1667 | 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) 12:10:05 INFO - PROCESS | 1667 | RSS: Main: 285126656 12:10:05 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | 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) 12:10:07 INFO - PROCESS | 1667 | RSS: Main: 286023680 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | __start_tp_report 12:10:07 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 12:10:07 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 12:10:07 INFO - PROCESS | 1667 | |i|pagename|runs| 12:10:07 INFO - PROCESS | 1667 | |0;ai-astar;156;172;108;116;116;117;100;116;116;115 12:10:07 INFO - PROCESS | 1667 | |1;audio-beat-detection;144;111;136;184;138;160;128;111;158;105 12:10:07 INFO - PROCESS | 1667 | |2;audio-dft;195;199;195;215;230;252;178;260;273;200 12:10:07 INFO - PROCESS | 1667 | |3;audio-fft;71;83;77;142;60;72;89;88;131;63 12:10:07 INFO - PROCESS | 1667 | |4;audio-oscillator;54;103;145;69;72;83;111;71;72;112 12:10:07 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;89;89;90;90;86;89;90;92;103 12:10:07 INFO - PROCESS | 1667 | |6;imaging-darkroom;105;96;96;97;96;99;94;107;151;94 12:10:07 INFO - PROCESS | 1667 | |7;imaging-desaturate;91;93;144;147;90;92;96;90;90;95 12:10:07 INFO - PROCESS | 1667 | |8;json-parse-financial;56;57;57;64;82;72;57;58;56;58 12:10:07 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;69;72;84;95;93;115;114;70;69;69 12:10:07 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;88;84;85;80;82;84;82;88;87;87 12:10:07 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;143;155;121;126;166;135;155;162;243;144 12:10:07 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;172;182;165;168;169;168;168;168;167;167 12:10:07 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;66;69;69;85;88;66;62;60;80 12:10:07 INFO - PROCESS | 1667 | __end_tp_report 12:10:07 INFO - PROCESS | 1667 | __start_cc_report 12:10:07 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1134 12:10:07 INFO - PROCESS | 1667 | __end_cc_report 12:10:07 INFO - PROCESS | 1667 | __startTimestamp1468523407728__endTimestamp 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | ------- Summary: start ------- 12:10:07 INFO - PROCESS | 1667 | Number of tests: 14 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:123.20 Median:116.00 stddev:22.46 (19.4%) stddev-sans-first:20.45 12:10:07 INFO - PROCESS | 1667 | Values: 156.0 172.0 108.0 116.0 116.0 117.0 100.0 116.0 116.0 115.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:141.00 stddev:25.13 (17.8%) stddev-sans-first:26.55 12:10:07 INFO - PROCESS | 1667 | Values: 144.0 111.0 136.0 184.0 138.0 160.0 128.0 111.0 158.0 105.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:219.70 Median:222.50 stddev:32.34 (14.5%) stddev-sans-first:33.04 12:10:07 INFO - PROCESS | 1667 | Values: 195.0 199.0 195.0 215.0 230.0 252.0 178.0 260.0 273.0 200.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:87.60 Median:74.50 stddev:27.62 (37.1%) stddev-sans-first:28.63 12:10:07 INFO - PROCESS | 1667 | Values: 71.0 83.0 77.0 142.0 60.0 72.0 89.0 88.0 131.0 63.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:70.00 stddev:27.70 (39.6%) stddev-sans-first:26.29 12:10:07 INFO - PROCESS | 1667 | Values: 54.0 103.0 145.0 69.0 72.0 83.0 111.0 71.0 72.0 112.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:90.00 stddev:4.54 (5.0%) stddev-sans-first:4.81 12:10:07 INFO - PROCESS | 1667 | Values: 90.0 89.0 89.0 90.0 90.0 86.0 89.0 90.0 92.0 103.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:103.50 Median:96.00 stddev:17.26 (18.0%) stddev-sans-first:18.30 12:10:07 INFO - PROCESS | 1667 | Values: 105.0 96.0 96.0 97.0 96.0 99.0 94.0 107.0 151.0 94.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:102.80 Median:91.50 stddev:22.61 (24.7%) stddev-sans-first:23.58 12:10:07 INFO - PROCESS | 1667 | Values: 91.0 93.0 144.0 147.0 90.0 92.0 96.0 90.0 90.0 95.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:58.00 stddev:8.71 (15.0%) stddev-sans-first:8.99 12:10:07 INFO - PROCESS | 1667 | Values: 56.0 57.0 57.0 64.0 82.0 72.0 57.0 58.0 56.0 58.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:85.00 Median:71.00 stddev:18.46 (26.0%) stddev-sans-first:18.65 12:10:07 INFO - PROCESS | 1667 | Values: 69.0 72.0 84.0 95.0 93.0 115.0 114.0 70.0 69.0 69.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:86.00 stddev:2.79 (3.2%) stddev-sans-first:2.69 12:10:07 INFO - PROCESS | 1667 | Values: 88.0 84.0 85.0 80.0 82.0 84.0 82.0 88.0 87.0 87.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:155.00 Median:155.00 stddev:34.28 (22.1%) stddev-sans-first:36.08 12:10:07 INFO - PROCESS | 1667 | Values: 143.0 155.0 121.0 126.0 166.0 135.0 155.0 162.0 243.0 144.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:168.00 stddev:4.77 (2.8%) stddev-sans-first:4.96 12:10:07 INFO - PROCESS | 1667 | Values: 172.0 182.0 165.0 168.0 169.0 168.0 168.0 168.0 167.0 167.0 12:10:07 INFO - PROCESS | 1667 | 12:10:07 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:69.00 stddev:9.59 (13.9%) stddev-sans-first:10.14 12:10:07 INFO - PROCESS | 1667 | Values: 69.0 66.0 69.0 69.0 85.0 88.0 66.0 62.0 60.0 80.0 12:10:07 INFO - PROCESS | 1667 | -------- Summary: end -------- 12:10:07 INFO - PROCESS | 1667 | 12:10:08 INFO - TEST-INFO | 1667: exit 0 12:10:08 INFO - TEST-OK | kraken | took 60169ms 12:10:08 INFO - SUITE-END | took 1172s 12:10:08 INFO - Completed test suite (00:19:32) 12:10:08 INFO - javascript benchmark 12:10:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7383.378145912784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3383.9830800845994, 3399.915002124948, 3424.7602667813253, 3434.965650343496, 3453.274812289421, 4903.092927808358, 5737.225474560938, 5765.9999999999945, 5808.1578171165265, 5837.562182836288, 5548.833534993946, 5722.027255366587, 5759.82720518384, 5768.480836724694, 5812.883742325162, 5149.30484384608, 5207.375114986188, 5264.8157314494, 5293.15309550472, 5316.308879845634, 57.04486555296699, 5163.690178589278, 5164.6384753067305, 5264.973675131619, 5278.445763194867, 5160.251763494272, 5161.483851614846, 5190.169572868323, 5194.246834209038, 5227.059129356733, 5196.324477817897, 5235.110031294651, 5243.475652434764, 5244.370675518924, 5259.395169555473, 5111.488851114896, 5154.407243167008, 5188.792448302063, 5201.037808005531, 5248.81629142982, 5575.721213939328, 5730.68481233532, 5741.62679425836, 5771.220885180489, 5820.650760954314, 5466.644668096561, 6125.052321061979, 6273.341299163613, 6298.4646305064125, 6308.337624549448, 6210.347913469066, 6246.562740608159, 6283.183186185766, 6344.555881088326, 6393.296737358887, 5847.181394604759, 5869.178315035899, 5889.293284805851, 5894.322152952423, 5930.347661757246, 6248.28144763349, 6272.1219029335925, 6302.936970630235, 6344.68276586178, 6350.206224221973, 6113.385090542009, 6131.774283661951, 6195.039768835838, 6196.535259855529, 6224.875502489925, 6273.9372606273355, 6299.653519056405, 6317.5893566918, 6348.555601107878, 6360.809175724736, 5955.940440595626, 6164.599301045418, 6175.44421002103, 6189.876202475925, 6302.65335406557, 6273.278572964076, 6290.150829638032, 6294.0558916162945, 6294.559380843297, 6303.873922521524, 4849.539293767087, 4898.9712160446, 4907.3620429343955, 4913.263010548446, 4924.482929292372, 3721.2743515014313, 4147.605977432199, 4273.572642735764, 4352.129574085196, 4430.601245887886, 4896.3389942358035, 5882.470577648032, 5897.911531327033, 5951.047832346891, 6029.547783916224, 6289.088082228142, 6298.275698294755, 6310.242770867525, 6316.336784637639, 6322.336154703782, 5781.88436231273, 5957.523398128139, 5988.790392336335, 6026.939730602726, 6047.516198704093, 5436.537894278951, 5462.289902312674, 5464.1257398816, 5478.616496845262, 5481.972590137024, 6229.0967809668255, 6433.035044743232, 6434.099226108348, 6440.227172739395, 6447.1618689571, 6177.722002509988, 6247.718852651551, 6271.059341098871, 6288.591241569284, 6290.622562646256, 6378.712957916998, 6412.038194270896, 6422.839429014312, 6439.3238709934785, 6482.546221764431, 6103.307364981803, 6139.921477737097, 6257.155284036597, 6277.0, 6283.434490895658, 5790.160426738184, 6209.503239740719, 6282.4974002080635, 6298.842528936813, 6324.905126423199, 6150.477209437069, 6176.166217560752, 6183.227096612924, 6192.256929168529, 6196.225471816023, 5990.820275391745, 6062.969685151723, 6078.300995385587, 6154.815355539341, 6190.907136392868, 5735.455131762643, 5851.268591426072, 5872.412758724094, 5911.231539899785, 5923.141144533933, 6105.186826067751, 6147.862645410613, 6185.226846644169, 6211.751529938751, 6241.126242326169, 6032.366601506778, 6045.365236650088, 6071.574989750675, 6107.358727333566, 6136.048912418582], "value": 5689.264533402738, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.38572862514786, 522.9869253268669, 540.4271472239426, 569.1661715586667, 577.780443431496, 36847.81576092119, 38792.806035969814, 38881.611183888155, 38888.80555597225, 38918.027049323784, 39866.202675946464, 39873.40189897154, 40513.189736205255, 40632.0, 40666.0, 9213.447193168415, 9424.151826335628, 9446.102620251066, 9469.384490008128, 9487.051294870493, 9489.240860731124, 9555.761105972337, 9581.904180958205, 9587.90412095877, 9607.711768646917, 9612.615495380176, 9623.326367154303, 9632.422054676741, 9640.276979226552, 9668.323217374787, 8041.477303975252, 8077.919220807805, 9485.47829869357, 9658.034196580356, 9803.607855685765, 9473.952630236805, 9485.241180705527, 9499.620015199453, 9603.855942160873, 9633.940266570671, 28335.716642833515, 38402.42396364057, 38917.41623875644, 38945.0, 39451.21097578061, 2907.7092290770966, 3088.4903990841485, 3548.946765798515, 3706.2031663192543, 4310.0, 23174.884125579432, 28541.0, 30587.62355693999, 30732.8463357684, 31308.0, 3141.2303985523463, 3247.886323978673, 3280.1963518937773, 3291.2759192977746, 3295.242094318296, 363769.0, 485052.72420913714, 488293.0, 488746.0, 489303.99999999645, 32837.0, 32853.17867053295, 33116.33767324688, 33438.0, 34407.0, 33685.326293474485, 33897.15257118543, 33943.660563394544, 33987.83006084954, 34122.0, 14961.625959351104, 15087.0, 15091.471798487, 15107.169105699291, 15108.54674359771, 12715.55495557651, 12792.488300467878, 12816.166949148275, 12821.102522823312, 12831.743365132645, 7425.9628701856145, 7591.278828511283, 7604.8479030419085, 7678.232176782389, 7678.308952194217, 2897.5508796136633, 3268.2809781847955, 3300.4586468419184, 3303.8678452862096, 3352.094934367707, 916.8808054952814, 927.3879239701764, 928.8653145293895, 967.3180407812475, 1062.937062937063, 30191.698083019328, 30280.84859575688, 31015.844920775704, 32206.516902246483, 32556.674433255837, 938.5776400619749, 1005.3010412403015, 1029.994850025745, 1065.1265961911158, 1067.962621308266, 15512.673099035235, 15678.294476748573, 15737.370505179664, 15856.841431585537, 16062.75905861413, 735724.2496512596, 1020738.0, 1040174.0, 1050334.0, 1050870.0, 59873.70063149656, 59909.70045149746, 60405.697971509864, 60528.0, 62301.75396492045, 1388.6042477893752, 1391.8329800423812, 1410.1398147130242, 1414.8443671196367, 1418.865207805257, 24335.634965475885, 24850.0, 25353.366165846, 25472.617910730984, 25710.485790283714, 51484.22773658473, 58260.83478330494, 59536.51158721067, 59541.70229148826, 61943.76112477815, 487753.0, 584214.0, 589845.0, 590201.0, 591101.0, 44381.0, 44772.77613612042, 44886.65340039804, 45280.547194528954, 45585.77207113943, 48513.27230091481, 48769.512304876494, 49053.509464906325, 50068.24215215297, 50078.74960625174, 37948.0, 41171.38242926419, 41738.79130604328, 41772.79113604413, 42261.57738422576, 40692.38961415522, 40961.0, 40981.0, 42121.78939105285, 42195.0, 39148.0, 39388.0, 39566.20867582575, 39603.80198098991, 39807.40288895611, 35263.64736352603, 35496.935091947285, 35928.101797455274, 36366.27267454689, 36466.8176659115, 22765.08939642396, 26054.60918086268, 26342.585477818124, 26493.60259596146, 27097.0], "value": 18883.850387514387, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.87445021991186, 371.6525049079111, 386.3875756925273, 391.64556076750534, 408.6873541740569, 16866.56634186096, 20328.491787705316, 21332.89333553332, 21991.34025979221, 22015.889920550373, 21157.365279041653, 21217.151313947423, 21619.45951351213, 22336.776632233672, 22549.872506374657, 5537.418571050042, 5948.40515948406, 6147.262328520584, 6149.877002459948, 6197.721102550374, 5962.314333851619, 5964.701764911759, 5991.310999235078, 5998.700064996733, 6052.122442245872, 5863.149843272723, 5906.822795316148, 5966.8806623867495, 6060.2424696912885, 6073.331933487335, 5942.61373010753, 5958.821235362946, 5986.132010858423, 6040.275166979968, 6044.335123136451, 5187.559057480119, 5222.451642577513, 5295.602829787781, 5320.920186197211, 5323.574114070865, 22800.31599052031, 26896.924123035056, 27949.441011179864, 28092.297692557644, 28370.716292837013, 2075.57450722603, 2151.698762173297, 2160.4922843131853, 2477.690288713911, 2666.973330266692, 7096.574205547632, 7195.244499327548, 9078.77303067422, 10519.0, 10946.616868409646, 1886.4717878993904, 1916.1281616864433, 1932.5651728361006, 1944.3777991042873, 1960.9411717648493, 126415.0, 129793.0, 131905.34047329798, 131989.0, 132133.0, 11714.88285117155, 11816.172867899337, 12004.0, 12073.396330183456, 12215.938920305342, 14699.26503674812, 14722.63193420173, 14800.0, 14831.70336593262, 14844.109353438827, 8649.308055355683, 8797.780055498664, 8826.42628229163, 8850.20348168668, 8952.8657070144, 8842.823143537093, 8873.778155546162, 8948.373613847098, 8973.05782892787, 8980.281577473786, 4657.930131048037, 4671.416072990876, 4681.836135735233, 4712.410948631421, 4744.217204161344, 1721.9397321093702, 1752.0188694331216, 1906.8379187768917, 2003.1686849957105, 2008.4878356019121, 856.2678909532385, 868.5345471568396, 959.472290240365, 1043.9269251152346, 1053.394298278493, 18151.546211344823, 20522.56342056042, 22255.998480068436, 22578.54842903133, 22804.885975570018, 830.4145577367941, 944.2681921510747, 957.8132264208413, 960.490939801906, 976.9316147869581, 9872.96333884946, 11733.237339572901, 11914.523419063315, 12013.15907886457, 12049.216800907912, 546271.0, 594543.0, 600926.0, 611976.0, 613763.0, 130835.34582327218, 131998.0, 139413.0, 140970.0, 143436.0, 929.6699671616614, 948.8945378633953, 991.9702408927744, 1026.1226651213403, 1026.4508487959056, 19372.515687107934, 19392.321268755524, 19676.90161549183, 19722.704159437333, 19751.802481974995, 37573.81213093917, 56295.0, 56623.0, 57696.0, 58615.82768344524, 77904.61047694726, 83258.0, 83690.58154709188, 84703.15296846953, 85571.0, 7142.607156606437, 8301.0, 8341.582920854054, 8415.831683366176, 8681.522516261666, 12357.25856448616, 13551.983601230144, 13583.52457663977, 13824.654383640489, 13850.930745346208, 11673.182877198515, 11686.123540734308, 11698.76602467929, 11720.06239500855, 11983.520659173884, 11284.0, 11461.713457163638, 11535.653930382103, 11721.765564688489, 11768.411579420823, 11681.824772628248, 11722.882771172179, 12020.879791202326, 12048.939755301168, 12119.818202727143, 8364.707235246737, 8385.119562445856, 8517.74446766598, 8609.741707748777, 8635.870461943201, 10683.198760093179, 11043.282186657842, 11462.369569673749, 11505.079593632321, 11580.6525804226], "value": 9812.532051206681, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.7813202513814, 1581.351645825211, 1821.4262507310204, 1939.3406241877758, 1958.7551556055494, 8033.357331413473, 8653.134686531344, 8657.567121643908, 9198.98811130775, 9229.815403691922, 8744.038155802857, 8803.251723603502, 8920.330975176856, 8948.955255223731, 8962.41744286621, 2360.327306717586, 2385.9284221473386, 2386.2364043506086, 2391.2467572714627, 2399.256230568529, 2371.4427109629223, 2382.4163080045414, 2394.1261439574605, 2404.7354790972977, 2413.78275955164, 2351.600227961242, 2369.727481339642, 2385.940351491209, 2391.234804862445, 2395.4131237846664, 2066.71066050753, 2285.7257129144527, 2355.458244603742, 2363.09021026905, 2376.2989917974237, 2351.130081869719, 2359.4691194481275, 2364.881755912215, 2368.6447032945025, 2382.29722231942, 9052.230560402373, 9113.726588202298, 9141.497217653094, 9156.725298240997, 9168.495732734697, 5236.764345604457, 5308.92036619451, 5313.44208858072, 5342.091844386464, 5377.784888604451, 3246.253361726816, 3319.668033196685, 3694.3350196964534, 3745.9438108428394, 3761.8307176177136, 1100.499272830868, 1119.8936101070467, 1121.9326840389522, 1131.7906187355366, 1133.1161693878787, 10450.843237351446, 11786.469608867535, 11991.441112655299, 12004.819927701092, 12006.459709313101, 4415.2935530315, 4486.775661216926, 4669.369635099286, 4674.415698037746, 4698.647601429906, 9083.0, 9292.16370526656, 9307.813843723088, 9319.580618872167, 9328.160465558132, 5249.895002099936, 5265.8156964506825, 5275.050490911596, 5277.0, 5278.392984806719, 4404.669649776216, 4768.976155119271, 4938.678985865908, 4945.901081978413, 4963.156263435225, 3731.6828069614385, 3789.7536660117003, 3831.1571454280015, 3853.0174805424435, 3907.0, 1163.4299193395345, 1170.2510393348093, 1171.6485054483621, 1174.8061569841052, 1182.8994535464583, 787.7833595761211, 893.5041052216083, 920.7191806498948, 940.5438362394233, 963.3112324687742, 5408.59435542328, 5981.0, 6140.662263575547, 6140.938590614126, 6229.0, 425.38107054236013, 434.6913691279164, 443.1668463288996, 445.4876891574715, 447.9674350621848, 3192.2498212919945, 4055.8174882130374, 4151.8546850860075, 4221.746695198298, 4247.660187185018, 10507.894921050845, 10782.838257426145, 10957.01386875185, 11005.724856878482, 11010.614628487965, 10868.130549556017, 10987.230893837355, 11013.889861101447, 11014.0, 11034.117270618332, 7937.206279372017, 8352.24829765312, 8359.0, 8388.119247478928, 8458.915410845935, 5255.421903590525, 6156.78451254204, 6287.245530536182, 6323.430891219812, 6413.0, 8401.873971890303, 9915.30592858493, 10304.278700490893, 10343.84484232722, 10351.171906247331, 10437.791244175225, 10479.68560943173, 10535.947320263349, 10604.840927385942, 10688.091512221548, 7123.0, 7542.585157816373, 7763.4953728007495, 7794.766157015299, 7897.1707970662255, 8628.827423451621, 8688.565571721516, 8712.0, 8730.0, 8731.214190722865, 6287.591306565241, 7683.34691551202, 7689.9615501922135, 7735.806604834924, 7814.0623125223065, 6529.0, 6872.725090996304, 7558.0, 7585.127710313384, 7666.156722760604, 7224.277572242734, 7233.095863017123, 7272.490925635367, 7282.0533330668795, 7294.63526823646, 5050.898982020265, 5122.615803814654, 5191.870203244949, 5283.630145889904, 5294.100002999577, 5107.463716309734, 5166.4316925137455, 5235.738213089407, 5345.33183352081, 5368.221607866915], "value": 4540.193166660294, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [252.57062992912049, 313.33260155868, 316.439901374567, 316.9825659588723, 320.06221770213267, 5559.471850174232, 5656.208130861683, 5672.234248376468, 5677.744501497432, 5704.600677952534, 4558.817647294104, 5518.696471694066, 5536.889262214753, 5558.943191019329, 5560.888782224353, 3992.840286388541, 4123.381652650559, 4187.874363769077, 4198.496180458349, 4204.222218889515, 3581.8209089545417, 4135.979320103395, 4199.9580004200025, 4206.1377417629465, 4224.936625950613, 3605.5673319201733, 4036.9302134934264, 4182.769947652878, 4206.569766279465, 4206.936895946563, 4039.152397559728, 4179.519355274152, 4181.142865712522, 4214.726042807208, 4221.472315960505, 3618.4851528187655, 3623.0942264433893, 3629.836657350399, 3664.3770559005034, 3669.8165091745304, 4608.723476591382, 4653.697509661895, 4868.318435419044, 5222.746540830173, 5397.54120899724, 4446.688731788776, 4754.215554433515, 4790.8323208687525, 4815.975920120412, 4834.226523756217, 5887.761731047949, 5895.882082358329, 5903.0, 5924.792632257893, 5942.762289508414, 3918.902027449308, 3927.8625248116177, 3940.940885886714, 3946.763194208328, 3948.447217389568, 5065.746712664352, 5109.565686916617, 5807.709614519299, 5938.565188272831, 6235.844103897393, 3962.187751510933, 3999.560048394674, 4002.699797515198, 4017.738846974996, 4046.3121269384274, 3651.908702282464, 3885.251636763411, 4085.1216988347055, 4088.6115818997146, 4103.199876024147, 3739.495168152319, 3943.38877473992, 4011.9799401002806, 4431.119772148065, 4822.961534233481, 5945.286565612154, 5965.313988891333, 5966.254218222723, 5968.492678122321, 5985.191999080155, 1206.324458303353, 1208.079154144914, 1403.326403326409, 1403.6561042544643, 1405.4027038508798, 761.6191904047976, 829.4820478524287, 858.4677499950071, 861.8362511122866, 898.8067565473455, 5413.566914646819, 5463.535599474009, 5487.478689524489, 5493.395726470085, 5495.697736624524, 4576.931346029813, 5054.368203974504, 5973.761049557969, 6101.542384321194, 6128.509719222451, 4296.892577685583, 5433.5329461046085, 5457.263269458652, 5472.124460086367, 5513.724313784295, 2670.626112344273, 2909.3744844858034, 2987.6414830220515, 3029.7879148459397, 3155.9053228403186, 5162.045021671003, 5690.3456102548735, 5974.364437221584, 6173.753049878044, 6198.822223777468, 6018.368071352533, 6046.727897244635, 6123.3363486883345, 6159.012878753801, 6190.347694859965, 5812.0119579671555, 6186.7317199973895, 6206.658633775005, 6232.136075633137, 6236.563440559117, 5745.638801301118, 5972.671503067199, 5997.520198384206, 6187.12298781069, 6237.438630523275, 5024.799008039784, 5129.05079579236, 6109.694515274307, 6110.694465276807, 6165.0, 5827.79602713903, 6135.815925522063, 6425.742970281136, 6468.288488266193, 6471.417572418505, 4013.15723698015, 4019.4677353268426, 4025.698072644622, 4025.9130034891, 4038.7778672172135, 5811.4479124483105, 6194.5354098443695, 6205.789870975116, 6206.968965155145, 6211.223597050369, 5385.434529374516, 5469.441209255343, 5522.502974732293, 5759.617691754032, 6011.7595296187665, 4874.390701162355, 5140.665856719302, 5470.781168753205, 5931.1992880960515, 5964.940350596438, 4773.904521909473, 5423.457654234545, 5522.282103326542, 5598.1602759586385, 5876.1773351729935, 4961.875953101057, 5387.407385187705, 5873.060310350324, 5924.644521328734, 5943.355206932873, 5134.97300539901, 5760.675044739817, 5796.521886918808, 5837.970810145922, 5838.649681019152], "value": 4238.233865411586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.922728113548, 757.4886951307866, 797.4139007829244, 813.731468615357, 855.4525103933483, 13147.605571832837, 15349.616259593502, 15759.054456732603, 15966.0, 16059.919700401497, 13035.41340639671, 13072.673183170426, 13103.148295360796, 13105.54130605429, 13192.472301107944, 707.4163814852767, 876.8903887014123, 896.2068569316169, 897.1118592593351, 898.993127696977, 875.1991927386434, 892.4020905993, 905.597009330848, 907.6233363154283, 911.0, 942.4157022645969, 946.1248345280623, 961.528850863079, 963.8216929867962, 967.632299726103, 935.3732998890725, 950.5722424908785, 955.5174636808437, 955.7276176289724, 963.2486660404895, 702.5328156775789, 706.0010085728687, 707.5542408282749, 710.1868360726991, 715.5206011971991, 14719.264036798224, 14919.403223871032, 15017.474388396353, 15071.020383675026, 15134.0, 14793.408263669548, 14842.183679897602, 14879.47921822731, 14976.625584360369, 15010.324535395934, 11968.0, 12227.205231660002, 12426.068044896578, 12451.564195253122, 12459.003279737599, 3870.825812838429, 3896.7856767877756, 4062.4109504122034, 4091.40674602184, 4093.5087789465456, 115454.0, 115972.0, 116319.83680163174, 116582.41708791486, 119516.40241798735, 11579.826302605468, 11586.304821710724, 11596.536138554533, 11622.360770157553, 12162.939185304194, 23987.640185397235, 24294.514109717707, 24295.757042429705, 24376.390590235387, 24433.877830610734, 8274.13121622221, 8423.410361274651, 8448.366372522085, 8483.024452188078, 8558.82882342362, 4126.216018956448, 4602.470715867651, 4649.422190288017, 4650.6046986005895, 4676.929846052312, 3629.364861149288, 3744.3260213161893, 3753.6246375362243, 3758.699304055669, 3763.7741735495956, 654.2508827392609, 667.002830768005, 669.2370697404962, 677.5054210426317, 685.1948959972013, 515.6132900324757, 540.664787831547, 580.7734983356494, 671.1275342055309, 673.7978606418055, 8569.10024447424, 9181.81636367269, 9567.712968610953, 9632.229421646252, 9658.034196580425, 628.0516420205522, 634.8002275698933, 646.5958775765147, 652.3020368206069, 663.2637772072995, 3962.583928687446, 4536.251518499476, 4672.2057250267535, 4688.367070445514, 4691.483936766953, 117242.0, 122343.0, 127709.0, 144639.0, 146992.0, 123818.0, 125833.0, 127137.72862271444, 128337.07494387592, 131131.68868311387, 93723.0, 104282.47858760657, 112568.0, 114895.42552287353, 117496.41251793857, 8258.42191046621, 8456.873146902679, 8846.513441760764, 8973.192412682629, 9104.271658267191, 59657.0, 60282.69858650678, 61117.69441152766, 62446.375536245876, 66310.66844665745, 74866.62566687132, 76317.23682763102, 78887.60556197182, 90798.63802043107, 91578.0, 13623.046386752832, 13641.249731264876, 13672.453101875813, 13889.374978125807, 14126.081804683074, 15353.462628807938, 15465.226738663247, 15609.985350952153, 15623.375064997274, 15920.52238432849, 14219.502317419254, 14329.713405732036, 14368.640783980483, 14555.0, 14757.188354640597, 14072.085314454527, 14326.426942922584, 14570.635734106732, 14876.256187190813, 14887.627809304853, 12173.69565760863, 13794.37925293344, 13991.860081399056, 14161.079529830527, 14252.358643860844, 11528.481218345027, 11545.538178472767, 11547.13396495283, 11675.474603643026, 11922.284662920252, 11408.600698975495, 11544.711382215512, 11582.942085289857, 11735.530578776754, 11766.235194712317], "value": 7985.470060946288, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1581.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 172.0, 108.0, 116.0, 116.0, 117.0, 100.0, 116.0, 116.0, 115.0], "value": 123.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 136.0, 184.0, 138.0, 160.0, 128.0, 111.0, 158.0, 105.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 195.0, 215.0, 230.0, 252.0, 178.0, 260.0, 273.0, 200.0], "value": 219.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 77.0, 142.0, 60.0, 72.0, 89.0, 88.0, 131.0, 63.0], "value": 87.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 103.0, 145.0, 69.0, 72.0, 83.0, 111.0, 71.0, 72.0, 112.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 90.0, 90.0, 86.0, 89.0, 90.0, 92.0, 103.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 96.0, 96.0, 97.0, 96.0, 99.0, 94.0, 107.0, 151.0, 94.0], "value": 103.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 144.0, 147.0, 90.0, 92.0, 96.0, 90.0, 90.0, 95.0], "value": 102.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 64.0, 82.0, 72.0, 57.0, 58.0, 56.0, 58.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 84.0, 95.0, 93.0, 115.0, 114.0, 70.0, 69.0, 69.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 85.0, 80.0, 82.0, 84.0, 82.0, 88.0, 87.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 155.0, 121.0, 126.0, 166.0, 135.0, 155.0, 162.0, 243.0, 144.0], "value": 155.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 182.0, 165.0, 168.0, 169.0, 168.0, 168.0, 168.0, 167.0, 167.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 69.0, 69.0, 85.0, 88.0, 66.0, 62.0, 60.0, 80.0], "value": 71.4, "unit": "score"}]}]} 12:10:08 INFO - Return code: 0 12:10:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:10:09 ERROR - # TBPL SUCCESS # 12:10:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:10:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:10:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:10:09 INFO - 2016-07-14 12:10:09.026 screenresolution[1672:10447] starting screenresolution argv=screenresolution get 12:10:09 INFO - 2016-07-14 12:10:09.029 screenresolution[1672:10447] Display 0: 1600x1200x32@60 12:10:09 INFO - 2016-07-14 12:10:09.035 screenresolution[1673:10450] starting screenresolution argv=screenresolution list 12:10:09 INFO - Available Modes on Display 0 12:10:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:10:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:10:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:10:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:10:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:10:09 INFO - Intel Iris: 12:10:09 INFO - Chipset Model: Intel Iris 12:10:09 INFO - Type: GPU 12:10:09 INFO - Bus: Built-In 12:10:09 INFO - VRAM (Dynamic, Max): 1536 MB 12:10:09 INFO - Vendor: Intel (0x8086) 12:10:09 INFO - Device ID: 0x0a2e 12:10:09 INFO - Revision ID: 0x0009 12:10:09 INFO - Displays: 12:10:09 INFO - Display: 12:10:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:10:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:10:09 INFO - Display Serial Number: 1600x1200 60 12:10:09 INFO - Main Display: Yes 12:10:09 INFO - Mirror: Off 12:10:09 INFO - Online: Yes 12:10:09 INFO - Rotation: Supported 12:10:09 INFO - Return code: 0 12:10:09 INFO - Running post-action listener: _resource_record_post_action 12:10:09 INFO - ##### 12:10:09 INFO - ##### Finished run-tests step (success) 12:10:09 INFO - ##### 12:10:09 INFO - Running post-run listener: _resource_record_post_run 12:10:09 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 36644352; Write bytes: 708593664; Read time: 243; Write time: 1990 12:10:09 INFO - TinderboxPrint: CPU usage
54.1% 12:10:09 INFO - TinderboxPrint: I/O read bytes / time
36,644,352 / 243 12:10:09 INFO - TinderboxPrint: I/O write bytes / time
708,593,664 / 1,990 12:10:09 INFO - TinderboxPrint: CPU idle
2,219.9 (45.9%) 12:10:09 INFO - TinderboxPrint: CPU system
968.7 (20.0%) 12:10:09 INFO - TinderboxPrint: CPU user
1,645.0 (34.0%) 12:10:09 INFO - TinderboxPrint: Swap in / out
444,133,376 / 0 12:10:09 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389583360; Write bytes: 380176384; Read time: 29064; Write time: 788 12:10:09 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 30387712; Write bytes: 298008576; Read time: 183; Write time: 1131 12:10:09 INFO - Running post-run listener: _upload_blobber_files 12:10:09 INFO - Blob upload gear active. 12:10:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:10 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:10:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:10:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:11 INFO - (blobuploader) - INFO - Done attempting. 12:10:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:10:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:10:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:12 INFO - (blobuploader) - INFO - Done attempting. 12:10:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:10:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:10:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:15 INFO - (blobuploader) - INFO - Done attempting. 12:10:15 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:15 INFO - Return code: 0 12:10:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/046a28a6224a856d30b8ea8bc54aa4d641bcd4f33ab54c6cf2e21eea9bf9ad6a79081a8a5180fbb2bafd7a5f5ab87dfc58f9c0ef255d1fbc66ccfcf7e4c7aff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb620e1a67dd6a2385ce62167056643265b889b97b6f6f18696cb32407b0eb82293d61acd1c3c77641aad2cfe0a1a6fe90e3e558f2129be52c6714ced3ba78b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890ae8322e5702042c1ad15c1a0baac2f53958d66e2c4c91ea6010c8efb20dc689f11d2056d408c66283ff3f8c29d1ad04c2e7e592ced46ac0a1a7b6dab6c71d"} 12:10:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:15 INFO - Contents: 12:10:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/046a28a6224a856d30b8ea8bc54aa4d641bcd4f33ab54c6cf2e21eea9bf9ad6a79081a8a5180fbb2bafd7a5f5ab87dfc58f9c0ef255d1fbc66ccfcf7e4c7aff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb620e1a67dd6a2385ce62167056643265b889b97b6f6f18696cb32407b0eb82293d61acd1c3c77641aad2cfe0a1a6fe90e3e558f2129be52c6714ced3ba78b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890ae8322e5702042c1ad15c1a0baac2f53958d66e2c4c91ea6010c8efb20dc689f11d2056d408c66283ff3f8c29d1ad04c2e7e592ced46ac0a1a7b6dab6c71d"} 12:10:15 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:15 INFO - Copying logs to upload dir... 12:10:15 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.764783 ========= master_lag: 5.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-07-14 12:10:20.373444) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-14 12:10:20.377114) ========= 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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/046a28a6224a856d30b8ea8bc54aa4d641bcd4f33ab54c6cf2e21eea9bf9ad6a79081a8a5180fbb2bafd7a5f5ab87dfc58f9c0ef255d1fbc66ccfcf7e4c7aff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb620e1a67dd6a2385ce62167056643265b889b97b6f6f18696cb32407b0eb82293d61acd1c3c77641aad2cfe0a1a6fe90e3e558f2129be52c6714ced3ba78b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890ae8322e5702042c1ad15c1a0baac2f53958d66e2c4c91ea6010c8efb20dc689f11d2056d408c66283ff3f8c29d1ad04c2e7e592ced46ac0a1a7b6dab6c71d"} build_url:https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/fMEMX79cRLqfOZs0hx7K6w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/046a28a6224a856d30b8ea8bc54aa4d641bcd4f33ab54c6cf2e21eea9bf9ad6a79081a8a5180fbb2bafd7a5f5ab87dfc58f9c0ef255d1fbc66ccfcf7e4c7aff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb620e1a67dd6a2385ce62167056643265b889b97b6f6f18696cb32407b0eb82293d61acd1c3c77641aad2cfe0a1a6fe90e3e558f2129be52c6714ced3ba78b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/890ae8322e5702042c1ad15c1a0baac2f53958d66e2c4c91ea6010c8efb20dc689f11d2056d408c66283ff3f8c29d1ad04c2e7e592ced46ac0a1a7b6dab6c71d"}' ========= master_lag: 1.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-14 12:10:21.922350) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 12:10:21.922797) ========= 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.3hgBW8HyrW/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.gDrxNhyJ6v/Listeners TMPDIR=/var/folders/rv/3yqh8vjn0nx53n2r8sx5mb2w00000w/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.005153 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 12:10:22.054435) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-07-14 12:10:22.054745) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-07-14 12:10:23.655064) ========= ========= Total master_lag: 7.15 =========