builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0105 starttime: 1462883542.42 results: success (0) buildid: 20160510024009 builduid: 03b897821c6b4ffca2dba3e961ddb355 revision: e4260b4769a02960afa8ffe89cf1824fa0580a30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.416488) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.416896) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.417177) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.435832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.436103) ========= 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.KStc9kfrHq/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.djEddsPNL9/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-05-10 05:32:22-- 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% 6.09M=0.002s 2016-05-10 05:32:22 (6.09 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.529328) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.529633) ========= 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.KStc9kfrHq/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.djEddsPNL9/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.019546 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:22.577368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 05:32:22.577674) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e4260b4769a02960afa8ffe89cf1824fa0580a30 --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 e4260b4769a02960afa8ffe89cf1824fa0580a30 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KStc9kfrHq/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.djEddsPNL9/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-05-10 05:32:22,645 truncating revision to first 12 chars 2016-05-10 05:32:22,645 Setting DEBUG logging. 2016-05-10 05:32:22,645 attempt 1/10 2016-05-10 05:32:22,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e4260b4769a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-10 05:32:23,925 unpacking tar archive at: fx-team-e4260b4769a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.523628 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-10 05:32:24.118406) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:24.118720) ========= script_repo_revision: e4260b4769a02960afa8ffe89cf1824fa0580a30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:24.119109) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:24.119366) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-10 05:32:24.132582) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-10 05:32:24.132851) ========= /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.KStc9kfrHq/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.djEddsPNL9/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:32:24 INFO - MultiFileLogger online at 20160510 05:32:24 in /builds/slave/test 05:32:24 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 05:32:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:24 INFO - {'append_to_log': False, 05:32:24 INFO - 'base_work_dir': '/builds/slave/test', 05:32:24 INFO - 'blob_upload_branch': 'Fx-Team', 05:32:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:24 INFO - 'branch': 'Fx-Team', 05:32:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:24 INFO - 'config_files': ('talos/mac_config.py',), 05:32:24 INFO - 'default_actions': ('clobber', 05:32:24 INFO - 'read-buildbot-config', 05:32:24 INFO - 'download-and-extract', 05:32:24 INFO - 'populate-webroot', 05:32:24 INFO - 'create-virtualenv', 05:32:24 INFO - 'install', 05:32:24 INFO - 'run-tests'), 05:32:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:24 INFO - 'download_minidump_stackwalk': True, 05:32:24 INFO - 'download_symbols': 'ondemand', 05:32:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:24 INFO - 'installer_path': 'installer.exe', 05:32:24 INFO - 'log_level': 'info', 05:32:24 INFO - 'log_name': 'talos', 05:32:24 INFO - 'log_to_console': True, 05:32:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:24 INFO - 'opt_config_files': (), 05:32:24 INFO - 'pip_index': False, 05:32:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:24 INFO - 'cmd': ('bash', 05:32:24 INFO - '-c', 05:32:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:24 INFO - 'enabled': True, 05:32:24 INFO - 'halt_on_failure': False, 05:32:24 INFO - 'name': 'check_screen_resolution'},), 05:32:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:24 INFO - 'cmd': ('bash', 05:32:24 INFO - '-c', 05:32:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:24 INFO - 'enabled': True, 05:32:24 INFO - 'halt_on_failure': False, 05:32:24 INFO - 'name': 'check_screen_resolution'},), 05:32:24 INFO - 'run_cmd_checks_enabled': True, 05:32:24 INFO - 'sps_profile': False, 05:32:24 INFO - 'sps_profile_interval': 0, 05:32:24 INFO - 'suite': 'dromaeojs-e10s', 05:32:24 INFO - 'system_bits': '32', 05:32:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:24 INFO - 'title': 't-yosemite-r7-0105', 05:32:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:24 INFO - 'use_talos_json': True, 05:32:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:24 INFO - 'work_dir': 'build'} 05:32:24 INFO - ##### 05:32:24 INFO - ##### Running clobber step. 05:32:24 INFO - ##### 05:32:24 INFO - Running pre-action listener: _resource_record_pre_action 05:32:24 INFO - Running main action method: clobber 05:32:24 INFO - rmtree: /builds/slave/test/build 05:32:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:25 INFO - Running post-action listener: _resource_record_post_action 05:32:25 INFO - ##### 05:32:25 INFO - ##### Finished clobber step (success) 05:32:25 INFO - ##### 05:32:25 INFO - ##### 05:32:25 INFO - ##### Running read-buildbot-config step. 05:32:25 INFO - ##### 05:32:25 INFO - Running pre-action listener: _resource_record_pre_action 05:32:25 INFO - Running main action method: read_buildbot_config 05:32:25 INFO - Using buildbot properties: 05:32:25 INFO - { 05:32:25 INFO - "project": "", 05:32:25 INFO - "product": "firefox", 05:32:25 INFO - "script_repo_revision": "production", 05:32:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:32:25 INFO - "repository": "", 05:32:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:32:25 INFO - "buildid": "20160510024009", 05:32:25 INFO - "pgo_build": "False", 05:32:25 INFO - "basedir": "/builds/slave/test", 05:32:25 INFO - "buildnumber": 2, 05:32:25 INFO - "slavename": "t-yosemite-r7-0105", 05:32:25 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:32:25 INFO - "platform": "yosemite_r7", 05:32:25 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:32:25 INFO - "branch": "fx-team", 05:32:25 INFO - "repo_path": "integration/fx-team", 05:32:25 INFO - "revision": "e4260b4769a02960afa8ffe89cf1824fa0580a30", 05:32:25 INFO - "stage_platform": "macosx64", 05:32:25 INFO - "builduid": "03b897821c6b4ffca2dba3e961ddb355", 05:32:25 INFO - "slavebuilddir": "test" 05:32:25 INFO - } 05:32:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:32:25 INFO - Running post-action listener: _resource_record_post_action 05:32:25 INFO - ##### 05:32:25 INFO - ##### Finished read-buildbot-config step (success) 05:32:25 INFO - ##### 05:32:25 INFO - ##### 05:32:25 INFO - ##### Running download-and-extract step. 05:32:25 INFO - ##### 05:32:25 INFO - Running pre-action listener: _resource_record_pre_action 05:32:25 INFO - Running main action method: download_and_extract 05:32:25 INFO - mkdir: /builds/slave/test/build/tests 05:32: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')]} 05:32:25 INFO - https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:32:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:32:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:32:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:32:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:32:27 INFO - Downloaded 1199 bytes. 05:32:27 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:32:27 INFO - Using the following test package requirements: 05:32:27 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:32:27 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:32:27 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:32:27 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'jsshell-mac.zip'], 05:32:27 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:32:27 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:32:27 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:32:27 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:32:27 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:32:27 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:32:27 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:32:27 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:32:27 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')]} 05:32:27 INFO - https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:32:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:32:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:32:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:32:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:28 INFO - Downloaded 18146482 bytes. 05:32:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:32:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:32:31 INFO - Return code: 0 05:32:31 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:31 INFO - https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:34 INFO - Downloaded 18146482 bytes. 05:32:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:32:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:32:37 INFO - Return code: 0 05:32:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:37 INFO - https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:32:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:32:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:32:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:32:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:38 INFO - Downloaded 10840152 bytes. 05:32:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:32:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:32:39 INFO - Return code: 0 05:32:39 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')]} 05:32:39 INFO - https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:32:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:32:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:32:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:32:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:32:42 INFO - Downloaded 110414432 bytes. 05:32:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:32:42 INFO - mkdir: /builds/slave/test/properties 05:32:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:42 INFO - Contents: 05:32:42 INFO - build_url:https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:32:44 INFO - Running post-action listener: _resource_record_post_action 05:32:44 INFO - Running post-action listener: set_extra_try_arguments 05:32:44 INFO - ##### 05:32:44 INFO - ##### Finished download-and-extract step (success) 05:32:44 INFO - ##### 05:32:44 INFO - ##### 05:32:44 INFO - ##### Running populate-webroot step. 05:32:44 INFO - ##### 05:32:44 INFO - Running pre-action listener: _resource_record_pre_action 05:32:44 INFO - Running main action method: populate_webroot 05:32:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:44 INFO - '--tppagecycles', 05:32:44 INFO - '7'], 05:32:44 INFO - 'tests': ['tsvgm']}}, 05:32:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['damp', 'tps']}, 05:32:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'tests': ['damp', 'tps']}, 05:32:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['dromaeo_dom']}, 05:32:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['a11yr', 05:32:44 INFO - 'ts_paint', 05:32:44 INFO - 'tpaint', 05:32:44 INFO - 'sessionrestore', 05:32:44 INFO - 'sessionrestore_no_auto_restore', 05:32:44 INFO - 'tabpaint']}, 05:32:44 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:44 INFO - 'ts_paint', 05:32:44 INFO - 'tpaint', 05:32:44 INFO - 'sessionrestore', 05:32:44 INFO - 'sessionrestore_no_auto_restore', 05:32:44 INFO - 'tabpaint']}, 05:32:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:44 INFO - 'ts_paint', 05:32:44 INFO - 'tpaint', 05:32:44 INFO - 'sessionrestore', 05:32:44 INFO - 'sessionrestore_no_auto_restore', 05:32:44 INFO - 'tabpaint']}, 05:32:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:44 INFO - 'ts_paint', 05:32:44 INFO - 'tpaint', 05:32:44 INFO - 'sessionrestore', 05:32:44 INFO - 'sessionrestore_no_auto_restore', 05:32:44 INFO - 'tabpaint']}, 05:32:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['a11yr', 05:32:44 INFO - 'ts_paint', 05:32:44 INFO - 'tpaint', 05:32:44 INFO - 'sessionrestore', 05:32:44 INFO - 'sessionrestore_no_auto_restore', 05:32:44 INFO - 'tabpaint']}, 05:32:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['a11yr', 05:32:44 INFO - 'ts_paint', 05:32:44 INFO - 'tpaint', 05:32:44 INFO - 'sessionrestore', 05:32:44 INFO - 'sessionrestore_no_auto_restore', 05:32:44 INFO - 'tabpaint']}, 05:32:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['tsvgx', 05:32:44 INFO - 'tsvgr_opacity', 05:32:44 INFO - 'tart', 05:32:44 INFO - 'tscrollx', 05:32:44 INFO - 'cart']}, 05:32:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:44 INFO - 'tsvgr_opacity', 05:32:44 INFO - 'tart', 05:32:44 INFO - 'tscrollx', 05:32:44 INFO - 'cart']}, 05:32:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'talos_options': ['--disable-e10s'], 05:32:44 INFO - 'tests': ['tp5o']}, 05:32:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'tests': ['tp5o']}, 05:32:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'talos_options': ['--disable-e10s', 05:32:44 INFO - '--xperf_path', 05:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:44 INFO - 'tests': ['tp5n']}, 05:32:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:44 INFO - 'talos_options': ['--xperf_path', 05:32:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:44 INFO - 'tests': ['tp5n']}}, 05:32:44 INFO - 'talos.zip': {'path': '', 05:32:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:44 INFO - Running post-action listener: _resource_record_post_action 05:32:44 INFO - ##### 05:32:44 INFO - ##### Finished populate-webroot step (success) 05:32:44 INFO - ##### 05:32:44 INFO - ##### 05:32:44 INFO - ##### Running create-virtualenv step. 05:32:44 INFO - ##### 05:32:44 INFO - Running pre-action listener: _resource_record_pre_action 05:32:44 INFO - Running main action method: create_virtualenv 05:32:44 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:44 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 05:32:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:44 INFO - Using real prefix '/tools/python27' 05:32:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:45 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:47 INFO - Installing pip.................done. 05:32:47 INFO - Return code: 0 05:32:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:47 INFO - 'HOME': '/Users/cltbld', 05:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:47 INFO - 'LOGNAME': 'cltbld', 05:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:47 INFO - 'MOZ_NO_REMOTE': '1', 05:32:47 INFO - 'NO_EM_RESTART': '1', 05:32:47 INFO - 'PAGER': '/bin/cat', 05:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:47 INFO - 'PWD': '/builds/slave/test', 05:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:47 INFO - 'SHELL': '/bin/bash', 05:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:32:47 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:47 INFO - 'USER': 'cltbld', 05:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:47 INFO - 'XPC_FLAGS': '0x0', 05:32:47 INFO - 'XPC_SERVICE_NAME': '0', 05:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 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 05:32:48 INFO - Cleaning up... 05:32:48 INFO - Return code: 0 05:32:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:48 INFO - 'HOME': '/Users/cltbld', 05:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:48 INFO - 'LOGNAME': 'cltbld', 05:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:48 INFO - 'MOZ_NO_REMOTE': '1', 05:32:48 INFO - 'NO_EM_RESTART': '1', 05:32:48 INFO - 'PAGER': '/bin/cat', 05:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:48 INFO - 'PWD': '/builds/slave/test', 05:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:48 INFO - 'SHELL': '/bin/bash', 05:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:32:48 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:48 INFO - 'USER': 'cltbld', 05:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:48 INFO - 'XPC_FLAGS': '0x0', 05:32:48 INFO - 'XPC_SERVICE_NAME': '0', 05:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 INFO - Downloading/unpacking psutil>=0.7.1 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:51 INFO - Installing collected packages: psutil 05:32:51 INFO - Running setup.py install for psutil 05:32:51 INFO - building 'psutil._psutil_osx' extension 05:32:51 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 05:32:51 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 05:32:51 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 05:32:52 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 05:32:52 INFO - building 'psutil._psutil_posix' extension 05:32:52 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 05:32:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:52 INFO - ^ 05:32:52 INFO - 1 warning generated. 05:32:52 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 05:32:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:52 INFO - Successfully installed psutil 05:32:52 INFO - Cleaning up... 05:32:52 INFO - Return code: 0 05:32:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:32:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:32:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:52 INFO - 'HOME': '/Users/cltbld', 05:32:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:52 INFO - 'LOGNAME': 'cltbld', 05:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:52 INFO - 'MOZ_NO_REMOTE': '1', 05:32:52 INFO - 'NO_EM_RESTART': '1', 05:32:52 INFO - 'PAGER': '/bin/cat', 05:32:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:52 INFO - 'PWD': '/builds/slave/test', 05:32:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:52 INFO - 'SHELL': '/bin/bash', 05:32:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:32:52 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:32:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:52 INFO - 'USER': 'cltbld', 05:32:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:52 INFO - 'XPC_FLAGS': '0x0', 05:32:52 INFO - 'XPC_SERVICE_NAME': '0', 05:32:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:32:55 INFO - Installing collected packages: mozsystemmonitor 05:32:55 INFO - Running setup.py install for mozsystemmonitor 05:32:55 INFO - Successfully installed mozsystemmonitor 05:32:55 INFO - Cleaning up... 05:32:55 INFO - Return code: 0 05:32:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:55 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 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:32:55 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 05:32:55 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 05:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:55 INFO - 'HOME': '/Users/cltbld', 05:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:55 INFO - 'LOGNAME': 'cltbld', 05:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:55 INFO - 'MOZ_NO_REMOTE': '1', 05:32:55 INFO - 'NO_EM_RESTART': '1', 05:32:55 INFO - 'PAGER': '/bin/cat', 05:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:55 INFO - 'PWD': '/builds/slave/test', 05:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:55 INFO - 'SHELL': '/bin/bash', 05:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:32:55 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:55 INFO - 'USER': 'cltbld', 05:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:55 INFO - 'XPC_FLAGS': '0x0', 05:32:55 INFO - 'XPC_SERVICE_NAME': '0', 05:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:55 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:58 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 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 05:32:58 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 05:32:59 INFO - Downloading docopt-0.6.1.tar.gz 05:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:59 INFO - Running setup.py install for blobuploader 05:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:59 INFO - Running setup.py install for requests 05:33:00 INFO - Running setup.py install for docopt 05:33:00 INFO - Successfully installed blobuploader requests docopt 05:33:00 INFO - Cleaning up... 05:33:00 INFO - Return code: 0 05:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:00 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 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:33:00 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 05:33:00 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 05:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:00 INFO - 'HOME': '/Users/cltbld', 05:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:00 INFO - 'LOGNAME': 'cltbld', 05:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:00 INFO - 'MOZ_NO_REMOTE': '1', 05:33:00 INFO - 'NO_EM_RESTART': '1', 05:33:00 INFO - 'PAGER': '/bin/cat', 05:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:00 INFO - 'PWD': '/builds/slave/test', 05:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:00 INFO - 'SHELL': '/bin/bash', 05:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:33:00 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:00 INFO - 'USER': 'cltbld', 05:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:00 INFO - 'XPC_FLAGS': '0x0', 05:33:00 INFO - 'XPC_SERVICE_NAME': '0', 05:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-t1UU1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-b3_gxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-l_3Gi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:00 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-214aB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-trNsyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-okgGby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-VZIIFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-6fXMX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-h9_1Bh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-KlYzvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-hWP4XN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-2XKsOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:01 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-IJe20I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:02 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-5d60lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:02 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-V_qVw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:02 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Rwet5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:02 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-6OZY9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:02 INFO - Running setup.py install for manifestparser 05:33:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:02 INFO - Running setup.py install for mozcrash 05:33:02 INFO - Running setup.py install for mozdebug 05:33:02 INFO - Running setup.py install for mozdevice 05:33:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for mozfile 05:33:03 INFO - Running setup.py install for mozhttpd 05:33:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for mozinfo 05:33:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for mozInstall 05:33:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for mozleak 05:33:03 INFO - Running setup.py install for mozlog 05:33:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:03 INFO - Running setup.py install for moznetwork 05:33:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for mozprocess 05:33:04 INFO - Running setup.py install for mozprofile 05:33:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for mozrunner 05:33:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:04 INFO - Running setup.py install for mozscreenshot 05:33:04 INFO - Running setup.py install for moztest 05:33:04 INFO - Running setup.py install for mozversion 05:33:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:05 INFO - Cleaning up... 05:33:05 INFO - Return code: 0 05:33:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:05 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')]} 05:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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')]} 05:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:05 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 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:33:05 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 05:33:05 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 05:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:05 INFO - 'HOME': '/Users/cltbld', 05:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:05 INFO - 'LOGNAME': 'cltbld', 05:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:05 INFO - 'MOZ_NO_REMOTE': '1', 05:33:05 INFO - 'NO_EM_RESTART': '1', 05:33:05 INFO - 'PAGER': '/bin/cat', 05:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:05 INFO - 'PWD': '/builds/slave/test', 05:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:05 INFO - 'SHELL': '/bin/bash', 05:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:33:05 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:05 INFO - 'USER': 'cltbld', 05:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:05 INFO - 'XPC_FLAGS': '0x0', 05:33:05 INFO - 'XPC_SERVICE_NAME': '0', 05:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-TFK83G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:05 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)) 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-vUciog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:05 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)) 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-hxpZgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:05 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)) 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-_Am4EF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:05 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)) 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-d9kdaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:05 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)) 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-Hn_faD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:05 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)) 05:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:05 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-QOuuTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:06 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-HXDwB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:06 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-oQX0aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:06 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-RvuXPh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-9hE74R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:06 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-nHEtMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-8PrVaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:06 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-nwT3BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-j3ruk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:06 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)) 05:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:06 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-HBt3RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:07 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)) 05:33:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:07 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-QgWsln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:07 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)) 05:33:07 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)) 05:33:07 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)) 05:33:07 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)) 05:33:07 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)) 05:33:07 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)) 05:33:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:07 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 05:33:07 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 05:33:07 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 05:33:07 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 05:33:07 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 05:33:07 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 05:33:09 INFO - Downloading blessings-1.6.tar.gz 05:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:09 INFO - Installing collected packages: blessings 05:33:09 INFO - Running setup.py install for blessings 05:33:09 INFO - Successfully installed blessings 05:33:09 INFO - Cleaning up... 05:33:09 INFO - Return code: 0 05:33:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:10 INFO - Reading from file tmpfile_stdout 05:33:10 INFO - Current package versions: 05:33:10 INFO - blessings == 1.6 05:33:10 INFO - blobuploader == 1.2.4 05:33:10 INFO - docopt == 0.6.1 05:33:10 INFO - manifestparser == 1.1 05:33:10 INFO - mozInstall == 1.12 05:33:10 INFO - mozcrash == 0.17 05:33:10 INFO - mozdebug == 0.1 05:33:10 INFO - mozdevice == 0.48 05:33:10 INFO - mozfile == 1.2 05:33:10 INFO - mozhttpd == 0.7 05:33:10 INFO - mozinfo == 0.9 05:33:10 INFO - mozleak == 0.1 05:33:10 INFO - mozlog == 3.1 05:33:10 INFO - moznetwork == 0.27 05:33:10 INFO - mozprocess == 0.22 05:33:10 INFO - mozprofile == 0.28 05:33:10 INFO - mozrunner == 6.11 05:33:10 INFO - mozscreenshot == 0.1 05:33:10 INFO - mozsystemmonitor == 0.0 05:33:10 INFO - moztest == 0.7 05:33:10 INFO - mozversion == 1.4 05:33:10 INFO - psutil == 3.1.1 05:33:10 INFO - requests == 1.2.3 05:33:10 INFO - wsgiref == 0.1.2 05:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:10 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 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:33:10 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 05:33:10 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 05:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:10 INFO - 'HOME': '/Users/cltbld', 05:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:10 INFO - 'LOGNAME': 'cltbld', 05:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:10 INFO - 'MOZ_NO_REMOTE': '1', 05:33:10 INFO - 'NO_EM_RESTART': '1', 05:33:10 INFO - 'PAGER': '/bin/cat', 05:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:10 INFO - 'PWD': '/builds/slave/test', 05:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:10 INFO - 'SHELL': '/bin/bash', 05:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:33:10 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:10 INFO - 'USER': 'cltbld', 05:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:10 INFO - 'XPC_FLAGS': '0x0', 05:33:10 INFO - 'XPC_SERVICE_NAME': '0', 05:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 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)) 05:33:10 INFO - Cleaning up... 05:33:10 INFO - Return code: 0 05:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:10 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 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:33:10 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 05:33:10 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 05:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:10 INFO - 'HOME': '/Users/cltbld', 05:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:10 INFO - 'LOGNAME': 'cltbld', 05:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:10 INFO - 'MOZ_NO_REMOTE': '1', 05:33:10 INFO - 'NO_EM_RESTART': '1', 05:33:10 INFO - 'PAGER': '/bin/cat', 05:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:10 INFO - 'PWD': '/builds/slave/test', 05:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:10 INFO - 'SHELL': '/bin/bash', 05:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:33:10 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:10 INFO - 'USER': 'cltbld', 05:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:10 INFO - 'XPC_FLAGS': '0x0', 05:33:10 INFO - 'XPC_SERVICE_NAME': '0', 05:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:10 INFO - Downloading/unpacking jsonschema 05:33:10 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 05:33:10 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 05:33:10 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 05:33:10 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 05:33:10 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 05:33:10 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 05:33:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 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 05:33:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:13 INFO - warning: no files found matching '*.txt' 05:33:13 INFO - no previously-included directories found matching 'build' 05:33:13 INFO - no previously-included directories found matching 'dist' 05:33:13 INFO - no previously-included directories found matching '.git*' 05:33:13 INFO - Installing collected packages: jsonschema, functools32 05:33:13 INFO - Running setup.py install for functools32 05:33:13 INFO - warning: no files found matching '*.txt' 05:33:13 INFO - no previously-included directories found matching 'build' 05:33:13 INFO - no previously-included directories found matching 'dist' 05:33:13 INFO - no previously-included directories found matching '.git*' 05:33:13 INFO - Successfully installed jsonschema functools32 05:33:13 INFO - Cleaning up... 05:33:13 INFO - Return code: 0 05:33:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:13 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105281a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105287570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9641cd1090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, '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.KStc9kfrHq/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.djEddsPNL9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 05:33:13 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', 'flake8'] in /builds/slave/test/build 05:33:13 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 flake8 05:33:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:33:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:13 INFO - 'HOME': '/Users/cltbld', 05:33:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:13 INFO - 'LOGNAME': 'cltbld', 05:33:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:13 INFO - 'MOZ_NO_REMOTE': '1', 05:33:13 INFO - 'NO_EM_RESTART': '1', 05:33:13 INFO - 'PAGER': '/bin/cat', 05:33:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:13 INFO - 'PWD': '/builds/slave/test', 05:33:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:13 INFO - 'SHELL': '/bin/bash', 05:33:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:33:13 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:33:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:13 INFO - 'USER': 'cltbld', 05:33:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:13 INFO - 'XPC_FLAGS': '0x0', 05:33:13 INFO - 'XPC_SERVICE_NAME': '0', 05:33:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:14 INFO - Downloading/unpacking flake8 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:33:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 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 05:33:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:33:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 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 05:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:17 INFO - no previously-included directories found matching 'docs/_build' 05:33:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:33:17 INFO - Running setup.py install for pep8 05:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:18 INFO - no previously-included directories found matching 'docs/_build' 05:33:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:33:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:33:18 INFO - Cleaning up... 05:33:18 INFO - Return code: 0 05:33:18 INFO - Running post-action listener: _resource_record_post_action 05:33:18 INFO - Running post-action listener: _start_resource_monitoring 05:33:18 INFO - Starting resource monitoring. 05:33:18 INFO - ##### 05:33:18 INFO - ##### Finished create-virtualenv step (success) 05:33:18 INFO - ##### 05:33:18 INFO - ##### 05:33:18 INFO - ##### Running install step. 05:33:18 INFO - ##### 05:33:18 INFO - Running pre-action listener: _resource_record_pre_action 05:33:18 INFO - Running main action method: install 05:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:18 INFO - Reading from file tmpfile_stdout 05:33:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:18 INFO - Reading from file tmpfile_stdout 05:33:18 INFO - Output received: 05:33:18 INFO - Usage: mozinstall [options] installer 05:33:18 INFO - Options: 05:33:18 INFO - -h, --help show this help message and exit 05:33:18 INFO - -d DEST, --destination=DEST 05:33:18 INFO - Directory to install application into. [default: 05:33:18 INFO - "/builds/slave/test"] 05:33:18 INFO - --app=APP Application being installed. [default: firefox] 05:33:18 INFO - mkdir: /builds/slave/test/build/application 05:33:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:33:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:33:52 INFO - Reading from file tmpfile_stdout 05:33:52 INFO - Output received: 05:33:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:33:52 INFO - Running post-action listener: _resource_record_post_action 05:33:52 INFO - ##### 05:33:52 INFO - ##### Finished install step (success) 05:33:52 INFO - ##### 05:33:52 INFO - ##### 05:33:52 INFO - ##### Running run-tests step. 05:33:52 INFO - ##### 05:33:52 INFO - Running pre-action listener: _resource_record_pre_action 05:33:52 INFO - Running main action method: run_tests 05:33:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:52 INFO - 2016-05-10 05:33:52.510 screenresolution[1950:12901] starting screenresolution argv=screenresolution get 05:33:52 INFO - 2016-05-10 05:33:52.512 screenresolution[1950:12901] Display 0: 1600x1200x32@60 05:33:52 INFO - 2016-05-10 05:33:52.519 screenresolution[1951:12903] starting screenresolution argv=screenresolution list 05:33:52 INFO - Available Modes on Display 0 05:33:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:52 INFO - Intel Iris: 05:33:52 INFO - Chipset Model: Intel Iris 05:33:52 INFO - Type: GPU 05:33:52 INFO - Bus: Built-In 05:33:52 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:52 INFO - Vendor: Intel (0x8086) 05:33:52 INFO - Device ID: 0x0a2e 05:33:52 INFO - Revision ID: 0x0009 05:33:52 INFO - Displays: 05:33:52 INFO - Display: 05:33:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:52 INFO - Display Serial Number: 1600x1200 60 05:33:52 INFO - Main Display: Yes 05:33:52 INFO - Mirror: Off 05:33:52 INFO - Online: Yes 05:33:52 INFO - Rotation: Supported 05:33:52 INFO - Return code: 0 05:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:52 INFO - Python 2.7.3 05:33:52 INFO - Return code: 0 05:33:52 INFO - grabbing minidump binary from tooltool 05:33:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:33:52 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105125d30>, '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 0x104f49db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10511cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:52 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 05:33:52 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 05:33:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:52 INFO - Return code: 0 05:33:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:33:53 INFO - Return code: 0 05:33:53 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/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 05:33:53 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/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --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 05:33:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KStc9kfrHq/Render', 05:33:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:53 INFO - 'HOME': '/Users/cltbld', 05:33:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:53 INFO - 'LOGNAME': 'cltbld', 05:33:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:53 INFO - 'MOZ_NO_REMOTE': '1', 05:33:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:53 INFO - 'NO_EM_RESTART': '1', 05:33:53 INFO - 'PAGER': '/bin/cat', 05:33:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:53 INFO - 'PWD': '/builds/slave/test', 05:33:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:53 INFO - 'SHELL': '/bin/bash', 05:33:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.djEddsPNL9/Listeners', 05:33:53 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 05:33:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:53 INFO - 'USER': 'cltbld', 05:33:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:53 INFO - 'XPC_FLAGS': '0x0', 05:33:53 INFO - 'XPC_SERVICE_NAME': '0', 05:33:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:53 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/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--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 05:33:54 INFO - mozversion application_buildid: 20160510024009 05:33:54 INFO - mozversion application_changeset: e4260b4769a02960afa8ffe89cf1824fa0580a30 05:33:54 INFO - mozversion application_display_name: Nightly 05:33:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:54 INFO - mozversion application_name: Firefox 05:33:54 INFO - mozversion application_remotingname: firefox 05:33:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:33:54 INFO - mozversion application_vendor: Mozilla 05:33:54 INFO - mozversion application_version: 49.0a1 05:33:54 INFO - mozversion platform_buildid: 20160510024009 05:33:54 INFO - mozversion platform_changeset: e4260b4769a02960afa8ffe89cf1824fa0580a30 05:33:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:33:54 INFO - mozversion platform_version: 49.0a1 05:33:54 INFO - using testdate: 1462883634 05:33:54 INFO - actual date: 1462883634 05:33:54 INFO - starting webserver on 'localhost:49513' 05:33:54 INFO - SUITE-START | Running 2 tests 05:33:54 INFO - TEST-START | dromaeo_css 05:33:54 INFO - operating with platform_type : mac_ 05:33:54 INFO - Initialising browser for dromaeo_css test... 05:33:54 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpD4wYSw/profile http://localhost:49513/getInfo.html) 05:33:57 INFO - PROCESS | 1969 | __metrics Screen width/height:1600/1200 05:33:57 INFO - PROCESS | 1969 | colorDepth:24 05:33:57 INFO - PROCESS | 1969 | Browser inner width/height: 1024/689 05:33:57 INFO - PROCESS | 1969 | __metrics 05:33:57 ERROR - PROCESS | 1969 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:33:57 INFO - TEST-INFO | 1969: exit 0 05:33:57 INFO - Browser initialized. 05:33:57 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:57 INFO - TEST-INFO | started process 1972 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpD4wYSw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:09 INFO - PROCESS | 1972 | RSS: Main: 249925632 05:34:09 INFO - PROCESS | 1972 | 05:34:59 INFO - PROCESS | 1972 | 1462883699461 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] 05:37:10 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49513/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49513/tests/dromaeo/cssquery-ext.html) 05:37:11 INFO - PROCESS | 1972 | RSS: Main: 262094848 05:37:11 INFO - PROCESS | 1972 | 05:40:13 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49513/tests/dromaeo/cssquery-ext.html (next: http://localhost:49513/tests/dromaeo/cssquery-jquery.html) 05:40:14 INFO - PROCESS | 1972 | RSS: Main: 273465344 05:40:14 INFO - PROCESS | 1972 | 05:43:16 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49513/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49513/tests/dromaeo/cssquery-mootools.html) 05:43:16 INFO - PROCESS | 1972 | RSS: Main: 275300352 05:43:16 INFO - PROCESS | 1972 | 05:46:18 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49513/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49513/tests/dromaeo/cssquery-prototype.html) 05:46:19 INFO - PROCESS | 1972 | RSS: Main: 276881408 05:46:19 INFO - PROCESS | 1972 | 05:49:21 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49513/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49513/tests/dromaeo/cssquery-yui.html) 05:49:22 INFO - PROCESS | 1972 | RSS: Main: 279732224 05:49:22 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | Cycle 1(1): loaded http://localhost:49513/tests/dromaeo/cssquery-yui.html (next: http://localhost:49513/tests/dromaeo/cssquery-dojo.html) 05:52:25 INFO - PROCESS | 1972 | RSS: Main: 280702976 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | __start_tp_report 05:52:25 INFO - PROCESS | 1972 | _x_x_mozilla_page_load 05:52:25 INFO - PROCESS | 1972 | _x_x_mozilla_page_load_details 05:52:25 INFO - PROCESS | 1972 | |i|pagename|runs| 05:52:25 INFO - PROCESS | 1972 | |0;dojo.html;3366.973073212669;3490.5462289902307;3490.8429120689566;3504.9649503504957;3511.4557243627237;4960.727160006199;5646.520045796107;5895.675737834417;5904.0553511438175;5942.138389933462;4937.481564435737;5018.623603229763;5721.856953576153;5909.881802363951;5999.820005399834;5232;5296.761645725952;5374.811881584145;5376.1129413646895;5430.56555475561;118.00464866797783;5232.3459567554055;5325.840224793243;5336.893262134755;5339.946600533984;4906.72425169455;5024.723640199788;5317.149256119022;5321.388040375348;5368.758405871745;5338.813141540028;5349.117395629716;5364.14173732201;5370.4361042090795;5411.323584551931;5195.298634684307;5211.478852114796;5259.710715910624;5296.2055691646565;5319;5677.545796336283;5784.421557844224;5811.622244554091;5835.095560188178;5840.795572154954;6172.567920245585;6173.753049878;6191.349908259613;6245.437910588023;6250.093736408196;5359.946400535984;6173.259208894961;6207.751689932397;6269.87460250797;6282.2147231596055;5952.0476723724;5972.641641501524;5983.700814959235;5986.670733109634;5991.850203744898;6172.537059720449;6230.470410015199;6277.24673039229;6328.588641738273;6347.174867267318;6140.50424869748;6155.538334624921;6234.75060997555;6242.500599951993;6278.152449419361;6206.441420272197;6220.066989951543;6272.686365681698;6297.2128483939505;6315.336889626615;5920.644761314335;6147.370946699129;6182.381761823872;6205.596636218631;6210.223722034746;5899.439553242435;6210.689465526796;6226.470749986302;6230.470410015199;6231.189945307081;4969.726665033386;4993.275974983607;4993.950060499348;5000.349954505891;5008.198688209869;4381.298992161239;4396.846110386121;4404.141192467502;4435.911281774411;4519.367288579601;5905.43898329658;5929.851753706105;5967.462928336384;5998.820035398945;6061.605995610271;6277.7993372936435;6279;6290.056491526308;6292.276388215322;6336.366363363719;5790.536757059425;5836.095405212199;5849.6782676952325;5851.180834683148;5885.087811389241;5438.129899216106;5443.346798384219;5459.69971651563;5464.754086066137;5472.5348345391085;6309.621422714652;6312.274088479791;6357.205349331333;6437.678116094083;6488.15653964991;6205.720742566686;6246.718897649707;6260.655663938345;6265.686715664107;6279.466245369194;6283.7800676976085;6332.873342533031;6448.32292609288;6448.548601597843;6488.513361497812;6155.72299246526;6185.938140618537;6255.56211065221;6258.405451482102;6263.843403914939;5308.25684404176;5433.56531477473;6270.028145637251;6313.210848643919;6327.462165715966;6121.117656725574;6155.738073694972;6177.536684748572;6262.812115636538;6263.561550691408;5659.801906933238;5861.9706901465215;6208.1308616792785;6223.564350495421;6223.782167624111;6045.730396616584;6085.726142323518;6160.568760186923;6185.907211391743;6236.407541283571;5730.455606717355;5898.675572843363;6160.784372546939;6200.046985199648;6206.317305096526;5889.52883769306;6106.816795496142;6176.166217560572;6189.96905015472;6195.504359651307 05:52:25 INFO - PROCESS | 1972 | |1;ext.html;485.5751217684524;496.183777685707;514.3776031002487;519.7479222577052;543.0686372870528;32832.5075123873;41718.374224386585;41972;41993.16013679725;42231.577684223186;37662.24675506495;41533;42543.787281063625;42852;42869;9551.474668893225;9648.98685638005;9697.515124243795;9741.805163896717;9745.610175592969;9523.476208808514;9572.617095316178;9583.760405989837;9605;9668.854967175497;9640.662576809813;9650.08324209199;9690.273229507815;9693.757656058584;9703.466309352983;9536.2371010319;9624.181944534723;9664.951675241578;9684.903150968506;9686.612535498572;9562;9626.903730962671;9646.71059868198;9670.70987870365;9684.56419461126;39173;39186;39278.410823837665;39405.802970984965;39703.40444893329;3156.8263745493987;3347.866085356583;3422.366862130489;3438.4670376091744;3642.380795264785;28705.569416458562;30112;30361.544576831366;30397.848010759804;30447;2651.681798184211;2660.441307325464;2833.3624934389804;2835.39039106591;2842.7157284271616;428120;499144;505226;508283.4585827047;510484;64737.676311619085;65323.08061516324;65333.34666653273;65546.67226663836;65685.67157164184;69352;69609;69890.65054674694;70093;70120.94818577725;16404.343826247055;16412.343506259855;16931.322747090224;16964.660706785795;16970;12564.371781410893;12781.808272875729;12923.741525169444;13046;13047.673808154872;14724.33740481681;17063.658726825393;18459.353922612645;18866;18939.715904261448;6561.114249576246;6612.966935165389;6627.469802415795;6657.335666083479;6716.697748601325;853.3429259470173;913.8811954446012;994.7264502261936;1040.6136647440048;1193.8567371915426;29466.852665736533;29745.553816692765;29896.701032989393;30417.543736843523;30548.54177187344;1020.6427750287488;1102.2725001499132;1172.5309876049648;1188.8454500914825;1190.3036723516666;14572.540477891462;15071.09573425598;15373.308201130976;15405.148712821794;15436.536903892676;634339;646171;650783.4921650818;651704;652249;60919;61440.156795296214;61552;61822.38177618256;61986.38013619806;1297.6042307096427;1299.3503248375812;1447.442734547207;1459.8248210214629;1466.9926650366892;28617;28738.712612873605;29303.267418314714;29412.705872941;29458;51884.481155189475;52702;52804;53320;53372.4662753383;554850;555213;562311;564178;565054;33778.15554611154;39881.60414385483;40497.987550310296;40777;41574.79212604039;40950.795246023576;44685.32972005488;46220.306695398926;46496.7675161622;46553.53446465492;33086.83456582702;38056.80971595124;38773.41839872461;38795;39668.80165599269;37467;37883.24233515369;38413.80793096017;38486;38982.220355593294;31692.841535792173;37277.440838387985;37949;38497.65258215949;38545.22909541737;30106.24734381658;32661.510077349332;33850.49224261687;34162.31675366528;34203.48694769531;24497.877510612332;24942.376440588403;25015.12447064344;25473.872630636728;25608.61587076158 05:52:25 INFO - PROCESS | 1972 | |2;jquery.html;360.57092060448065;385.77432202161737;389.9883003509894;403.4956304619226;412.8823285363672;18738;20931.37205883822;21937.890310548446;21950.902454877272;22121.889390553024;21463.034163462642;21473.785262147372;21964.341069767932;22163.891805409745;22214.66677999831;5745.7127143642965;6053.75784968603;6059.575829691923;6063.302720187169;6079.240094988127;4119.97940010301;5883.823485295448;6247.468965137946;6604.207495100594;6624.304448032959;6541.116949211843;6548.083268342436;6566.80299591013;6620.933790662104;6621.039949207386;6601.2738598754095;6615.106960560359;6615.834604134887;6625.204975402959;6640.535162538624;5638.238837756891;5751.223584816038;5786.623869448515;5851.824445266649;5852.180694702745;26867.865660671767;26958.5956210657;27008.864955675293;27110.32224194391;27354.863225683945;2247.4718441166315;2411.746766589518;2762.4475104979083;2856.9285767855763;2861.3848022675224;9578.75476188098;9786.75533111678;10207.438590877498;14267.07264027835;14547.90890683203;1695.2201987085955;1711.0674682298177;1720.8623310135285;1729.5070904792074;1814.6461440019202;112294;130322.3483882584;130920.3453982724;134518.32740836233;135275.32362338126;9718.368306060083;11460.083193344512;11569.305841649528;11762.117841161948;11909.821352679717;14529.200893950723;14570.562883113524;14589;14798.48205312809;14934.029288096239;7386.15059268191;8579.056303806576;8798;8827.602757875911;8909.064548222474;8587.27008204297;8604.311655067704;8695.826083478421;8708;8745.344099192458;3994.201159768058;4422.823087076481;4582.464874267092;4615.076984603025;4621.69958952667;1808.2405389736343;1830.3746750115442;1976.9802301977084;1983.4347211044783;2000.6598878190453;854.4446110028531;919.5356345045709;985.2659768472533;992.3450522655013;1042.5152304178594;19411.51471213231;21048;21190.04644790988;21209.89395053015;21340.893295533424;963.9710808675751;965.4352203960761;986.7502095222903;1019.7807471393686;1023.1712313026323;10833.362305739995;10849;11182.888171118348;11248.212625116163;11282.94358528202;472402;640224;643946;655028;659274;75674;76435.61782191053;109587;133662;135807.567697291;926.2589928057527;1028.1158203944601;1055.2402270365324;1060.4962642744636;1091.263397206898;17630.471085867444;19066.33267835619;19204.615907682048;19278.421647350602;19315.710264345766;40916.181676366905;53527.32363381893;54325.91348172935;54585;54708.72645636746;79959;80785;83027.58486207531;83221.58389208015;83339.5833020831;7476.289752473506;7701.92298077012;7788.532688038736;7863.095743989515;8026.959865200637;8554;12214.633560993185;12220.205686630341;12540.435680394221;12717.491300348252;5575.77696892136;8406.369522285731;9444.52777361143;10746.83879741789;10788.838167427339;10709.518071686636;10761;10838.945805270923;10908.563657453931;11023.228374013743;10733.355998640107;10826.079783218514;10858.891411085788;11305.095592352756;11438.485268163118;7445.808670612676;7967.083785364757;8003.3597312213715;8101.149379315087;8355.540445275568;9510.38182518134;10815.188860835311;10994.120470362512;11021.779564408827;11138.777224455627 05:52:25 INFO - PROCESS | 1972 | |3;mootools.html;1447.6308541321962;1635.6810421967716;1872.4382685194446;1944.3777991042855;1952.4923519884835;7787.7274295399675;8370.204830541097;8429.578521073952;8849.292056635462;8869.733907982763;8541.017782954961;8567.485950842954;8716.997545282295;8731.650733970633;8750.562471876412;2386.3556839653324;2415.6738840256517;2416.516696660666;2416.903323867043;2421.987890060547;2341.239097293378;2392.85642861428;2413.3725231439776;2423.563758523465;2427.635854621803;2398.760123987605;2400.3999000249937;2405.1101092595763;2416.3717433467336;2422.0675040109595;1863.683173860447;1928.8360489358422;2312.3063081075693;2364;2401.4236583220077;2328.5459335429596;2336.824738144646;2354.917577884783;2379.940501487459;2382.7140743110936;6635.170603674541;8360.916390836075;8614.913850861536;8619.913800862036;8704.303655707592;5182.170852663556;5348.384935732402;5356.6518176318805;5366.91949620756;5373.623846330758;3345.364380767671;3468.4623883298127;3525.065857547752;3535.8939231823088;3541.1678255609913;870.9346798990101;1010.8786945566505;1017.4048181813648;1017.6183931025865;1028.8096702110133;11270.323780573191;11282.830757538644;11422.771544569145;11425.771484570261;11456.656300311004;4461.531539188339;4540.273556230987;4571.9085618287445;4630.21286381316;4657.371254880615;7619;8898.955505222562;9002.684906028258;9028.774280643036;9038.502882341534;4429.512753597101;4591.173588754056;4688.898108944395;5165.225216217522;5232.686038837682;4048.5344185418467;4326.286162783168;4838.685485443435;4841.176999910023;4914.950850491521;3736.7944763038295;3776.4524143998965;3786.469894214812;3879.922401551953;3888.319544079775;1169.5789515774316;1183.8638556565934;1184.1651635596884;1192.7375977284983;1203.9518419263306;873.2490058549643;920.9125133112343;936.0732874454377;951.3816019587185;973.6251543155794;5760.798372057042;5907.497862681635;5927.407259274038;5994.580379373489;6025.849353766191;398.62330098057635;424.4100700026965;437.5230998211964;447.6307046686497;455.77666943198255;3820.006798232424;3982.7411218270718;4013;4034.2133284009924;4083.8774836754947;8931.19619234272;10465.9476702616;10534.631287904887;10564.260501764802;10605.25763196569;10552.525136368882;10560.049595536439;10647.30792498485;10683.664541932258;10691.144708423308;7943.64253608589;8117.512949223065;8128.065272493739;8163.755087347389;8231.629576669064;5839.766409343579;5851.414858514285;5918.17145599625;5949.583529152917;5974.163617093697;9748.658796942073;9849.310548261554;9889.950550247202;9942.552585133832;9967.850482242628;9429;9859.408435493893;9881.95059024729;10243.539040743333;10247.48762561854;6391.552591318563;6765.594064356154;6973.302669732986;6987.196472405739;7043.542169758949;8257.42198046131;8303.04514980785;8324.292435143081;8341.916580834113;8406.495610263404;7320.26797320285;7436.73971410998;7440.516366436164;7573.2048134947245;7589.848203036019;7234.819129521804;7265.963670181615;7344.779656610311;7359.227281135403;7360.374368178765;6896.551724137915;6957.060796792571;6996.405305549085;7000.754973576104;7026.156861176692;3996.480457540501;4711.293306004127;4819.660555066578;4949.059678661043;5030.37120359955;4966.652334336562;4976.154053810933;5021.322121513695;5074.264231686311;5218.347706536683 05:52:25 INFO - PROCESS | 1972 | |4;prototype.html;299.2653036794669;316.439901374567;317.6331337305413;320.7914855344026;322.69182930301565;4568.812108851702;4864.294677271793;5391.541718953888;5479.849231661346;5585.849447962533;4175.037732265838;4830.758462076899;4946.597528199905;5503.559715222783;5505.614606977513;3558.7508874378805;3715.9628403715956;4147.900806286337;4182.769947652878;4190.895227619303;3338.479448016744;3342.9498557521533;3694.150345420555;4183.138503365988;4188.72773269738;3352.7988320700715;3688.5020522229556;3825.6854602965223;4133.669306455491;4176.436181115556;4055.695822813271;4161.771102589357;4182.393552934807;4190.559991200926;4191.538930717618;3060.9540856887165;3342.348242092793;3572.338862428957;3588.2644057968314;3624.9275014499826;4244.87265382039;4769.737664428455;5232.816851410183;5253.395859476171;5294.444083371229;3957.9907123683274;4515.277555591089;4691.62467002639;4821.662483626147;4848.200046992242;4771;5142.254373115915;5282.57370509964;5328.706921119337;5759.539236861041;3301.504774283853;3592.4072528032843;4012.799360031987;4034.374671925856;4050.0482386639114;4919.671688644082;5268.341457317873;5888.701248088876;6035.7283922223605;6112.51099912006;3820.369639009588;3822.5412950446125;4050.18996200761;4093.63157315843;4122.711410201317;3667.339878821784;4115.1975364804175;4145.274576949022;4170.749755014709;4178.979105104455;4783.904321913542;4792.603698150924;4833.879153021132;4844.95155048445;4849.345338379274;4904.656674032854;5245.3088399086655;5411.458854114557;5456.599096397573;5458.37997761069;1149.965031471682;1268.7081971146688;1302.3358087375507;1311.9081664283408;1345.3004437692541;804.4047404920434;870.4385671242013;916.1022198245756;925.5372313843078;939.0421769794771;4514.300283456069;4899.456671148577;5262.2632831403635;5323.920141197885;5410.891782164414;5412.810551630674;5596.692181930033;5598.300212473441;6039.275286965592;6089.908651370233;4509.616682582017;4575.2450845610765;4634.814607415666;4887.022595480918;5350.732463376816;2822.520171570838;2929.3555417808047;2997.1567485995956;3008.9398212035635;3022.9546556801665;5099.413567439792;5589.8602534936135;5781.207825574002;5854.268216472941;5958.6722730249385;5244.662611034162;5557.277553918046;5875.764969401176;5888.941110588925;6026;5013.523715247045;5667.093265077568;5834.737436815353;6021.42796434338;6068.878622427526;5060.367454068241;5297.973510132425;5305.389880163676;5368;5697.145428185805;5082.288479612783;5169.92245116316;5230.626246071187;5675.112547904699;5763.94236057634;5064.924026139684;5457;5503.504684578407;5878.707304151299;6045.848853778691;3254.1701866024014;3611.5124458197806;3687.446882967469;3857.363535016803;3889.5915928827067;4985.675931064469;5157.638965272395;5322.813701520428;5483.75323110453;5952.821415357546;5329.893402132013;5562.969516126665;5739.044392137969;5819.854503637443;5820.214271073351;5291.788328466818;5438.320209973754;5686.730130175083;5728.140778883201;5761.567882408753;4723.291506273949;4851.539103785276;5552.33371995347;5571.275734154696;5603.7758489659955;5565.38780734127;5686.810577927445;5787.016207244863;5789.305283366023;5802.390748971297;5033.043721692867;5272.367315922113;5553.750081246434;5676.460736230051;5741.770329186786 05:52:25 INFO - PROCESS | 1972 | |5;yui.html;592.4075924075925;651.5113664751433;659.7782907185248;698.4342682427233;706.0292098364748;12162.817557736642;12499.43752531136;15031.872609554286;15229.39082436704;15405.768913466307;13968.092074015181;14923.179225142612;15440.84559154408;15448.459303924365;15760;918.0773322810566;920.2591913509622;926.865604487349;928.5078908178676;928.8838895138108;708.6315116139605;897.5198268926126;919.2140719684674;924.2652091587171;926.5691453474133;964.6961207219739;965.377331621104;966.2897770138942;969.7866469376726;971.3249291742242;931.2270815223416;964.0118878149917;965.0446058402166;965.3098034905041;965.3918031640022;701.7614011236204;710.0698085508001;714.5319815520842;715.2561336210387;716.29087203668;14738.926305368404;14757.704845903128;14928.552143435605;15066.472673456487;15117.319720612599;12111.757764844742;12130.393480325949;12134.453949572291;12137.393130343447;12248.571300004547;9604.855927161097;9657.275704322134;9855.162311203556;9946.30375873689;9947.552360143738;3371.7976921384798;3421.9657803421896;3424.109731469811;3445.104272889067;3513.472979053137;87276;88297;89108.55445722795;89388.65917011185;90320.54839725759;9088.545572721338;9093.454392736458;9095.681651142178;9151.771205719777;9452.43285402878;19966.90016549908;20358.796412035987;20644;20937.685934710993;20938.895305523376;7330.743423980135;7336.2296958819625;7366.852662946818;7413.777586672409;7477.36442402391;3964.4053391991433;4022.8390864365097;4034.2133284009337;4035.576264492186;4036;3441.3633477806684;3550.3964326064115;3555.2711694102645;3559.3059353425833;3564.572251329857;618.4217756397693;628.6950828848005;637.5791977294963;647.1910112359551;647.6308504152588;481.838584074332;560.0854971500963;565.7271139935145;572.9140628905698;585.2771826793906;6572.868542629216;8093.773943500792;8140.75577732669;8275.83448331042;8308.418410711192;481.379021062832;545.26661640094;571.4770984549091;578.6238944685988;592.7865968251426;3860.652541271299;3875.5155605549307;3907.9804600976813;3913.9021524462114;3933.1347103637154;70268.64865675638;85959.71060434099;86045.1395486037;86250.46728971963;86981.52073917098;80140;81351.7797233042;82213;82724;82800.58599706963;72707.63646181735;73956.26043739602;73983.63008184925;74991;75224.24775752283;7356.117265928123;7551.433642476726;7737.92262077372;7796.10344810354;7952.125266220827;36047.81976090103;39418.802905985285;43517.129657407306;43692.90767730832;44756.77621611871;58958.70520647369;59124.70437647784;59154.40845591489;59327;59714.70142649259;8934.240589549961;10600.416977066336;10642.148628109579;10965.561377545127;11362.602308919148;11993.520259189883;11996.820047699466;12138.514459421878;12329.383530823243;12460.937695311466;11307.265027773168;11418.31490110596;11584.884151158381;11736.530538778354;11984.161108722306;10296.124829389586;10989.725256868322;11522.596709115141;11786.941065294961;11898.280589568589;11119;11192.022633088653;11478.598249061242;11537.711557211136;11549.595764148215;9354.95322523383;9563.856542152012;9671.758206044624;9866.161376283097;9941.850872237066;8987.595558199766;9546.093121153479;9619.807603848023;9645.758856028655;9703.320767546204 05:52:25 INFO - PROCESS | 1972 | __end_tp_report 05:52:25 INFO - PROCESS | 1972 | __start_cc_report 05:52:25 INFO - PROCESS | 1972 | _x_x_mozilla_cycle_collect,423 05:52:25 INFO - PROCESS | 1972 | __end_cc_report 05:52:25 INFO - PROCESS | 1972 | __startTimestamp1462884745505__endTimestamp 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | ------- Summary: start ------- 05:52:25 INFO - PROCESS | 1972 | Number of tests: 6 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | [#0] dojo.html Cycles:165 Average:5753.10 Median:5998.82 stddev:774.50 (12.9%) stddev-sans-first:753.91 05:52:25 INFO - PROCESS | 1972 | Values: 3367.0 3490.5 3490.8 3505.0 3511.5 4960.7 5646.5 5895.7 5904.1 5942.1 4937.5 5018.6 5721.9 5909.9 5999.8 5232.0 5296.8 5374.8 5376.1 5430.6 118.0 5232.3 5325.8 5336.9 5339.9 4906.7 5024.7 5317.1 5321.4 5368.8 5338.8 5349.1 5364.1 5370.4 5411.3 5195.3 5211.5 5259.7 5296.2 5319.0 5677.5 5784.4 5811.6 5835.1 5840.8 6172.6 6173.8 6191.3 6245.4 6250.1 5359.9 6173.3 6207.8 6269.9 6282.2 5952.0 5972.6 5983.7 5986.7 5991.9 6172.5 6230.5 6277.2 6328.6 6347.2 6140.5 6155.5 6234.8 6242.5 6278.2 6206.4 6220.1 6272.7 6297.2 6315.3 5920.6 6147.4 6182.4 6205.6 6210.2 5899.4 6210.7 6226.5 6230.5 6231.2 4969.7 4993.3 4994.0 5000.3 5008.2 4381.3 4396.8 4404.1 4435.9 4519.4 5905.4 5929.9 5967.5 5998.8 6061.6 6277.8 6279.0 6290.1 6292.3 6336.4 5790.5 5836.1 5849.7 5851.2 5885.1 5438.1 5443.3 5459.7 5464.8 5472.5 6309.6 6312.3 6357.2 6437.7 6488.2 6205.7 6246.7 6260.7 6265.7 6279.5 6283.8 6332.9 6448.3 6448.5 6488.5 6155.7 6185.9 6255.6 6258.4 6263.8 5308.3 5433.6 6270.0 6313.2 6327.5 6121.1 6155.7 6177.5 6262.8 6263.6 5659.8 5862.0 6208.1 6223.6 6223.8 6045.7 6085.7 6160.6 6185.9 6236.4 5730.5 5898.7 6160.8 6200.0 6206.3 5889.5 6106.8 6176.2 6190.0 6195.5 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | [#1] ext.html Cycles:180 Average:70549.85 Median:40189.80 stddev:152188.96 (378.7%) stddev-sans-first:152524.98 05:52:25 INFO - PROCESS | 1972 | Values: 485.6 496.2 514.4 519.7 543.1 32832.5 41718.4 41972.0 41993.2 42231.6 37662.2 41533.0 42543.8 42852.0 42869.0 9551.5 9649.0 9697.5 9741.8 9745.6 9523.5 9572.6 9583.8 9605.0 9668.9 9640.7 9650.1 9690.3 9693.8 9703.5 9536.2 9624.2 9665.0 9684.9 9686.6 9562.0 9626.9 9646.7 9670.7 9684.6 39173.0 39186.0 39278.4 39405.8 39703.4 3156.8 3347.9 3422.4 3438.5 3642.4 28705.6 30112.0 30361.5 30397.8 30447.0 2651.7 2660.4 2833.4 2835.4 2842.7 428120.0 499144.0 505226.0 508283.5 510484.0 64737.7 65323.1 65333.3 65546.7 65685.7 69352.0 69609.0 69890.7 70093.0 70120.9 16404.3 16412.3 16931.3 16964.7 16970.0 12564.4 12781.8 12923.7 13046.0 13047.7 14724.3 17063.7 18459.4 18866.0 18939.7 6561.1 6613.0 6627.5 6657.3 6716.7 853.3 913.9 994.7 1040.6 1193.9 29466.9 29745.6 29896.7 30417.5 30548.5 1020.6 1102.3 1172.5 1188.8 1190.3 14572.5 15071.1 15373.3 15405.1 15436.5 634339.0 646171.0 650783.5 651704.0 652249.0 60919.0 61440.2 61552.0 61822.4 61986.4 1297.6 1299.4 1447.4 1459.8 1467.0 28617.0 28738.7 29303.3 29412.7 29458.0 51884.5 52702.0 52804.0 53320.0 53372.5 554850.0 555213.0 562311.0 564178.0 565054.0 33778.2 39881.6 40498.0 40777.0 41574.8 40950.8 44685.3 46220.3 46496.8 46553.5 33086.8 38056.8 38773.4 38795.0 39668.8 37467.0 37883.2 38413.8 38486.0 38982.2 31692.8 37277.4 37949.0 38497.7 38545.2 30106.2 32661.5 33850.5 34162.3 34203.5 24497.9 24942.4 25015.1 25473.9 25608.6 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | [#2] jquery.html Cycles:180 Average:35343.79 Median:2859.16 stddev:102956.64 (3600.9%) stddev-sans-first:103211.95 05:52:25 INFO - PROCESS | 1972 | Values: 360.6 385.8 390.0 403.5 412.9 18738.0 20931.4 21937.9 21950.9 22121.9 21463.0 21473.8 21964.3 22163.9 22214.7 5745.7 6053.8 6059.6 6063.3 6079.2 4120.0 5883.8 6247.5 6604.2 6624.3 6541.1 6548.1 6566.8 6620.9 6621.0 6601.3 6615.1 6615.8 6625.2 6640.5 5638.2 5751.2 5786.6 5851.8 5852.2 26867.9 26958.6 27008.9 27110.3 27354.9 2247.5 2411.7 2762.4 2856.9 2861.4 9578.8 9786.8 10207.4 14267.1 14547.9 1695.2 1711.1 1720.9 1729.5 1814.6 112294.0 130322.3 130920.3 134518.3 135275.3 9718.4 11460.1 11569.3 11762.1 11909.8 14529.2 14570.6 14589.0 14798.5 14934.0 7386.2 8579.1 8798.0 8827.6 8909.1 8587.3 8604.3 8695.8 8708.0 8745.3 3994.2 4422.8 4582.5 4615.1 4621.7 1808.2 1830.4 1977.0 1983.4 2000.7 854.4 919.5 985.3 992.3 1042.5 19411.5 21048.0 21190.0 21209.9 21340.9 964.0 965.4 986.8 1019.8 1023.2 10833.4 10849.0 11182.9 11248.2 11282.9 472402.0 640224.0 643946.0 655028.0 659274.0 75674.0 76435.6 109587.0 133662.0 135807.6 926.3 1028.1 1055.2 1060.5 1091.3 17630.5 19066.3 19204.6 19278.4 19315.7 40916.2 53527.3 54325.9 54585.0 54708.7 79959.0 80785.0 83027.6 83221.6 83339.6 7476.3 7701.9 7788.5 7863.1 8027.0 8554.0 12214.6 12220.2 12540.4 12717.5 5575.8 8406.4 9444.5 10746.8 10788.8 10709.5 10761.0 10838.9 10908.6 11023.2 10733.4 10826.1 10858.9 11305.1 11438.5 7445.8 7967.1 8003.4 8101.1 8355.5 9510.4 10815.2 10994.1 11021.8 11138.8 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | [#3] mootools.html Cycles:180 Average:5564.85 Median:4932.01 stddev:3117.07 (63.2%) stddev-sans-first:3110.45 05:52:25 INFO - PROCESS | 1972 | Values: 1447.6 1635.7 1872.4 1944.4 1952.5 7787.7 8370.2 8429.6 8849.3 8869.7 8541.0 8567.5 8717.0 8731.7 8750.6 2386.4 2415.7 2416.5 2416.9 2422.0 2341.2 2392.9 2413.4 2423.6 2427.6 2398.8 2400.4 2405.1 2416.4 2422.1 1863.7 1928.8 2312.3 2364.0 2401.4 2328.5 2336.8 2354.9 2379.9 2382.7 6635.2 8360.9 8614.9 8619.9 8704.3 5182.2 5348.4 5356.7 5366.9 5373.6 3345.4 3468.5 3525.1 3535.9 3541.2 870.9 1010.9 1017.4 1017.6 1028.8 11270.3 11282.8 11422.8 11425.8 11456.7 4461.5 4540.3 4571.9 4630.2 4657.4 7619.0 8899.0 9002.7 9028.8 9038.5 4429.5 4591.2 4688.9 5165.2 5232.7 4048.5 4326.3 4838.7 4841.2 4915.0 3736.8 3776.5 3786.5 3879.9 3888.3 1169.6 1183.9 1184.2 1192.7 1204.0 873.2 920.9 936.1 951.4 973.6 5760.8 5907.5 5927.4 5994.6 6025.8 398.6 424.4 437.5 447.6 455.8 3820.0 3982.7 4013.0 4034.2 4083.9 8931.2 10465.9 10534.6 10564.3 10605.3 10552.5 10560.0 10647.3 10683.7 10691.1 7943.6 8117.5 8128.1 8163.8 8231.6 5839.8 5851.4 5918.2 5949.6 5974.2 9748.7 9849.3 9890.0 9942.6 9967.9 9429.0 9859.4 9882.0 10243.5 10247.5 6391.6 6765.6 6973.3 6987.2 7043.5 8257.4 8303.0 8324.3 8341.9 8406.5 7320.3 7436.7 7440.5 7573.2 7589.8 7234.8 7266.0 7344.8 7359.2 7360.4 6896.6 6957.1 6996.4 7000.8 7026.2 3996.5 4711.3 4819.7 4949.1 5030.4 4966.7 4976.2 5021.3 5074.3 5218.3 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | [#4] prototype.html Cycles:180 Average:4524.52 Median:5046.71 stddev:1389.63 (27.5%) stddev-sans-first:1356.86 05:52:25 INFO - PROCESS | 1972 | Values: 299.3 316.4 317.6 320.8 322.7 4568.8 4864.3 5391.5 5479.8 5585.8 4175.0 4830.8 4946.6 5503.6 5505.6 3558.8 3716.0 4147.9 4182.8 4190.9 3338.5 3342.9 3694.2 4183.1 4188.7 3352.8 3688.5 3825.7 4133.7 4176.4 4055.7 4161.8 4182.4 4190.6 4191.5 3061.0 3342.3 3572.3 3588.3 3624.9 4244.9 4769.7 5232.8 5253.4 5294.4 3958.0 4515.3 4691.6 4821.7 4848.2 4771.0 5142.3 5282.6 5328.7 5759.5 3301.5 3592.4 4012.8 4034.4 4050.0 4919.7 5268.3 5888.7 6035.7 6112.5 3820.4 3822.5 4050.2 4093.6 4122.7 3667.3 4115.2 4145.3 4170.7 4179.0 4783.9 4792.6 4833.9 4845.0 4849.3 4904.7 5245.3 5411.5 5456.6 5458.4 1150.0 1268.7 1302.3 1311.9 1345.3 804.4 870.4 916.1 925.5 939.0 4514.3 4899.5 5262.3 5323.9 5410.9 5412.8 5596.7 5598.3 6039.3 6089.9 4509.6 4575.2 4634.8 4887.0 5350.7 2822.5 2929.4 2997.2 3008.9 3023.0 5099.4 5589.9 5781.2 5854.3 5958.7 5244.7 5557.3 5875.8 5888.9 6026.0 5013.5 5667.1 5834.7 6021.4 6068.9 5060.4 5298.0 5305.4 5368.0 5697.1 5082.3 5169.9 5230.6 5675.1 5763.9 5064.9 5457.0 5503.5 5878.7 6045.8 3254.2 3611.5 3687.4 3857.4 3889.6 4985.7 5157.6 5322.8 5483.8 5952.8 5329.9 5563.0 5739.0 5819.9 5820.2 5291.8 5438.3 5686.7 5728.1 5761.6 4723.3 4851.5 5552.3 5571.3 5603.8 5565.4 5686.8 5787.0 5789.3 5802.4 5033.0 5272.4 5553.8 5676.5 5741.8 05:52:25 INFO - PROCESS | 1972 | 05:52:25 INFO - PROCESS | 1972 | [#5] yui.html Cycles:180 Average:17926.44 Median:623.56 stddev:25456.30 (4082.4%) stddev-sans-first:25494.43 05:52:25 INFO - PROCESS | 1972 | Values: 592.4 651.5 659.8 698.4 706.0 12162.8 12499.4 15031.9 15229.4 15405.8 13968.1 14923.2 15440.8 15448.5 15760.0 918.1 920.3 926.9 928.5 928.9 708.6 897.5 919.2 924.3 926.6 964.7 965.4 966.3 969.8 971.3 931.2 964.0 965.0 965.3 965.4 701.8 710.1 714.5 715.3 716.3 14738.9 14757.7 14928.6 15066.5 15117.3 12111.8 12130.4 12134.5 12137.4 12248.6 9604.9 9657.3 9855.2 9946.3 9947.6 3371.8 3422.0 3424.1 3445.1 3513.5 87276.0 88297.0 89108.6 89388.7 90320.5 9088.5 9093.5 9095.7 9151.8 9452.4 19966.9 20358.8 20644.0 20937.7 20938.9 7330.7 7336.2 7366.9 7413.8 7477.4 3964.4 4022.8 4034.2 4035.6 4036.0 3441.4 3550.4 3555.3 3559.3 3564.6 618.4 628.7 637.6 647.2 647.6 481.8 560.1 565.7 572.9 585.3 6572.9 8093.8 8140.8 8275.8 8308.4 481.4 545.3 571.5 578.6 592.8 3860.7 3875.5 3908.0 3913.9 3933.1 70268.6 85959.7 86045.1 86250.5 86981.5 80140.0 81351.8 82213.0 82724.0 82800.6 72707.6 73956.3 73983.6 74991.0 75224.2 7356.1 7551.4 7737.9 7796.1 7952.1 36047.8 39418.8 43517.1 43692.9 44756.8 58958.7 59124.7 59154.4 59327.0 59714.7 8934.2 10600.4 10642.1 10965.6 11362.6 11993.5 11996.8 12138.5 12329.4 12460.9 11307.3 11418.3 11584.9 11736.5 11984.2 10296.1 10989.7 11522.6 11786.9 11898.3 11119.0 11192.0 11478.6 11537.7 11549.6 9355.0 9563.9 9671.8 9866.2 9941.9 8987.6 9546.1 9619.8 9645.8 9703.3 05:52:25 INFO - PROCESS | 1972 | -------- Summary: end -------- 05:52:25 INFO - PROCESS | 1972 | 05:52:26 INFO - TEST-INFO | 1972: exit 0 05:52:26 INFO - TEST-OK | dromaeo_css | took 1111872ms 05:52:26 INFO - TEST-START | kraken 05:52:26 INFO - operating with platform_type : mac_ 05:52:26 INFO - Initialising browser for kraken test... 05:52:26 INFO - TEST-INFO | started process 1978 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpubhHPP/profile http://localhost:49513/getInfo.html) 05:52:28 INFO - PROCESS | 1978 | __metrics Screen width/height:1600/1200 05:52:28 INFO - PROCESS | 1978 | colorDepth:24 05:52:28 INFO - PROCESS | 1978 | Browser inner width/height: 1024/689 05:52:28 INFO - PROCESS | 1978 | __metrics 05:52:28 ERROR - PROCESS | 1978 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 05:52:29 INFO - TEST-INFO | 1978: exit 0 05:52:29 INFO - Browser initialized. 05:52:29 INFO - Running cycle 1/1 for kraken test... 05:52:29 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpubhHPP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:41 INFO - PROCESS | 1981 | RSS: Main: 249466880 05:52:41 INFO - PROCESS | 1981 | 05:52:44 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49513/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:45 INFO - PROCESS | 1981 | RSS: Main: 261419008 05:52:45 INFO - PROCESS | 1981 | 05:52:48 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49513/tests/kraken/driver.html?testName=audio-dft) 05:52:48 INFO - PROCESS | 1981 | RSS: Main: 266244096 05:52:48 INFO - PROCESS | 1981 | 05:52:52 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49513/tests/kraken/driver.html?testName=audio-fft) 05:52:52 INFO - PROCESS | 1981 | RSS: Main: 266620928 05:52:52 INFO - PROCESS | 1981 | 05:52:54 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49513/tests/kraken/driver.html?testName=audio-oscillator) 05:52:55 INFO - PROCESS | 1981 | RSS: Main: 267276288 05:52:55 INFO - PROCESS | 1981 | 05:52:57 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49513/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:58 INFO - PROCESS | 1981 | RSS: Main: 267747328 05:52:58 INFO - PROCESS | 1981 | 05:53:01 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49513/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:02 INFO - PROCESS | 1981 | RSS: Main: 267534336 05:53:02 INFO - PROCESS | 1981 | 05:53:05 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49513/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:05 INFO - PROCESS | 1981 | RSS: Main: 268185600 05:53:05 INFO - PROCESS | 1981 | 05:53:09 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49513/tests/kraken/driver.html?testName=json-parse-financial) 05:53:09 INFO - PROCESS | 1981 | RSS: Main: 267833344 05:53:09 INFO - PROCESS | 1981 | 05:53:11 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49513/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:12 INFO - PROCESS | 1981 | RSS: Main: 267956224 05:53:12 INFO - PROCESS | 1981 | 05:53:13 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:14 INFO - PROCESS | 1981 | RSS: Main: 267931648 05:53:14 INFO - PROCESS | 1981 | 05:53:17 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:17 INFO - PROCESS | 1981 | RSS: Main: 268120064 05:53:17 INFO - PROCESS | 1981 | 05:53:20 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:21 INFO - PROCESS | 1981 | RSS: Main: 268005376 05:53:21 INFO - PROCESS | 1981 | 05:53:24 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:25 INFO - PROCESS | 1981 | RSS: Main: 268136448 05:53:25 INFO - PROCESS | 1981 | 05:53:26 INFO - PROCESS | 1981 | Cycle 1(1): loaded http://localhost:49513/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49513/tests/kraken/driver.html?testName=ai-astar) 05:53:27 INFO - PROCESS | 1981 | RSS: Main: 270475264 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | __start_tp_report 05:53:27 INFO - PROCESS | 1981 | _x_x_mozilla_page_load 05:53:27 INFO - PROCESS | 1981 | _x_x_mozilla_page_load_details 05:53:27 INFO - PROCESS | 1981 | |i|pagename|runs| 05:53:27 INFO - PROCESS | 1981 | |0;ai-astar;116;119;108;116;118;116;108;117;116;117 05:53:27 INFO - PROCESS | 1981 | |1;audio-beat-detection;186;111;137;209;123;137;168;139;197;127 05:53:27 INFO - PROCESS | 1981 | |2;audio-dft;199;205;214;214;207;197;228;267;210;200 05:53:27 INFO - PROCESS | 1981 | |3;audio-fft;72;80;76;178;58;59;61;70;152;77 05:53:27 INFO - PROCESS | 1981 | |4;audio-oscillator;84;93;161;104;110;107;126;84;80;128 05:53:27 INFO - PROCESS | 1981 | |5;imaging-gaussian-blur;92;117;91;89;92;109;122;90;123;121 05:53:27 INFO - PROCESS | 1981 | |6;imaging-darkroom;98;99;98;97;96;98;98;98;98;97 05:53:27 INFO - PROCESS | 1981 | |7;imaging-desaturate;91;90;91;91;109;131;98;76;139;139 05:53:27 INFO - PROCESS | 1981 | |8;json-parse-financial;62;62;63;62;62;62;62;122;78;80 05:53:27 INFO - PROCESS | 1981 | |9;json-stringify-tinderbox;69;67;75;79;77;71;67;70;69;71 05:53:27 INFO - PROCESS | 1981 | |10;stanford-crypto-aes;101;77;110;77;94;101;101;104;77;104 05:53:27 INFO - PROCESS | 1981 | |11;stanford-crypto-ccm;163;160;155;141;161;140;125;159;248;172 05:53:27 INFO - PROCESS | 1981 | |12;stanford-crypto-pbkdf2;177;184;218;171;169;168;174;173;169;169 05:53:27 INFO - PROCESS | 1981 | |13;stanford-crypto-sha256-iterative;67;68;66;69;68;66;67;80;92;81 05:53:27 INFO - PROCESS | 1981 | __end_tp_report 05:53:27 INFO - PROCESS | 1981 | __start_cc_report 05:53:27 INFO - PROCESS | 1981 | _x_x_mozilla_cycle_collect,1093 05:53:27 INFO - PROCESS | 1981 | __end_cc_report 05:53:27 INFO - PROCESS | 1981 | __startTimestamp1462884807199__endTimestamp 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | ------- Summary: start ------- 05:53:27 INFO - PROCESS | 1981 | Number of tests: 14 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.50 stddev:3.87 (3.3%) stddev-sans-first:4.09 05:53:27 INFO - PROCESS | 1981 | Values: 116.0 119.0 108.0 116.0 118.0 116.0 108.0 117.0 116.0 117.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:153.50 stddev:34.05 (22.2%) stddev-sans-first:34.01 05:53:27 INFO - PROCESS | 1981 | Values: 186.0 111.0 137.0 209.0 123.0 137.0 168.0 139.0 197.0 127.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#2] audio-dft Cycles:10 Average:214.10 Median:212.00 stddev:20.71 (9.8%) stddev-sans-first:21.24 05:53:27 INFO - PROCESS | 1981 | Values: 199.0 205.0 214.0 214.0 207.0 197.0 228.0 267.0 210.0 200.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#3] audio-fft Cycles:10 Average:88.30 Median:71.00 stddev:41.60 (58.6%) stddev-sans-first:43.70 05:53:27 INFO - PROCESS | 1981 | Values: 72.0 80.0 76.0 178.0 58.0 59.0 61.0 70.0 152.0 77.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#4] audio-oscillator Cycles:10 Average:107.70 Median:120.50 stddev:25.20 (20.9%) stddev-sans-first:25.22 05:53:27 INFO - PROCESS | 1981 | Values: 84.0 93.0 161.0 104.0 110.0 107.0 126.0 84.0 80.0 128.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#5] imaging-gaussian-blur Cycles:10 Average:104.60 Median:89.50 stddev:15.06 (16.8%) stddev-sans-first:15.27 05:53:27 INFO - PROCESS | 1981 | Values: 92.0 117.0 91.0 89.0 92.0 109.0 122.0 90.0 123.0 121.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#6] imaging-darkroom Cycles:10 Average:97.70 Median:98.00 stddev:0.82 (0.8%) stddev-sans-first:0.87 05:53:27 INFO - PROCESS | 1981 | Values: 98.0 99.0 98.0 97.0 96.0 98.0 98.0 98.0 98.0 97.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#7] imaging-desaturate Cycles:10 Average:105.50 Median:90.50 stddev:22.86 (25.3%) stddev-sans-first:23.64 05:53:27 INFO - PROCESS | 1981 | Values: 91.0 90.0 91.0 91.0 109.0 131.0 98.0 76.0 139.0 139.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#8] json-parse-financial Cycles:10 Average:71.50 Median:62.00 stddev:19.09 (30.8%) stddev-sans-first:19.93 05:53:27 INFO - PROCESS | 1981 | Values: 62.0 62.0 63.0 62.0 62.0 62.0 62.0 122.0 78.0 80.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.00 stddev:4.14 (5.8%) stddev-sans-first:4.29 05:53:27 INFO - PROCESS | 1981 | Values: 69.0 67.0 75.0 79.0 77.0 71.0 67.0 70.0 69.0 71.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:93.50 stddev:12.76 (13.7%) stddev-sans-first:13.33 05:53:27 INFO - PROCESS | 1981 | Values: 101.0 77.0 110.0 77.0 94.0 101.0 101.0 104.0 77.0 104.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:160.50 stddev:33.09 (20.6%) stddev-sans-first:35.09 05:53:27 INFO - PROCESS | 1981 | Values: 163.0 160.0 155.0 141.0 161.0 140.0 125.0 159.0 248.0 172.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:173.50 stddev:15.14 (8.7%) stddev-sans-first:16.06 05:53:27 INFO - PROCESS | 1981 | Values: 177.0 184.0 218.0 171.0 169.0 168.0 174.0 173.0 169.0 169.0 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - PROCESS | 1981 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:68.50 stddev:8.86 (12.9%) stddev-sans-first:9.18 05:53:27 INFO - PROCESS | 1981 | Values: 67.0 68.0 66.0 69.0 68.0 66.0 67.0 80.0 92.0 81.0 05:53:27 INFO - PROCESS | 1981 | -------- Summary: end -------- 05:53:27 INFO - PROCESS | 1981 | 05:53:27 INFO - TEST-INFO | 1981: exit 0 05:53:27 INFO - TEST-OK | kraken | took 61958ms 05:53:27 INFO - SUITE-END | took 1173s 05:53:28 INFO - Completed test suite (00:19:34) 05:53:28 INFO - javascript benchmark 05:53:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.973073212669, 3490.5462289902307, 3490.8429120689566, 3504.9649503504957, 3511.4557243627237, 4960.727160006199, 5646.520045796107, 5895.675737834417, 5904.0553511438175, 5942.138389933462, 4937.481564435737, 5018.623603229763, 5721.856953576153, 5909.881802363951, 5999.820005399834, 5232.0, 5296.761645725952, 5374.811881584145, 5376.1129413646895, 5430.56555475561, 118.00464866797783, 5232.3459567554055, 5325.840224793243, 5336.893262134755, 5339.946600533984, 4906.72425169455, 5024.723640199788, 5317.149256119022, 5321.388040375348, 5368.758405871745, 5338.813141540028, 5349.117395629716, 5364.14173732201, 5370.4361042090795, 5411.323584551931, 5195.298634684307, 5211.478852114796, 5259.710715910624, 5296.2055691646565, 5319.0, 5677.545796336283, 5784.421557844224, 5811.622244554091, 5835.095560188178, 5840.795572154954, 6172.567920245585, 6173.753049878, 6191.349908259613, 6245.437910588023, 6250.093736408196, 5359.946400535984, 6173.259208894961, 6207.751689932397, 6269.87460250797, 6282.2147231596055, 5952.0476723724, 5972.641641501524, 5983.700814959235, 5986.670733109634, 5991.850203744898, 6172.537059720449, 6230.470410015199, 6277.24673039229, 6328.588641738273, 6347.174867267318, 6140.50424869748, 6155.538334624921, 6234.75060997555, 6242.500599951993, 6278.152449419361, 6206.441420272197, 6220.066989951543, 6272.686365681698, 6297.2128483939505, 6315.336889626615, 5920.644761314335, 6147.370946699129, 6182.381761823872, 6205.596636218631, 6210.223722034746, 5899.439553242435, 6210.689465526796, 6226.470749986302, 6230.470410015199, 6231.189945307081, 4969.726665033386, 4993.275974983607, 4993.950060499348, 5000.349954505891, 5008.198688209869, 4381.298992161239, 4396.846110386121, 4404.141192467502, 4435.911281774411, 4519.367288579601, 5905.43898329658, 5929.851753706105, 5967.462928336384, 5998.820035398945, 6061.605995610271, 6277.7993372936435, 6279.0, 6290.056491526308, 6292.276388215322, 6336.366363363719, 5790.536757059425, 5836.095405212199, 5849.6782676952325, 5851.180834683148, 5885.087811389241, 5438.129899216106, 5443.346798384219, 5459.69971651563, 5464.754086066137, 5472.5348345391085, 6309.621422714652, 6312.274088479791, 6357.205349331333, 6437.678116094083, 6488.15653964991, 6205.720742566686, 6246.718897649707, 6260.655663938345, 6265.686715664107, 6279.466245369194, 6283.7800676976085, 6332.873342533031, 6448.32292609288, 6448.548601597843, 6488.513361497812, 6155.72299246526, 6185.938140618537, 6255.56211065221, 6258.405451482102, 6263.843403914939, 5308.25684404176, 5433.56531477473, 6270.028145637251, 6313.210848643919, 6327.462165715966, 6121.117656725574, 6155.738073694972, 6177.536684748572, 6262.812115636538, 6263.561550691408, 5659.801906933238, 5861.9706901465215, 6208.1308616792785, 6223.564350495421, 6223.782167624111, 6045.730396616584, 6085.726142323518, 6160.568760186923, 6185.907211391743, 6236.407541283571, 5730.455606717355, 5898.675572843363, 6160.784372546939, 6200.046985199648, 6206.317305096526, 5889.52883769306, 6106.816795496142, 6176.166217560572, 6189.96905015472, 6195.504359651307], "value": 5708.091900003794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [485.5751217684524, 496.183777685707, 514.3776031002487, 519.7479222577052, 543.0686372870528, 32832.5075123873, 41718.374224386585, 41972.0, 41993.16013679725, 42231.577684223186, 37662.24675506495, 41533.0, 42543.787281063625, 42852.0, 42869.0, 9551.474668893225, 9648.98685638005, 9697.515124243795, 9741.805163896717, 9745.610175592969, 9523.476208808514, 9572.617095316178, 9583.760405989837, 9605.0, 9668.854967175497, 9640.662576809813, 9650.08324209199, 9690.273229507815, 9693.757656058584, 9703.466309352983, 9536.2371010319, 9624.181944534723, 9664.951675241578, 9684.903150968506, 9686.612535498572, 9562.0, 9626.903730962671, 9646.71059868198, 9670.70987870365, 9684.56419461126, 39173.0, 39186.0, 39278.410823837665, 39405.802970984965, 39703.40444893329, 3156.8263745493987, 3347.866085356583, 3422.366862130489, 3438.4670376091744, 3642.380795264785, 28705.569416458562, 30112.0, 30361.544576831366, 30397.848010759804, 30447.0, 2651.681798184211, 2660.441307325464, 2833.3624934389804, 2835.39039106591, 2842.7157284271616, 428120.0, 499144.0, 505226.0, 508283.4585827047, 510484.0, 64737.676311619085, 65323.08061516324, 65333.34666653273, 65546.67226663836, 65685.67157164184, 69352.0, 69609.0, 69890.65054674694, 70093.0, 70120.94818577725, 16404.343826247055, 16412.343506259855, 16931.322747090224, 16964.660706785795, 16970.0, 12564.371781410893, 12781.808272875729, 12923.741525169444, 13046.0, 13047.673808154872, 14724.33740481681, 17063.658726825393, 18459.353922612645, 18866.0, 18939.715904261448, 6561.114249576246, 6612.966935165389, 6627.469802415795, 6657.335666083479, 6716.697748601325, 853.3429259470173, 913.8811954446012, 994.7264502261936, 1040.6136647440048, 1193.8567371915426, 29466.852665736533, 29745.553816692765, 29896.701032989393, 30417.543736843523, 30548.54177187344, 1020.6427750287488, 1102.2725001499132, 1172.5309876049648, 1188.8454500914825, 1190.3036723516666, 14572.540477891462, 15071.09573425598, 15373.308201130976, 15405.148712821794, 15436.536903892676, 634339.0, 646171.0, 650783.4921650818, 651704.0, 652249.0, 60919.0, 61440.156795296214, 61552.0, 61822.38177618256, 61986.38013619806, 1297.6042307096427, 1299.3503248375812, 1447.442734547207, 1459.8248210214629, 1466.9926650366892, 28617.0, 28738.712612873605, 29303.267418314714, 29412.705872941, 29458.0, 51884.481155189475, 52702.0, 52804.0, 53320.0, 53372.4662753383, 554850.0, 555213.0, 562311.0, 564178.0, 565054.0, 33778.15554611154, 39881.60414385483, 40497.987550310296, 40777.0, 41574.79212604039, 40950.795246023576, 44685.32972005488, 46220.306695398926, 46496.7675161622, 46553.53446465492, 33086.83456582702, 38056.80971595124, 38773.41839872461, 38795.0, 39668.80165599269, 37467.0, 37883.24233515369, 38413.80793096017, 38486.0, 38982.220355593294, 31692.841535792173, 37277.440838387985, 37949.0, 38497.65258215949, 38545.22909541737, 30106.24734381658, 32661.510077349332, 33850.49224261687, 34162.31675366528, 34203.48694769531, 24497.877510612332, 24942.376440588403, 25015.12447064344, 25473.872630636728, 25608.61587076158], "value": 20122.83608711612, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.57092060448065, 385.77432202161737, 389.9883003509894, 403.4956304619226, 412.8823285363672, 18738.0, 20931.37205883822, 21937.890310548446, 21950.902454877272, 22121.889390553024, 21463.034163462642, 21473.785262147372, 21964.341069767932, 22163.891805409745, 22214.66677999831, 5745.7127143642965, 6053.75784968603, 6059.575829691923, 6063.302720187169, 6079.240094988127, 4119.97940010301, 5883.823485295448, 6247.468965137946, 6604.207495100594, 6624.304448032959, 6541.116949211843, 6548.083268342436, 6566.80299591013, 6620.933790662104, 6621.039949207386, 6601.2738598754095, 6615.106960560359, 6615.834604134887, 6625.204975402959, 6640.535162538624, 5638.238837756891, 5751.223584816038, 5786.623869448515, 5851.824445266649, 5852.180694702745, 26867.865660671767, 26958.5956210657, 27008.864955675293, 27110.32224194391, 27354.863225683945, 2247.4718441166315, 2411.746766589518, 2762.4475104979083, 2856.9285767855763, 2861.3848022675224, 9578.75476188098, 9786.75533111678, 10207.438590877498, 14267.07264027835, 14547.90890683203, 1695.2201987085955, 1711.0674682298177, 1720.8623310135285, 1729.5070904792074, 1814.6461440019202, 112294.0, 130322.3483882584, 130920.3453982724, 134518.32740836233, 135275.32362338126, 9718.368306060083, 11460.083193344512, 11569.305841649528, 11762.117841161948, 11909.821352679717, 14529.200893950723, 14570.562883113524, 14589.0, 14798.48205312809, 14934.029288096239, 7386.15059268191, 8579.056303806576, 8798.0, 8827.602757875911, 8909.064548222474, 8587.27008204297, 8604.311655067704, 8695.826083478421, 8708.0, 8745.344099192458, 3994.201159768058, 4422.823087076481, 4582.464874267092, 4615.076984603025, 4621.69958952667, 1808.2405389736343, 1830.3746750115442, 1976.9802301977084, 1983.4347211044783, 2000.6598878190453, 854.4446110028531, 919.5356345045709, 985.2659768472533, 992.3450522655013, 1042.5152304178594, 19411.51471213231, 21048.0, 21190.04644790988, 21209.89395053015, 21340.893295533424, 963.9710808675751, 965.4352203960761, 986.7502095222903, 1019.7807471393686, 1023.1712313026323, 10833.362305739995, 10849.0, 11182.888171118348, 11248.212625116163, 11282.94358528202, 472402.0, 640224.0, 643946.0, 655028.0, 659274.0, 75674.0, 76435.61782191053, 109587.0, 133662.0, 135807.567697291, 926.2589928057527, 1028.1158203944601, 1055.2402270365324, 1060.4962642744636, 1091.263397206898, 17630.471085867444, 19066.33267835619, 19204.615907682048, 19278.421647350602, 19315.710264345766, 40916.181676366905, 53527.32363381893, 54325.91348172935, 54585.0, 54708.72645636746, 79959.0, 80785.0, 83027.58486207531, 83221.58389208015, 83339.5833020831, 7476.289752473506, 7701.92298077012, 7788.532688038736, 7863.095743989515, 8026.959865200637, 8554.0, 12214.633560993185, 12220.205686630341, 12540.435680394221, 12717.491300348252, 5575.77696892136, 8406.369522285731, 9444.52777361143, 10746.83879741789, 10788.838167427339, 10709.518071686636, 10761.0, 10838.945805270923, 10908.563657453931, 11023.228374013743, 10733.355998640107, 10826.079783218514, 10858.891411085788, 11305.095592352756, 11438.485268163118, 7445.808670612676, 7967.083785364757, 8003.3597312213715, 8101.149379315087, 8355.540445275568, 9510.38182518134, 10815.188860835311, 10994.120470362512, 11021.779564408827, 11138.777224455627], "value": 9677.257848720767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.6308541321962, 1635.6810421967716, 1872.4382685194446, 1944.3777991042855, 1952.4923519884835, 7787.7274295399675, 8370.204830541097, 8429.578521073952, 8849.292056635462, 8869.733907982763, 8541.017782954961, 8567.485950842954, 8716.997545282295, 8731.650733970633, 8750.562471876412, 2386.3556839653324, 2415.6738840256517, 2416.516696660666, 2416.903323867043, 2421.987890060547, 2341.239097293378, 2392.85642861428, 2413.3725231439776, 2423.563758523465, 2427.635854621803, 2398.760123987605, 2400.3999000249937, 2405.1101092595763, 2416.3717433467336, 2422.0675040109595, 1863.683173860447, 1928.8360489358422, 2312.3063081075693, 2364.0, 2401.4236583220077, 2328.5459335429596, 2336.824738144646, 2354.917577884783, 2379.940501487459, 2382.7140743110936, 6635.170603674541, 8360.916390836075, 8614.913850861536, 8619.913800862036, 8704.303655707592, 5182.170852663556, 5348.384935732402, 5356.6518176318805, 5366.91949620756, 5373.623846330758, 3345.364380767671, 3468.4623883298127, 3525.065857547752, 3535.8939231823088, 3541.1678255609913, 870.9346798990101, 1010.8786945566505, 1017.4048181813648, 1017.6183931025865, 1028.8096702110133, 11270.323780573191, 11282.830757538644, 11422.771544569145, 11425.771484570261, 11456.656300311004, 4461.531539188339, 4540.273556230987, 4571.9085618287445, 4630.21286381316, 4657.371254880615, 7619.0, 8898.955505222562, 9002.684906028258, 9028.774280643036, 9038.502882341534, 4429.512753597101, 4591.173588754056, 4688.898108944395, 5165.225216217522, 5232.686038837682, 4048.5344185418467, 4326.286162783168, 4838.685485443435, 4841.176999910023, 4914.950850491521, 3736.7944763038295, 3776.4524143998965, 3786.469894214812, 3879.922401551953, 3888.319544079775, 1169.5789515774316, 1183.8638556565934, 1184.1651635596884, 1192.7375977284983, 1203.9518419263306, 873.2490058549643, 920.9125133112343, 936.0732874454377, 951.3816019587185, 973.6251543155794, 5760.798372057042, 5907.497862681635, 5927.407259274038, 5994.580379373489, 6025.849353766191, 398.62330098057635, 424.4100700026965, 437.5230998211964, 447.6307046686497, 455.77666943198255, 3820.006798232424, 3982.7411218270718, 4013.0, 4034.2133284009924, 4083.8774836754947, 8931.19619234272, 10465.9476702616, 10534.631287904887, 10564.260501764802, 10605.25763196569, 10552.525136368882, 10560.049595536439, 10647.30792498485, 10683.664541932258, 10691.144708423308, 7943.64253608589, 8117.512949223065, 8128.065272493739, 8163.755087347389, 8231.629576669064, 5839.766409343579, 5851.414858514285, 5918.17145599625, 5949.583529152917, 5974.163617093697, 9748.658796942073, 9849.310548261554, 9889.950550247202, 9942.552585133832, 9967.850482242628, 9429.0, 9859.408435493893, 9881.95059024729, 10243.539040743333, 10247.48762561854, 6391.552591318563, 6765.594064356154, 6973.302669732986, 6987.196472405739, 7043.542169758949, 8257.42198046131, 8303.04514980785, 8324.292435143081, 8341.916580834113, 8406.495610263404, 7320.26797320285, 7436.73971410998, 7440.516366436164, 7573.2048134947245, 7589.848203036019, 7234.819129521804, 7265.963670181615, 7344.779656610311, 7359.227281135403, 7360.374368178765, 6896.551724137915, 6957.060796792571, 6996.405305549085, 7000.754973576104, 7026.156861176692, 3996.480457540501, 4711.293306004127, 4819.660555066578, 4949.059678661043, 5030.37120359955, 4966.652334336562, 4976.154053810933, 5021.322121513695, 5074.264231686311, 5218.347706536683], "value": 4410.441668573273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.2653036794669, 316.439901374567, 317.6331337305413, 320.7914855344026, 322.69182930301565, 4568.812108851702, 4864.294677271793, 5391.541718953888, 5479.849231661346, 5585.849447962533, 4175.037732265838, 4830.758462076899, 4946.597528199905, 5503.559715222783, 5505.614606977513, 3558.7508874378805, 3715.9628403715956, 4147.900806286337, 4182.769947652878, 4190.895227619303, 3338.479448016744, 3342.9498557521533, 3694.150345420555, 4183.138503365988, 4188.72773269738, 3352.7988320700715, 3688.5020522229556, 3825.6854602965223, 4133.669306455491, 4176.436181115556, 4055.695822813271, 4161.771102589357, 4182.393552934807, 4190.559991200926, 4191.538930717618, 3060.9540856887165, 3342.348242092793, 3572.338862428957, 3588.2644057968314, 3624.9275014499826, 4244.87265382039, 4769.737664428455, 5232.816851410183, 5253.395859476171, 5294.444083371229, 3957.9907123683274, 4515.277555591089, 4691.62467002639, 4821.662483626147, 4848.200046992242, 4771.0, 5142.254373115915, 5282.57370509964, 5328.706921119337, 5759.539236861041, 3301.504774283853, 3592.4072528032843, 4012.799360031987, 4034.374671925856, 4050.0482386639114, 4919.671688644082, 5268.341457317873, 5888.701248088876, 6035.7283922223605, 6112.51099912006, 3820.369639009588, 3822.5412950446125, 4050.18996200761, 4093.63157315843, 4122.711410201317, 3667.339878821784, 4115.1975364804175, 4145.274576949022, 4170.749755014709, 4178.979105104455, 4783.904321913542, 4792.603698150924, 4833.879153021132, 4844.95155048445, 4849.345338379274, 4904.656674032854, 5245.3088399086655, 5411.458854114557, 5456.599096397573, 5458.37997761069, 1149.965031471682, 1268.7081971146688, 1302.3358087375507, 1311.9081664283408, 1345.3004437692541, 804.4047404920434, 870.4385671242013, 916.1022198245756, 925.5372313843078, 939.0421769794771, 4514.300283456069, 4899.456671148577, 5262.2632831403635, 5323.920141197885, 5410.891782164414, 5412.810551630674, 5596.692181930033, 5598.300212473441, 6039.275286965592, 6089.908651370233, 4509.616682582017, 4575.2450845610765, 4634.814607415666, 4887.022595480918, 5350.732463376816, 2822.520171570838, 2929.3555417808047, 2997.1567485995956, 3008.9398212035635, 3022.9546556801665, 5099.413567439792, 5589.8602534936135, 5781.207825574002, 5854.268216472941, 5958.6722730249385, 5244.662611034162, 5557.277553918046, 5875.764969401176, 5888.941110588925, 6026.0, 5013.523715247045, 5667.093265077568, 5834.737436815353, 6021.42796434338, 6068.878622427526, 5060.367454068241, 5297.973510132425, 5305.389880163676, 5368.0, 5697.145428185805, 5082.288479612783, 5169.92245116316, 5230.626246071187, 5675.112547904699, 5763.94236057634, 5064.924026139684, 5457.0, 5503.504684578407, 5878.707304151299, 6045.848853778691, 3254.1701866024014, 3611.5124458197806, 3687.446882967469, 3857.363535016803, 3889.5915928827067, 4985.675931064469, 5157.638965272395, 5322.813701520428, 5483.75323110453, 5952.821415357546, 5329.893402132013, 5562.969516126665, 5739.044392137969, 5819.854503637443, 5820.214271073351, 5291.788328466818, 5438.320209973754, 5686.730130175083, 5728.140778883201, 5761.567882408753, 4723.291506273949, 4851.539103785276, 5552.33371995347, 5571.275734154696, 5603.7758489659955, 5565.38780734127, 5686.810577927445, 5787.016207244863, 5789.305283366023, 5802.390748971297, 5033.043721692867, 5272.367315922113, 5553.750081246434, 5676.460736230051, 5741.770329186786], "value": 4084.410289820698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.4075924075925, 651.5113664751433, 659.7782907185248, 698.4342682427233, 706.0292098364748, 12162.817557736642, 12499.43752531136, 15031.872609554286, 15229.39082436704, 15405.768913466307, 13968.092074015181, 14923.179225142612, 15440.84559154408, 15448.459303924365, 15760.0, 918.0773322810566, 920.2591913509622, 926.865604487349, 928.5078908178676, 928.8838895138108, 708.6315116139605, 897.5198268926126, 919.2140719684674, 924.2652091587171, 926.5691453474133, 964.6961207219739, 965.377331621104, 966.2897770138942, 969.7866469376726, 971.3249291742242, 931.2270815223416, 964.0118878149917, 965.0446058402166, 965.3098034905041, 965.3918031640022, 701.7614011236204, 710.0698085508001, 714.5319815520842, 715.2561336210387, 716.29087203668, 14738.926305368404, 14757.704845903128, 14928.552143435605, 15066.472673456487, 15117.319720612599, 12111.757764844742, 12130.393480325949, 12134.453949572291, 12137.393130343447, 12248.571300004547, 9604.855927161097, 9657.275704322134, 9855.162311203556, 9946.30375873689, 9947.552360143738, 3371.7976921384798, 3421.9657803421896, 3424.109731469811, 3445.104272889067, 3513.472979053137, 87276.0, 88297.0, 89108.55445722795, 89388.65917011185, 90320.54839725759, 9088.545572721338, 9093.454392736458, 9095.681651142178, 9151.771205719777, 9452.43285402878, 19966.90016549908, 20358.796412035987, 20644.0, 20937.685934710993, 20938.895305523376, 7330.743423980135, 7336.2296958819625, 7366.852662946818, 7413.777586672409, 7477.36442402391, 3964.4053391991433, 4022.8390864365097, 4034.2133284009337, 4035.576264492186, 4036.0, 3441.3633477806684, 3550.3964326064115, 3555.2711694102645, 3559.3059353425833, 3564.572251329857, 618.4217756397693, 628.6950828848005, 637.5791977294963, 647.1910112359551, 647.6308504152588, 481.838584074332, 560.0854971500963, 565.7271139935145, 572.9140628905698, 585.2771826793906, 6572.868542629216, 8093.773943500792, 8140.75577732669, 8275.83448331042, 8308.418410711192, 481.379021062832, 545.26661640094, 571.4770984549091, 578.6238944685988, 592.7865968251426, 3860.652541271299, 3875.5155605549307, 3907.9804600976813, 3913.9021524462114, 3933.1347103637154, 70268.64865675638, 85959.71060434099, 86045.1395486037, 86250.46728971963, 86981.52073917098, 80140.0, 81351.7797233042, 82213.0, 82724.0, 82800.58599706963, 72707.63646181735, 73956.26043739602, 73983.63008184925, 74991.0, 75224.24775752283, 7356.117265928123, 7551.433642476726, 7737.92262077372, 7796.10344810354, 7952.125266220827, 36047.81976090103, 39418.802905985285, 43517.129657407306, 43692.90767730832, 44756.77621611871, 58958.70520647369, 59124.70437647784, 59154.40845591489, 59327.0, 59714.70142649259, 8934.240589549961, 10600.416977066336, 10642.148628109579, 10965.561377545127, 11362.602308919148, 11993.520259189883, 11996.820047699466, 12138.514459421878, 12329.383530823243, 12460.937695311466, 11307.265027773168, 11418.31490110596, 11584.884151158381, 11736.530538778354, 11984.161108722306, 10296.124829389586, 10989.725256868322, 11522.596709115141, 11786.941065294961, 11898.280589568589, 11119.0, 11192.022633088653, 11478.598249061242, 11537.711557211136, 11549.595764148215, 9354.95322523383, 9563.856542152012, 9671.758206044624, 9866.161376283097, 9941.850872237066, 8987.595558199766, 9546.093121153479, 9619.807603848023, 9645.758856028655, 9703.320767546204], "value": 6774.199714601198, "unit": "score"}], "name": "dromaeo_css", "value": 7168.170115433627, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 119.0, 108.0, 116.0, 118.0, 116.0, 108.0, 117.0, 116.0, 117.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 111.0, 137.0, 209.0, 123.0, 137.0, 168.0, 139.0, 197.0, 127.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 205.0, 214.0, 214.0, 207.0, 197.0, 228.0, 267.0, 210.0, 200.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 80.0, 76.0, 178.0, 58.0, 59.0, 61.0, 70.0, 152.0, 77.0], "value": 88.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 161.0, 104.0, 110.0, 107.0, 126.0, 84.0, 80.0, 128.0], "value": 107.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 117.0, 91.0, 89.0, 92.0, 109.0, 122.0, 90.0, 123.0, 121.0], "value": 104.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 98.0, 97.0, 96.0, 98.0, 98.0, 98.0, 98.0, 97.0], "value": 97.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 91.0, 91.0, 109.0, 131.0, 98.0, 76.0, 139.0, 139.0], "value": 105.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 122.0, 78.0, 80.0], "value": 71.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 75.0, 79.0, 77.0, 71.0, 67.0, 70.0, 69.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 77.0, 110.0, 77.0, 94.0, 101.0, 101.0, 104.0, 77.0, 104.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 155.0, 141.0, 161.0, 140.0, 125.0, 159.0, 248.0, 172.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 184.0, 218.0, 171.0, 169.0, 168.0, 174.0, 173.0, 169.0, 169.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 69.0, 68.0, 66.0, 67.0, 80.0, 92.0, 81.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1636.0000000000002, "alertThreshold": 2.0}]} 05:53:28 INFO - Return code: 0 05:53:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:53:28 ERROR - # TBPL SUCCESS # 05:53:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:28 INFO - 2016-05-10 05:53:28.463 screenresolution[1986:15683] starting screenresolution argv=screenresolution get 05:53:28 INFO - 2016-05-10 05:53:28.465 screenresolution[1986:15683] Display 0: 1600x1200x32@60 05:53:28 INFO - 2016-05-10 05:53:28.471 screenresolution[1987:15686] starting screenresolution argv=screenresolution list 05:53:28 INFO - Available Modes on Display 0 05:53:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:28 INFO - Intel Iris: 05:53:28 INFO - Chipset Model: Intel Iris 05:53:28 INFO - Type: GPU 05:53:28 INFO - Bus: Built-In 05:53:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:28 INFO - Vendor: Intel (0x8086) 05:53:28 INFO - Device ID: 0x0a2e 05:53:28 INFO - Revision ID: 0x0009 05:53:28 INFO - Displays: 05:53:28 INFO - Display: 05:53:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:28 INFO - Display Serial Number: 1600x1200 60 05:53:28 INFO - Main Display: Yes 05:53:28 INFO - Mirror: Off 05:53:28 INFO - Online: Yes 05:53:28 INFO - Rotation: Supported 05:53:28 INFO - Return code: 0 05:53:28 INFO - Running post-action listener: _resource_record_post_action 05:53:28 INFO - ##### 05:53:28 INFO - ##### Finished run-tests step (success) 05:53:28 INFO - ##### 05:53:28 INFO - Running post-run listener: _resource_record_post_run 05:53:29 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 1105920; Write bytes: 699451904; Read time: 15; Write time: 2578 05:53:29 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 394689024; Write bytes: 392891904; Read time: 29767; Write time: 1073 05:53:29 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 1105920; Write bytes: 295582720; Read time: 15; Write time: 1474 05:53:29 INFO - Running post-run listener: _upload_blobber_files 05:53:29 INFO - Blob upload gear active. 05:53:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:29 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 05:53:29 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'] 05:53:29 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 05:53:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:53:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:30 INFO - (blobuploader) - INFO - Done attempting. 05:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:32 INFO - (blobuploader) - INFO - Done attempting. 05:53:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:32 INFO - Return code: 0 05:53:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32b1c9780138bb856b1432e62861f255a5dc2d316f3e957981839f755d61a40438c2d1f9984b524a08e2e303ba090af5e91e49f842b4b7b9ac221ae277904315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c659bcfd4404eeabda0822c3b87e085e3609a7dee77bcb397e08a3d3b50c1560b25c95c823ec82917afc7684eb59e4c17119c91ba921bb2bff4110b2944e6573"} 05:53:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:32 INFO - Contents: 05:53:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32b1c9780138bb856b1432e62861f255a5dc2d316f3e957981839f755d61a40438c2d1f9984b524a08e2e303ba090af5e91e49f842b4b7b9ac221ae277904315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c659bcfd4404eeabda0822c3b87e085e3609a7dee77bcb397e08a3d3b50c1560b25c95c823ec82917afc7684eb59e4c17119c91ba921bb2bff4110b2944e6573"} 05:53:32 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:32 INFO - Copying logs to upload dir... 05:53:32 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.050975 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-05-10 05:53:32.213686) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:53:32.217400) ========= 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.KStc9kfrHq/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.djEddsPNL9/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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/32b1c9780138bb856b1432e62861f255a5dc2d316f3e957981839f755d61a40438c2d1f9984b524a08e2e303ba090af5e91e49f842b4b7b9ac221ae277904315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c659bcfd4404eeabda0822c3b87e085e3609a7dee77bcb397e08a3d3b50c1560b25c95c823ec82917afc7684eb59e4c17119c91ba921bb2bff4110b2944e6573"} build_url:https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011292 build_url: 'https://queue.taskcluster.net/v1/task/LW6qPNbwT3OuNaKoOGp8pA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/32b1c9780138bb856b1432e62861f255a5dc2d316f3e957981839f755d61a40438c2d1f9984b524a08e2e303ba090af5e91e49f842b4b7b9ac221ae277904315", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c659bcfd4404eeabda0822c3b87e085e3609a7dee77bcb397e08a3d3b50c1560b25c95c823ec82917afc7684eb59e4c17119c91ba921bb2bff4110b2944e6573"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-10 05:53:32.244256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:53:32.244530) ========= 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.KStc9kfrHq/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.djEddsPNL9/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005329 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-10 05:53:32.292952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:53:32.293226) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-10 05:53:32.293481) ========= ========= Total master_lag: 0.15 =========