builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0014 starttime: 1460732890.9 results: success (0) buildid: 20160415052445 builduid: c291f87fc2d6423e9a7d7ce2259de22e revision: 0260dd297a25b97b11dfa208c3d556cb7b62542c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:08:10.897157) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 08:08:10.897584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 mins, 4 secs) (at 2016-04-15 08:08:10.897924) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 mins, 4 secs) (at 2016-04-15 08:10:15.274458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2016-04-15 08:10:15.274733) ========= 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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04-15 08:10:19-- 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% 10.2M=0.001s 2016-04-15 08:10:20 (10.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.525095 ========= master_lag: 19.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 19 secs) (at 2016-04-15 08:10:34.866436) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 24 secs) (at 2016-04-15 08:10:34.866773) ========= 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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.019950 ========= master_lag: 24.59 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 24 secs) (at 2016-04-15 08:10:59.473996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2016-04-15 08:10:59.474315) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0260dd297a25b97b11dfa208c3d556cb7b62542c --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 0260dd297a25b97b11dfa208c3d556cb7b62542c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YxAjXx2ILN/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.8jM9QoYpsB/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04-15 08:11:00,175 truncating revision to first 12 chars 2016-04-15 08:11:00,175 Setting DEBUG logging. 2016-04-15 08:11:00,175 attempt 1/10 2016-04-15 08:11:00,175 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0260dd297a25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 08:11:01,252 unpacking tar archive at: fx-team-0260dd297a25/testing/mozharness/ program finished with exit code 0 elapsedTime=1.322117 ========= master_lag: 11.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 secs) (at 2016-04-15 08:11:12.029295) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:11:12.030962) ========= script_repo_revision: 0260dd297a25b97b11dfa208c3d556cb7b62542c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 08:11:12.031391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 1 mins, 5 secs) (at 2016-04-15 08:11:12.031661) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 1 mins, 5 secs) (at 2016-04-15 08:12:17.347482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-04-15 08:12:17.347779) ========= /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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:18 INFO - MultiFileLogger online at 20160415 08:12:18 in /builds/slave/test 08:12:18 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 08:12:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:18 INFO - {'append_to_log': False, 08:12:18 INFO - 'base_work_dir': '/builds/slave/test', 08:12:18 INFO - 'blob_upload_branch': 'Fx-Team', 08:12:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:18 INFO - 'branch': 'Fx-Team', 08:12:18 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:18 INFO - 'config_files': ('talos/mac_config.py',), 08:12:18 INFO - 'default_actions': ('clobber', 08:12:18 INFO - 'read-buildbot-config', 08:12:18 INFO - 'download-and-extract', 08:12:18 INFO - 'populate-webroot', 08:12:18 INFO - 'create-virtualenv', 08:12:18 INFO - 'install', 08:12:18 INFO - 'run-tests'), 08:12:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:18 INFO - 'download_minidump_stackwalk': True, 08:12:18 INFO - 'download_symbols': 'ondemand', 08:12:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:18 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:18 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:18 INFO - 'installer_path': 'installer.exe', 08:12:18 INFO - 'log_level': 'info', 08:12:18 INFO - 'log_name': 'talos', 08:12:18 INFO - 'log_to_console': True, 08:12:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:12:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:12:18 INFO - 'opt_config_files': (), 08:12:18 INFO - 'pip_index': False, 08:12:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:12:18 INFO - 'cmd': ('bash', 08:12:18 INFO - '-c', 08:12:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:12:18 INFO - 'enabled': True, 08:12:18 INFO - 'halt_on_failure': False, 08:12:18 INFO - 'name': 'check_screen_resolution'},), 08:12:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:12:18 INFO - 'cmd': ('bash', 08:12:18 INFO - '-c', 08:12:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:12:18 INFO - 'enabled': True, 08:12:18 INFO - 'halt_on_failure': False, 08:12:18 INFO - 'name': 'check_screen_resolution'},), 08:12:18 INFO - 'run_cmd_checks_enabled': True, 08:12:18 INFO - 'sps_profile': False, 08:12:18 INFO - 'sps_profile_interval': 0, 08:12:18 INFO - 'suite': 'dromaeojs-e10s', 08:12:18 INFO - 'system_bits': '32', 08:12:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:18 INFO - 'title': 't-yosemite-r7-0014', 08:12:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:18 INFO - 'use_talos_json': True, 08:12:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:18 INFO - 'work_dir': 'build'} 08:12:18 INFO - ##### 08:12:18 INFO - ##### Running clobber step. 08:12:18 INFO - ##### 08:12:18 INFO - Running pre-action listener: _resource_record_pre_action 08:12:18 INFO - Running main action method: clobber 08:12:18 INFO - rmtree: /builds/slave/test/build 08:12:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:19 INFO - Running post-action listener: _resource_record_post_action 08:12:19 INFO - ##### 08:12:19 INFO - ##### Running read-buildbot-config step. 08:12:19 INFO - ##### 08:12:19 INFO - Running pre-action listener: _resource_record_pre_action 08:12:19 INFO - Running main action method: read_buildbot_config 08:12:19 INFO - Using buildbot properties: 08:12:19 INFO - { 08:12:19 INFO - "project": "", 08:12:19 INFO - "product": "firefox", 08:12:19 INFO - "script_repo_revision": "production", 08:12:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:12:19 INFO - "repository": "", 08:12:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:12:19 INFO - "buildid": "20160415052445", 08:12:19 INFO - "pgo_build": "False", 08:12:19 INFO - "basedir": "/builds/slave/test", 08:12:19 INFO - "buildnumber": 695, 08:12:19 INFO - "slavename": "t-yosemite-r7-0014", 08:12:19 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:12:19 INFO - "platform": "yosemite_r7", 08:12:19 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:12:19 INFO - "branch": "fx-team", 08:12:19 INFO - "repo_path": "integration/fx-team", 08:12:19 INFO - "revision": "0260dd297a25b97b11dfa208c3d556cb7b62542c", 08:12:19 INFO - "stage_platform": "macosx64", 08:12:19 INFO - "builduid": "c291f87fc2d6423e9a7d7ce2259de22e", 08:12:19 INFO - "slavebuilddir": "test" 08:12:19 INFO - } 08:12:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 08:12:19 INFO - Running post-action listener: _resource_record_post_action 08:12:19 INFO - ##### 08:12:19 INFO - ##### Running download-and-extract step. 08:12:19 INFO - ##### 08:12:19 INFO - Running pre-action listener: _resource_record_pre_action 08:12:19 INFO - Running main action method: download_and_extract 08:12:19 INFO - mkdir: /builds/slave/test/build/tests 08:12:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:19 INFO - https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:12:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:12:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 08:12:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:12:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 08:12:21 INFO - Downloaded 1199 bytes. 08:12:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 08:12:21 INFO - Using the following test package requirements: 08:12:21 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:12:21 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 08:12:21 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 08:12:21 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'jsshell-mac.zip'], 08:12:21 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 08:12:21 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 08:12:21 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 08:12:21 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 08:12:21 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 08:12:21 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 08:12:21 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 08:12:21 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:21 INFO - https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:12:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:12:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:12:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:12:23 INFO - Downloaded 18034025 bytes. 08:12:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:12:26 INFO - Return code: 0 08:12:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:12:26 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')]} 08:12:26 INFO - https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:12:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:12:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:12:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 08:12:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:12:27 INFO - Downloaded 18034025 bytes. 08:12:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:12:30 INFO - Return code: 0 08:12:30 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')]} 08:12:30 INFO - https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:12:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:12:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:12:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 08:12:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:12:31 INFO - Downloaded 10841076 bytes. 08:12:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:12:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:12:32 INFO - Return code: 0 08:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:32 INFO - https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:12:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:12:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:12:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 08:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 08:12:36 INFO - Downloaded 109943394 bytes. 08:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:12:36 INFO - mkdir: /builds/slave/test/properties 08:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:36 INFO - Contents: 08:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 08:12:38 INFO - Running post-action listener: _resource_record_post_action 08:12:38 INFO - Running post-action listener: set_extra_try_arguments 08:12:38 INFO - ##### 08:12:38 INFO - ##### Running populate-webroot step. 08:12:38 INFO - ##### 08:12:38 INFO - Running pre-action listener: _resource_record_pre_action 08:12:38 INFO - Running main action method: populate_webroot 08:12:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:38 INFO - '--tppagecycles', 08:12:38 INFO - '7'], 08:12:38 INFO - 'tests': ['tsvgm']}}, 08:12:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:12:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:12:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['damp', 'tps']}, 08:12:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'tests': ['damp', 'tps']}, 08:12:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['dromaeo_dom']}, 08:12:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['a11yr', 08:12:38 INFO - 'ts_paint', 08:12:38 INFO - 'tpaint', 08:12:38 INFO - 'sessionrestore', 08:12:38 INFO - 'sessionrestore_no_auto_restore', 08:12:38 INFO - 'tabpaint']}, 08:12:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:12:38 INFO - 'ts_paint', 08:12:38 INFO - 'tpaint', 08:12:38 INFO - 'sessionrestore', 08:12:38 INFO - 'sessionrestore_no_auto_restore', 08:12:38 INFO - 'tabpaint']}, 08:12:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:12:38 INFO - 'ts_paint', 08:12:38 INFO - 'tpaint', 08:12:38 INFO - 'sessionrestore', 08:12:38 INFO - 'sessionrestore_no_auto_restore', 08:12:38 INFO - 'tabpaint']}, 08:12:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:12:38 INFO - 'ts_paint', 08:12:38 INFO - 'tpaint', 08:12:38 INFO - 'sessionrestore', 08:12:38 INFO - 'sessionrestore_no_auto_restore', 08:12:38 INFO - 'tabpaint']}, 08:12:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['a11yr', 08:12:38 INFO - 'ts_paint', 08:12:38 INFO - 'tpaint', 08:12:38 INFO - 'sessionrestore', 08:12:38 INFO - 'sessionrestore_no_auto_restore', 08:12:38 INFO - 'tabpaint']}, 08:12:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['a11yr', 08:12:38 INFO - 'ts_paint', 08:12:38 INFO - 'tpaint', 08:12:38 INFO - 'sessionrestore', 08:12:38 INFO - 'sessionrestore_no_auto_restore', 08:12:38 INFO - 'tabpaint']}, 08:12:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['tsvgx', 08:12:38 INFO - 'tsvgr_opacity', 08:12:38 INFO - 'tart', 08:12:38 INFO - 'tscrollx', 08:12:38 INFO - 'cart']}, 08:12:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:12:38 INFO - 'tsvgr_opacity', 08:12:38 INFO - 'tart', 08:12:38 INFO - 'tscrollx', 08:12:38 INFO - 'cart']}, 08:12:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'talos_options': ['--disable-e10s'], 08:12:38 INFO - 'tests': ['tp5o']}, 08:12:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'tests': ['tp5o']}, 08:12:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'talos_options': ['--disable-e10s', 08:12:38 INFO - '--xperf_path', 08:12:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:38 INFO - 'tests': ['tp5n']}, 08:12:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:38 INFO - 'talos_options': ['--xperf_path', 08:12:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:38 INFO - 'tests': ['tp5n']}}, 08:12:38 INFO - 'talos.zip': {'path': '', 08:12:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:38 INFO - Running post-action listener: _resource_record_post_action 08:12:38 INFO - ##### 08:12:38 INFO - ##### Running create-virtualenv step. 08:12:38 INFO - ##### 08:12:38 INFO - Running pre-action listener: _resource_record_pre_action 08:12:38 INFO - Running main action method: create_virtualenv 08:12:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:38 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 08:12:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:38 INFO - Using real prefix '/tools/python27' 08:12:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:41 INFO - Installing pip.................done. 08:12:41 INFO - Return code: 0 08:12:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:12:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:12:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:12:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:41 INFO - 'HOME': '/Users/cltbld', 08:12:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:41 INFO - 'LOGNAME': 'cltbld', 08:12:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:41 INFO - 'MOZ_NO_REMOTE': '1', 08:12:41 INFO - 'NO_EM_RESTART': '1', 08:12:41 INFO - 'PAGER': '/bin/cat', 08:12:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:41 INFO - 'PWD': '/builds/slave/test', 08:12:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:41 INFO - 'SHELL': '/bin/bash', 08:12:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:12:41 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:12:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:41 INFO - 'USER': 'cltbld', 08:12:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:41 INFO - 'XPC_FLAGS': '0x0', 08:12:41 INFO - 'XPC_SERVICE_NAME': '0', 08:12:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:42 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 08:12:42 INFO - Cleaning up... 08:12:42 INFO - Return code: 0 08:12:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:12:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:12:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:42 INFO - 'HOME': '/Users/cltbld', 08:12:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:42 INFO - 'LOGNAME': 'cltbld', 08:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:42 INFO - 'MOZ_NO_REMOTE': '1', 08:12:42 INFO - 'NO_EM_RESTART': '1', 08:12:42 INFO - 'PAGER': '/bin/cat', 08:12:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:42 INFO - 'PWD': '/builds/slave/test', 08:12:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:42 INFO - 'SHELL': '/bin/bash', 08:12:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:12:42 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:12:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:42 INFO - 'USER': 'cltbld', 08:12:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:42 INFO - 'XPC_FLAGS': '0x0', 08:12:42 INFO - 'XPC_SERVICE_NAME': '0', 08:12:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:42 INFO - Downloading/unpacking psutil>=0.7.1 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:45 INFO - Installing collected packages: psutil 08:12:45 INFO - Running setup.py install for psutil 08:12:45 INFO - building 'psutil._psutil_osx' extension 08:12:45 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 08:12:45 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 08:12:45 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 08:12:45 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 08:12:45 INFO - building 'psutil._psutil_posix' extension 08:12:45 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 08:12:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:12:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:12:45 INFO - ^ 08:12:45 INFO - 1 warning generated. 08:12:45 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 08:12:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:46 INFO - Successfully installed psutil 08:12:46 INFO - Cleaning up... 08:12:46 INFO - Return code: 0 08:12:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:12:46 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')]} 08:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 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')]} 08:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:46 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:46 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 08:12:46 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 08:12:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:12:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:46 INFO - 'HOME': '/Users/cltbld', 08:12:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:46 INFO - 'LOGNAME': 'cltbld', 08:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:46 INFO - 'MOZ_NO_REMOTE': '1', 08:12:46 INFO - 'NO_EM_RESTART': '1', 08:12:46 INFO - 'PAGER': '/bin/cat', 08:12:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:46 INFO - 'PWD': '/builds/slave/test', 08:12:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:46 INFO - 'SHELL': '/bin/bash', 08:12:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:12:46 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:12:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:46 INFO - 'USER': 'cltbld', 08:12:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:46 INFO - 'XPC_FLAGS': '0x0', 08:12:46 INFO - 'XPC_SERVICE_NAME': '0', 08:12:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:12:46 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 08:12:46 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 08:12:46 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 08:12:46 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 08:12:46 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 08:12:46 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 08:12:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:12:48 INFO - Installing collected packages: mozsystemmonitor 08:12:48 INFO - Running setup.py install for mozsystemmonitor 08:12:49 INFO - Successfully installed mozsystemmonitor 08:12:49 INFO - Cleaning up... 08:12:49 INFO - Return code: 0 08:12:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:12:49 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')]} 08:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:49 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')]} 08:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:49 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:49 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 08:12:49 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 08:12:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:12:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:49 INFO - 'HOME': '/Users/cltbld', 08:12:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:49 INFO - 'LOGNAME': 'cltbld', 08:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:49 INFO - 'MOZ_NO_REMOTE': '1', 08:12:49 INFO - 'NO_EM_RESTART': '1', 08:12:49 INFO - 'PAGER': '/bin/cat', 08:12:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:49 INFO - 'PWD': '/builds/slave/test', 08:12:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:49 INFO - 'SHELL': '/bin/bash', 08:12:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:12:49 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:12:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:49 INFO - 'USER': 'cltbld', 08:12:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:49 INFO - 'XPC_FLAGS': '0x0', 08:12:49 INFO - 'XPC_SERVICE_NAME': '0', 08:12:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:49 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:49 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 08:12:51 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:51 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 08:12:51 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 08:12:51 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 08:12:51 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 08:12:51 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 08:12:51 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 08:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:52 INFO - Downloading docopt-0.6.1.tar.gz 08:12:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:53 INFO - Running setup.py install for blobuploader 08:12:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:53 INFO - Running setup.py install for requests 08:12:53 INFO - Running setup.py install for docopt 08:12:53 INFO - Successfully installed blobuploader requests docopt 08:12:53 INFO - Cleaning up... 08:12:53 INFO - Return code: 0 08:12:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:12:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:53 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:53 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 08:12:53 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 08:12:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:12:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:53 INFO - 'HOME': '/Users/cltbld', 08:12:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:53 INFO - 'LOGNAME': 'cltbld', 08:12:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:53 INFO - 'MOZ_NO_REMOTE': '1', 08:12:53 INFO - 'NO_EM_RESTART': '1', 08:12:53 INFO - 'PAGER': '/bin/cat', 08:12:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:53 INFO - 'PWD': '/builds/slave/test', 08:12:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:53 INFO - 'SHELL': '/bin/bash', 08:12:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:12:53 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:12:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:53 INFO - 'USER': 'cltbld', 08:12:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:53 INFO - 'XPC_FLAGS': '0x0', 08:12:53 INFO - 'XPC_SERVICE_NAME': '0', 08:12:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-6Wk3rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bWlIGJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Ju69CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-DEIJLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jLYGZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-t3Oy5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-yfbSF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:54 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-C6GOky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-XYQCWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-HR0xib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-BBiMyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-bzm5us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-wzGlOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-n3FjLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ky6X83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gYMmgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:55 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-FPdL8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:56 INFO - Running setup.py install for manifestparser 08:12:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:56 INFO - Running setup.py install for mozcrash 08:12:56 INFO - Running setup.py install for mozdebug 08:12:56 INFO - Running setup.py install for mozdevice 08:12:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:56 INFO - Running setup.py install for mozfile 08:12:56 INFO - Running setup.py install for mozhttpd 08:12:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:56 INFO - Running setup.py install for mozinfo 08:12:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Running setup.py install for mozInstall 08:12:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Running setup.py install for mozleak 08:12:57 INFO - Running setup.py install for mozlog 08:12:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Running setup.py install for moznetwork 08:12:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Running setup.py install for mozprocess 08:12:57 INFO - Running setup.py install for mozprofile 08:12:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:57 INFO - Running setup.py install for mozrunner 08:12:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:58 INFO - Running setup.py install for mozscreenshot 08:12:58 INFO - Running setup.py install for moztest 08:12:58 INFO - Running setup.py install for mozversion 08:12:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:58 INFO - Cleaning up... 08:12:58 INFO - Return code: 0 08:12:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:58 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')]} 08:12:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:58 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')]} 08:12:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:58 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:12:58 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 08:12:58 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 08:12:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:12:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:12:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:12:58 INFO - 'HOME': '/Users/cltbld', 08:12:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:12:58 INFO - 'LOGNAME': 'cltbld', 08:12:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:58 INFO - 'MOZ_NO_REMOTE': '1', 08:12:58 INFO - 'NO_EM_RESTART': '1', 08:12:58 INFO - 'PAGER': '/bin/cat', 08:12:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:12:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:58 INFO - 'PWD': '/builds/slave/test', 08:12:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:12:58 INFO - 'SHELL': '/bin/bash', 08:12:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:12:58 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:12:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:12:58 INFO - 'USER': 'cltbld', 08:12:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:12:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:12:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:58 INFO - 'XPC_FLAGS': '0x0', 08:12:58 INFO - 'XPC_SERVICE_NAME': '0', 08:12:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PsULTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:58 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)) 08:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:58 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-n7nyng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-AYDisM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-tBW283-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-iHvyx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-WsTrbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NgBUOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-u5FYbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-WW33NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-8VVOKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:59 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)) 08:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:59 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-REgI1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:13:00 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)) 08:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:13:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KkmEPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:13:00 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)) 08:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:13:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-RJ8CY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:13:00 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)) 08:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:13:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-MwWtCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:13:00 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)) 08:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-8oN8g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:13:00 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)) 08:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:13:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ObGPfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:13:00 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)) 08:13:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:13:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-JGiGir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:13:00 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)) 08:13:00 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)) 08:13:00 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)) 08:13:00 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)) 08:13:00 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)) 08:13:00 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)) 08:13:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:13:00 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 08:13:00 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 08:13:00 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 08:13:00 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 08:13:00 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 08:13:00 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 08:13:03 INFO - Downloading blessings-1.6.tar.gz 08:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:13:03 INFO - Installing collected packages: blessings 08:13:03 INFO - Running setup.py install for blessings 08:13:03 INFO - Successfully installed blessings 08:13:03 INFO - Cleaning up... 08:13:03 INFO - Return code: 0 08:13:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:13:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:03 INFO - Reading from file tmpfile_stdout 08:13:03 INFO - Current package versions: 08:13:03 INFO - blessings == 1.6 08:13:03 INFO - blobuploader == 1.2.4 08:13:03 INFO - docopt == 0.6.1 08:13:03 INFO - manifestparser == 1.1 08:13:03 INFO - mozInstall == 1.12 08:13:03 INFO - mozcrash == 0.17 08:13:03 INFO - mozdebug == 0.1 08:13:03 INFO - mozdevice == 0.48 08:13:03 INFO - mozfile == 1.2 08:13:03 INFO - mozhttpd == 0.7 08:13:03 INFO - mozinfo == 0.9 08:13:03 INFO - mozleak == 0.1 08:13:03 INFO - mozlog == 3.1 08:13:03 INFO - moznetwork == 0.27 08:13:03 INFO - mozprocess == 0.22 08:13:03 INFO - mozprofile == 0.28 08:13:03 INFO - mozrunner == 6.11 08:13:03 INFO - mozscreenshot == 0.1 08:13:03 INFO - mozsystemmonitor == 0.0 08:13:03 INFO - moztest == 0.7 08:13:03 INFO - mozversion == 1.4 08:13:03 INFO - psutil == 3.1.1 08:13:03 INFO - requests == 1.2.3 08:13:03 INFO - wsgiref == 0.1.2 08:13:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:13:03 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')]} 08:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:03 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')]} 08:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:03 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:13:03 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 08:13:03 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 08:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:03 INFO - 'HOME': '/Users/cltbld', 08:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:03 INFO - 'LOGNAME': 'cltbld', 08:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:03 INFO - 'MOZ_NO_REMOTE': '1', 08:13:03 INFO - 'NO_EM_RESTART': '1', 08:13:03 INFO - 'PAGER': '/bin/cat', 08:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:03 INFO - 'PWD': '/builds/slave/test', 08:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:03 INFO - 'SHELL': '/bin/bash', 08:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:13:03 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:03 INFO - 'USER': 'cltbld', 08:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:03 INFO - 'XPC_FLAGS': '0x0', 08:13:03 INFO - 'XPC_SERVICE_NAME': '0', 08:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 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)) 08:13:03 INFO - Cleaning up... 08:13:03 INFO - Return code: 0 08:13:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:13:03 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')]} 08:13:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:03 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')]} 08:13:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:03 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:13:03 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 08:13:03 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 08:13:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:13:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:03 INFO - 'HOME': '/Users/cltbld', 08:13:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:03 INFO - 'LOGNAME': 'cltbld', 08:13:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:03 INFO - 'MOZ_NO_REMOTE': '1', 08:13:03 INFO - 'NO_EM_RESTART': '1', 08:13:03 INFO - 'PAGER': '/bin/cat', 08:13:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:03 INFO - 'PWD': '/builds/slave/test', 08:13:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:03 INFO - 'SHELL': '/bin/bash', 08:13:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:13:03 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:13:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:03 INFO - 'USER': 'cltbld', 08:13:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:03 INFO - 'XPC_FLAGS': '0x0', 08:13:03 INFO - 'XPC_SERVICE_NAME': '0', 08:13:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:04 INFO - Downloading/unpacking jsonschema 08:13:04 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 08:13:04 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 08:13:04 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 08:13:04 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 08:13:04 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 08:13:04 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 08:13:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:13:06 INFO - Downloading/unpacking functools32 (from jsonschema) 08:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:13:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:13:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:13:06 INFO - Downloading functools32-3.2.3-2.tar.gz 08:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:13:07 INFO - warning: no files found matching '*.txt' 08:13:07 INFO - no previously-included directories found matching 'build' 08:13:07 INFO - no previously-included directories found matching 'dist' 08:13:07 INFO - no previously-included directories found matching '.git*' 08:13:07 INFO - Installing collected packages: jsonschema, functools32 08:13:07 INFO - Running setup.py install for functools32 08:13:07 INFO - warning: no files found matching '*.txt' 08:13:07 INFO - no previously-included directories found matching 'build' 08:13:07 INFO - no previously-included directories found matching 'dist' 08:13:07 INFO - no previously-included directories found matching '.git*' 08:13:07 INFO - Successfully installed jsonschema functools32 08:13:07 INFO - Cleaning up... 08:13:07 INFO - Return code: 0 08:13:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:13:07 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 0x1011c8a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8e28c64620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, '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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 08:13:07 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 08:13:07 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 08:13:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:13:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:07 INFO - 'HOME': '/Users/cltbld', 08:13:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:07 INFO - 'LOGNAME': 'cltbld', 08:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:07 INFO - 'MOZ_NO_REMOTE': '1', 08:13:07 INFO - 'NO_EM_RESTART': '1', 08:13:07 INFO - 'PAGER': '/bin/cat', 08:13:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:07 INFO - 'PWD': '/builds/slave/test', 08:13:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:07 INFO - 'SHELL': '/bin/bash', 08:13:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:13:07 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:13:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:07 INFO - 'USER': 'cltbld', 08:13:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:07 INFO - 'XPC_FLAGS': '0x0', 08:13:07 INFO - 'XPC_SERVICE_NAME': '0', 08:13:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:13:07 INFO - Downloading/unpacking flake8 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:13:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:13:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13: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 08:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:13:11 INFO - no previously-included directories found matching 'docs/_build' 08:13:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:13:11 INFO - Running setup.py install for pep8 08:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:13:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:13:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:13:11 INFO - no previously-included directories found matching 'docs/_build' 08:13:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:13:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:13:11 INFO - Cleaning up... 08:13:11 INFO - Return code: 0 08:13:11 INFO - Running post-action listener: _resource_record_post_action 08:13:11 INFO - Running post-action listener: _start_resource_monitoring 08:13:11 INFO - Starting resource monitoring. 08:13:11 INFO - ##### 08:13:11 INFO - ##### Running install step. 08:13:11 INFO - ##### 08:13:11 INFO - Running pre-action listener: _resource_record_pre_action 08:13:11 INFO - Running main action method: install 08:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:13:11 INFO - Reading from file tmpfile_stdout 08:13:11 INFO - Detecting whether we're running mozinstall >=1.0... 08:13:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:13:12 INFO - Reading from file tmpfile_stdout 08:13:12 INFO - Output received: 08:13:12 INFO - Usage: mozinstall [options] installer 08:13:12 INFO - Options: 08:13:12 INFO - -h, --help show this help message and exit 08:13:12 INFO - -d DEST, --destination=DEST 08:13:12 INFO - Directory to install application into. [default: 08:13:12 INFO - "/builds/slave/test"] 08:13:12 INFO - --app=APP Application being installed. [default: firefox] 08:13:12 INFO - mkdir: /builds/slave/test/build/application 08:13:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:13:45 INFO - Reading from file tmpfile_stdout 08:13:45 INFO - Output received: 08:13:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:13:45 INFO - Running post-action listener: _resource_record_post_action 08:13:45 INFO - ##### 08:13:45 INFO - ##### Running run-tests step. 08:13:45 INFO - ##### 08:13:45 INFO - Running pre-action listener: _resource_record_pre_action 08:13:45 INFO - Running main action method: run_tests 08:13:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:13:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:13:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:13:45 INFO - 2016-04-15 08:13:45.559 screenresolution[1932:18712] starting screenresolution argv=screenresolution get 08:13:45 INFO - 2016-04-15 08:13:45.561 screenresolution[1932:18712] Display 0: 1600x1200x32@60 08:13:45 INFO - 2016-04-15 08:13:45.568 screenresolution[1933:18714] starting screenresolution argv=screenresolution list 08:13:45 INFO - Available Modes on Display 0 08:13:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:13:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:13:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:13:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:13:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:13:45 INFO - Intel Iris: 08:13:45 INFO - Chipset Model: Intel Iris 08:13:45 INFO - Type: GPU 08:13:45 INFO - Bus: Built-In 08:13:45 INFO - VRAM (Dynamic, Max): 1536 MB 08:13:45 INFO - Vendor: Intel (0x8086) 08:13:45 INFO - Device ID: 0x0a2e 08:13:45 INFO - Revision ID: 0x0009 08:13:45 INFO - Displays: 08:13:45 INFO - Display: 08:13:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:13:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:13:45 INFO - Display Serial Number: 1600x1200 60 08:13:45 INFO - Main Display: Yes 08:13:45 INFO - Mirror: Off 08:13:45 INFO - Online: Yes 08:13:45 INFO - Rotation: Supported 08:13:45 INFO - Return code: 0 08:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:45 INFO - Python 2.7.3 08:13:45 INFO - Return code: 0 08:13:45 INFO - grabbing minidump binary from tooltool 08:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:45 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 0x101067e00>, '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 0x100ed0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101062b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:45 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 08:13:45 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 08:13:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:45 INFO - Return code: 0 08:13:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:13:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:13:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:13:47 INFO - Return code: 0 08:13:47 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/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 08:13:47 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/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 08:13:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YxAjXx2ILN/Render', 08:13:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:13:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:13:47 INFO - 'HOME': '/Users/cltbld', 08:13:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:13:47 INFO - 'LOGNAME': 'cltbld', 08:13:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:13:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:47 INFO - 'MOZ_NO_REMOTE': '1', 08:13:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:47 INFO - 'NO_EM_RESTART': '1', 08:13:47 INFO - 'PAGER': '/bin/cat', 08:13:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:13:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:47 INFO - 'PWD': '/builds/slave/test', 08:13:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:13:47 INFO - 'SHELL': '/bin/bash', 08:13:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8jM9QoYpsB/Listeners', 08:13:47 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 08:13:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:13:47 INFO - 'USER': 'cltbld', 08:13:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:13:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:13:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:47 INFO - 'XPC_FLAGS': '0x0', 08:13:47 INFO - 'XPC_SERVICE_NAME': '0', 08:13:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:13:47 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/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 08:13:47 INFO - mozversion application_buildid: 20160415052445 08:13:47 INFO - mozversion application_changeset: 0260dd297a25b97b11dfa208c3d556cb7b62542c 08:13:47 INFO - mozversion application_display_name: Nightly 08:13:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:47 INFO - mozversion application_name: Firefox 08:13:47 INFO - mozversion application_remotingname: firefox 08:13:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:13:47 INFO - mozversion application_vendor: Mozilla 08:13:47 INFO - mozversion application_version: 48.0a1 08:13:47 INFO - mozversion platform_buildid: 20160415052445 08:13:47 INFO - mozversion platform_changeset: 0260dd297a25b97b11dfa208c3d556cb7b62542c 08:13:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:13:47 INFO - mozversion platform_version: 48.0a1 08:13:47 INFO - using testdate: 1460733227 08:13:47 INFO - actual date: 1460733227 08:13:47 INFO - starting webserver on 'localhost:54202' 08:13:47 INFO - SUITE-START | Running 2 tests 08:13:47 INFO - TEST-START | dromaeo_css 08:13:47 INFO - operating with platform_type : mac_ 08:13:47 INFO - Initialising browser for dromaeo_css test... 08:13:47 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpzwyegb/profile http://localhost:54202/getInfo.html) 08:13:49 INFO - PROCESS | 1951 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:13:50 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 08:13:50 INFO - PROCESS | 1951 | colorDepth:24 08:13:50 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 08:13:50 INFO - PROCESS | 1951 | __metrics 08:13:50 ERROR - PROCESS | 1951 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:13:50 INFO - TEST-INFO | 1951: exit 0 08:13:50 INFO - Browser initialized. 08:13:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:50 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpzwyegb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:14:02 INFO - PROCESS | 1954 | RSS: Main: 248705024 08:14:02 INFO - PROCESS | 1954 | 08:14:52 INFO - PROCESS | 1954 | 1460733292253 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] 08:17:03 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54202/tests/dromaeo/cssquery-ext.html) 08:17:04 INFO - PROCESS | 1954 | RSS: Main: 260145152 08:17:04 INFO - PROCESS | 1954 | 08:20:06 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54202/tests/dromaeo/cssquery-ext.html (next: http://localhost:54202/tests/dromaeo/cssquery-jquery.html) 08:20:07 INFO - PROCESS | 1954 | RSS: Main: 272203776 08:20:07 INFO - PROCESS | 1954 | 08:23:09 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54202/tests/dromaeo/cssquery-mootools.html) 08:23:09 INFO - PROCESS | 1954 | RSS: Main: 274198528 08:23:10 INFO - PROCESS | 1954 | 08:26:11 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54202/tests/dromaeo/cssquery-prototype.html) 08:26:12 INFO - PROCESS | 1954 | RSS: Main: 275771392 08:26:12 INFO - PROCESS | 1954 | 08:29:14 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54202/tests/dromaeo/cssquery-yui.html) 08:29:15 INFO - PROCESS | 1954 | RSS: Main: 278695936 08:29:15 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | Cycle 1(1): loaded http://localhost:54202/tests/dromaeo/cssquery-yui.html (next: http://localhost:54202/tests/dromaeo/cssquery-dojo.html) 08:32:18 INFO - PROCESS | 1954 | RSS: Main: 279740416 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | __start_tp_report 08:32:18 INFO - PROCESS | 1954 | _x_x_mozilla_page_load 08:32:18 INFO - PROCESS | 1954 | _x_x_mozilla_page_load_details 08:32:18 INFO - PROCESS | 1954 | |i|pagename|runs| 08:32:18 INFO - PROCESS | 1954 | |0;dojo.html;2954.630671166104;2980.3592227671047;3396.796192228468;3444.6727560881714;3514.420120680088;4576.862694119178;5081.923771143426;5812.709364531777;5818.86532126235;5886.411358864111;5758.683272420015;5811.4479124483105;5861.17943487911;5919.467247947684;6009.429104235091;5214.035403450373;5285.577153827694;5290.153575427932;5360.356757189143;5366.248725178478;5388.595855310848;5424;5442.9727851360685;5467.972660136694;5482.616216864821;5179.663321884065;5236.633435659505;5291.179867120564;5314.362276526842;5324.334458192726;5296.311479507678;5309.177077552986;5327.227552004938;5337.733113344356;5350.357957045179;5248.186531087687;5293.258943747878;5315.441878602768;5323.653962492425;5370.570354371641;4465.933011004838;5699.316082070137;5701.258836351248;5763.971180144114;5815.302163740336;6219;6250.593711408744;6261.436470717612;6280.2777680566405;6281.8743625127245;6178.783742568989;6227.09707092469;6299.590526615755;6312.684365781738;6320.652364119972;6008.128821320884;6009.789657361971;6010.489108425745;6035.366286539938;6057.515398768088;6428.935710642833;6467.126937863328;6474.546781725234;6496.187976502937;6509.153810004669;6099.884870379854;6150.538709596798;6227.813165605039;6250.874982500324;6259.280182779039;6289.8742025159245;6300.8892021172505;6302.464290535264;6318.304986451487;6321.715522801485;5150.742462876841;6141.692915354214;6188.319284878659;6285.340039295899;6297.433231009231;6130.153553065376;6184.381561843779;6198.0702894566175;6281.309056003836;6292.05619157121;5020.497950205024;5024.296598476216;5041.974790126026;5048.899022019539;5076.213186956028;4469.195544801967;4495.370648109268;4499.055198408371;4515.571020753023;4526.479454862667;5516.117421212587;5747.339056008613;5776.537876969833;5944.286685597669;5972.701364931736;6251.718672659741;6255.96872015637;6326.936730632635;6328.303886572473;6333.746650134035;5886.735096920649;5934.940650593525;5944.791932282349;5945.227120474311;5989.460948514655;5388.7305634718105;5452.591055670761;5527.115661494142;5531.004419204582;5544.528715059265;6486.481081513562;6514;6533.085368048477;6541.149650545399;6573.3098024706715;6156.107364432221;6279.30927597973;6309.621422714652;6322.399372059647;6325.746970121144;6425.614463132227;6470.514711396759;6475.384838440341;6547.312532184052;6557.803265902031;6216.906746398718;6253.280872699698;6278.183836101278;6297.055441683601;6309.652969086745;6187.381261873777;6189.1025801257665;6302.369763023661;6305.432511074026;6444.387783160592;6121.479674227562;6126.877462450815;6149.739303442694;6240.032794916795;6274.717637706223;6207.410296021871;6222.657753823583;6223.657698826608;6245.0320200369015;6248.0003199487865;5327.7746118392215;5940.316863560746;6013.218281623361;6144.354842741448;6149.938500614937;5681.602287839812;6120.782376608402;6187.84530386726;6195.1636529068;6222.28443728977;6085.482733967662;6098.359672234352;6123.693815309306;6132.2947860996555;6135.14108024868 08:32:18 INFO - PROCESS | 1954 | |1;ext.html;502.4096686393487;527.064460582466;573.7360814025548;580.3558050563876;591.3347484080409;29644;35660.821695891515;36700.44949325762;36810.631893681086;36969.630303696955;30483;36982.63017369826;37195.25609487809;37601.059973500676;37606.87179384623;9225.031371705974;9238.491882946435;9395.859062114074;9443.291753118508;9472.242220622335;7862.567558784264;9425.151736343727;9492.66775662852;9518.190953768937;9561;9307.76730581734;9459.24326053914;9475.47884866332;9547.904520954806;9575.23398128148;8046.758597242092;9344.439333640003;9455.669051583196;9506.714798556055;9541.475218862994;9260.953695231548;9273.675421360287;9363.48500832454;9436.339456238065;9520.095590918852;36214;36250.8187459061;36283.4557481638;37008.444873326924;37422.812885935666;2504.3864253257884;2943.234758962664;3015.8271085358488;3298.5217143514055;3835.4101868177554;26210;26352.60471092935;26989.460210795674;27001.72998270012;27130.1860944172;2638.274474519503;2647.3116989582654;2662.6671666041743;2726.6046423268517;2765.198092553157;319703;319736;319751.40124299465;321601;322962.38518807257;32765.50851737226;33059;33110.337793244;33117.33765324728;33172.3365532688;34064.82967585146;64221;65194;66043;66228.33771662318;16531.173441327886;16585.336586536643;16711.66576668484;16729.581760455843;16739.414120505724;12813.487460501661;12902.290374029331;12924.095313327976;12965.22208667483;12981.545645902537;17957.551061223312;18586.907065464588;18635.720464193048;18674.533136671693;18693.439196824118;7227.927720722725;7755.759078547405;8003;8169.12110214654;8210.835783284301;923.879895613566;993.0764389118045;993.9503024848729;1017.6896046705825;1023.3808545829814;27621.171364859085;28951.56572651412;29278.560821587693;29459.558106628418;29675.703242967294;914.9222316103205;1060.692399204222;1066.7599790047332;1147.8234809320513;1233.901287896966;14235.928820355832;14530.709385812435;14582.4896128635;14683.706325873423;14874.553763387115;578694;593994;599902;605334;616575;52183.47816521862;55708;56131;56523.43476565264;56607.150892736645;1288.1626942487458;1335.6861137632648;1352.5198554513006;1372.6499742565582;1485.1163557683162;22870.313890583308;28261.43477130487;28678.71321286844;29017;29195.562066569444;52878;54905.45094549003;55570.72214638901;56069.71965140148;56381.71809140928;575528.1223593855;578130;578524;584642;587235;39586.40620390754;40546.59453405428;40634.57778977721;41240.968975775846;41413.171736564494;37018.8149059253;44562.77718611386;45005.774971124934;45554.54445455503;45939.310910335706;34845;36232;37090.62909370872;37159.44260836144;37749.62250377571;35499.82250088836;36260;36277.45583816192;36935.076623084635;37546;36091.819540903176;36398;36483.635163648025;37045;37130;26100.477990440464;31758;32503.512447313784;32764.50853237251;33092.503612446315;21835.344939651837;22361;22555.887220563793;24218.273451796475;25051 08:32:18 INFO - PROCESS | 1954 | |2;jquery.html;325.99430756117374;343.65806023007104;383.39615106207714;389.16524055900095;405.5073086200266;19338.323158689433;20003.89998050008;20071.598568028632;20872.791272087274;20930.953452327398;15185.240737963113;15356;15662.373505059812;16628.337166283367;19997.800021999774;5462.808801691932;6024.789132380368;6050.576459647805;6068.908966365508;6140.324564297924;5671.291088613923;5803.709814509279;5866.061430171173;5928.436798504157;5932.495737862266;4912.557869791718;5632.239647647556;5851.79518716845;5853.531717462614;5889.2049573307695;5890.558208134407;5916.645001299936;5921.674307913063;5930.28836539618;5962.046072628359;4223.7140931892545;5003.249512573107;5059.241113832918;5089.3638295213095;5096.235564665293;19829.801701983084;25108.497830043478;25174.622380664303;25509.107181248753;25631.48737025268;2082.781307962657;2186.726659167604;2244.16965722682;2458.4591389894194;2635.3148181472957;14242.430302787876;14676;14914.925425372803;14920.552383428514;14949.850501494955;1693.1618848669864;1745.729411941151;1746.388763932626;1782.9019403932778;1793.175139435861;83709.58145209296;105314;108907.91092089057;109112;109717;9282.535873206447;9615.50959601263;10493.213009024354;10625.574977000833;10820.296680715728;13298.800517992238;13307.802297793245;13384.263865487492;13389.330533473481;13443.529476468473;8580;8724.912750872538;8745.868811967826;8755.255803256794;8787.989381221114;8747.387682862265;8840.823183536293;8852.8672069919;8870.157335053289;8941.284697224206;5989.850253743692;6115.113308570321;6439.5170362223025;6585.769498067544;6586.571872828251;1664.9583760405844;1767.4785938148277;1840.6778813707547;1849.861260405475;1868.4301288106985;374.9418840079792;389.75055964182945;426.1179358727405;1029.234862211311;1052.952617132231;10564.260501764957;10807.729806754895;10933.016028557468;11054.336739795637;11451.141164412702;430.4812700695654;436.62886546435277;440.18565653541333;444.1782702001336;447.11471286852213;5801.477866991991;5867.14926335679;5921.585489015813;5937.346891841894;5963.7912673056235;600312;614109;617786;622560;628939;98235;139076;140704;141625;146081;425.37894673776634;439.3695047606695;439.69221544918685;439.83066519390263;439.93400989851136;10358.378497289885;10613.09788667941;10645.361278323326;10743.946280268548;10757.462126893468;47380.60361851106;48718.782030449525;49293.50706492889;51557.48442515677;52950.29347945607;77192.61403692946;77262.6136869312;78634.60682696779;79026.20973790418;80719.38561228625;7572.962135189288;7649.082110146818;7679.808004799701;7869.134395216407;8088.3529317653265;10081.344712593658;10617.362958222531;12122.696932576404;12296.446659900505;12449.439775209956;8380.706675266336;10044.497775111362;10540.104091152338;10623.575056997943;10806.081483074027;10429.061384475433;10454;10549.578016879239;10596.576136954436;10933.234673572773;10819.621313253998;10834.404107774148;10999.945000274947;11113;11152.386618736047;6865.176178858569;7293.671784769592;7359.043324368012;7745.457817952689;7884.29041386278;10511.526981285708;10707.250492465453;11269.605563805555;11511.021563167225;11513.654590362303 08:32:18 INFO - PROCESS | 1954 | |3;mootools.html;1608.1878651281102;1630.7064728348896;1797.4248240563018;1904.3620387170297;1961.892095934723;7300.2334754850635;7946.721864734735;8501.787455313612;8799.999999999993;8807.647694092237;8719.4332368396;8765.561721913895;8789.91210087899;8841.160089791476;8864.822703545926;2387.2480168746833;2415.806735461159;2416.1301931304806;2421.092090466075;2440.6827112475444;2389.2951579284154;2416.830821842472;2417.891194896225;2438.9146379876706;2439.182873737291;2374.2402431222017;2403.6514705367713;2406.109739396426;2433.2578563538113;2438;2206.801387875099;2334.2180369576213;2345.2729653807373;2375.6080246759266;2383.678203442539;2069.627467055929;2359.7168339799164;2374.4894847607675;2387.7612238775982;2391.7727815857465;8673.739787806377;8678.088800675901;8685.869711954325;8804.515751633657;8807.515586642732;3970.642642162219;4453.688241823073;5076.213186956028;5096.133657278272;5172.301739265226;3315;3405.540252065989;3435.347284016054;3435.4331535296897;3444.603870554893;946.2524605561598;964.1659964130977;972.4311277902365;973.7127547373542;989.5200827598609;11124.888751112467;11254;11312.717182070432;11420.14348923834;11425;4005.339119045325;4029.932068001982;4247.936280955788;4363.759993200341;4394.648428125743;8859.557022148867;8927.508987005776;8953.373263871466;8973;8973.685920992733;4947.431045429822;4978.253262010728;5004.099262132779;5023.171176755867;5049.368828896388;4347.108842687241;4627.838025669085;4675.976620116946;4802.687825291345;4822.373091498082;3741;3756.981215093907;3856.36369998947;3867.1105645701646;3876.767393956315;1176.0474016047028;1196.0610920427423;1197.8862008109215;1205.3370646144585;1210.4855436439477;623.7910300049534;894.4052205283414;924.995375023134;932.5523748600709;938.4932136646134;5674.744636491368;5715.942840571624;5869.618474799125;5930.525557955353;5956.85107872298;436.4260996789212;436.7794263896712;437.01235208429176;439.2072309481353;439.6394956135938;3099.9225019374244;3830;3880.3791393376923;3930.606939306104;3992.9817896436225;10370.377777333384;10783.730406739738;10813.243072984815;10832.133429325635;10838.187135964834;8878.378513503993;10282.485875706185;10549.261551691461;10607.628732994308;10648;7153.570785752871;8102.837943241102;8179.67281308741;8197.754067377988;8216.178382161856;4681.625469962463;5708.001099807434;5726.9713651431475;5844.26946631671;5888.028475301699;9758.951205243928;9853.901460985586;9983.900160998297;10023.799524009333;10036.397816131055;9699;9754.609815607297;9962.55168517404;10044.447555384524;10115.39307641544;6396.872062558629;6694.665266736546;6798.490113241625;6857.588544687334;6972.7908162753165;8177.427580069576;8249.422540422112;8274.379421543288;8283.130271321665;8311.127331630092;7186.532875363085;7215.71137154508;7309.597972111372;7322.157951835394;7370.889436658347;7197.532160409557;7321.963390183015;7367.115946086504;7381.8154546136775;7395.556266624019;6334.8733025338315;6838.179418469816;6892.896606550806;6929.480288978246;6935.410490108397;4774.522547745198;4812.35033270504;4912.066707325596;4936.062148191832;5026.371703537058;4868.513148685103;4916.139675556835;4924.975375123101;4975.527324904128;5077.669951453144 08:32:18 INFO - PROCESS | 1954 | |4;prototype.html;312.49220017471606;313.4592827372781;319.5925195375894;320.1244596029858;326.32613652806964;5920.9407905920925;5967.850803729909;5968.941120038372;5976.462118409342;5999.820005399834;4612.584867361937;5722.771089156428;5799.9130013049835;5919.141724449953;5930.110483427488;3867.916983244696;4007.418924255981;4181.540030596632;4333.544977777336;4395.428594282755;3251.92686413483;4337.219300525904;4379.386885835986;4430.778461076933;4436.201483732927;4384.539623339551;4386.714863533876;4386.868393948187;4394.450693663292;4415.271480205778;3227.7417806575418;4065.5934406559404;4309.267424537836;4361.018770776582;4421.513633500313;3715.925681486355;3719.274741425423;3732.6453986871475;3738.7195960302815;3742.2141350316465;5160;5629.577781666391;5631.831045068655;5673.6879471629045;5676.716164191774;4390.429244198233;4700.224462963607;5022.4726403727445;5034.874128146789;5038.722870242135;5256.81601143962;5549.916751248735;6190.133381326618;6242.971034413788;6254.874902501924;3445.896623101286;3671.1372827385544;3923.901902452433;4118.320477121271;4130.153318569716;6325.209348831396;6567.211934567835;6567.967160164217;6625.37058979401;6670.232923213844;3159.9684003159673;3656.7440279180732;4144.150449157915;4147.771872547039;4158.708890377705;3540.8052557109604;4068.010012640707;4214.3889136075095;4228.112096459778;4262.488501379792;4434.5343738907595;4810.7835147418455;4998.90002199954;5015.22264049073;5022.869854282757;5559.360673522516;5924.970375148183;6212.937870621236;6268.905966410507;6332.366763323723;1287.6394609509166;1306.3598836570013;1356.51165580391;1468.566772802026;1473.8747206487353;761.6153842309598;876.4268138691065;887.5296093070683;926.4672813132476;965.1410244882061;5766.654000759968;5796.1595568642315;5829.417058294137;5829.88340233193;5834.533237341003;5635.746391412396;5863.706814659336;6451.064595633607;6461.321561236096;6489.253735820441;5530.695811730394;5588.524975377057;5909.674967876808;5930.466258036798;5938.168656388109;3018.9245268868017;3355.1043660331834;3429.794212347267;3488.686018258369;3504.159001839591;5340.732963351817;5813.982553053199;6270.498360131179;6683.866322673519;6745.156855393076;5450.291462109901;6442.967785161138;6758.763443279461;6783.118194634764;6788.321167883172;5729.942700573024;6378.52161087911;6872.312768723088;6880.176753160416;6918.481113916477;6524.804255872332;6525.771597994048;6554.967225163844;6562.901556476561;6565.310642382672;5645.633033852787;6167.5374346925055;6453;6465.2564955030775;6480.837979050561;6550.705218265094;6849.10961575012;6855.280195579392;6877.552959057645;6911.274316196928;3783.905402364963;4195.727277726938;4207.894802629837;4208.81060352291;4220.198162349144;5769.749527929564;6170.444659980623;6521.054447105048;6546.672666366758;6587.80236592903;5833.387494313036;5975.043992961106;6320.462760665395;6323.36766323364;6348.238211414659;5269.841904742864;5407.729613519387;6007.279126504847;6310.5073495969755;6331.9366806331345;4542.909141817211;5119.257707632447;6041.879162416815;6183.96908015457;6303.275123360872;4918.491569299611;5257.4742525747115;6020.795840831764;6301.842453938688;6314.652694101868;4651.418572678415;5378.784848606012;5872.619934315518;6020.819375418744;6185 08:32:18 INFO - PROCESS | 1954 | |5;yui.html;659.9043138744883;756.7578374920024;757.8749506331455;762.546284960449;768.9038870141233;14698.824094072475;14995.92502037491;15032.17323047232;15201.923990380046;15225.39098436064;13204.735905281888;13310.800337994939;13410.19538827671;13453.125546839448;13459.528916487925;730.9122905251351;899.7390756680555;910.2444970674358;919.0763282900675;919.9494027828467;893.2318206342541;910.508325504227;915.3455279475174;932.4591736792678;934.1219253901345;922.4004397141845;943.1087622197026;959.1990687775716;960.1742501448748;963.9614415423409;923.3859483443503;940.9012053734363;950.9191718703919;955.5795450002012;959.0888655777039;676.6650507998572;686.1765880942838;706.8901824136109;707.982300442493;710.9004739336497;14756.631084222872;14992.625184370369;15009.324580393799;15014.423485533971;15027.474038408604;12482.687932801662;12598.68503287416;12598.685032874251;12614.306213158272;12864.035197360236;10063.245256605784;10074.345167564084;10129.290949633529;10299.330543514647;10494.212934029978;3379.2734562069027;3485.2158264390564;3532.417151170054;3696.0390298522307;3721.5162028936334;83307.58346208291;84691.57654211752;84891;85132.99999999937;85679.57160214159;9373;9516.571754271074;9530.904690953003;9592.616295348107;9827.820661520664;21302.36092917215;21360.57278854414;21374.679379809317;21388.35834924955;22028.77971220267;7510.511816732004;7605.885911711329;7683;7708.49894756839;7903.217024141284;4056.6957478189256;4070.5115386153257;4112;4150.771707556053;4163.937540936889;3411.6588341165684;3453.430184019659;3522.0842580929143;3528.8235588221;3794.6205379461835;654.9476041916636;663.6880666086931;666.5500786968777;671.9966400167967;675.8598135934988;493.76804871844257;506.7086425305464;523.2674256041572;570.6918264137403;572.7365411910484;7782.416318776114;7911.841763164704;8151.714689985822;8196.385271104691;8475.618597163142;539.0620320642133;552.9834104976857;560.7504660426152;569.900267453194;599.6132494540997;3757.511523501982;3871.903202419962;3970.9679670598134;3972.2651309507255;3987.142764305688;77657.83513247306;86804;89957.90378865933;90174.64738028935;98689.01310986943;56873.715631421575;71063.57872842514;73476;74807.62596186984;75730;49366.25950610744;63546;70461;71350.64324678344;71993.28006719971;7914.762557123296;7945.523268603903;8061.355091592542;8151.1441298662785;8160.959195203986;30872.30202338893;36371.545138194175;40451.797741011105;42965.747244474594;43676.781616091714;55742.885142296116;59830.70084649549;61520;62068.37931620807;62107.136785896495;10585.52365143555;10722.356658600509;10816.513256903616;10869.347839129678;10925.342006604076;11697.766044679229;11768.82346764782;12237.0822188338;12323;12916.418761155583;11061.944690276498;11207.383593902414;11325.71685707864;11553;11657.591984280509;10454;10598.470076496298;10619.94690026545;10653.520591573553;10787;10371.27401081917;10855.348679079281;11165.49755260999;11189.328640281608;11280.66158015228;9137.497437640994;9347.298952578447;9517.857232141661;9615.807683846424;9618.182454491447;9335.486548239913;9533.998930112515;9587.568559414982;9606.711798646053;9658 08:32:18 INFO - PROCESS | 1954 | __end_tp_report 08:32:18 INFO - PROCESS | 1954 | __start_cc_report 08:32:18 INFO - PROCESS | 1954 | _x_x_mozilla_cycle_collect,413 08:32:18 INFO - PROCESS | 1954 | __end_cc_report 08:32:18 INFO - PROCESS | 1954 | __startTimestamp1460734338366__endTimestamp 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | ------- Summary: start ------- 08:32:18 INFO - PROCESS | 1954 | Number of tests: 6 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | [#0] dojo.html Cycles:165 Average:5815.46 Median:6099.88 stddev:681.48 (11.2%) stddev-sans-first:645.56 08:32:18 INFO - PROCESS | 1954 | Values: 2954.6 2980.4 3396.8 3444.7 3514.4 4576.9 5081.9 5812.7 5818.9 5886.4 5758.7 5811.4 5861.2 5919.5 6009.4 5214.0 5285.6 5290.2 5360.4 5366.2 5388.6 5424.0 5443.0 5468.0 5482.6 5179.7 5236.6 5291.2 5314.4 5324.3 5296.3 5309.2 5327.2 5337.7 5350.4 5248.2 5293.3 5315.4 5323.7 5370.6 4465.9 5699.3 5701.3 5764.0 5815.3 6219.0 6250.6 6261.4 6280.3 6281.9 6178.8 6227.1 6299.6 6312.7 6320.7 6008.1 6009.8 6010.5 6035.4 6057.5 6428.9 6467.1 6474.5 6496.2 6509.2 6099.9 6150.5 6227.8 6250.9 6259.3 6289.9 6300.9 6302.5 6318.3 6321.7 5150.7 6141.7 6188.3 6285.3 6297.4 6130.2 6184.4 6198.1 6281.3 6292.1 5020.5 5024.3 5042.0 5048.9 5076.2 4469.2 4495.4 4499.1 4515.6 4526.5 5516.1 5747.3 5776.5 5944.3 5972.7 6251.7 6256.0 6326.9 6328.3 6333.7 5886.7 5934.9 5944.8 5945.2 5989.5 5388.7 5452.6 5527.1 5531.0 5544.5 6486.5 6514.0 6533.1 6541.1 6573.3 6156.1 6279.3 6309.6 6322.4 6325.7 6425.6 6470.5 6475.4 6547.3 6557.8 6216.9 6253.3 6278.2 6297.1 6309.7 6187.4 6189.1 6302.4 6305.4 6444.4 6121.5 6126.9 6149.7 6240.0 6274.7 6207.4 6222.7 6223.7 6245.0 6248.0 5327.8 5940.3 6013.2 6144.4 6149.9 5681.6 6120.8 6187.8 6195.2 6222.3 6085.5 6098.4 6123.7 6132.3 6135.1 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | [#1] ext.html Cycles:180 Average:63048.55 Median:36755.54 stddev:138193.14 (376.0%) stddev-sans-first:138501.02 08:32:18 INFO - PROCESS | 1954 | Values: 502.4 527.1 573.7 580.4 591.3 29644.0 35660.8 36700.4 36810.6 36969.6 30483.0 36982.6 37195.3 37601.1 37606.9 9225.0 9238.5 9395.9 9443.3 9472.2 7862.6 9425.2 9492.7 9518.2 9561.0 9307.8 9459.2 9475.5 9547.9 9575.2 8046.8 9344.4 9455.7 9506.7 9541.5 9261.0 9273.7 9363.5 9436.3 9520.1 36214.0 36250.8 36283.5 37008.4 37422.8 2504.4 2943.2 3015.8 3298.5 3835.4 26210.0 26352.6 26989.5 27001.7 27130.2 2638.3 2647.3 2662.7 2726.6 2765.2 319703.0 319736.0 319751.4 321601.0 322962.4 32765.5 33059.0 33110.3 33117.3 33172.3 34064.8 64221.0 65194.0 66043.0 66228.3 16531.2 16585.3 16711.7 16729.6 16739.4 12813.5 12902.3 12924.1 12965.2 12981.5 17957.6 18586.9 18635.7 18674.5 18693.4 7227.9 7755.8 8003.0 8169.1 8210.8 923.9 993.1 994.0 1017.7 1023.4 27621.2 28951.6 29278.6 29459.6 29675.7 914.9 1060.7 1066.8 1147.8 1233.9 14235.9 14530.7 14582.5 14683.7 14874.6 578694.0 593994.0 599902.0 605334.0 616575.0 52183.5 55708.0 56131.0 56523.4 56607.2 1288.2 1335.7 1352.5 1372.6 1485.1 22870.3 28261.4 28678.7 29017.0 29195.6 52878.0 54905.5 55570.7 56069.7 56381.7 575528.1 578130.0 578524.0 584642.0 587235.0 39586.4 40546.6 40634.6 41241.0 41413.2 37018.8 44562.8 45005.8 45554.5 45939.3 34845.0 36232.0 37090.6 37159.4 37749.6 35499.8 36260.0 36277.5 36935.1 37546.0 36091.8 36398.0 36483.6 37045.0 37130.0 26100.5 31758.0 32503.5 32764.5 33092.5 21835.3 22361.0 22555.9 24218.3 25051.0 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | [#2] jquery.html Cycles:180 Average:34388.79 Median:386.28 stddev:102824.29 (26619.1%) stddev-sans-first:103080.93 08:32:18 INFO - PROCESS | 1954 | Values: 326.0 343.7 383.4 389.2 405.5 19338.3 20003.9 20071.6 20872.8 20931.0 15185.2 15356.0 15662.4 16628.3 19997.8 5462.8 6024.8 6050.6 6068.9 6140.3 5671.3 5803.7 5866.1 5928.4 5932.5 4912.6 5632.2 5851.8 5853.5 5889.2 5890.6 5916.6 5921.7 5930.3 5962.0 4223.7 5003.2 5059.2 5089.4 5096.2 19829.8 25108.5 25174.6 25509.1 25631.5 2082.8 2186.7 2244.2 2458.5 2635.3 14242.4 14676.0 14914.9 14920.6 14949.9 1693.2 1745.7 1746.4 1782.9 1793.2 83709.6 105314.0 108907.9 109112.0 109717.0 9282.5 9615.5 10493.2 10625.6 10820.3 13298.8 13307.8 13384.3 13389.3 13443.5 8580.0 8724.9 8745.9 8755.3 8788.0 8747.4 8840.8 8852.9 8870.2 8941.3 5989.9 6115.1 6439.5 6585.8 6586.6 1665.0 1767.5 1840.7 1849.9 1868.4 374.9 389.8 426.1 1029.2 1053.0 10564.3 10807.7 10933.0 11054.3 11451.1 430.5 436.6 440.2 444.2 447.1 5801.5 5867.1 5921.6 5937.3 5963.8 600312.0 614109.0 617786.0 622560.0 628939.0 98235.0 139076.0 140704.0 141625.0 146081.0 425.4 439.4 439.7 439.8 439.9 10358.4 10613.1 10645.4 10743.9 10757.5 47380.6 48718.8 49293.5 51557.5 52950.3 77192.6 77262.6 78634.6 79026.2 80719.4 7573.0 7649.1 7679.8 7869.1 8088.4 10081.3 10617.4 12122.7 12296.4 12449.4 8380.7 10044.5 10540.1 10623.6 10806.1 10429.1 10454.0 10549.6 10596.6 10933.2 10819.6 10834.4 10999.9 11113.0 11152.4 6865.2 7293.7 7359.0 7745.5 7884.3 10511.5 10707.3 11269.6 11511.0 11513.7 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | [#3] mootools.html Cycles:180 Average:5532.20 Median:4920.56 stddev:3132.13 (63.7%) stddev-sans-first:3127.04 08:32:18 INFO - PROCESS | 1954 | Values: 1608.2 1630.7 1797.4 1904.4 1961.9 7300.2 7946.7 8501.8 8800.0 8807.6 8719.4 8765.6 8789.9 8841.2 8864.8 2387.2 2415.8 2416.1 2421.1 2440.7 2389.3 2416.8 2417.9 2438.9 2439.2 2374.2 2403.7 2406.1 2433.3 2438.0 2206.8 2334.2 2345.3 2375.6 2383.7 2069.6 2359.7 2374.5 2387.8 2391.8 8673.7 8678.1 8685.9 8804.5 8807.5 3970.6 4453.7 5076.2 5096.1 5172.3 3315.0 3405.5 3435.3 3435.4 3444.6 946.3 964.2 972.4 973.7 989.5 11124.9 11254.0 11312.7 11420.1 11425.0 4005.3 4029.9 4247.9 4363.8 4394.6 8859.6 8927.5 8953.4 8973.0 8973.7 4947.4 4978.3 5004.1 5023.2 5049.4 4347.1 4627.8 4676.0 4802.7 4822.4 3741.0 3757.0 3856.4 3867.1 3876.8 1176.0 1196.1 1197.9 1205.3 1210.5 623.8 894.4 925.0 932.6 938.5 5674.7 5715.9 5869.6 5930.5 5956.9 436.4 436.8 437.0 439.2 439.6 3099.9 3830.0 3880.4 3930.6 3993.0 10370.4 10783.7 10813.2 10832.1 10838.2 8878.4 10282.5 10549.3 10607.6 10648.0 7153.6 8102.8 8179.7 8197.8 8216.2 4681.6 5708.0 5727.0 5844.3 5888.0 9759.0 9853.9 9983.9 10023.8 10036.4 9699.0 9754.6 9962.6 10044.4 10115.4 6396.9 6694.7 6798.5 6857.6 6972.8 8177.4 8249.4 8274.4 8283.1 8311.1 7186.5 7215.7 7309.6 7322.2 7370.9 7197.5 7322.0 7367.1 7381.8 7395.6 6334.9 6838.2 6892.9 6929.5 6935.4 4774.5 4812.4 4912.1 4936.1 5026.4 4868.5 4916.1 4925.0 4975.5 5077.7 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | [#4] prototype.html Cycles:180 Average:4988.65 Median:5659.66 stddev:1621.17 (28.6%) stddev-sans-first:1587.27 08:32:18 INFO - PROCESS | 1954 | Values: 312.5 313.5 319.6 320.1 326.3 5920.9 5967.9 5968.9 5976.5 5999.8 4612.6 5722.8 5799.9 5919.1 5930.1 3867.9 4007.4 4181.5 4333.5 4395.4 3251.9 4337.2 4379.4 4430.8 4436.2 4384.5 4386.7 4386.9 4394.5 4415.3 3227.7 4065.6 4309.3 4361.0 4421.5 3715.9 3719.3 3732.6 3738.7 3742.2 5160.0 5629.6 5631.8 5673.7 5676.7 4390.4 4700.2 5022.5 5034.9 5038.7 5256.8 5549.9 6190.1 6243.0 6254.9 3445.9 3671.1 3923.9 4118.3 4130.2 6325.2 6567.2 6568.0 6625.4 6670.2 3160.0 3656.7 4144.2 4147.8 4158.7 3540.8 4068.0 4214.4 4228.1 4262.5 4434.5 4810.8 4998.9 5015.2 5022.9 5559.4 5925.0 6212.9 6268.9 6332.4 1287.6 1306.4 1356.5 1468.6 1473.9 761.6 876.4 887.5 926.5 965.1 5766.7 5796.2 5829.4 5829.9 5834.5 5635.7 5863.7 6451.1 6461.3 6489.3 5530.7 5588.5 5909.7 5930.5 5938.2 3018.9 3355.1 3429.8 3488.7 3504.2 5340.7 5814.0 6270.5 6683.9 6745.2 5450.3 6443.0 6758.8 6783.1 6788.3 5729.9 6378.5 6872.3 6880.2 6918.5 6524.8 6525.8 6555.0 6562.9 6565.3 5645.6 6167.5 6453.0 6465.3 6480.8 6550.7 6849.1 6855.3 6877.6 6911.3 3783.9 4195.7 4207.9 4208.8 4220.2 5769.7 6170.4 6521.1 6546.7 6587.8 5833.4 5975.0 6320.5 6323.4 6348.2 5269.8 5407.7 6007.3 6310.5 6331.9 4542.9 5119.3 6041.9 6184.0 6303.3 4918.5 5257.5 6020.8 6301.8 6314.7 4651.4 5378.8 5872.6 6020.8 6185.0 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - PROCESS | 1954 | [#5] yui.html Cycles:180 Average:17396.85 Median:571.71 stddev:24342.46 (4257.8%) stddev-sans-first:24378.31 08:32:18 INFO - PROCESS | 1954 | Values: 659.9 756.8 757.9 762.5 768.9 14698.8 14995.9 15032.2 15201.9 15225.4 13204.7 13310.8 13410.2 13453.1 13459.5 730.9 899.7 910.2 919.1 919.9 893.2 910.5 915.3 932.5 934.1 922.4 943.1 959.2 960.2 964.0 923.4 940.9 950.9 955.6 959.1 676.7 686.2 706.9 708.0 710.9 14756.6 14992.6 15009.3 15014.4 15027.5 12482.7 12598.7 12598.7 12614.3 12864.0 10063.2 10074.3 10129.3 10299.3 10494.2 3379.3 3485.2 3532.4 3696.0 3721.5 83307.6 84691.6 84891.0 85133.0 85679.6 9373.0 9516.6 9530.9 9592.6 9827.8 21302.4 21360.6 21374.7 21388.4 22028.8 7510.5 7605.9 7683.0 7708.5 7903.2 4056.7 4070.5 4112.0 4150.8 4163.9 3411.7 3453.4 3522.1 3528.8 3794.6 654.9 663.7 666.6 672.0 675.9 493.8 506.7 523.3 570.7 572.7 7782.4 7911.8 8151.7 8196.4 8475.6 539.1 553.0 560.8 569.9 599.6 3757.5 3871.9 3971.0 3972.3 3987.1 77657.8 86804.0 89957.9 90174.6 98689.0 56873.7 71063.6 73476.0 74807.6 75730.0 49366.3 63546.0 70461.0 71350.6 71993.3 7914.8 7945.5 8061.4 8151.1 8161.0 30872.3 36371.5 40451.8 42965.7 43676.8 55742.9 59830.7 61520.0 62068.4 62107.1 10585.5 10722.4 10816.5 10869.3 10925.3 11697.8 11768.8 12237.1 12323.0 12916.4 11061.9 11207.4 11325.7 11553.0 11657.6 10454.0 10598.5 10619.9 10653.5 10787.0 10371.3 10855.3 11165.5 11189.3 11280.7 9137.5 9347.3 9517.9 9615.8 9618.2 9335.5 9534.0 9587.6 9606.7 9658.0 08:32:18 INFO - PROCESS | 1954 | -------- Summary: end -------- 08:32:18 INFO - PROCESS | 1954 | 08:32:18 INFO - TEST-INFO | 1954: exit 0 08:32:18 INFO - TEST-OK | dromaeo_css | took 1111623ms 08:32:18 INFO - TEST-START | kraken 08:32:18 INFO - operating with platform_type : mac_ 08:32:18 INFO - Initialising browser for kraken test... 08:32:18 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpUYdWce/profile http://localhost:54202/getInfo.html) 08:32:21 INFO - PROCESS | 1960 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 08:32:22 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 08:32:22 INFO - PROCESS | 1960 | colorDepth:24 08:32:22 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 08:32:22 INFO - PROCESS | 1960 | __metrics 08:32:22 ERROR - PROCESS | 1960 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:32:22 INFO - TEST-INFO | 1960: exit 0 08:32:22 INFO - Browser initialized. 08:32:22 INFO - Running cycle 1/1 for kraken test... 08:32:22 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpUYdWce/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:34 INFO - PROCESS | 1963 | RSS: Main: 249188352 08:32:34 INFO - PROCESS | 1963 | 08:32:37 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54202/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:38 INFO - PROCESS | 1963 | RSS: Main: 261251072 08:32:38 INFO - PROCESS | 1963 | 08:32:41 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54202/tests/kraken/driver.html?testName=audio-dft) 08:32:42 INFO - PROCESS | 1963 | RSS: Main: 270639104 08:32:42 INFO - PROCESS | 1963 | 08:32:45 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54202/tests/kraken/driver.html?testName=audio-fft) 08:32:45 INFO - PROCESS | 1963 | RSS: Main: 272773120 08:32:45 INFO - PROCESS | 1963 | 08:32:47 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54202/tests/kraken/driver.html?testName=audio-oscillator) 08:32:48 INFO - PROCESS | 1963 | RSS: Main: 274399232 08:32:48 INFO - PROCESS | 1963 | 08:32:50 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:51 INFO - PROCESS | 1963 | RSS: Main: 274993152 08:32:51 INFO - PROCESS | 1963 | 08:32:54 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54202/tests/kraken/driver.html?testName=imaging-darkroom) 08:32:54 INFO - PROCESS | 1963 | RSS: Main: 275746816 08:32:54 INFO - PROCESS | 1963 | 08:32:57 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54202/tests/kraken/driver.html?testName=imaging-desaturate) 08:32:58 INFO - PROCESS | 1963 | RSS: Main: 275849216 08:32:58 INFO - PROCESS | 1963 | 08:33:01 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54202/tests/kraken/driver.html?testName=json-parse-financial) 08:33:02 INFO - PROCESS | 1963 | RSS: Main: 276254720 08:33:02 INFO - PROCESS | 1963 | 08:33:03 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:33:04 INFO - PROCESS | 1963 | RSS: Main: 275902464 08:33:04 INFO - PROCESS | 1963 | 08:33:06 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:33:07 INFO - PROCESS | 1963 | RSS: Main: 275169280 08:33:07 INFO - PROCESS | 1963 | 08:33:09 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:33:09 INFO - PROCESS | 1963 | RSS: Main: 275386368 08:33:09 INFO - PROCESS | 1963 | 08:33:12 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:33:13 INFO - PROCESS | 1963 | RSS: Main: 275447808 08:33:13 INFO - PROCESS | 1963 | 08:33:16 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:33:17 INFO - PROCESS | 1963 | RSS: Main: 275689472 08:33:17 INFO - PROCESS | 1963 | 08:33:18 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:54202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54202/tests/kraken/driver.html?testName=ai-astar) 08:33:19 INFO - PROCESS | 1963 | RSS: Main: 276733952 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | __start_tp_report 08:33:19 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 08:33:19 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 08:33:19 INFO - PROCESS | 1963 | |i|pagename|runs| 08:33:19 INFO - PROCESS | 1963 | |0;ai-astar;157;155;166;115;115;158;171;153;116;117 08:33:19 INFO - PROCESS | 1963 | |1;audio-beat-detection;156;114;151;169;121;140;141;124;174;122 08:33:19 INFO - PROCESS | 1963 | |2;audio-dft;196;211;233;198;197;201;201;197;199;198 08:33:19 INFO - PROCESS | 1963 | |3;audio-fft;66;81;74;135;56;57;68;60;93;59 08:33:19 INFO - PROCESS | 1963 | |4;audio-oscillator;82;80;135;76;80;84;118;103;119;162 08:33:19 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;90;105;135;89;88;100;92;84;134;123 08:33:19 INFO - PROCESS | 1963 | |6;imaging-darkroom;152;122;96;132;148;95;96;95;107;136 08:33:19 INFO - PROCESS | 1963 | |7;imaging-desaturate;144;142;91;91;90;91;91;91;91;91 08:33:19 INFO - PROCESS | 1963 | |8;json-parse-financial;61;63;60;60;62;60;68;92;101;100 08:33:19 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;67;67;71;63;71;93;76;68;67;67 08:33:19 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;85;86;84;84;85;86;110;110;83;87 08:33:19 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;165;176;164;138;140;139;146;151;202;169 08:33:19 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;173;178;170;177;176;170;175;174;174;216 08:33:19 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;72;65;91;78;67;67;66;70;68;70 08:33:19 INFO - PROCESS | 1963 | __end_tp_report 08:33:19 INFO - PROCESS | 1963 | __start_cc_report 08:33:19 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1044 08:33:19 INFO - PROCESS | 1963 | __end_cc_report 08:33:19 INFO - PROCESS | 1963 | __startTimestamp1460734399033__endTimestamp 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | ------- Summary: start ------- 08:33:19 INFO - PROCESS | 1963 | Number of tests: 14 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:142.30 Median:156.00 stddev:23.44 (15.0%) stddev-sans-first:24.25 08:33:19 INFO - PROCESS | 1963 | Values: 157.0 155.0 166.0 115.0 115.0 158.0 171.0 153.0 116.0 117.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:146.00 stddev:21.02 (14.4%) stddev-sans-first:21.61 08:33:19 INFO - PROCESS | 1963 | Values: 156.0 114.0 151.0 169.0 121.0 140.0 141.0 124.0 174.0 122.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:203.10 Median:200.00 stddev:11.35 (5.7%) stddev-sans-first:11.74 08:33:19 INFO - PROCESS | 1963 | Values: 196.0 211.0 233.0 198.0 197.0 201.0 201.0 197.0 199.0 198.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:74.90 Median:67.00 stddev:24.17 (36.1%) stddev-sans-first:25.42 08:33:19 INFO - PROCESS | 1963 | Values: 66.0 81.0 74.0 135.0 56.0 57.0 68.0 60.0 93.0 59.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:103.90 Median:78.00 stddev:29.00 (37.2%) stddev-sans-first:29.65 08:33:19 INFO - PROCESS | 1963 | Values: 82.0 80.0 135.0 76.0 80.0 84.0 118.0 103.0 119.0 162.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:104.00 Median:86.00 stddev:19.61 (22.8%) stddev-sans-first:20.13 08:33:19 INFO - PROCESS | 1963 | Values: 90.0 105.0 135.0 89.0 88.0 100.0 92.0 84.0 134.0 123.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:117.90 Median:123.50 stddev:22.95 (18.6%) stddev-sans-first:20.76 08:33:19 INFO - PROCESS | 1963 | Values: 152.0 122.0 96.0 132.0 148.0 95.0 96.0 95.0 107.0 136.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:101.30 Median:91.00 stddev:21.99 (24.2%) stddev-sans-first:17.04 08:33:19 INFO - PROCESS | 1963 | Values: 144.0 142.0 91.0 91.0 90.0 91.0 91.0 91.0 91.0 91.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:72.70 Median:61.50 stddev:17.54 (28.5%) stddev-sans-first:18.09 08:33:19 INFO - PROCESS | 1963 | Values: 61.0 63.0 60.0 60.0 62.0 60.0 68.0 92.0 101.0 100.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:69.50 stddev:8.47 (12.2%) stddev-sans-first:8.86 08:33:19 INFO - PROCESS | 1963 | Values: 67.0 67.0 71.0 63.0 71.0 93.0 76.0 68.0 67.0 67.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:85.00 stddev:10.60 (12.5%) stddev-sans-first:11.09 08:33:19 INFO - PROCESS | 1963 | Values: 85.0 86.0 84.0 84.0 85.0 86.0 110.0 110.0 83.0 87.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:159.00 Median:164.50 stddev:20.37 (12.4%) stddev-sans-first:21.49 08:33:19 INFO - PROCESS | 1963 | Values: 165.0 176.0 164.0 138.0 140.0 139.0 146.0 151.0 202.0 169.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.30 Median:175.50 stddev:13.51 (7.7%) stddev-sans-first:14.19 08:33:19 INFO - PROCESS | 1963 | Values: 173.0 178.0 170.0 177.0 176.0 170.0 175.0 174.0 174.0 216.0 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.00 stddev:7.83 (11.2%) stddev-sans-first:8.31 08:33:19 INFO - PROCESS | 1963 | Values: 72.0 65.0 91.0 78.0 67.0 67.0 66.0 70.0 68.0 70.0 08:33:19 INFO - PROCESS | 1963 | -------- Summary: end -------- 08:33:19 INFO - PROCESS | 1963 | 08:33:19 INFO - TEST-INFO | 1963: exit 0 08:33:19 INFO - TEST-OK | kraken | took 61062ms 08:33:19 INFO - SUITE-END | took 1172s 08:33:20 INFO - Completed test suite (00:19:32) 08:33:20 INFO - javascript benchmark 08:33:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2954.630671166104, 2980.3592227671047, 3396.796192228468, 3444.6727560881714, 3514.420120680088, 4576.862694119178, 5081.923771143426, 5812.709364531777, 5818.86532126235, 5886.411358864111, 5758.683272420015, 5811.4479124483105, 5861.17943487911, 5919.467247947684, 6009.429104235091, 5214.035403450373, 5285.577153827694, 5290.153575427932, 5360.356757189143, 5366.248725178478, 5388.595855310848, 5424.0, 5442.9727851360685, 5467.972660136694, 5482.616216864821, 5179.663321884065, 5236.633435659505, 5291.179867120564, 5314.362276526842, 5324.334458192726, 5296.311479507678, 5309.177077552986, 5327.227552004938, 5337.733113344356, 5350.357957045179, 5248.186531087687, 5293.258943747878, 5315.441878602768, 5323.653962492425, 5370.570354371641, 4465.933011004838, 5699.316082070137, 5701.258836351248, 5763.971180144114, 5815.302163740336, 6219.0, 6250.593711408744, 6261.436470717612, 6280.2777680566405, 6281.8743625127245, 6178.783742568989, 6227.09707092469, 6299.590526615755, 6312.684365781738, 6320.652364119972, 6008.128821320884, 6009.789657361971, 6010.489108425745, 6035.366286539938, 6057.515398768088, 6428.935710642833, 6467.126937863328, 6474.546781725234, 6496.187976502937, 6509.153810004669, 6099.884870379854, 6150.538709596798, 6227.813165605039, 6250.874982500324, 6259.280182779039, 6289.8742025159245, 6300.8892021172505, 6302.464290535264, 6318.304986451487, 6321.715522801485, 5150.742462876841, 6141.692915354214, 6188.319284878659, 6285.340039295899, 6297.433231009231, 6130.153553065376, 6184.381561843779, 6198.0702894566175, 6281.309056003836, 6292.05619157121, 5020.497950205024, 5024.296598476216, 5041.974790126026, 5048.899022019539, 5076.213186956028, 4469.195544801967, 4495.370648109268, 4499.055198408371, 4515.571020753023, 4526.479454862667, 5516.117421212587, 5747.339056008613, 5776.537876969833, 5944.286685597669, 5972.701364931736, 6251.718672659741, 6255.96872015637, 6326.936730632635, 6328.303886572473, 6333.746650134035, 5886.735096920649, 5934.940650593525, 5944.791932282349, 5945.227120474311, 5989.460948514655, 5388.7305634718105, 5452.591055670761, 5527.115661494142, 5531.004419204582, 5544.528715059265, 6486.481081513562, 6514.0, 6533.085368048477, 6541.149650545399, 6573.3098024706715, 6156.107364432221, 6279.30927597973, 6309.621422714652, 6322.399372059647, 6325.746970121144, 6425.614463132227, 6470.514711396759, 6475.384838440341, 6547.312532184052, 6557.803265902031, 6216.906746398718, 6253.280872699698, 6278.183836101278, 6297.055441683601, 6309.652969086745, 6187.381261873777, 6189.1025801257665, 6302.369763023661, 6305.432511074026, 6444.387783160592, 6121.479674227562, 6126.877462450815, 6149.739303442694, 6240.032794916795, 6274.717637706223, 6207.410296021871, 6222.657753823583, 6223.657698826608, 6245.0320200369015, 6248.0003199487865, 5327.7746118392215, 5940.316863560746, 6013.218281623361, 6144.354842741448, 6149.938500614937, 5681.602287839812, 6120.782376608402, 6187.84530386726, 6195.1636529068, 6222.28443728977, 6085.482733967662, 6098.359672234352, 6123.693815309306, 6132.2947860996555, 6135.14108024868], "value": 5770.346368877355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.4096686393487, 527.064460582466, 573.7360814025548, 580.3558050563876, 591.3347484080409, 29644.0, 35660.821695891515, 36700.44949325762, 36810.631893681086, 36969.630303696955, 30483.0, 36982.63017369826, 37195.25609487809, 37601.059973500676, 37606.87179384623, 9225.031371705974, 9238.491882946435, 9395.859062114074, 9443.291753118508, 9472.242220622335, 7862.567558784264, 9425.151736343727, 9492.66775662852, 9518.190953768937, 9561.0, 9307.76730581734, 9459.24326053914, 9475.47884866332, 9547.904520954806, 9575.23398128148, 8046.758597242092, 9344.439333640003, 9455.669051583196, 9506.714798556055, 9541.475218862994, 9260.953695231548, 9273.675421360287, 9363.48500832454, 9436.339456238065, 9520.095590918852, 36214.0, 36250.8187459061, 36283.4557481638, 37008.444873326924, 37422.812885935666, 2504.3864253257884, 2943.234758962664, 3015.8271085358488, 3298.5217143514055, 3835.4101868177554, 26210.0, 26352.60471092935, 26989.460210795674, 27001.72998270012, 27130.1860944172, 2638.274474519503, 2647.3116989582654, 2662.6671666041743, 2726.6046423268517, 2765.198092553157, 319703.0, 319736.0, 319751.40124299465, 321601.0, 322962.38518807257, 32765.50851737226, 33059.0, 33110.337793244, 33117.33765324728, 33172.3365532688, 34064.82967585146, 64221.0, 65194.0, 66043.0, 66228.33771662318, 16531.173441327886, 16585.336586536643, 16711.66576668484, 16729.581760455843, 16739.414120505724, 12813.487460501661, 12902.290374029331, 12924.095313327976, 12965.22208667483, 12981.545645902537, 17957.551061223312, 18586.907065464588, 18635.720464193048, 18674.533136671693, 18693.439196824118, 7227.927720722725, 7755.759078547405, 8003.0, 8169.12110214654, 8210.835783284301, 923.879895613566, 993.0764389118045, 993.9503024848729, 1017.6896046705825, 1023.3808545829814, 27621.171364859085, 28951.56572651412, 29278.560821587693, 29459.558106628418, 29675.703242967294, 914.9222316103205, 1060.692399204222, 1066.7599790047332, 1147.8234809320513, 1233.901287896966, 14235.928820355832, 14530.709385812435, 14582.4896128635, 14683.706325873423, 14874.553763387115, 578694.0, 593994.0, 599902.0, 605334.0, 616575.0, 52183.47816521862, 55708.0, 56131.0, 56523.43476565264, 56607.150892736645, 1288.1626942487458, 1335.6861137632648, 1352.5198554513006, 1372.6499742565582, 1485.1163557683162, 22870.313890583308, 28261.43477130487, 28678.71321286844, 29017.0, 29195.562066569444, 52878.0, 54905.45094549003, 55570.72214638901, 56069.71965140148, 56381.71809140928, 575528.1223593855, 578130.0, 578524.0, 584642.0, 587235.0, 39586.40620390754, 40546.59453405428, 40634.57778977721, 41240.968975775846, 41413.171736564494, 37018.8149059253, 44562.77718611386, 45005.774971124934, 45554.54445455503, 45939.310910335706, 34845.0, 36232.0, 37090.62909370872, 37159.44260836144, 37749.62250377571, 35499.82250088836, 36260.0, 36277.45583816192, 36935.076623084635, 37546.0, 36091.819540903176, 36398.0, 36483.635163648025, 37045.0, 37130.0, 26100.477990440464, 31758.0, 32503.512447313784, 32764.50853237251, 33092.503612446315, 21835.344939651837, 22361.0, 22555.887220563793, 24218.273451796475, 25051.0], "value": 18910.19392377012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.99430756117374, 343.65806023007104, 383.39615106207714, 389.16524055900095, 405.5073086200266, 19338.323158689433, 20003.89998050008, 20071.598568028632, 20872.791272087274, 20930.953452327398, 15185.240737963113, 15356.0, 15662.373505059812, 16628.337166283367, 19997.800021999774, 5462.808801691932, 6024.789132380368, 6050.576459647805, 6068.908966365508, 6140.324564297924, 5671.291088613923, 5803.709814509279, 5866.061430171173, 5928.436798504157, 5932.495737862266, 4912.557869791718, 5632.239647647556, 5851.79518716845, 5853.531717462614, 5889.2049573307695, 5890.558208134407, 5916.645001299936, 5921.674307913063, 5930.28836539618, 5962.046072628359, 4223.7140931892545, 5003.249512573107, 5059.241113832918, 5089.3638295213095, 5096.235564665293, 19829.801701983084, 25108.497830043478, 25174.622380664303, 25509.107181248753, 25631.48737025268, 2082.781307962657, 2186.726659167604, 2244.16965722682, 2458.4591389894194, 2635.3148181472957, 14242.430302787876, 14676.0, 14914.925425372803, 14920.552383428514, 14949.850501494955, 1693.1618848669864, 1745.729411941151, 1746.388763932626, 1782.9019403932778, 1793.175139435861, 83709.58145209296, 105314.0, 108907.91092089057, 109112.0, 109717.0, 9282.535873206447, 9615.50959601263, 10493.213009024354, 10625.574977000833, 10820.296680715728, 13298.800517992238, 13307.802297793245, 13384.263865487492, 13389.330533473481, 13443.529476468473, 8580.0, 8724.912750872538, 8745.868811967826, 8755.255803256794, 8787.989381221114, 8747.387682862265, 8840.823183536293, 8852.8672069919, 8870.157335053289, 8941.284697224206, 5989.850253743692, 6115.113308570321, 6439.5170362223025, 6585.769498067544, 6586.571872828251, 1664.9583760405844, 1767.4785938148277, 1840.6778813707547, 1849.861260405475, 1868.4301288106985, 374.9418840079792, 389.75055964182945, 426.1179358727405, 1029.234862211311, 1052.952617132231, 10564.260501764957, 10807.729806754895, 10933.016028557468, 11054.336739795637, 11451.141164412702, 430.4812700695654, 436.62886546435277, 440.18565653541333, 444.1782702001336, 447.11471286852213, 5801.477866991991, 5867.14926335679, 5921.585489015813, 5937.346891841894, 5963.7912673056235, 600312.0, 614109.0, 617786.0, 622560.0, 628939.0, 98235.0, 139076.0, 140704.0, 141625.0, 146081.0, 425.37894673776634, 439.3695047606695, 439.69221544918685, 439.83066519390263, 439.93400989851136, 10358.378497289885, 10613.09788667941, 10645.361278323326, 10743.946280268548, 10757.462126893468, 47380.60361851106, 48718.782030449525, 49293.50706492889, 51557.48442515677, 52950.29347945607, 77192.61403692946, 77262.6136869312, 78634.60682696779, 79026.20973790418, 80719.38561228625, 7572.962135189288, 7649.082110146818, 7679.808004799701, 7869.134395216407, 8088.3529317653265, 10081.344712593658, 10617.362958222531, 12122.696932576404, 12296.446659900505, 12449.439775209956, 8380.706675266336, 10044.497775111362, 10540.104091152338, 10623.575056997943, 10806.081483074027, 10429.061384475433, 10454.0, 10549.578016879239, 10596.576136954436, 10933.234673572773, 10819.621313253998, 10834.404107774148, 10999.945000274947, 11113.0, 11152.386618736047, 6865.176178858569, 7293.671784769592, 7359.043324368012, 7745.457817952689, 7884.29041386278, 10511.526981285708, 10707.250492465453, 11269.605563805555, 11511.021563167225, 11513.654590362303], "value": 8515.44084156512, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1608.1878651281102, 1630.7064728348896, 1797.4248240563018, 1904.3620387170297, 1961.892095934723, 7300.2334754850635, 7946.721864734735, 8501.787455313612, 8799.999999999993, 8807.647694092237, 8719.4332368396, 8765.561721913895, 8789.91210087899, 8841.160089791476, 8864.822703545926, 2387.2480168746833, 2415.806735461159, 2416.1301931304806, 2421.092090466075, 2440.6827112475444, 2389.2951579284154, 2416.830821842472, 2417.891194896225, 2438.9146379876706, 2439.182873737291, 2374.2402431222017, 2403.6514705367713, 2406.109739396426, 2433.2578563538113, 2438.0, 2206.801387875099, 2334.2180369576213, 2345.2729653807373, 2375.6080246759266, 2383.678203442539, 2069.627467055929, 2359.7168339799164, 2374.4894847607675, 2387.7612238775982, 2391.7727815857465, 8673.739787806377, 8678.088800675901, 8685.869711954325, 8804.515751633657, 8807.515586642732, 3970.642642162219, 4453.688241823073, 5076.213186956028, 5096.133657278272, 5172.301739265226, 3315.0, 3405.540252065989, 3435.347284016054, 3435.4331535296897, 3444.603870554893, 946.2524605561598, 964.1659964130977, 972.4311277902365, 973.7127547373542, 989.5200827598609, 11124.888751112467, 11254.0, 11312.717182070432, 11420.14348923834, 11425.0, 4005.339119045325, 4029.932068001982, 4247.936280955788, 4363.759993200341, 4394.648428125743, 8859.557022148867, 8927.508987005776, 8953.373263871466, 8973.0, 8973.685920992733, 4947.431045429822, 4978.253262010728, 5004.099262132779, 5023.171176755867, 5049.368828896388, 4347.108842687241, 4627.838025669085, 4675.976620116946, 4802.687825291345, 4822.373091498082, 3741.0, 3756.981215093907, 3856.36369998947, 3867.1105645701646, 3876.767393956315, 1176.0474016047028, 1196.0610920427423, 1197.8862008109215, 1205.3370646144585, 1210.4855436439477, 623.7910300049534, 894.4052205283414, 924.995375023134, 932.5523748600709, 938.4932136646134, 5674.744636491368, 5715.942840571624, 5869.618474799125, 5930.525557955353, 5956.85107872298, 436.4260996789212, 436.7794263896712, 437.01235208429176, 439.2072309481353, 439.6394956135938, 3099.9225019374244, 3830.0, 3880.3791393376923, 3930.606939306104, 3992.9817896436225, 10370.377777333384, 10783.730406739738, 10813.243072984815, 10832.133429325635, 10838.187135964834, 8878.378513503993, 10282.485875706185, 10549.261551691461, 10607.628732994308, 10648.0, 7153.570785752871, 8102.837943241102, 8179.67281308741, 8197.754067377988, 8216.178382161856, 4681.625469962463, 5708.001099807434, 5726.9713651431475, 5844.26946631671, 5888.028475301699, 9758.951205243928, 9853.901460985586, 9983.900160998297, 10023.799524009333, 10036.397816131055, 9699.0, 9754.609815607297, 9962.55168517404, 10044.447555384524, 10115.39307641544, 6396.872062558629, 6694.665266736546, 6798.490113241625, 6857.588544687334, 6972.7908162753165, 8177.427580069576, 8249.422540422112, 8274.379421543288, 8283.130271321665, 8311.127331630092, 7186.532875363085, 7215.71137154508, 7309.597972111372, 7322.157951835394, 7370.889436658347, 7197.532160409557, 7321.963390183015, 7367.115946086504, 7381.8154546136775, 7395.556266624019, 6334.8733025338315, 6838.179418469816, 6892.896606550806, 6929.480288978246, 6935.410490108397, 4774.522547745198, 4812.35033270504, 4912.066707325596, 4936.062148191832, 5026.371703537058, 4868.513148685103, 4916.139675556835, 4924.975375123101, 4975.527324904128, 5077.669951453144], "value": 4374.464452934265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.49220017471606, 313.4592827372781, 319.5925195375894, 320.1244596029858, 326.32613652806964, 5920.9407905920925, 5967.850803729909, 5968.941120038372, 5976.462118409342, 5999.820005399834, 4612.584867361937, 5722.771089156428, 5799.9130013049835, 5919.141724449953, 5930.110483427488, 3867.916983244696, 4007.418924255981, 4181.540030596632, 4333.544977777336, 4395.428594282755, 3251.92686413483, 4337.219300525904, 4379.386885835986, 4430.778461076933, 4436.201483732927, 4384.539623339551, 4386.714863533876, 4386.868393948187, 4394.450693663292, 4415.271480205778, 3227.7417806575418, 4065.5934406559404, 4309.267424537836, 4361.018770776582, 4421.513633500313, 3715.925681486355, 3719.274741425423, 3732.6453986871475, 3738.7195960302815, 3742.2141350316465, 5160.0, 5629.577781666391, 5631.831045068655, 5673.6879471629045, 5676.716164191774, 4390.429244198233, 4700.224462963607, 5022.4726403727445, 5034.874128146789, 5038.722870242135, 5256.81601143962, 5549.916751248735, 6190.133381326618, 6242.971034413788, 6254.874902501924, 3445.896623101286, 3671.1372827385544, 3923.901902452433, 4118.320477121271, 4130.153318569716, 6325.209348831396, 6567.211934567835, 6567.967160164217, 6625.37058979401, 6670.232923213844, 3159.9684003159673, 3656.7440279180732, 4144.150449157915, 4147.771872547039, 4158.708890377705, 3540.8052557109604, 4068.010012640707, 4214.3889136075095, 4228.112096459778, 4262.488501379792, 4434.5343738907595, 4810.7835147418455, 4998.90002199954, 5015.22264049073, 5022.869854282757, 5559.360673522516, 5924.970375148183, 6212.937870621236, 6268.905966410507, 6332.366763323723, 1287.6394609509166, 1306.3598836570013, 1356.51165580391, 1468.566772802026, 1473.8747206487353, 761.6153842309598, 876.4268138691065, 887.5296093070683, 926.4672813132476, 965.1410244882061, 5766.654000759968, 5796.1595568642315, 5829.417058294137, 5829.88340233193, 5834.533237341003, 5635.746391412396, 5863.706814659336, 6451.064595633607, 6461.321561236096, 6489.253735820441, 5530.695811730394, 5588.524975377057, 5909.674967876808, 5930.466258036798, 5938.168656388109, 3018.9245268868017, 3355.1043660331834, 3429.794212347267, 3488.686018258369, 3504.159001839591, 5340.732963351817, 5813.982553053199, 6270.498360131179, 6683.866322673519, 6745.156855393076, 5450.291462109901, 6442.967785161138, 6758.763443279461, 6783.118194634764, 6788.321167883172, 5729.942700573024, 6378.52161087911, 6872.312768723088, 6880.176753160416, 6918.481113916477, 6524.804255872332, 6525.771597994048, 6554.967225163844, 6562.901556476561, 6565.310642382672, 5645.633033852787, 6167.5374346925055, 6453.0, 6465.2564955030775, 6480.837979050561, 6550.705218265094, 6849.10961575012, 6855.280195579392, 6877.552959057645, 6911.274316196928, 3783.905402364963, 4195.727277726938, 4207.894802629837, 4208.81060352291, 4220.198162349144, 5769.749527929564, 6170.444659980623, 6521.054447105048, 6546.672666366758, 6587.80236592903, 5833.387494313036, 5975.043992961106, 6320.462760665395, 6323.36766323364, 6348.238211414659, 5269.841904742864, 5407.729613519387, 6007.279126504847, 6310.5073495969755, 6331.9366806331345, 4542.909141817211, 5119.257707632447, 6041.879162416815, 6183.96908015457, 6303.275123360872, 4918.491569299611, 5257.4742525747115, 6020.795840831764, 6301.842453938688, 6314.652694101868, 4651.418572678415, 5378.784848606012, 5872.619934315518, 6020.819375418744, 6185.0], "value": 4461.926199112261, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.9043138744883, 756.7578374920024, 757.8749506331455, 762.546284960449, 768.9038870141233, 14698.824094072475, 14995.92502037491, 15032.17323047232, 15201.923990380046, 15225.39098436064, 13204.735905281888, 13310.800337994939, 13410.19538827671, 13453.125546839448, 13459.528916487925, 730.9122905251351, 899.7390756680555, 910.2444970674358, 919.0763282900675, 919.9494027828467, 893.2318206342541, 910.508325504227, 915.3455279475174, 932.4591736792678, 934.1219253901345, 922.4004397141845, 943.1087622197026, 959.1990687775716, 960.1742501448748, 963.9614415423409, 923.3859483443503, 940.9012053734363, 950.9191718703919, 955.5795450002012, 959.0888655777039, 676.6650507998572, 686.1765880942838, 706.8901824136109, 707.982300442493, 710.9004739336497, 14756.631084222872, 14992.625184370369, 15009.324580393799, 15014.423485533971, 15027.474038408604, 12482.687932801662, 12598.68503287416, 12598.685032874251, 12614.306213158272, 12864.035197360236, 10063.245256605784, 10074.345167564084, 10129.290949633529, 10299.330543514647, 10494.212934029978, 3379.2734562069027, 3485.2158264390564, 3532.417151170054, 3696.0390298522307, 3721.5162028936334, 83307.58346208291, 84691.57654211752, 84891.0, 85132.99999999937, 85679.57160214159, 9373.0, 9516.571754271074, 9530.904690953003, 9592.616295348107, 9827.820661520664, 21302.36092917215, 21360.57278854414, 21374.679379809317, 21388.35834924955, 22028.77971220267, 7510.511816732004, 7605.885911711329, 7683.0, 7708.49894756839, 7903.217024141284, 4056.6957478189256, 4070.5115386153257, 4112.0, 4150.771707556053, 4163.937540936889, 3411.6588341165684, 3453.430184019659, 3522.0842580929143, 3528.8235588221, 3794.6205379461835, 654.9476041916636, 663.6880666086931, 666.5500786968777, 671.9966400167967, 675.8598135934988, 493.76804871844257, 506.7086425305464, 523.2674256041572, 570.6918264137403, 572.7365411910484, 7782.416318776114, 7911.841763164704, 8151.714689985822, 8196.385271104691, 8475.618597163142, 539.0620320642133, 552.9834104976857, 560.7504660426152, 569.900267453194, 599.6132494540997, 3757.511523501982, 3871.903202419962, 3970.9679670598134, 3972.2651309507255, 3987.142764305688, 77657.83513247306, 86804.0, 89957.90378865933, 90174.64738028935, 98689.01310986943, 56873.715631421575, 71063.57872842514, 73476.0, 74807.62596186984, 75730.0, 49366.25950610744, 63546.0, 70461.0, 71350.64324678344, 71993.28006719971, 7914.762557123296, 7945.523268603903, 8061.355091592542, 8151.1441298662785, 8160.959195203986, 30872.30202338893, 36371.545138194175, 40451.797741011105, 42965.747244474594, 43676.781616091714, 55742.885142296116, 59830.70084649549, 61520.0, 62068.37931620807, 62107.136785896495, 10585.52365143555, 10722.356658600509, 10816.513256903616, 10869.347839129678, 10925.342006604076, 11697.766044679229, 11768.82346764782, 12237.0822188338, 12323.0, 12916.418761155583, 11061.944690276498, 11207.383593902414, 11325.71685707864, 11553.0, 11657.591984280509, 10454.0, 10598.470076496298, 10619.94690026545, 10653.520591573553, 10787.0, 10371.27401081917, 10855.348679079281, 11165.49755260999, 11189.328640281608, 11280.66158015228, 9137.497437640994, 9347.298952578447, 9517.857232141661, 9615.807683846424, 9618.182454491447, 9335.486548239913, 9533.998930112515, 9587.568559414982, 9606.711798646053, 9658.0], "value": 6765.787495589553, "unit": "score"}], "name": "dromaeo_css", "value": 7049.394810536196, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 155.0, 166.0, 115.0, 115.0, 158.0, 171.0, 153.0, 116.0, 117.0], "value": 142.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 114.0, 151.0, 169.0, 121.0, 140.0, 141.0, 124.0, 174.0, 122.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 211.0, 233.0, 198.0, 197.0, 201.0, 201.0, 197.0, 199.0, 198.0], "value": 203.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 81.0, 74.0, 135.0, 56.0, 57.0, 68.0, 60.0, 93.0, 59.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 135.0, 76.0, 80.0, 84.0, 118.0, 103.0, 119.0, 162.0], "value": 103.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 135.0, 89.0, 88.0, 100.0, 92.0, 84.0, 134.0, 123.0], "value": 104.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 96.0, 132.0, 148.0, 95.0, 96.0, 95.0, 107.0, 136.0], "value": 117.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 91.0, 91.0, 90.0, 91.0, 91.0, 91.0, 91.0, 91.0], "value": 101.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 60.0, 60.0, 62.0, 60.0, 68.0, 92.0, 101.0, 100.0], "value": 72.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 71.0, 63.0, 71.0, 93.0, 76.0, 68.0, 67.0, 67.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 84.0, 84.0, 85.0, 86.0, 110.0, 110.0, 83.0, 87.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 176.0, 164.0, 138.0, 140.0, 139.0, 146.0, 151.0, 202.0, 169.0], "value": 159.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 178.0, 170.0, 177.0, 176.0, 170.0, 175.0, 174.0, 174.0, 216.0], "value": 178.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 65.0, 91.0, 78.0, 67.0, 67.0, 66.0, 70.0, 68.0, 70.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1631.0, "alertThreshold": 2.0}]} 08:33:20 INFO - Return code: 0 08:33:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:33:20 ERROR - # TBPL SUCCESS # 08:33:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:33:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:33:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:33:20 INFO - 2016-04-15 08:33:20.368 screenresolution[1968:21366] starting screenresolution argv=screenresolution get 08:33:20 INFO - 2016-04-15 08:33:20.371 screenresolution[1968:21366] Display 0: 1600x1200x32@60 08:33:20 INFO - 2016-04-15 08:33:20.377 screenresolution[1969:21369] starting screenresolution argv=screenresolution list 08:33:20 INFO - Available Modes on Display 0 08:33:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:33:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:33:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:33:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:33:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:33:20 INFO - Intel Iris: 08:33:20 INFO - Chipset Model: Intel Iris 08:33:20 INFO - Type: GPU 08:33:20 INFO - Bus: Built-In 08:33:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:33:20 INFO - Vendor: Intel (0x8086) 08:33:20 INFO - Device ID: 0x0a2e 08:33:20 INFO - Revision ID: 0x0009 08:33:20 INFO - Displays: 08:33:20 INFO - Display: 08:33:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:33:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:33:20 INFO - Display Serial Number: 1600x1200 60 08:33:20 INFO - Main Display: Yes 08:33:20 INFO - Mirror: Off 08:33:20 INFO - Online: Yes 08:33:20 INFO - Rotation: Supported 08:33:20 INFO - Return code: 0 08:33:20 INFO - Running post-action listener: _resource_record_post_action 08:33:20 INFO - Running post-run listener: _resource_record_post_run 08:33:21 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 708608; Write bytes: 697829888; Read time: 8; Write time: 1981 08:33:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 377287168; Write bytes: 371918848; Read time: 28007; Write time: 736 08:33:21 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 708608; Write bytes: 300777984; Read time: 8; Write time: 1195 08:33:21 INFO - Running post-run listener: _upload_blobber_files 08:33:21 INFO - Blob upload gear active. 08:33:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:33:21 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 08:33:21 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'] 08:33:21 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 08:33:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:33:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:33:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:33:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:23 INFO - (blobuploader) - INFO - Done attempting. 08:33:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:33:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:33:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:24 INFO - (blobuploader) - INFO - Done attempting. 08:33:24 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:24 INFO - Return code: 0 08:33:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2d5bae2a33ad9ecefca65ab7b47b000bf4f1837c8e1c077bc6d219cc2ce02e6414e64fca74620ed95597d9b9fb1d7249fbb9fcf79c8c75539af7cd4c9434e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/931eef5a6061a017a22847f6ea9bd9f91be6f1f8c38e991c2f7b89c216c8f289aee95a75467f9545436d1f3b2769b7913ad668f0c30a3828bfcff33362c3da05"} 08:33:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:24 INFO - Contents: 08:33:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2d5bae2a33ad9ecefca65ab7b47b000bf4f1837c8e1c077bc6d219cc2ce02e6414e64fca74620ed95597d9b9fb1d7249fbb9fcf79c8c75539af7cd4c9434e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/931eef5a6061a017a22847f6ea9bd9f91be6f1f8c38e991c2f7b89c216c8f289aee95a75467f9545436d1f3b2769b7913ad668f0c30a3828bfcff33362c3da05"} 08:33:24 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:24 INFO - Copying logs to upload dir... 08:33:24 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.178865 ========= master_lag: 27.74 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-04-15 08:33:51.265667) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 08:33:51.270868) ========= 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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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/e2d5bae2a33ad9ecefca65ab7b47b000bf4f1837c8e1c077bc6d219cc2ce02e6414e64fca74620ed95597d9b9fb1d7249fbb9fcf79c8c75539af7cd4c9434e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/931eef5a6061a017a22847f6ea9bd9f91be6f1f8c38e991c2f7b89c216c8f289aee95a75467f9545436d1f3b2769b7913ad668f0c30a3828bfcff33362c3da05"} build_url:https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011251 build_url: 'https://queue.taskcluster.net/v1/task/ZL10ZnMtQxKm_RiFMW7R_A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e2d5bae2a33ad9ecefca65ab7b47b000bf4f1837c8e1c077bc6d219cc2ce02e6414e64fca74620ed95597d9b9fb1d7249fbb9fcf79c8c75539af7cd4c9434e70", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/931eef5a6061a017a22847f6ea9bd9f91be6f1f8c38e991c2f7b89c216c8f289aee95a75467f9545436d1f3b2769b7913ad668f0c30a3828bfcff33362c3da05"}' ========= master_lag: 0.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 08:33:51.763299) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 08:33:51.763636) ========= 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.YxAjXx2ILN/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.8jM9QoYpsB/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005255 ========= master_lag: 2.50 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 08:33:54.266583) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-15 08:33:54.269930) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-15 08:33:56.799360) ========= ========= Total master_lag: 85.60 =========