builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0195 starttime: 1462491703.04 results: success (0) buildid: 20160505142107 builduid: 5ff692bcf09146beadbd427f348b434b revision: daa53f98b541117b380d848f34eb00570ae71d2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.040611) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.041242) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.041561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.064774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.065207) ========= 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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-05 16:41:43-- 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% 18.3M=0.001s 2016-05-05 16:41:43 (18.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097250 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.178772) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.179150) ========= 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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.026884 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:43.228641) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 16:41:43.229024) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev daa53f98b541117b380d848f34eb00570ae71d2b --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 daa53f98b541117b380d848f34eb00570ae71d2b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cmhpYz3T2w/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.TjOtXMYPHy/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-05 16:41:43,304 truncating revision to first 12 chars 2016-05-05 16:41:43,304 Setting DEBUG logging. 2016-05-05 16:41:43,304 attempt 1/10 2016-05-05 16:41:43,304 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/daa53f98b541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-05 16:41:44,277 unpacking tar archive at: fx-team-daa53f98b541/testing/mozharness/ program finished with exit code 0 elapsedTime=1.218346 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-05-05 16:41:44.464736) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:44.465204) ========= script_repo_revision: daa53f98b541117b380d848f34eb00570ae71d2b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:44.465859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:44.466143) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-05 16:41:44.479924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-05 16:41:44.480364) ========= /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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:41:44 INFO - MultiFileLogger online at 20160505 16:41:44 in /builds/slave/test 16:41:44 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 16:41:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:41:44 INFO - {'append_to_log': False, 16:41:44 INFO - 'base_work_dir': '/builds/slave/test', 16:41:44 INFO - 'blob_upload_branch': 'Fx-Team', 16:41:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:41:44 INFO - 'branch': 'Fx-Team', 16:41:44 INFO - 'buildbot_json_path': 'buildprops.json', 16:41:44 INFO - 'config_files': ('talos/mac_config.py',), 16:41:44 INFO - 'default_actions': ('clobber', 16:41:44 INFO - 'read-buildbot-config', 16:41:44 INFO - 'download-and-extract', 16:41:44 INFO - 'populate-webroot', 16:41:44 INFO - 'create-virtualenv', 16:41:44 INFO - 'install', 16:41:44 INFO - 'run-tests'), 16:41:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:41:44 INFO - 'download_minidump_stackwalk': True, 16:41:44 INFO - 'download_symbols': 'ondemand', 16:41:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:41:44 INFO - 'tooltool.py': '/tools/tooltool.py', 16:41:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:41:44 INFO - '/tools/misc-python/virtualenv.py')}, 16:41:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:41:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:41:44 INFO - 'installer_path': 'installer.exe', 16:41:44 INFO - 'log_level': 'info', 16:41:44 INFO - 'log_name': 'talos', 16:41:44 INFO - 'log_to_console': True, 16:41:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:41:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:41:44 INFO - 'opt_config_files': (), 16:41:44 INFO - 'pip_index': False, 16:41:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:41:44 INFO - 'cmd': ('bash', 16:41:44 INFO - '-c', 16:41:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:41:44 INFO - 'enabled': True, 16:41:44 INFO - 'halt_on_failure': False, 16:41:44 INFO - 'name': 'check_screen_resolution'},), 16:41:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:41:44 INFO - 'cmd': ('bash', 16:41:44 INFO - '-c', 16:41:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:41:44 INFO - 'enabled': True, 16:41:44 INFO - 'halt_on_failure': False, 16:41:44 INFO - 'name': 'check_screen_resolution'},), 16:41:44 INFO - 'run_cmd_checks_enabled': True, 16:41:44 INFO - 'sps_profile': False, 16:41:44 INFO - 'sps_profile_interval': 0, 16:41:44 INFO - 'suite': 'dromaeojs-e10s', 16:41:44 INFO - 'system_bits': '32', 16:41:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:41:44 INFO - 'title': 't-yosemite-r7-0195', 16:41:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:41:44 INFO - 'use_talos_json': True, 16:41:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:41:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:41:44 INFO - 'work_dir': 'build'} 16:41:44 INFO - ##### 16:41:44 INFO - ##### Running clobber step. 16:41:44 INFO - ##### 16:41:44 INFO - Running pre-action listener: _resource_record_pre_action 16:41:44 INFO - Running main action method: clobber 16:41:44 INFO - rmtree: /builds/slave/test/build 16:41:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:41:46 INFO - Running post-action listener: _resource_record_post_action 16:41:46 INFO - ##### 16:41:46 INFO - ##### Running read-buildbot-config step. 16:41:46 INFO - ##### 16:41:46 INFO - Running pre-action listener: _resource_record_pre_action 16:41:46 INFO - Running main action method: read_buildbot_config 16:41:46 INFO - Using buildbot properties: 16:41:46 INFO - { 16:41:46 INFO - "project": "", 16:41:46 INFO - "product": "firefox", 16:41:46 INFO - "script_repo_revision": "production", 16:41:46 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:41:46 INFO - "repository": "", 16:41:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:41:46 INFO - "buildid": "20160505142107", 16:41:46 INFO - "pgo_build": "False", 16:41:46 INFO - "basedir": "/builds/slave/test", 16:41:46 INFO - "buildnumber": 657, 16:41:46 INFO - "slavename": "t-yosemite-r7-0195", 16:41:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:41:46 INFO - "platform": "yosemite_r7", 16:41:46 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 16:41:46 INFO - "branch": "fx-team", 16:41:46 INFO - "repo_path": "integration/fx-team", 16:41:46 INFO - "revision": "daa53f98b541117b380d848f34eb00570ae71d2b", 16:41:46 INFO - "stage_platform": "macosx64", 16:41:46 INFO - "builduid": "5ff692bcf09146beadbd427f348b434b", 16:41:46 INFO - "slavebuilddir": "test" 16:41:46 INFO - } 16:41:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 16:41:46 INFO - Running post-action listener: _resource_record_post_action 16:41:46 INFO - ##### 16:41:46 INFO - ##### Running download-and-extract step. 16:41:46 INFO - ##### 16:41:46 INFO - Running pre-action listener: _resource_record_pre_action 16:41:46 INFO - Running main action method: download_and_extract 16:41:46 INFO - mkdir: /builds/slave/test/build/tests 16:41: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')]} 16:41:46 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:41:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 16:41:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 16:41:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:41:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 16:41:48 INFO - Downloaded 1199 bytes. 16:41:48 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 16:41:48 INFO - Using the following test package requirements: 16:41:48 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:41:48 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 16:41:48 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 16:41:48 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'jsshell-mac.zip'], 16:41:48 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 16:41:48 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 16:41:48 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 16:41:48 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 16:41:48 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 16:41:48 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 16:41:48 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 16:41:48 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:41:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:48 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:41:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:41:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:41:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:41:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:41:49 INFO - Downloaded 18144951 bytes. 16:41:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:41:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:41:52 INFO - Return code: 0 16:41:52 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:41:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:52 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:41:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:41:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:41:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 16:41:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:41:53 INFO - Downloaded 18144951 bytes. 16:41:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:41:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 16:41:57 INFO - Return code: 0 16:41:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:41:57 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:41:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:41:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:41:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 16:41:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:41:58 INFO - Downloaded 10840152 bytes. 16:41:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 16:41:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 16:41:58 INFO - Return code: 0 16:41: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')]} 16:41:58 INFO - https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:41:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:41:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:41:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 16:41:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 16:42:01 INFO - Downloaded 110400026 bytes. 16:42:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:42:01 INFO - mkdir: /builds/slave/test/properties 16:42:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:42:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:42:01 INFO - Contents: 16:42:01 INFO - build_url:https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 16:42:03 INFO - Running post-action listener: _resource_record_post_action 16:42:03 INFO - Running post-action listener: set_extra_try_arguments 16:42:03 INFO - ##### 16:42:03 INFO - ##### Running populate-webroot step. 16:42:03 INFO - ##### 16:42:03 INFO - Running pre-action listener: _resource_record_pre_action 16:42:03 INFO - Running main action method: populate_webroot 16:42:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:42:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:42:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:42:03 INFO - '--tppagecycles', 16:42:03 INFO - '7'], 16:42:03 INFO - 'tests': ['tsvgm']}}, 16:42:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:42:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:42:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:42:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:42:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:42:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['damp', 'tps']}, 16:42:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'tests': ['damp', 'tps']}, 16:42:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['dromaeo_dom']}, 16:42:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:42:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['a11yr', 16:42:03 INFO - 'ts_paint', 16:42:03 INFO - 'tpaint', 16:42:03 INFO - 'sessionrestore', 16:42:03 INFO - 'sessionrestore_no_auto_restore', 16:42:03 INFO - 'tabpaint']}, 16:42:03 INFO - 'other-e10s': {'tests': ['a11yr', 16:42:03 INFO - 'ts_paint', 16:42:03 INFO - 'tpaint', 16:42:03 INFO - 'sessionrestore', 16:42:03 INFO - 'sessionrestore_no_auto_restore', 16:42:03 INFO - 'tabpaint']}, 16:42:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:42:03 INFO - 'ts_paint', 16:42:03 INFO - 'tpaint', 16:42:03 INFO - 'sessionrestore', 16:42:03 INFO - 'sessionrestore_no_auto_restore', 16:42:03 INFO - 'tabpaint']}, 16:42:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:42:03 INFO - 'ts_paint', 16:42:03 INFO - 'tpaint', 16:42:03 INFO - 'sessionrestore', 16:42:03 INFO - 'sessionrestore_no_auto_restore', 16:42:03 INFO - 'tabpaint']}, 16:42:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['a11yr', 16:42:03 INFO - 'ts_paint', 16:42:03 INFO - 'tpaint', 16:42:03 INFO - 'sessionrestore', 16:42:03 INFO - 'sessionrestore_no_auto_restore', 16:42:03 INFO - 'tabpaint']}, 16:42:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['a11yr', 16:42:03 INFO - 'ts_paint', 16:42:03 INFO - 'tpaint', 16:42:03 INFO - 'sessionrestore', 16:42:03 INFO - 'sessionrestore_no_auto_restore', 16:42:03 INFO - 'tabpaint']}, 16:42:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['tsvgx', 16:42:03 INFO - 'tsvgr_opacity', 16:42:03 INFO - 'tart', 16:42:03 INFO - 'tscrollx', 16:42:03 INFO - 'cart']}, 16:42:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:42:03 INFO - 'tsvgr_opacity', 16:42:03 INFO - 'tart', 16:42:03 INFO - 'tscrollx', 16:42:03 INFO - 'cart']}, 16:42:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'talos_options': ['--disable-e10s'], 16:42:03 INFO - 'tests': ['tp5o']}, 16:42:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'tests': ['tp5o']}, 16:42:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'talos_options': ['--disable-e10s', 16:42:03 INFO - '--xperf_path', 16:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:03 INFO - 'tests': ['tp5n']}, 16:42:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:42:03 INFO - 'talos_options': ['--xperf_path', 16:42:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:42:03 INFO - 'tests': ['tp5n']}}, 16:42:03 INFO - 'talos.zip': {'path': '', 16:42:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:42:03 INFO - Running post-action listener: _resource_record_post_action 16:42:03 INFO - ##### 16:42:03 INFO - ##### Running create-virtualenv step. 16:42:03 INFO - ##### 16:42:03 INFO - Running pre-action listener: _resource_record_pre_action 16:42:03 INFO - Running main action method: create_virtualenv 16:42:03 INFO - Creating virtualenv /builds/slave/test/build/venv 16:42:03 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 16:42:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:42:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:42:03 INFO - Using real prefix '/tools/python27' 16:42:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:42:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:42:06 INFO - Installing pip.................done. 16:42:06 INFO - Return code: 0 16:42:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:42:06 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')]} 16:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:06 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')]} 16:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:06 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:06 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 16:42:06 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 16:42:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:06 INFO - 'HOME': '/Users/cltbld', 16:42:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:06 INFO - 'LOGNAME': 'cltbld', 16:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:06 INFO - 'MOZ_NO_REMOTE': '1', 16:42:06 INFO - 'NO_EM_RESTART': '1', 16:42:06 INFO - 'PAGER': '/bin/cat', 16:42:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:06 INFO - 'PWD': '/builds/slave/test', 16:42:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:06 INFO - 'SHELL': '/bin/bash', 16:42:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:06 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:06 INFO - 'USER': 'cltbld', 16:42:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:06 INFO - 'XPC_FLAGS': '0x0', 16:42:06 INFO - 'XPC_SERVICE_NAME': '0', 16:42:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:07 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 16:42:07 INFO - Cleaning up... 16:42:07 INFO - Return code: 0 16:42:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:42: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')]} 16:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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')]} 16:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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', '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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42: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', 'psutil>=0.7.1'] in /builds/slave/test/build 16:42: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 psutil>=0.7.1 16:42:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:07 INFO - 'HOME': '/Users/cltbld', 16:42:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:07 INFO - 'LOGNAME': 'cltbld', 16:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:07 INFO - 'MOZ_NO_REMOTE': '1', 16:42:07 INFO - 'NO_EM_RESTART': '1', 16:42:07 INFO - 'PAGER': '/bin/cat', 16:42:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:07 INFO - 'PWD': '/builds/slave/test', 16:42:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:07 INFO - 'SHELL': '/bin/bash', 16:42:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:07 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:07 INFO - 'USER': 'cltbld', 16:42:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:07 INFO - 'XPC_FLAGS': '0x0', 16:42:07 INFO - 'XPC_SERVICE_NAME': '0', 16:42:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:07 INFO - Downloading/unpacking psutil>=0.7.1 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42: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 16:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:42:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:10 INFO - Installing collected packages: psutil 16:42:10 INFO - Running setup.py install for psutil 16:42:10 INFO - building 'psutil._psutil_osx' extension 16:42:10 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 16:42:10 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 16:42:10 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 16:42:11 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 16:42:11 INFO - building 'psutil._psutil_posix' extension 16:42:11 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 16:42:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:42:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:42:11 INFO - ^ 16:42:11 INFO - 1 warning generated. 16:42:11 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 16:42:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:42:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:42:11 INFO - Successfully installed psutil 16:42:11 INFO - Cleaning up... 16:42:11 INFO - Return code: 0 16:42:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:11 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:11 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 16:42:11 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 16:42:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:11 INFO - 'HOME': '/Users/cltbld', 16:42:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:11 INFO - 'LOGNAME': 'cltbld', 16:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:11 INFO - 'MOZ_NO_REMOTE': '1', 16:42:11 INFO - 'NO_EM_RESTART': '1', 16:42:11 INFO - 'PAGER': '/bin/cat', 16:42:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:11 INFO - 'PWD': '/builds/slave/test', 16:42:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:11 INFO - 'SHELL': '/bin/bash', 16:42:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:11 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:11 INFO - 'USER': 'cltbld', 16:42:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:11 INFO - 'XPC_FLAGS': '0x0', 16:42:11 INFO - 'XPC_SERVICE_NAME': '0', 16:42:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:42:11 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 16:42:11 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 16:42:11 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 16:42:11 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 16:42:11 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 16:42:11 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 16:42:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:42:14 INFO - Installing collected packages: mozsystemmonitor 16:42:14 INFO - Running setup.py install for mozsystemmonitor 16:42:14 INFO - Successfully installed mozsystemmonitor 16:42:14 INFO - Cleaning up... 16:42:14 INFO - Return code: 0 16:42:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:42:14 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')]} 16:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:14 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')]} 16:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:14 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:14 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 16:42:14 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 16:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:14 INFO - 'HOME': '/Users/cltbld', 16:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:14 INFO - 'LOGNAME': 'cltbld', 16:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:14 INFO - 'MOZ_NO_REMOTE': '1', 16:42:14 INFO - 'NO_EM_RESTART': '1', 16:42:14 INFO - 'PAGER': '/bin/cat', 16:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:14 INFO - 'PWD': '/builds/slave/test', 16:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:14 INFO - 'SHELL': '/bin/bash', 16:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:14 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:14 INFO - 'USER': 'cltbld', 16:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:14 INFO - 'XPC_FLAGS': '0x0', 16:42:14 INFO - 'XPC_SERVICE_NAME': '0', 16:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:14 INFO - Downloading/unpacking blobuploader==1.2.4 16:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:17 INFO - Downloading blobuploader-1.2.4.tar.gz 16:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:42:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:42:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:18 INFO - Downloading docopt-0.6.1.tar.gz 16:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:42:18 INFO - Installing collected packages: blobuploader, requests, docopt 16:42:18 INFO - Running setup.py install for blobuploader 16:42:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:42:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:42:18 INFO - Running setup.py install for requests 16:42:19 INFO - Running setup.py install for docopt 16:42:19 INFO - Successfully installed blobuploader requests docopt 16:42:19 INFO - Cleaning up... 16:42:19 INFO - Return code: 0 16:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42: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')]} 16:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42: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')]} 16:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:19 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:19 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 16:42:19 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 16:42:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:19 INFO - 'HOME': '/Users/cltbld', 16:42:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:19 INFO - 'LOGNAME': 'cltbld', 16:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:19 INFO - 'MOZ_NO_REMOTE': '1', 16:42:19 INFO - 'NO_EM_RESTART': '1', 16:42:19 INFO - 'PAGER': '/bin/cat', 16:42:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:19 INFO - 'PWD': '/builds/slave/test', 16:42:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:19 INFO - 'SHELL': '/bin/bash', 16:42:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:19 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:19 INFO - 'USER': 'cltbld', 16:42:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:19 INFO - 'XPC_FLAGS': '0x0', 16:42:19 INFO - 'XPC_SERVICE_NAME': '0', 16:42:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:19 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-H15z3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:19 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-PIg9Db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:19 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-_yBsvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:19 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-ZLwmfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:19 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-wSpMI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-ytPyYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-_uErS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-NABG1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-gjsh37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Nbq8VR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-3CLzR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-cM1wpe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-226m_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-Qk4tYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:20 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-mRFSmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-NzNwZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:21 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-RE_JR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:42:21 INFO - Running setup.py install for manifestparser 16:42:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:42:21 INFO - Running setup.py install for mozcrash 16:42:21 INFO - Running setup.py install for mozdebug 16:42:21 INFO - Running setup.py install for mozdevice 16:42:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:42:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:42:21 INFO - Running setup.py install for mozfile 16:42:22 INFO - Running setup.py install for mozhttpd 16:42:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Running setup.py install for mozinfo 16:42:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Running setup.py install for mozInstall 16:42:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Running setup.py install for mozleak 16:42:22 INFO - Running setup.py install for mozlog 16:42:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Running setup.py install for moznetwork 16:42:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:42:22 INFO - Running setup.py install for mozprocess 16:42:23 INFO - Running setup.py install for mozprofile 16:42:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:42:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:42:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:42:23 INFO - Running setup.py install for mozrunner 16:42:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:42:23 INFO - Running setup.py install for mozscreenshot 16:42:23 INFO - Running setup.py install for moztest 16:42:23 INFO - Running setup.py install for mozversion 16:42:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:42:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:42:23 INFO - Cleaning up... 16:42:23 INFO - Return code: 0 16:42:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:23 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:23 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 16:42:23 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 16:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:23 INFO - 'HOME': '/Users/cltbld', 16:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:23 INFO - 'LOGNAME': 'cltbld', 16:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:23 INFO - 'MOZ_NO_REMOTE': '1', 16:42:23 INFO - 'NO_EM_RESTART': '1', 16:42:23 INFO - 'PAGER': '/bin/cat', 16:42:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:23 INFO - 'PWD': '/builds/slave/test', 16:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:23 INFO - 'SHELL': '/bin/bash', 16:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:23 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:23 INFO - 'USER': 'cltbld', 16:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:23 INFO - 'XPC_FLAGS': '0x0', 16:42:23 INFO - 'XPC_SERVICE_NAME': '0', 16:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-wcFxfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-jDrns7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-nnzMzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-PyoDTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-0lwnaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-kLrZip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-hl_EjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-DphqaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:42:24 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)) 16:42:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:42:24 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-53pPrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-ABz_oc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-sBO6H6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-fBI8uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-jj2kPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-9EoUur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-SV2pEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-cCG4ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:42:25 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)) 16:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:42:25 INFO - Running setup.py (path:/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/pip-NZvHtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:42:25 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)) 16:42:25 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)) 16:42:25 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)) 16:42:25 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)) 16:42:25 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)) 16:42:25 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)) 16:42:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:42:25 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 16:42:25 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 16:42:25 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 16:42:25 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 16:42:25 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 16:42:25 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 16:42:28 INFO - Downloading blessings-1.6.tar.gz 16:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:42:28 INFO - Installing collected packages: blessings 16:42:28 INFO - Running setup.py install for blessings 16:42:28 INFO - Successfully installed blessings 16:42:28 INFO - Cleaning up... 16:42:28 INFO - Return code: 0 16:42:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:42:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:28 INFO - Reading from file tmpfile_stdout 16:42:28 INFO - Current package versions: 16:42:28 INFO - blessings == 1.6 16:42:28 INFO - blobuploader == 1.2.4 16:42:28 INFO - docopt == 0.6.1 16:42:28 INFO - manifestparser == 1.1 16:42:28 INFO - mozInstall == 1.12 16:42:28 INFO - mozcrash == 0.17 16:42:28 INFO - mozdebug == 0.1 16:42:28 INFO - mozdevice == 0.48 16:42:28 INFO - mozfile == 1.2 16:42:28 INFO - mozhttpd == 0.7 16:42:28 INFO - mozinfo == 0.9 16:42:28 INFO - mozleak == 0.1 16:42:28 INFO - mozlog == 3.1 16:42:28 INFO - moznetwork == 0.27 16:42:28 INFO - mozprocess == 0.22 16:42:28 INFO - mozprofile == 0.28 16:42:28 INFO - mozrunner == 6.11 16:42:28 INFO - mozscreenshot == 0.1 16:42:28 INFO - mozsystemmonitor == 0.0 16:42:28 INFO - moztest == 0.7 16:42:28 INFO - mozversion == 1.4 16:42:28 INFO - psutil == 3.1.1 16:42:28 INFO - requests == 1.2.3 16:42:28 INFO - wsgiref == 0.1.2 16:42:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:42:28 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')]} 16:42:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:28 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')]} 16:42:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:28 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:28 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 16:42:28 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 16:42:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:28 INFO - 'HOME': '/Users/cltbld', 16:42:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:28 INFO - 'LOGNAME': 'cltbld', 16:42:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:28 INFO - 'MOZ_NO_REMOTE': '1', 16:42:28 INFO - 'NO_EM_RESTART': '1', 16:42:28 INFO - 'PAGER': '/bin/cat', 16:42:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:28 INFO - 'PWD': '/builds/slave/test', 16:42:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:28 INFO - 'SHELL': '/bin/bash', 16:42:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:28 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:28 INFO - 'USER': 'cltbld', 16:42:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:28 INFO - 'XPC_FLAGS': '0x0', 16:42:28 INFO - 'XPC_SERVICE_NAME': '0', 16:42:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 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)) 16:42:29 INFO - Cleaning up... 16:42:29 INFO - Return code: 0 16:42:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:29 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 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:29 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 16:42:29 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 16:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:29 INFO - 'HOME': '/Users/cltbld', 16:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:29 INFO - 'LOGNAME': 'cltbld', 16:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:29 INFO - 'MOZ_NO_REMOTE': '1', 16:42:29 INFO - 'NO_EM_RESTART': '1', 16:42:29 INFO - 'PAGER': '/bin/cat', 16:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:29 INFO - 'PWD': '/builds/slave/test', 16:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:29 INFO - 'SHELL': '/bin/bash', 16:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:29 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:29 INFO - 'USER': 'cltbld', 16:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:29 INFO - 'XPC_FLAGS': '0x0', 16:42:29 INFO - 'XPC_SERVICE_NAME': '0', 16:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:29 INFO - Downloading/unpacking jsonschema 16:42:29 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 16:42:29 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 16:42:29 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 16:42:29 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 16:42:29 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 16:42:29 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 16:42:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:42:30 INFO - Downloading/unpacking functools32 (from jsonschema) 16:42:30 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 16:42:30 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 16:42:30 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 16:42:30 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 16:42:30 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 16:42:30 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 16:42:30 INFO - Downloading functools32-3.2.3-2.tar.gz 16:42:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:42:31 INFO - warning: no files found matching '*.txt' 16:42:31 INFO - no previously-included directories found matching 'build' 16:42:31 INFO - no previously-included directories found matching 'dist' 16:42:31 INFO - no previously-included directories found matching '.git*' 16:42:31 INFO - Installing collected packages: jsonschema, functools32 16:42:31 INFO - Running setup.py install for functools32 16:42:31 INFO - warning: no files found matching '*.txt' 16:42:31 INFO - no previously-included directories found matching 'build' 16:42:31 INFO - no previously-included directories found matching 'dist' 16:42:31 INFO - no previously-included directories found matching '.git*' 16:42:31 INFO - Successfully installed jsonschema functools32 16:42:31 INFO - Cleaning up... 16:42:31 INFO - Return code: 0 16:42:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103cb2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103cc2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92db4c3670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, '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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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 16:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:42:31 INFO - 'HOME': '/Users/cltbld', 16:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:42:31 INFO - 'LOGNAME': 'cltbld', 16:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:42:31 INFO - 'MOZ_NO_REMOTE': '1', 16:42:31 INFO - 'NO_EM_RESTART': '1', 16:42:31 INFO - 'PAGER': '/bin/cat', 16:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:42:31 INFO - 'PWD': '/builds/slave/test', 16:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:42:31 INFO - 'SHELL': '/bin/bash', 16:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:42:31 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:42:31 INFO - 'USER': 'cltbld', 16:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:42:31 INFO - 'XPC_FLAGS': '0x0', 16:42:31 INFO - 'XPC_SERVICE_NAME': '0', 16:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:42:31 INFO - Downloading/unpacking flake8 16:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:42:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:42:33 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 16:42:33 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 16:42:33 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 16:42:33 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 16:42:33 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 16:42:33 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 16:42:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:42:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:42:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:42:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:42:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:42:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:42:35 INFO - no previously-included directories found matching 'docs/_build' 16:42:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:42:35 INFO - Running setup.py install for pep8 16:42:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:42:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:42:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:42:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:42:35 INFO - no previously-included directories found matching 'docs/_build' 16:42:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:42:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:42:35 INFO - Cleaning up... 16:42:35 INFO - Return code: 0 16:42:35 INFO - Running post-action listener: _resource_record_post_action 16:42:35 INFO - Running post-action listener: _start_resource_monitoring 16:42:35 INFO - Starting resource monitoring. 16:42:35 INFO - ##### 16:42:35 INFO - ##### Running install step. 16:42:35 INFO - ##### 16:42:35 INFO - Running pre-action listener: _resource_record_pre_action 16:42:35 INFO - Running main action method: install 16:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:42:35 INFO - Reading from file tmpfile_stdout 16:42:35 INFO - Detecting whether we're running mozinstall >=1.0... 16:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:42:35 INFO - Reading from file tmpfile_stdout 16:42:35 INFO - Output received: 16:42:35 INFO - Usage: mozinstall [options] installer 16:42:35 INFO - Options: 16:42:35 INFO - -h, --help show this help message and exit 16:42:35 INFO - -d DEST, --destination=DEST 16:42:35 INFO - Directory to install application into. [default: 16:42:35 INFO - "/builds/slave/test"] 16:42:35 INFO - --app=APP Application being installed. [default: firefox] 16:42:35 INFO - mkdir: /builds/slave/test/build/application 16:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:43:09 INFO - Reading from file tmpfile_stdout 16:43:09 INFO - Output received: 16:43:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:43:09 INFO - Running post-action listener: _resource_record_post_action 16:43:09 INFO - ##### 16:43:09 INFO - ##### Running run-tests step. 16:43:09 INFO - ##### 16:43:09 INFO - Running pre-action listener: _resource_record_pre_action 16:43:09 INFO - Running main action method: run_tests 16:43:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:43:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:43:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:43:09 INFO - 2016-05-05 16:43:09.938 screenresolution[1637:7474] starting screenresolution argv=screenresolution get 16:43:09 INFO - 2016-05-05 16:43:09.941 screenresolution[1637:7474] Display 0: 1600x1200x32@60 16:43:09 INFO - 2016-05-05 16:43:09.946 screenresolution[1638:7476] starting screenresolution argv=screenresolution list 16:43:09 INFO - Available Modes on Display 0 16:43:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:43:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:43:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:43:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:43:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:43:10 INFO - Intel Iris: 16:43:10 INFO - Chipset Model: Intel Iris 16:43:10 INFO - Type: GPU 16:43:10 INFO - Bus: Built-In 16:43:10 INFO - VRAM (Dynamic, Max): 1536 MB 16:43:10 INFO - Vendor: Intel (0x8086) 16:43:10 INFO - Device ID: 0x0a2e 16:43:10 INFO - Revision ID: 0x0009 16:43:10 INFO - Displays: 16:43:10 INFO - Display: 16:43:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:43:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:43:10 INFO - Display Serial Number: 1600x1200 60 16:43:10 INFO - Main Display: Yes 16:43:10 INFO - Mirror: Off 16:43:10 INFO - Online: Yes 16:43:10 INFO - Rotation: Supported 16:43:10 INFO - Return code: 0 16:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:43:10 INFO - Python 2.7.3 16:43:10 INFO - Return code: 0 16:43:10 INFO - grabbing minidump binary from tooltool 16:43:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:10 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 0x103b51e00>, '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 0x1039badb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b4cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:43:10 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 16:43:10 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 16:43:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:43:10 INFO - Return code: 0 16:43:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:43:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:43:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:43:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:43:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:43:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:43:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:43:11 INFO - Return code: 0 16:43:11 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/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--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 16:43:11 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/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0195 --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 16:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cmhpYz3T2w/Render', 16:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:43:11 INFO - 'HOME': '/Users/cltbld', 16:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:43:11 INFO - 'LOGNAME': 'cltbld', 16:43:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:43:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:11 INFO - 'MOZ_NO_REMOTE': '1', 16:43:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:43:11 INFO - 'NO_EM_RESTART': '1', 16:43:11 INFO - 'PAGER': '/bin/cat', 16:43:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:11 INFO - 'PWD': '/builds/slave/test', 16:43:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:43:11 INFO - 'SHELL': '/bin/bash', 16:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TjOtXMYPHy/Listeners', 16:43:11 INFO - 'TMPDIR': '/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/', 16:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:43:11 INFO - 'USER': 'cltbld', 16:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:11 INFO - 'XPC_FLAGS': '0x0', 16:43:11 INFO - 'XPC_SERVICE_NAME': '0', 16:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:43:11 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/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0195', '--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 16:43:11 INFO - mozversion application_buildid: 20160505142107 16:43:11 INFO - mozversion application_changeset: daa53f98b541117b380d848f34eb00570ae71d2b 16:43:11 INFO - mozversion application_display_name: Nightly 16:43:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:43:11 INFO - mozversion application_name: Firefox 16:43:11 INFO - mozversion application_remotingname: firefox 16:43:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:43:11 INFO - mozversion application_vendor: Mozilla 16:43:11 INFO - mozversion application_version: 49.0a1 16:43:11 INFO - mozversion platform_buildid: 20160505142107 16:43:11 INFO - mozversion platform_changeset: daa53f98b541117b380d848f34eb00570ae71d2b 16:43:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:43:11 INFO - mozversion platform_version: 49.0a1 16:43:11 INFO - using testdate: 1462491791 16:43:11 INFO - actual date: 1462491791 16:43:11 INFO - starting webserver on 'localhost:49279' 16:43:11 INFO - SUITE-START | Running 2 tests 16:43:11 INFO - TEST-START | dromaeo_css 16:43:11 INFO - operating with platform_type : mac_ 16:43:11 INFO - Initialising browser for dromaeo_css test... 16:43:11 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpgddNvE/profile http://localhost:49279/getInfo.html) 16:43:14 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 16:43:14 INFO - PROCESS | 1656 | colorDepth:24 16:43:14 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 16:43:14 INFO - PROCESS | 1656 | __metrics 16:43:14 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 16:43:15 INFO - TEST-INFO | 1656: exit 0 16:43:15 INFO - Browser initialized. 16:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 16:43:15 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpgddNvE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:43:27 INFO - PROCESS | 1659 | RSS: Main: 250052608 16:43:27 INFO - PROCESS | 1659 | 16:44:16 INFO - PROCESS | 1659 | 1462491856698 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] 16:46:28 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 16:46:29 INFO - PROCESS | 1659 | RSS: Main: 261865472 16:46:29 INFO - PROCESS | 1659 | 16:49:31 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 16:49:32 INFO - PROCESS | 1659 | RSS: Main: 273944576 16:49:32 INFO - PROCESS | 1659 | 16:52:34 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 16:52:35 INFO - PROCESS | 1659 | RSS: Main: 275804160 16:52:35 INFO - PROCESS | 1659 | 16:55:36 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 16:55:37 INFO - PROCESS | 1659 | RSS: Main: 277577728 16:55:37 INFO - PROCESS | 1659 | 16:58:40 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 16:58:40 INFO - PROCESS | 1659 | RSS: Main: 280358912 16:58:40 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 17:01:43 INFO - PROCESS | 1659 | RSS: Main: 281456640 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | __start_tp_report 17:01:43 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 17:01:43 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 17:01:43 INFO - PROCESS | 1659 | |i|pagename|runs| 17:01:43 INFO - PROCESS | 1659 | |0;dojo.html;3538.8407521661525;3553.484744712015;3560.3947328954077;3569.303985722785;3592.784432934024;5239.738013099349;5449.891002179959;5863.530917526598;5994.16081748555;5999.580029397944;5896.439838215363;6014.368491308415;6036.15493830864;6037.486813620848;6086.178365920599;4620.191466493367;5280.947190528103;5354.651947623392;5446.591505637093;5455.372632147294;4734.810607575693;5393.81121660742;5526.778928842861;5539.833804985837;5574.888502229973;4216.777134630954;4884.5603895649565;5304.496072873071;5389.78440862365;5421.593380496479;5358.062339090682;5371.006363822706;5371.301730775013;5381.354237491487;5389.649672771257;4750.836045168921;5225.759804532656;5299.814506492293;5394.32570928634;5455.618106732491;5871.882562348772;5919.112133180014;5967.104934259853;5987.940120598825;5995;6253.093301471306;6298.968505157491;6342.587731797418;6353.714082866282;6373.426391624776;6192.504599632019;6437.678116094176;6441.420272175526;6454.290028096905;6469.514786390992;6046.062860256668;6095.19653686519;6127.785527506516;6146.354632763585;6151.846203844851;6556.770513032021;6587.143671322698;6589.80230593083;6601.141851559362;6602.339766023455;6147.784827531015;6162.291336496361;6238.906416403757;6256.812295631138;6257.749690012349;6144.648177400964;6286.528510361742;6295.496360291166;6300.653464059521;6303.432691057827;6133.693315334215;6160.10678451622;6188.752449902044;6217.347178546278;6233.75064997395;6112.564273424362;6196;6233.158523599347;6327.873442531216;6339.270983836917;5067.265246539231;5106.897862042739;5113.974430127825;5120.436751957282;5145.382554093533;4492.932606010912;4528.637708983273;4553.658475614342;4561.1333846569705;4587.770611469413;6001.039833626686;6072.817815465543;6098.085287206865;6110.938890611037;6144.17053697754;6469.77355792545;6477.093206951031;6481.837954051092;6491.383318584727;6553.442957348679;6120.449159575571;6134.294556126102;6143.600665956698;6160.753569857246;6166.784162554379;5144.048351055067;5247.134222853263;5464.426235245242;5587.189857470644;5621.381648018714;6614.86770264592;6649.867002660017;6655.567388119756;6678.365555272241;6680.198376194888;5562.694051827189;6418.518611104279;6449.4517965971545;6461.773837915651;6477.740890364333;6362.363763623601;6502.284748677736;6528.771492997722;6577.769778057745;6608.900866486911;6238.376162383725;6245.8750824982335;6248.218972628421;6255.53083518747;6270;5620;5842.948269311395;5873.882522349443;6396.648184349905;6416.101745755691;6145.7708458307625;6146.569740118328;6162.767446510806;6169.722362493609;6171.352008039091;5036.06832735945;5448.264484294569;5579.023670857665;6054.878902421839;6230.657313847782;6065.848353791191;6102.420270074336;6154.876902462015;6196.628202307876;6229.4393504582995;6095.6499315652145;6120.710695802514;6139.032198454696;6158.3225845157895;6304.117423560797;6162.168107305456;6183.350748171557;6193.071039344134;6193.318734939243;6193.628382297076 17:01:43 INFO - PROCESS | 1659 | |1;ext.html;489.49337435754;498.1332481482221;503.944236823854;504.3468708023114;530.777073629076;34724.95825125247;40245;40332.19335613286;40342.991425214386;40361.3945790813;41277.96805079874;41733.79133104338;41750;41788.95527611811;41809.372859407056;9490.145886870181;9591.040895910388;9698.757531061745;9714;9714.805703885919;9617.374870633386;9664.613415463373;9726.805463890718;9726.854097188549;9753.853692194623;8560.529170895597;8778.253848422892;9412.247020238365;9738.853917191213;9792.412455252708;8562.315014798802;9622.037796220391;9703.078207570341;9762.658306959222;9785.363951343212;9569.569369378394;9582.377145485521;9591;9675.467849268287;9681.983391743835;38448.23103537942;38475.807620962;38582.22835543301;38694;38877.80561097205;3134.467140586083;3207.7754557181006;3376.9324613507592;3474.9826250868837;3494.586271977759;28021.859890700416;28715.28211794701;29223;29422.26444338887;29599;2705.8917643294244;2726.768224700903;2741.369485018457;2746.4232511172677;2855.514562524376;411891;471006;493960;495225;496213;63354.36645633485;63797.68101159464;63985.680071599345;64027;64108.67945660242;34787.13032174165;36404.63595364012;37274.44088338677;38273.425898611546;38517.61482385196;16887.831121688872;16999.830001700073;17225.7416138758;17246.310147594206;17293.22180501855;11215.32708037504;12775.105742598114;13188.934055329853;13219;13266.137701049594;19707.704384434244;19878.90060549717;19905;19921.402357929284;19946.601067978558;8140;8167.264946154874;8240;8259.182979744446;8374.162583741578;920.2729843423754;1043.4626167523732;1048.7849990751877;1081.6106201767357;1115.6764538283808;26074.82663280157;29629.259268518028;30165.09504714862;30270.54594181045;30339.544906826417;935.5088578496344;984.921206303494;1053.7629033467563;1127.520803658442;1164.91263155262;14934;14990.325435355435;15066.623334416508;15197.996087980617;15250.618734531725;631178;674647;690081;690263;691078;57034.14448783272;58070.8385832281;58080.709596452594;58341;58693.25027621878;1392.9442822287197;1442.7114577084415;1487.1894817324585;1493.320539154682;1496.9700605987819;27147;27215;28300.85849570739;29107.7089229105;29211.7078829209;48337.03325933532;48841.755791220814;48931.75534122449;49577.50422495729;49893.501064990334;567502;573554;574318;575181;578217;26489.470210596064;26864.731352686224;26906.59640105439;26983.730162698906;27491.450170996068;45423.77288113538;45616.54383456256;45998.77000614975;46441;46585;32515.674843251265;37979.62020379761;37996;38282.80858595689;38355;36760.978146202215;37084.258314833016;37224.62775372212;37791.62208377881;38023;31889.681103188672;36484.45273320849;36719.449208261365;37389.878303650934;37733.622663773014;32671.509927350635;33469.66530334666;33472.995810125736;33588.3282334347;33743.98768036963;24451.633225501275;24811.25566233016;24988.386903424136;25142.371440713396;25239.11663091783 17:01:43 INFO - PROCESS | 1659 | |2;jquery.html;368.8487720034785;378.6062495005195;390.17867389145846;395.4167602785891;408.1917802750556;19230.71153932692;20349.880756558385;21034.368968930918;21112.944352782375;21292.4676883078;15937.681246375065;20344.88103154326;20832.68750968733;20959.790402095976;21146.048427820748;4887.315775791392;5353.223782551528;5573.777048918038;6094.390560943914;6106.084087386906;6113.449789518942;6135.079738039308;6166.660833654148;6176.4749996250375;6180.443760061594;6073.696315184246;6155.230596175478;6157.076438534234;6162.5069994400565;6165.383461653843;6015;6048.7882924097885;6116.847078823021;6157;6167.691615419233;5783.0747080467345;5909.6158749681135;5925.703714814285;5950.404959504058;5953.464188223081;13737.725245495034;17001.489955301236;18643.627127457512;25775.48449031009;25804.74195258042;2081.843861710378;2354.835161538693;2377.5720370333333;2472.8269021168526;2501.961685900349;9890.9505452473;10377;10649.041586257197;11388.430578471043;15243.466478673194;1682.1421075251587;1726.9827301726948;1767.9823201767947;1781.3498073203318;1811.7554130192386;99628;102636;116263;119942.400287998;129330.99999999905;9676.758081047888;11760.000399965927;11906.642800715992;12022.338771367658;12115.39423028845;15119.319630616648;15138.318775655121;15439.536813895602;15515.612109697347;15630.59324660786;6762.72949082041;6987.161540615159;8069.475484093515;8751.737447876447;9020;8721.825563488695;8751.241804093062;8756.78108047304;8833.469991800384;8872.822543549093;4685.742284174403;4736.8578942631775;4764.8332308369045;4827.106985207748;4845.466998630148;1678.7565802958502;1758.2351677020538;2003.8697484663742;2015.8891260980786;2036.256766280297;881.66496731243;883.4964070479894;912.7535565397305;967.617790972576;978.6721448314752;19952;20681.862497562477;20699.06854191565;20916.163353465996;21150;830.8000039608977;951.286535098676;975.0667190148029;1018.6943916824923;1032.8605638238892;10892.61875834342;11172.44137793107;11178.888211117785;11181.776364472666;11210.495527701272;475313;478619;482263;596074;597142;135999;138380;138944.3181534319;141072.2946385282;142373.57626423604;982.2240430060315;1000.5247507433911;1022.8977102289712;1033.0495943731635;1051.4322265976286;18503.907480462512;18584.628307433504;18612.813871861108;18733.71899421537;19116.713249300992;38122.809385952896;39545.80227098846;51440;51479.74260128675;51991;62960;63054.68472657607;77406;77799.05502362487;77912;8147.266745992889;8320.417570769989;8404.53775042354;8619.482831030158;8756.168164024408;11223.60717374888;12962.935185324013;13176.736465270833;13327.200367977952;13393.531226407029;10814.513346899252;11222.326660400402;11352.318860868374;11628.592999244986;11730.70673233176;10915.890841091805;11149.219554631098;11326.943365283121;11451.969322760991;11499.482523286639;11498.597549085742;11542.884571154182;11686.24039437434;11736;11910.344931028876;8284.627191776264;8341.541215232977;8411.285040771603;8557.871631925402;8762.824743504967;8201.507909525448;10220.744481388025;11369.943150284196;11742.060635148997;11788.174827761974 17:01:43 INFO - PROCESS | 1659 | |3;mootools.html;1566.2247187642115;1566.4125952767713;1821.3261093395445;1909.999999999999;1930.459471348023;7902.96048519758;8325.625346859391;8528.829423411527;9045.683401080963;9068.365214434993;8407.957960210191;8557.187067228604;8567.971843378804;8644;8717.389782715212;2457.4102215468247;2485.092941076503;2486.7388924162883;2495.625656151574;2507.4358269389422;2446.8287219894614;2487.2786891801356;2492.2274095030507;2504.949901001979;2507.8119141064403;2469.2221950085755;2474.6782918220606;2484.8012159027326;2508.2600632813273;2521.0168034466574;2449.497852940143;2455.70531536215;2464.605663093905;2470.0984140788664;2475.344033831036;2436.902523899042;2441.292025312657;2449.375409270642;2458.201084647497;2464.8028157747335;8707.172818582225;8718.21536061751;8728.214460698568;8743.606537705818;8786.253168480687;5414.40441551429;5414.729263536808;5444.047291723932;5473.452654734535;5519.006578815812;3638.5088013118157;3650.7261955353456;3653.6529029742132;3723.478712980185;3729.8321575528894;1037.2635428845529;1058.2380685906135;1058.3120971368594;1061.8407238914224;1064.9467526623716;11353.262037967506;11408.258463199949;11437.256578322382;11616.709582260342;11636.650900472914;4837.105135549935;4854.271859221145;4976.5023497649945;4979.427365852974;4991.875203119951;9904.10863022317;9932.354396964174;9992.500374981368;9997.000299969945;10036.899631003742;4310.31035034393;5269.077911365573;5434.3207099112615;5434.347878254634;5451.972740136274;4452.154090722753;4798.5441383068555;4927.90144197114;4954.925676114861;4958.404991401055;3876.8836934891997;3946.408038794204;3966.960330396717;4016.477857878457;4043.8584649537124;1361.8229630148016;1382.2535830651536;1389.7359501694848;1393.6933874547583;1402.3759427054863;741.2513361504919;857.1514200941024;932.6819050818234;951.3578334624101;975.7511834482161;5616.9157462638095;5836.328822185418;5996.820095397145;6004.099385092271;6014.48876845473;430.5027693014573;460.18776858844166;467.7754677754697;472.9739864307496;478.19424270104986;3544.592371877267;3926.018495376156;4027.6576490998596;4028.073543085048;4060.675145988314;9992.557777122924;10521.631742888962;10595.15238780911;10659;10721.410322432184;10417.427041512638;10458.424786636655;10487.265891387682;10524.00021997909;10723.731906702238;8060.717874874468;8084.353251739847;8157.388195885333;8174.978127734153;8239.217274358927;5792.304923409218;5801.129830525455;5866.2960444745195;5879.676617786063;5900.350961394329;9701.466419347003;9953.502324883582;9958.900410996088;9986.900130998598;10031.097201251923;9451.243900488082;9957.651482198089;10084.092431681183;10121.69634910954;10234.437105958947;6839.350261725128;7251.746188883364;7379.704811807467;7504.362129219077;7535.849283014419;8348.37387195975;8376.455530390505;8419.536925469158;8433.114522975246;8449.197326253996;7154.928450715426;7280.817979550554;7463.179050304354;7565.130010048915;7608.353289970414;6455.160829092188;7244.855102898018;7376.7049318026675;7391;7413.66638501258;6919.204291506541;6924.584524928319;6973.75591854303;6976.372126508639;7001.229864714979;4827.589654879374;4890.731009794496;4906.067847109038;4973.875653108701;5095.592352611856;4934.55588996992;4959.826406075915;4997.3253610762085;5078.111330517218;5246.186841039645 17:01:43 INFO - PROCESS | 1659 | |4;prototype.html;307.84607696151926;315.78526601910704;322.12864202332685;325.3395606917957;328.94736842105254;4381.518033016369;4579.5195651305;4946.579540739037;4958.528939750722;5360.571154307656;4590.678652494318;4951.55436010759;5411.972940135303;5481.643693159942;5482.342118945732;3697.85208591656;4138.6482149017365;4160.271952408317;4161.542230354658;4165.187788381267;3840.9039774005732;4129.483814523184;4129.979350103245;4167.812448439812;4175.31107367284;4064.471618689566;4093.1199792044704;4099.385092236159;4123.855665051724;4140.7515549067;3320.9870989348237;4110.630043296088;4112.465379500661;4135.29699951009;4146.212219678251;3177.7616678748955;3429.6741809528053;3442.242706604543;3558.5018097466377;3597.442396428558;4441.933370999405;4481.969147096186;4910.337104490884;5150.665206761549;5299.867503312448;4467.709598876063;4719.150552900476;4723.197056500403;4728.6453515986095;4739.597134243593;5337.386200586943;5657.603967722261;5723.08430651098;5768.798092066758;5782.884342313172;3768.152165762709;3907.902302442462;3921.784301863396;3939.7833119178435;3941.5664276929515;6076.301225359096;6095.756169753205;6102.847428814315;6157.599756015845;6174.314173334614;3577.3024260269517;3665.3139555804096;3870.767753934773;3989.7007724420782;3989.9601003989587;3208.53476245943;3824.655780979725;3903.6877049835944;4048.7975601219823;4064.5732198119363;4695.506971767915;4720.33915251865;4732.763361831963;4744.786484608201;4747;4762.976185119052;4850.805967761321;5223.4776522347465;5463.6614029562215;5937.881242375215;1129.5143088472037;1192.4753108632347;1317.7298653775954;1319.287584704268;1321.3327269728725;834;858.978525536854;880.9163129502687;894.1684233662626;898.4519443139679;4509.301058335963;4558.612517935946;4740.293494342034;5167.6641018333685;5176.204849381292;4974.0051989602225;5418.4039755626845;5435.374931882805;5443.265159203457;5748.626339287933;4619;4631.892488917534;4784.4497882743235;5108.489151084862;5136.178211486144;2865.2550336912554;2991.8354490502797;2993.431248062861;2993.521036634128;3006.9398612027635;5174.508421699932;5289.444608316148;5465.535429488538;5529.811090615537;5793.741599924052;5046.34397528319;5417.941182350761;5472.099787112837;5501.4223506532035;5931.851703707442;5616.634918730269;5690.833379157263;6015.608985416022;6024.2469691287715;6046.7581296749395;5130;5195.623159862564;5382.596305277199;5802.535797136304;5807.448292412214;4855.951440485691;5087.109755792795;5539.41836107219;5690.231818704588;5729.710815066744;5876.324222714272;5914.585978981602;5995.070764031582;6026.276846778414;6080.969595151996;3847.8076096195637;3889.902752431212;3904.570497245244;3921.568627450921;3954.980225098856;4970.652054356305;5702.116171993348;5817.243758311392;5902.671898822902;5905.616134951214;4701.8480472283145;4844.297576851266;5700.686462244616;5729.023486897014;5735.050082971809;4898.436679781728;5279.947200527946;5719.370869204467;5726.680694318808;5759.222504961776;4735.910740529628;5506.476884695948;5520.91718624229;5532.06377767778;5590.748416321194;5473.014857325719;5517.751701173537;5715.685637289823;5731.713414329183;5742.540596752333;4923.242983929012;5184.507471790174;5559;5664.638228564065;5669.433056694297 17:01:43 INFO - PROCESS | 1659 | |5;yui.html;697.8150790040638;725.1551941987585;748.1732685382652;759.2217976574011;767.5279702982664;14730.779038314435;15128.848711512881;15175.848241517582;15327;15370.385184592631;14077.718445631106;14166.291685415714;14668.926655366708;14905.32926018329;15316.234188290597;618.452669387593;893.714011516315;897.1387468030682;901.4681338010572;903.0653273861554;869.9391042627019;889.0842432294746;898.5462341517557;899.2042042792143;901.3465237702646;918.8437965545874;927.6892241099206;939.7556635274843;947.8625599288099;950.4867371619317;928.0487500312166;937.5499760115115;939.5631031570318;940.7601061729215;942.3874481586955;691.9135108111486;693.4383149648801;695.4054283587561;697.1773307497151;697.1842943755768;14672.339744711513;14687.412503499847;15060.32228549707;15061.096334219981;15096.622584435367;12239.632811015685;12278.201916875374;12314.322712250823;12431.875681243162;12683.619491415273;9971.451570163637;9975.401475911469;10025.799484010351;10175.84736228957;10692.839607405895;3452.602950660681;3457.2739724657854;3468.8612455501748;3503.8948831535095;3529.9647003529894;77797.44405111922;78215.6089219556;79392.60303698502;79777.20222797756;80483;9239.39943903644;9323.673671421468;9324.681806838033;9372.578233979488;9532.52337383142;20945.37163885086;21136.894315528323;21142.47143821417;21206.893965530075;21231.575368492544;7133.750318738819;7352.70589176427;7473.439492038119;7498.32515073646;7528.887066694004;4023.0344717267644;4136.482939632546;4137.77242251679;4139.275626765304;4147.709660323809;3535.5227044348685;3639.2175682227917;3644.9817750911607;3653.1415117447377;3654.0499470137956;634.0900807341479;655.2104713819836;659.1102012283379;659.7629444791016;660.0956689335641;524.44408926538;558.2937583956299;559.4004019762209;595.8748662780778;608.3794529579803;6004.969975150097;7074.469414793808;8050.5169689818795;8103.351731861437;8222.753317400488;465.95340465953814;518.5669965578784;530.821576101055;556.274062348639;575.0195915963272;3320.3027364253776;3834.2331533693373;3835.53973523179;3939.330313846653;4007.73949693269;84759;87002;87923;88208.55895720609;89098;60151.39848601545;61555.38444615586;73311.26688733151;73945;75534.48931021459;70016.59966800737;70269.64865175642;70285;71014.28985710077;71554.28445715476;7673.769786906401;7705.576193309422;7816.648250828613;7886.881696774668;7902.130765615892;44280.335794962455;44562.77718611386;44677;44819.77590112029;44965.32552011657;61368;62048;62091;62571.374286258375;62744;9869;10048.49757512136;10078.294519383573;10194.74513137148;10264.178865690577;10712.464376781285;11098.445077746243;11124.721881953015;11149.72125696864;11439.370834604177;10609.734756631146;10625.787484250426;10668.786624267315;10751.90701053395;10775.94612026935;10489.370637761758;10683.5192416343;10811.6215932442;10958.123350131811;11302;10003.749906252402;10028.398296102258;10336;10661.360318380923;11210.607628732956;8757.781055473664;8895.911040889509;8925.241354484682;9081.45511269326;9174.862377064483;7763.456558040883;8772.649094036422;8801.91198088011;8856.64573417082;8969.416987895765 17:01:43 INFO - PROCESS | 1659 | __end_tp_report 17:01:43 INFO - PROCESS | 1659 | __start_cc_report 17:01:43 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,416 17:01:43 INFO - PROCESS | 1659 | __end_cc_report 17:01:43 INFO - PROCESS | 1659 | __startTimestamp1462492903792__endTimestamp 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | ------- Summary: start ------- 17:01:43 INFO - PROCESS | 1659 | Number of tests: 6 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5867.99 Median:6134.29 stddev:672.79 (11.0%) stddev-sans-first:649.57 17:01:43 INFO - PROCESS | 1659 | Values: 3538.8 3553.5 3560.4 3569.3 3592.8 5239.7 5449.9 5863.5 5994.2 5999.6 5896.4 6014.4 6036.2 6037.5 6086.2 4620.2 5280.9 5354.7 5446.6 5455.4 4734.8 5393.8 5526.8 5539.8 5574.9 4216.8 4884.6 5304.5 5389.8 5421.6 5358.1 5371.0 5371.3 5381.4 5389.6 4750.8 5225.8 5299.8 5394.3 5455.6 5871.9 5919.1 5967.1 5987.9 5995.0 6253.1 6299.0 6342.6 6353.7 6373.4 6192.5 6437.7 6441.4 6454.3 6469.5 6046.1 6095.2 6127.8 6146.4 6151.8 6556.8 6587.1 6589.8 6601.1 6602.3 6147.8 6162.3 6238.9 6256.8 6257.7 6144.6 6286.5 6295.5 6300.7 6303.4 6133.7 6160.1 6188.8 6217.3 6233.8 6112.6 6196.0 6233.2 6327.9 6339.3 5067.3 5106.9 5114.0 5120.4 5145.4 4492.9 4528.6 4553.7 4561.1 4587.8 6001.0 6072.8 6098.1 6110.9 6144.2 6469.8 6477.1 6481.8 6491.4 6553.4 6120.4 6134.3 6143.6 6160.8 6166.8 5144.0 5247.1 5464.4 5587.2 5621.4 6614.9 6649.9 6655.6 6678.4 6680.2 5562.7 6418.5 6449.5 6461.8 6477.7 6362.4 6502.3 6528.8 6577.8 6608.9 6238.4 6245.9 6248.2 6255.5 6270.0 5620.0 5842.9 5873.9 6396.6 6416.1 6145.8 6146.6 6162.8 6169.7 6171.4 5036.1 5448.3 5579.0 6054.9 6230.7 6065.8 6102.4 6154.9 6196.6 6229.4 6095.6 6120.7 6139.0 6158.3 6304.1 6162.2 6183.4 6193.1 6193.3 6193.6 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:69709.66 Median:38318.90 stddev:155459.76 (405.7%) stddev-sans-first:155809.00 17:01:43 INFO - PROCESS | 1659 | Values: 489.5 498.1 503.9 504.3 530.8 34725.0 40245.0 40332.2 40343.0 40361.4 41278.0 41733.8 41750.0 41789.0 41809.4 9490.1 9591.0 9698.8 9714.0 9714.8 9617.4 9664.6 9726.8 9726.9 9753.9 8560.5 8778.3 9412.2 9738.9 9792.4 8562.3 9622.0 9703.1 9762.7 9785.4 9569.6 9582.4 9591.0 9675.5 9682.0 38448.2 38475.8 38582.2 38694.0 38877.8 3134.5 3207.8 3376.9 3475.0 3494.6 28021.9 28715.3 29223.0 29422.3 29599.0 2705.9 2726.8 2741.4 2746.4 2855.5 411891.0 471006.0 493960.0 495225.0 496213.0 63354.4 63797.7 63985.7 64027.0 64108.7 34787.1 36404.6 37274.4 38273.4 38517.6 16887.8 16999.8 17225.7 17246.3 17293.2 11215.3 12775.1 13188.9 13219.0 13266.1 19707.7 19878.9 19905.0 19921.4 19946.6 8140.0 8167.3 8240.0 8259.2 8374.2 920.3 1043.5 1048.8 1081.6 1115.7 26074.8 29629.3 30165.1 30270.5 30339.5 935.5 984.9 1053.8 1127.5 1164.9 14934.0 14990.3 15066.6 15198.0 15250.6 631178.0 674647.0 690081.0 690263.0 691078.0 57034.1 58070.8 58080.7 58341.0 58693.3 1392.9 1442.7 1487.2 1493.3 1497.0 27147.0 27215.0 28300.9 29107.7 29211.7 48337.0 48841.8 48931.8 49577.5 49893.5 567502.0 573554.0 574318.0 575181.0 578217.0 26489.5 26864.7 26906.6 26983.7 27491.5 45423.8 45616.5 45998.8 46441.0 46585.0 32515.7 37979.6 37996.0 38282.8 38355.0 36761.0 37084.3 37224.6 37791.6 38023.0 31889.7 36484.5 36719.4 37389.9 37733.6 32671.5 33469.7 33473.0 33588.3 33744.0 24451.6 24811.3 24988.4 25142.4 25239.1 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:32834.82 Median:11823.65 stddev:89187.99 (754.3%) stddev-sans-first:89404.87 17:01:43 INFO - PROCESS | 1659 | Values: 368.8 378.6 390.2 395.4 408.2 19230.7 20349.9 21034.4 21112.9 21292.5 15937.7 20344.9 20832.7 20959.8 21146.0 4887.3 5353.2 5573.8 6094.4 6106.1 6113.4 6135.1 6166.7 6176.5 6180.4 6073.7 6155.2 6157.1 6162.5 6165.4 6015.0 6048.8 6116.8 6157.0 6167.7 5783.1 5909.6 5925.7 5950.4 5953.5 13737.7 17001.5 18643.6 25775.5 25804.7 2081.8 2354.8 2377.6 2472.8 2502.0 9891.0 10377.0 10649.0 11388.4 15243.5 1682.1 1727.0 1768.0 1781.3 1811.8 99628.0 102636.0 116263.0 119942.4 129331.0 9676.8 11760.0 11906.6 12022.3 12115.4 15119.3 15138.3 15439.5 15515.6 15630.6 6762.7 6987.2 8069.5 8751.7 9020.0 8721.8 8751.2 8756.8 8833.5 8872.8 4685.7 4736.9 4764.8 4827.1 4845.5 1678.8 1758.2 2003.9 2015.9 2036.3 881.7 883.5 912.8 967.6 978.7 19952.0 20681.9 20699.1 20916.2 21150.0 830.8 951.3 975.1 1018.7 1032.9 10892.6 11172.4 11178.9 11181.8 11210.5 475313.0 478619.0 482263.0 596074.0 597142.0 135999.0 138380.0 138944.3 141072.3 142373.6 982.2 1000.5 1022.9 1033.0 1051.4 18503.9 18584.6 18612.8 18733.7 19116.7 38122.8 39545.8 51440.0 51479.7 51991.0 62960.0 63054.7 77406.0 77799.1 77912.0 8147.3 8320.4 8404.5 8619.5 8756.2 11223.6 12962.9 13176.7 13327.2 13393.5 10814.5 11222.3 11352.3 11628.6 11730.7 10915.9 11149.2 11326.9 11452.0 11499.5 11498.6 11542.9 11686.2 11736.0 11910.3 8284.6 8341.5 8411.3 8557.9 8762.8 8201.5 10220.7 11369.9 11742.1 11788.2 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5702.03 Median:4959.12 stddev:3147.85 (63.5%) stddev-sans-first:3141.33 17:01:43 INFO - PROCESS | 1659 | Values: 1566.2 1566.4 1821.3 1910.0 1930.5 7903.0 8325.6 8528.8 9045.7 9068.4 8408.0 8557.2 8568.0 8644.0 8717.4 2457.4 2485.1 2486.7 2495.6 2507.4 2446.8 2487.3 2492.2 2504.9 2507.8 2469.2 2474.7 2484.8 2508.3 2521.0 2449.5 2455.7 2464.6 2470.1 2475.3 2436.9 2441.3 2449.4 2458.2 2464.8 8707.2 8718.2 8728.2 8743.6 8786.3 5414.4 5414.7 5444.0 5473.5 5519.0 3638.5 3650.7 3653.7 3723.5 3729.8 1037.3 1058.2 1058.3 1061.8 1064.9 11353.3 11408.3 11437.3 11616.7 11636.7 4837.1 4854.3 4976.5 4979.4 4991.9 9904.1 9932.4 9992.5 9997.0 10036.9 4310.3 5269.1 5434.3 5434.3 5452.0 4452.2 4798.5 4927.9 4954.9 4958.4 3876.9 3946.4 3967.0 4016.5 4043.9 1361.8 1382.3 1389.7 1393.7 1402.4 741.3 857.2 932.7 951.4 975.8 5616.9 5836.3 5996.8 6004.1 6014.5 430.5 460.2 467.8 473.0 478.2 3544.6 3926.0 4027.7 4028.1 4060.7 9992.6 10521.6 10595.2 10659.0 10721.4 10417.4 10458.4 10487.3 10524.0 10723.7 8060.7 8084.4 8157.4 8175.0 8239.2 5792.3 5801.1 5866.3 5879.7 5900.4 9701.5 9953.5 9958.9 9986.9 10031.1 9451.2 9957.7 10084.1 10121.7 10234.4 6839.4 7251.7 7379.7 7504.4 7535.8 8348.4 8376.5 8419.5 8433.1 8449.2 7154.9 7280.8 7463.2 7565.1 7608.4 6455.2 7244.9 7376.7 7391.0 7413.7 6919.2 6924.6 6973.8 6976.4 7001.2 4827.6 4890.7 4906.1 4973.9 5095.6 4934.6 4959.8 4997.3 5078.1 5246.2 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4539.81 Median:4949.07 stddev:1388.68 (28.1%) stddev-sans-first:1355.76 17:01:43 INFO - PROCESS | 1659 | Values: 307.8 315.8 322.1 325.3 328.9 4381.5 4579.5 4946.6 4958.5 5360.6 4590.7 4951.6 5412.0 5481.6 5482.3 3697.9 4138.6 4160.3 4161.5 4165.2 3840.9 4129.5 4130.0 4167.8 4175.3 4064.5 4093.1 4099.4 4123.9 4140.8 3321.0 4110.6 4112.5 4135.3 4146.2 3177.8 3429.7 3442.2 3558.5 3597.4 4441.9 4482.0 4910.3 5150.7 5299.9 4467.7 4719.2 4723.2 4728.6 4739.6 5337.4 5657.6 5723.1 5768.8 5782.9 3768.2 3907.9 3921.8 3939.8 3941.6 6076.3 6095.8 6102.8 6157.6 6174.3 3577.3 3665.3 3870.8 3989.7 3990.0 3208.5 3824.7 3903.7 4048.8 4064.6 4695.5 4720.3 4732.8 4744.8 4747.0 4763.0 4850.8 5223.5 5463.7 5937.9 1129.5 1192.5 1317.7 1319.3 1321.3 834.0 859.0 880.9 894.2 898.5 4509.3 4558.6 4740.3 5167.7 5176.2 4974.0 5418.4 5435.4 5443.3 5748.6 4619.0 4631.9 4784.4 5108.5 5136.2 2865.3 2991.8 2993.4 2993.5 3006.9 5174.5 5289.4 5465.5 5529.8 5793.7 5046.3 5417.9 5472.1 5501.4 5931.9 5616.6 5690.8 6015.6 6024.2 6046.8 5130.0 5195.6 5382.6 5802.5 5807.4 4856.0 5087.1 5539.4 5690.2 5729.7 5876.3 5914.6 5995.1 6026.3 6081.0 3847.8 3889.9 3904.6 3921.6 3955.0 4970.7 5702.1 5817.2 5902.7 5905.6 4701.8 4844.3 5700.7 5729.0 5735.1 4898.4 5279.9 5719.4 5726.7 5759.2 4735.9 5506.5 5520.9 5532.1 5590.7 5473.0 5517.8 5715.7 5731.7 5742.5 4923.2 5184.5 5559.0 5664.6 5669.4 17:01:43 INFO - PROCESS | 1659 | 17:01:43 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:17385.98 Median:31086.92 stddev:24262.43 (78.0%) stddev-sans-first:24298.14 17:01:43 INFO - PROCESS | 1659 | Values: 697.8 725.2 748.2 759.2 767.5 14730.8 15128.8 15175.8 15327.0 15370.4 14077.7 14166.3 14668.9 14905.3 15316.2 618.5 893.7 897.1 901.5 903.1 869.9 889.1 898.5 899.2 901.3 918.8 927.7 939.8 947.9 950.5 928.0 937.5 939.6 940.8 942.4 691.9 693.4 695.4 697.2 697.2 14672.3 14687.4 15060.3 15061.1 15096.6 12239.6 12278.2 12314.3 12431.9 12683.6 9971.5 9975.4 10025.8 10175.8 10692.8 3452.6 3457.3 3468.9 3503.9 3530.0 77797.4 78215.6 79392.6 79777.2 80483.0 9239.4 9323.7 9324.7 9372.6 9532.5 20945.4 21136.9 21142.5 21206.9 21231.6 7133.8 7352.7 7473.4 7498.3 7528.9 4023.0 4136.5 4137.8 4139.3 4147.7 3535.5 3639.2 3645.0 3653.1 3654.0 634.1 655.2 659.1 659.8 660.1 524.4 558.3 559.4 595.9 608.4 6005.0 7074.5 8050.5 8103.4 8222.8 466.0 518.6 530.8 556.3 575.0 3320.3 3834.2 3835.5 3939.3 4007.7 84759.0 87002.0 87923.0 88208.6 89098.0 60151.4 61555.4 73311.3 73945.0 75534.5 70016.6 70269.6 70285.0 71014.3 71554.3 7673.8 7705.6 7816.6 7886.9 7902.1 44280.3 44562.8 44677.0 44819.8 44965.3 61368.0 62048.0 62091.0 62571.4 62744.0 9869.0 10048.5 10078.3 10194.7 10264.2 10712.5 11098.4 11124.7 11149.7 11439.4 10609.7 10625.8 10668.8 10751.9 10775.9 10489.4 10683.5 10811.6 10958.1 11302.0 10003.7 10028.4 10336.0 10661.4 11210.6 8757.8 8895.9 8925.2 9081.5 9174.9 7763.5 8772.6 8801.9 8856.6 8969.4 17:01:43 INFO - PROCESS | 1659 | -------- Summary: end -------- 17:01:43 INFO - PROCESS | 1659 | 17:01:44 INFO - TEST-INFO | 1659: exit 0 17:01:44 INFO - TEST-OK | dromaeo_css | took 1112767ms 17:01:44 INFO - TEST-START | kraken 17:01:44 INFO - operating with platform_type : mac_ 17:01:44 INFO - Initialising browser for kraken test... 17:01:44 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpkVJ75p/profile http://localhost:49279/getInfo.html) 17:01:47 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 17:01:47 INFO - PROCESS | 1670 | colorDepth:24 17:01:47 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 17:01:47 INFO - PROCESS | 1670 | __metrics 17:01:47 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 17:01:48 INFO - TEST-INFO | 1670: exit 0 17:01:48 INFO - Browser initialized. 17:01:48 INFO - Running cycle 1/1 for kraken test... 17:01:48 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/T/tmpkVJ75p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:02:00 INFO - PROCESS | 1673 | RSS: Main: 250068992 17:02:00 INFO - PROCESS | 1673 | 17:02:02 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 17:02:03 INFO - PROCESS | 1673 | RSS: Main: 261844992 17:02:03 INFO - PROCESS | 1673 | 17:02:06 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 17:02:06 INFO - PROCESS | 1673 | RSS: Main: 266559488 17:02:06 INFO - PROCESS | 1673 | 17:02:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 17:02:11 INFO - PROCESS | 1673 | RSS: Main: 266641408 17:02:11 INFO - PROCESS | 1673 | 17:02:12 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 17:02:13 INFO - PROCESS | 1673 | RSS: Main: 267272192 17:02:13 INFO - PROCESS | 1673 | 17:02:15 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:02:16 INFO - PROCESS | 1673 | RSS: Main: 267829248 17:02:16 INFO - PROCESS | 1673 | 17:02:19 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 17:02:19 INFO - PROCESS | 1673 | RSS: Main: 268267520 17:02:19 INFO - PROCESS | 1673 | 17:02:22 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 17:02:23 INFO - PROCESS | 1673 | RSS: Main: 268496896 17:02:23 INFO - PROCESS | 1673 | 17:02:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 17:02:27 INFO - PROCESS | 1673 | RSS: Main: 268570624 17:02:27 INFO - PROCESS | 1673 | 17:02:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:02:29 INFO - PROCESS | 1673 | RSS: Main: 267968512 17:02:29 INFO - PROCESS | 1673 | 17:02:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:02:32 INFO - PROCESS | 1673 | RSS: Main: 268148736 17:02:32 INFO - PROCESS | 1673 | 17:02:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:02:35 INFO - PROCESS | 1673 | RSS: Main: 268513280 17:02:35 INFO - PROCESS | 1673 | 17:02:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:02:38 INFO - PROCESS | 1673 | RSS: Main: 268505088 17:02:38 INFO - PROCESS | 1673 | 17:02:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:02:42 INFO - PROCESS | 1673 | RSS: Main: 268476416 17:02:42 INFO - PROCESS | 1673 | 17:02:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 17:02:44 INFO - PROCESS | 1673 | RSS: Main: 269971456 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | __start_tp_report 17:02:44 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 17:02:44 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 17:02:44 INFO - PROCESS | 1673 | |i|pagename|runs| 17:02:44 INFO - PROCESS | 1673 | |0;ai-astar;114;116;107;115;117;117;107;115;117;115 17:02:44 INFO - PROCESS | 1673 | |1;audio-beat-detection;155;120;145;163;123;150;143;127;175;142 17:02:44 INFO - PROCESS | 1673 | |2;audio-dft;192;199;201;222;257;266;278;212;197;197 17:02:44 INFO - PROCESS | 1673 | |3;audio-fft;72;84;76;141;59;58;62;61;130;61 17:02:44 INFO - PROCESS | 1673 | |4;audio-oscillator;84;95;135;81;83;82;129;114;109;152 17:02:44 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;100;113;89;101;123;87;92;88;97;125 17:02:44 INFO - PROCESS | 1673 | |6;imaging-darkroom;149;97;125;146;96;96;96;96;96;101 17:02:44 INFO - PROCESS | 1673 | |7;imaging-desaturate;91;93;91;90;93;128;91;143;142;119 17:02:44 INFO - PROCESS | 1673 | |8;json-parse-financial;61;63;62;62;63;61;60;75;63;59 17:02:44 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;69;68;76;71;76;102;63;87;93;96 17:02:44 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;97;102;91;89;87;86;85;85;104;88 17:02:44 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;160;151;140;141;166;146;153;137;192;148 17:02:44 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;162;168;171;167;169;168;170;207;221;216 17:02:44 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;66;69;66;68;66;67;68;69;66;66 17:02:44 INFO - PROCESS | 1673 | __end_tp_report 17:02:44 INFO - PROCESS | 1673 | __start_cc_report 17:02:44 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1065 17:02:44 INFO - PROCESS | 1673 | __end_cc_report 17:02:44 INFO - PROCESS | 1673 | __startTimestamp1462492964060__endTimestamp 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | ------- Summary: start ------- 17:02:44 INFO - PROCESS | 1673 | Number of tests: 14 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.50 stddev:3.83 (3.3%) stddev-sans-first:4.06 17:02:44 INFO - PROCESS | 1673 | Values: 114.0 116.0 107.0 115.0 117.0 117.0 107.0 115.0 117.0 115.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:147.50 stddev:17.61 (11.9%) stddev-sans-first:18.24 17:02:44 INFO - PROCESS | 1673 | Values: 155.0 120.0 145.0 163.0 123.0 150.0 143.0 127.0 175.0 142.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:222.10 Median:217.00 stddev:32.52 (15.0%) stddev-sans-first:32.62 17:02:44 INFO - PROCESS | 1673 | Values: 192.0 199.0 201.0 222.0 257.0 266.0 278.0 212.0 197.0 197.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:80.40 Median:61.50 stddev:30.34 (49.3%) stddev-sans-first:32.03 17:02:44 INFO - PROCESS | 1673 | Values: 72.0 84.0 76.0 141.0 59.0 58.0 62.0 61.0 130.0 61.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:106.40 Median:81.50 stddev:25.59 (31.4%) stddev-sans-first:25.82 17:02:44 INFO - PROCESS | 1673 | Values: 84.0 95.0 135.0 81.0 83.0 82.0 129.0 114.0 109.0 152.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:87.50 stddev:14.18 (16.2%) stddev-sans-first:15.02 17:02:44 INFO - PROCESS | 1673 | Values: 100.0 113.0 89.0 101.0 123.0 87.0 92.0 88.0 97.0 125.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:109.80 Median:96.00 stddev:21.79 (22.7%) stddev-sans-first:17.90 17:02:44 INFO - PROCESS | 1673 | Values: 149.0 97.0 125.0 146.0 96.0 96.0 96.0 96.0 96.0 101.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:91.00 stddev:22.47 (24.7%) stddev-sans-first:22.96 17:02:44 INFO - PROCESS | 1673 | Values: 91.0 93.0 91.0 90.0 93.0 128.0 91.0 143.0 142.0 119.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:62.50 stddev:4.46 (7.1%) stddev-sans-first:4.68 17:02:44 INFO - PROCESS | 1673 | Values: 61.0 63.0 62.0 62.0 63.0 61.0 60.0 75.0 63.0 59.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:80.10 Median:76.00 stddev:13.44 (17.7%) stddev-sans-first:13.64 17:02:44 INFO - PROCESS | 1673 | Values: 69.0 68.0 76.0 71.0 76.0 102.0 63.0 87.0 93.0 96.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:87.50 stddev:7.07 (8.1%) stddev-sans-first:7.21 17:02:44 INFO - PROCESS | 1673 | Values: 97.0 102.0 91.0 89.0 87.0 86.0 85.0 85.0 104.0 88.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:152.00 stddev:16.28 (10.7%) stddev-sans-first:17.09 17:02:44 INFO - PROCESS | 1673 | Values: 160.0 151.0 140.0 141.0 166.0 146.0 153.0 137.0 192.0 148.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.90 Median:170.50 stddev:22.98 (13.5%) stddev-sans-first:23.22 17:02:44 INFO - PROCESS | 1673 | Values: 162.0 168.0 171.0 167.0 169.0 168.0 170.0 207.0 221.0 216.0 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.29 (1.9%) stddev-sans-first:1.30 17:02:44 INFO - PROCESS | 1673 | Values: 66.0 69.0 66.0 68.0 66.0 67.0 68.0 69.0 66.0 66.0 17:02:44 INFO - PROCESS | 1673 | -------- Summary: end -------- 17:02:44 INFO - PROCESS | 1673 | 17:02:44 INFO - TEST-INFO | 1673: exit 0 17:02:44 INFO - TEST-OK | kraken | took 60507ms 17:02:44 INFO - SUITE-END | took 1173s 17:02:45 INFO - Completed test suite (00:19:33) 17:02:45 INFO - javascript benchmark 17:02:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3538.8407521661525, 3553.484744712015, 3560.3947328954077, 3569.303985722785, 3592.784432934024, 5239.738013099349, 5449.891002179959, 5863.530917526598, 5994.16081748555, 5999.580029397944, 5896.439838215363, 6014.368491308415, 6036.15493830864, 6037.486813620848, 6086.178365920599, 4620.191466493367, 5280.947190528103, 5354.651947623392, 5446.591505637093, 5455.372632147294, 4734.810607575693, 5393.81121660742, 5526.778928842861, 5539.833804985837, 5574.888502229973, 4216.777134630954, 4884.5603895649565, 5304.496072873071, 5389.78440862365, 5421.593380496479, 5358.062339090682, 5371.006363822706, 5371.301730775013, 5381.354237491487, 5389.649672771257, 4750.836045168921, 5225.759804532656, 5299.814506492293, 5394.32570928634, 5455.618106732491, 5871.882562348772, 5919.112133180014, 5967.104934259853, 5987.940120598825, 5995.0, 6253.093301471306, 6298.968505157491, 6342.587731797418, 6353.714082866282, 6373.426391624776, 6192.504599632019, 6437.678116094176, 6441.420272175526, 6454.290028096905, 6469.514786390992, 6046.062860256668, 6095.19653686519, 6127.785527506516, 6146.354632763585, 6151.846203844851, 6556.770513032021, 6587.143671322698, 6589.80230593083, 6601.141851559362, 6602.339766023455, 6147.784827531015, 6162.291336496361, 6238.906416403757, 6256.812295631138, 6257.749690012349, 6144.648177400964, 6286.528510361742, 6295.496360291166, 6300.653464059521, 6303.432691057827, 6133.693315334215, 6160.10678451622, 6188.752449902044, 6217.347178546278, 6233.75064997395, 6112.564273424362, 6196.0, 6233.158523599347, 6327.873442531216, 6339.270983836917, 5067.265246539231, 5106.897862042739, 5113.974430127825, 5120.436751957282, 5145.382554093533, 4492.932606010912, 4528.637708983273, 4553.658475614342, 4561.1333846569705, 4587.770611469413, 6001.039833626686, 6072.817815465543, 6098.085287206865, 6110.938890611037, 6144.17053697754, 6469.77355792545, 6477.093206951031, 6481.837954051092, 6491.383318584727, 6553.442957348679, 6120.449159575571, 6134.294556126102, 6143.600665956698, 6160.753569857246, 6166.784162554379, 5144.048351055067, 5247.134222853263, 5464.426235245242, 5587.189857470644, 5621.381648018714, 6614.86770264592, 6649.867002660017, 6655.567388119756, 6678.365555272241, 6680.198376194888, 5562.694051827189, 6418.518611104279, 6449.4517965971545, 6461.773837915651, 6477.740890364333, 6362.363763623601, 6502.284748677736, 6528.771492997722, 6577.769778057745, 6608.900866486911, 6238.376162383725, 6245.8750824982335, 6248.218972628421, 6255.53083518747, 6270.0, 5620.0, 5842.948269311395, 5873.882522349443, 6396.648184349905, 6416.101745755691, 6145.7708458307625, 6146.569740118328, 6162.767446510806, 6169.722362493609, 6171.352008039091, 5036.06832735945, 5448.264484294569, 5579.023670857665, 6054.878902421839, 6230.657313847782, 6065.848353791191, 6102.420270074336, 6154.876902462015, 6196.628202307876, 6229.4393504582995, 6095.6499315652145, 6120.710695802514, 6139.032198454696, 6158.3225845157895, 6304.117423560797, 6162.168107305456, 6183.350748171557, 6193.071039344134, 6193.318734939243, 6193.628382297076], "value": 5826.564701010533, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.49337435754, 498.1332481482221, 503.944236823854, 504.3468708023114, 530.777073629076, 34724.95825125247, 40245.0, 40332.19335613286, 40342.991425214386, 40361.3945790813, 41277.96805079874, 41733.79133104338, 41750.0, 41788.95527611811, 41809.372859407056, 9490.145886870181, 9591.040895910388, 9698.757531061745, 9714.0, 9714.805703885919, 9617.374870633386, 9664.613415463373, 9726.805463890718, 9726.854097188549, 9753.853692194623, 8560.529170895597, 8778.253848422892, 9412.247020238365, 9738.853917191213, 9792.412455252708, 8562.315014798802, 9622.037796220391, 9703.078207570341, 9762.658306959222, 9785.363951343212, 9569.569369378394, 9582.377145485521, 9591.0, 9675.467849268287, 9681.983391743835, 38448.23103537942, 38475.807620962, 38582.22835543301, 38694.0, 38877.80561097205, 3134.467140586083, 3207.7754557181006, 3376.9324613507592, 3474.9826250868837, 3494.586271977759, 28021.859890700416, 28715.28211794701, 29223.0, 29422.26444338887, 29599.0, 2705.8917643294244, 2726.768224700903, 2741.369485018457, 2746.4232511172677, 2855.514562524376, 411891.0, 471006.0, 493960.0, 495225.0, 496213.0, 63354.36645633485, 63797.68101159464, 63985.680071599345, 64027.0, 64108.67945660242, 34787.13032174165, 36404.63595364012, 37274.44088338677, 38273.425898611546, 38517.61482385196, 16887.831121688872, 16999.830001700073, 17225.7416138758, 17246.310147594206, 17293.22180501855, 11215.32708037504, 12775.105742598114, 13188.934055329853, 13219.0, 13266.137701049594, 19707.704384434244, 19878.90060549717, 19905.0, 19921.402357929284, 19946.601067978558, 8140.0, 8167.264946154874, 8240.0, 8259.182979744446, 8374.162583741578, 920.2729843423754, 1043.4626167523732, 1048.7849990751877, 1081.6106201767357, 1115.6764538283808, 26074.82663280157, 29629.259268518028, 30165.09504714862, 30270.54594181045, 30339.544906826417, 935.5088578496344, 984.921206303494, 1053.7629033467563, 1127.520803658442, 1164.91263155262, 14934.0, 14990.325435355435, 15066.623334416508, 15197.996087980617, 15250.618734531725, 631178.0, 674647.0, 690081.0, 690263.0, 691078.0, 57034.14448783272, 58070.8385832281, 58080.709596452594, 58341.0, 58693.25027621878, 1392.9442822287197, 1442.7114577084415, 1487.1894817324585, 1493.320539154682, 1496.9700605987819, 27147.0, 27215.0, 28300.85849570739, 29107.7089229105, 29211.7078829209, 48337.03325933532, 48841.755791220814, 48931.75534122449, 49577.50422495729, 49893.501064990334, 567502.0, 573554.0, 574318.0, 575181.0, 578217.0, 26489.470210596064, 26864.731352686224, 26906.59640105439, 26983.730162698906, 27491.450170996068, 45423.77288113538, 45616.54383456256, 45998.77000614975, 46441.0, 46585.0, 32515.674843251265, 37979.62020379761, 37996.0, 38282.80858595689, 38355.0, 36760.978146202215, 37084.258314833016, 37224.62775372212, 37791.62208377881, 38023.0, 31889.681103188672, 36484.45273320849, 36719.449208261365, 37389.878303650934, 37733.622663773014, 32671.509927350635, 33469.66530334666, 33472.995810125736, 33588.3282334347, 33743.98768036963, 24451.633225501275, 24811.25566233016, 24988.386903424136, 25142.371440713396, 25239.11663091783], "value": 19557.526772826273, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.8487720034785, 378.6062495005195, 390.17867389145846, 395.4167602785891, 408.1917802750556, 19230.71153932692, 20349.880756558385, 21034.368968930918, 21112.944352782375, 21292.4676883078, 15937.681246375065, 20344.88103154326, 20832.68750968733, 20959.790402095976, 21146.048427820748, 4887.315775791392, 5353.223782551528, 5573.777048918038, 6094.390560943914, 6106.084087386906, 6113.449789518942, 6135.079738039308, 6166.660833654148, 6176.4749996250375, 6180.443760061594, 6073.696315184246, 6155.230596175478, 6157.076438534234, 6162.5069994400565, 6165.383461653843, 6015.0, 6048.7882924097885, 6116.847078823021, 6157.0, 6167.691615419233, 5783.0747080467345, 5909.6158749681135, 5925.703714814285, 5950.404959504058, 5953.464188223081, 13737.725245495034, 17001.489955301236, 18643.627127457512, 25775.48449031009, 25804.74195258042, 2081.843861710378, 2354.835161538693, 2377.5720370333333, 2472.8269021168526, 2501.961685900349, 9890.9505452473, 10377.0, 10649.041586257197, 11388.430578471043, 15243.466478673194, 1682.1421075251587, 1726.9827301726948, 1767.9823201767947, 1781.3498073203318, 1811.7554130192386, 99628.0, 102636.0, 116263.0, 119942.400287998, 129330.99999999905, 9676.758081047888, 11760.000399965927, 11906.642800715992, 12022.338771367658, 12115.39423028845, 15119.319630616648, 15138.318775655121, 15439.536813895602, 15515.612109697347, 15630.59324660786, 6762.72949082041, 6987.161540615159, 8069.475484093515, 8751.737447876447, 9020.0, 8721.825563488695, 8751.241804093062, 8756.78108047304, 8833.469991800384, 8872.822543549093, 4685.742284174403, 4736.8578942631775, 4764.8332308369045, 4827.106985207748, 4845.466998630148, 1678.7565802958502, 1758.2351677020538, 2003.8697484663742, 2015.8891260980786, 2036.256766280297, 881.66496731243, 883.4964070479894, 912.7535565397305, 967.617790972576, 978.6721448314752, 19952.0, 20681.862497562477, 20699.06854191565, 20916.163353465996, 21150.0, 830.8000039608977, 951.286535098676, 975.0667190148029, 1018.6943916824923, 1032.8605638238892, 10892.61875834342, 11172.44137793107, 11178.888211117785, 11181.776364472666, 11210.495527701272, 475313.0, 478619.0, 482263.0, 596074.0, 597142.0, 135999.0, 138380.0, 138944.3181534319, 141072.2946385282, 142373.57626423604, 982.2240430060315, 1000.5247507433911, 1022.8977102289712, 1033.0495943731635, 1051.4322265976286, 18503.907480462512, 18584.628307433504, 18612.813871861108, 18733.71899421537, 19116.713249300992, 38122.809385952896, 39545.80227098846, 51440.0, 51479.74260128675, 51991.0, 62960.0, 63054.68472657607, 77406.0, 77799.05502362487, 77912.0, 8147.266745992889, 8320.417570769989, 8404.53775042354, 8619.482831030158, 8756.168164024408, 11223.60717374888, 12962.935185324013, 13176.736465270833, 13327.200367977952, 13393.531226407029, 10814.513346899252, 11222.326660400402, 11352.318860868374, 11628.592999244986, 11730.70673233176, 10915.890841091805, 11149.219554631098, 11326.943365283121, 11451.969322760991, 11499.482523286639, 11498.597549085742, 11542.884571154182, 11686.24039437434, 11736.0, 11910.344931028876, 8284.627191776264, 8341.541215232977, 8411.285040771603, 8557.871631925402, 8762.824743504967, 8201.507909525448, 10220.744481388025, 11369.943150284196, 11742.060635148997, 11788.174827761974], "value": 9571.407578892125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1566.2247187642115, 1566.4125952767713, 1821.3261093395445, 1909.999999999999, 1930.459471348023, 7902.96048519758, 8325.625346859391, 8528.829423411527, 9045.683401080963, 9068.365214434993, 8407.957960210191, 8557.187067228604, 8567.971843378804, 8644.0, 8717.389782715212, 2457.4102215468247, 2485.092941076503, 2486.7388924162883, 2495.625656151574, 2507.4358269389422, 2446.8287219894614, 2487.2786891801356, 2492.2274095030507, 2504.949901001979, 2507.8119141064403, 2469.2221950085755, 2474.6782918220606, 2484.8012159027326, 2508.2600632813273, 2521.0168034466574, 2449.497852940143, 2455.70531536215, 2464.605663093905, 2470.0984140788664, 2475.344033831036, 2436.902523899042, 2441.292025312657, 2449.375409270642, 2458.201084647497, 2464.8028157747335, 8707.172818582225, 8718.21536061751, 8728.214460698568, 8743.606537705818, 8786.253168480687, 5414.40441551429, 5414.729263536808, 5444.047291723932, 5473.452654734535, 5519.006578815812, 3638.5088013118157, 3650.7261955353456, 3653.6529029742132, 3723.478712980185, 3729.8321575528894, 1037.2635428845529, 1058.2380685906135, 1058.3120971368594, 1061.8407238914224, 1064.9467526623716, 11353.262037967506, 11408.258463199949, 11437.256578322382, 11616.709582260342, 11636.650900472914, 4837.105135549935, 4854.271859221145, 4976.5023497649945, 4979.427365852974, 4991.875203119951, 9904.10863022317, 9932.354396964174, 9992.500374981368, 9997.000299969945, 10036.899631003742, 4310.31035034393, 5269.077911365573, 5434.3207099112615, 5434.347878254634, 5451.972740136274, 4452.154090722753, 4798.5441383068555, 4927.90144197114, 4954.925676114861, 4958.404991401055, 3876.8836934891997, 3946.408038794204, 3966.960330396717, 4016.477857878457, 4043.8584649537124, 1361.8229630148016, 1382.2535830651536, 1389.7359501694848, 1393.6933874547583, 1402.3759427054863, 741.2513361504919, 857.1514200941024, 932.6819050818234, 951.3578334624101, 975.7511834482161, 5616.9157462638095, 5836.328822185418, 5996.820095397145, 6004.099385092271, 6014.48876845473, 430.5027693014573, 460.18776858844166, 467.7754677754697, 472.9739864307496, 478.19424270104986, 3544.592371877267, 3926.018495376156, 4027.6576490998596, 4028.073543085048, 4060.675145988314, 9992.557777122924, 10521.631742888962, 10595.15238780911, 10659.0, 10721.410322432184, 10417.427041512638, 10458.424786636655, 10487.265891387682, 10524.00021997909, 10723.731906702238, 8060.717874874468, 8084.353251739847, 8157.388195885333, 8174.978127734153, 8239.217274358927, 5792.304923409218, 5801.129830525455, 5866.2960444745195, 5879.676617786063, 5900.350961394329, 9701.466419347003, 9953.502324883582, 9958.900410996088, 9986.900130998598, 10031.097201251923, 9451.243900488082, 9957.651482198089, 10084.092431681183, 10121.69634910954, 10234.437105958947, 6839.350261725128, 7251.746188883364, 7379.704811807467, 7504.362129219077, 7535.849283014419, 8348.37387195975, 8376.455530390505, 8419.536925469158, 8433.114522975246, 8449.197326253996, 7154.928450715426, 7280.817979550554, 7463.179050304354, 7565.130010048915, 7608.353289970414, 6455.160829092188, 7244.855102898018, 7376.7049318026675, 7391.0, 7413.66638501258, 6919.204291506541, 6924.584524928319, 6973.75591854303, 6976.372126508639, 7001.229864714979, 4827.589654879374, 4890.731009794496, 4906.067847109038, 4973.875653108701, 5095.592352611856, 4934.55588996992, 4959.826406075915, 4997.3253610762085, 5078.111330517218, 5246.186841039645], "value": 4549.460180177136, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.84607696151926, 315.78526601910704, 322.12864202332685, 325.3395606917957, 328.94736842105254, 4381.518033016369, 4579.5195651305, 4946.579540739037, 4958.528939750722, 5360.571154307656, 4590.678652494318, 4951.55436010759, 5411.972940135303, 5481.643693159942, 5482.342118945732, 3697.85208591656, 4138.6482149017365, 4160.271952408317, 4161.542230354658, 4165.187788381267, 3840.9039774005732, 4129.483814523184, 4129.979350103245, 4167.812448439812, 4175.31107367284, 4064.471618689566, 4093.1199792044704, 4099.385092236159, 4123.855665051724, 4140.7515549067, 3320.9870989348237, 4110.630043296088, 4112.465379500661, 4135.29699951009, 4146.212219678251, 3177.7616678748955, 3429.6741809528053, 3442.242706604543, 3558.5018097466377, 3597.442396428558, 4441.933370999405, 4481.969147096186, 4910.337104490884, 5150.665206761549, 5299.867503312448, 4467.709598876063, 4719.150552900476, 4723.197056500403, 4728.6453515986095, 4739.597134243593, 5337.386200586943, 5657.603967722261, 5723.08430651098, 5768.798092066758, 5782.884342313172, 3768.152165762709, 3907.902302442462, 3921.784301863396, 3939.7833119178435, 3941.5664276929515, 6076.301225359096, 6095.756169753205, 6102.847428814315, 6157.599756015845, 6174.314173334614, 3577.3024260269517, 3665.3139555804096, 3870.767753934773, 3989.7007724420782, 3989.9601003989587, 3208.53476245943, 3824.655780979725, 3903.6877049835944, 4048.7975601219823, 4064.5732198119363, 4695.506971767915, 4720.33915251865, 4732.763361831963, 4744.786484608201, 4747.0, 4762.976185119052, 4850.805967761321, 5223.4776522347465, 5463.6614029562215, 5937.881242375215, 1129.5143088472037, 1192.4753108632347, 1317.7298653775954, 1319.287584704268, 1321.3327269728725, 834.0, 858.978525536854, 880.9163129502687, 894.1684233662626, 898.4519443139679, 4509.301058335963, 4558.612517935946, 4740.293494342034, 5167.6641018333685, 5176.204849381292, 4974.0051989602225, 5418.4039755626845, 5435.374931882805, 5443.265159203457, 5748.626339287933, 4619.0, 4631.892488917534, 4784.4497882743235, 5108.489151084862, 5136.178211486144, 2865.2550336912554, 2991.8354490502797, 2993.431248062861, 2993.521036634128, 3006.9398612027635, 5174.508421699932, 5289.444608316148, 5465.535429488538, 5529.811090615537, 5793.741599924052, 5046.34397528319, 5417.941182350761, 5472.099787112837, 5501.4223506532035, 5931.851703707442, 5616.634918730269, 5690.833379157263, 6015.608985416022, 6024.2469691287715, 6046.7581296749395, 5130.0, 5195.623159862564, 5382.596305277199, 5802.535797136304, 5807.448292412214, 4855.951440485691, 5087.109755792795, 5539.41836107219, 5690.231818704588, 5729.710815066744, 5876.324222714272, 5914.585978981602, 5995.070764031582, 6026.276846778414, 6080.969595151996, 3847.8076096195637, 3889.902752431212, 3904.570497245244, 3921.568627450921, 3954.980225098856, 4970.652054356305, 5702.116171993348, 5817.243758311392, 5902.671898822902, 5905.616134951214, 4701.8480472283145, 4844.297576851266, 5700.686462244616, 5729.023486897014, 5735.050082971809, 4898.436679781728, 5279.947200527946, 5719.370869204467, 5726.680694318808, 5759.222504961776, 4735.910740529628, 5506.476884695948, 5520.91718624229, 5532.06377767778, 5590.748416321194, 5473.014857325719, 5517.751701173537, 5715.685637289823, 5731.713414329183, 5742.540596752333, 4923.242983929012, 5184.507471790174, 5559.0, 5664.638228564065, 5669.433056694297], "value": 4096.845724458971, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.8150790040638, 725.1551941987585, 748.1732685382652, 759.2217976574011, 767.5279702982664, 14730.779038314435, 15128.848711512881, 15175.848241517582, 15327.0, 15370.385184592631, 14077.718445631106, 14166.291685415714, 14668.926655366708, 14905.32926018329, 15316.234188290597, 618.452669387593, 893.714011516315, 897.1387468030682, 901.4681338010572, 903.0653273861554, 869.9391042627019, 889.0842432294746, 898.5462341517557, 899.2042042792143, 901.3465237702646, 918.8437965545874, 927.6892241099206, 939.7556635274843, 947.8625599288099, 950.4867371619317, 928.0487500312166, 937.5499760115115, 939.5631031570318, 940.7601061729215, 942.3874481586955, 691.9135108111486, 693.4383149648801, 695.4054283587561, 697.1773307497151, 697.1842943755768, 14672.339744711513, 14687.412503499847, 15060.32228549707, 15061.096334219981, 15096.622584435367, 12239.632811015685, 12278.201916875374, 12314.322712250823, 12431.875681243162, 12683.619491415273, 9971.451570163637, 9975.401475911469, 10025.799484010351, 10175.84736228957, 10692.839607405895, 3452.602950660681, 3457.2739724657854, 3468.8612455501748, 3503.8948831535095, 3529.9647003529894, 77797.44405111922, 78215.6089219556, 79392.60303698502, 79777.20222797756, 80483.0, 9239.39943903644, 9323.673671421468, 9324.681806838033, 9372.578233979488, 9532.52337383142, 20945.37163885086, 21136.894315528323, 21142.47143821417, 21206.893965530075, 21231.575368492544, 7133.750318738819, 7352.70589176427, 7473.439492038119, 7498.32515073646, 7528.887066694004, 4023.0344717267644, 4136.482939632546, 4137.77242251679, 4139.275626765304, 4147.709660323809, 3535.5227044348685, 3639.2175682227917, 3644.9817750911607, 3653.1415117447377, 3654.0499470137956, 634.0900807341479, 655.2104713819836, 659.1102012283379, 659.7629444791016, 660.0956689335641, 524.44408926538, 558.2937583956299, 559.4004019762209, 595.8748662780778, 608.3794529579803, 6004.969975150097, 7074.469414793808, 8050.5169689818795, 8103.351731861437, 8222.753317400488, 465.95340465953814, 518.5669965578784, 530.821576101055, 556.274062348639, 575.0195915963272, 3320.3027364253776, 3834.2331533693373, 3835.53973523179, 3939.330313846653, 4007.73949693269, 84759.0, 87002.0, 87923.0, 88208.55895720609, 89098.0, 60151.39848601545, 61555.38444615586, 73311.26688733151, 73945.0, 75534.48931021459, 70016.59966800737, 70269.64865175642, 70285.0, 71014.28985710077, 71554.28445715476, 7673.769786906401, 7705.576193309422, 7816.648250828613, 7886.881696774668, 7902.130765615892, 44280.335794962455, 44562.77718611386, 44677.0, 44819.77590112029, 44965.32552011657, 61368.0, 62048.0, 62091.0, 62571.374286258375, 62744.0, 9869.0, 10048.49757512136, 10078.294519383573, 10194.74513137148, 10264.178865690577, 10712.464376781285, 11098.445077746243, 11124.721881953015, 11149.72125696864, 11439.370834604177, 10609.734756631146, 10625.787484250426, 10668.786624267315, 10751.90701053395, 10775.94612026935, 10489.370637761758, 10683.5192416343, 10811.6215932442, 10958.123350131811, 11302.0, 10003.749906252402, 10028.398296102258, 10336.0, 10661.360318380923, 11210.607628732956, 8757.781055473664, 8895.911040889509, 8925.241354484682, 9081.45511269326, 9174.862377064483, 7763.456558040883, 8772.649094036422, 8801.91198088011, 8856.64573417082, 8969.416987895765], "value": 6669.173701414886, "unit": "score"}], "name": "dromaeo_css", "value": 7167.5625955098, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 107.0, 115.0, 117.0, 117.0, 107.0, 115.0, 117.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 145.0, 163.0, 123.0, 150.0, 143.0, 127.0, 175.0, 142.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 201.0, 222.0, 257.0, 266.0, 278.0, 212.0, 197.0, 197.0], "value": 222.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 84.0, 76.0, 141.0, 59.0, 58.0, 62.0, 61.0, 130.0, 61.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 95.0, 135.0, 81.0, 83.0, 82.0, 129.0, 114.0, 109.0, 152.0], "value": 106.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 113.0, 89.0, 101.0, 123.0, 87.0, 92.0, 88.0, 97.0, 125.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 97.0, 125.0, 146.0, 96.0, 96.0, 96.0, 96.0, 96.0, 101.0], "value": 109.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 91.0, 90.0, 93.0, 128.0, 91.0, 143.0, 142.0, 119.0], "value": 108.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 62.0, 63.0, 61.0, 60.0, 75.0, 63.0, 59.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 76.0, 71.0, 76.0, 102.0, 63.0, 87.0, 93.0, 96.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 102.0, 91.0, 89.0, 87.0, 86.0, 85.0, 85.0, 104.0, 88.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 151.0, 140.0, 141.0, 166.0, 146.0, 153.0, 137.0, 192.0, 148.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 168.0, 171.0, 167.0, 169.0, 168.0, 170.0, 207.0, 221.0, 216.0], "value": 181.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 68.0, 66.0, 67.0, 68.0, 69.0, 66.0, 66.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1623.4, "alertThreshold": 2.0}]} 17:02:45 INFO - Return code: 0 17:02:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:02:45 ERROR - # TBPL SUCCESS # 17:02:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:02:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:02:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:02:45 INFO - 2016-05-05 17:02:45.380 screenresolution[1678:10296] starting screenresolution argv=screenresolution get 17:02:45 INFO - 2016-05-05 17:02:45.383 screenresolution[1678:10296] Display 0: 1600x1200x32@60 17:02:45 INFO - 2016-05-05 17:02:45.389 screenresolution[1679:10299] starting screenresolution argv=screenresolution list 17:02:45 INFO - Available Modes on Display 0 17:02:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:02:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:02:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:02:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:02:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:02:45 INFO - Intel Iris: 17:02:45 INFO - Chipset Model: Intel Iris 17:02:45 INFO - Type: GPU 17:02:45 INFO - Bus: Built-In 17:02:45 INFO - VRAM (Dynamic, Max): 1536 MB 17:02:45 INFO - Vendor: Intel (0x8086) 17:02:45 INFO - Device ID: 0x0a2e 17:02:45 INFO - Revision ID: 0x0009 17:02:45 INFO - Displays: 17:02:45 INFO - Display: 17:02:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:02:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:02:45 INFO - Display Serial Number: 1600x1200 60 17:02:45 INFO - Main Display: Yes 17:02:45 INFO - Mirror: Off 17:02:45 INFO - Online: Yes 17:02:45 INFO - Rotation: Supported 17:02:45 INFO - Return code: 0 17:02:45 INFO - Running post-action listener: _resource_record_post_action 17:02:45 INFO - Running post-run listener: _resource_record_post_run 17:02:46 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 37492224; Write bytes: 696384512; Read time: 390; Write time: 2035 17:02:46 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 392653312; Write bytes: 386504704; Read time: 29877; Write time: 842 17:02:46 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 35669504; Write bytes: 296702976; Read time: 371; Write time: 1161 17:02:46 INFO - Running post-run listener: _upload_blobber_files 17:02:46 INFO - Blob upload gear active. 17:02:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:02:46 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 17:02:46 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'] 17:02:46 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 17:02:47 INFO - (blobuploader) - INFO - Open directory for files ... 17:02:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:02:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:02:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:48 INFO - (blobuploader) - INFO - Done attempting. 17:02:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:02:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:02:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:02:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:02:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:02:49 INFO - (blobuploader) - INFO - Done attempting. 17:02:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:02:49 INFO - Return code: 0 17:02:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:02:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:02:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec6a0c0d3f2bc0c45926aa541f0c242f74b73fb95fabe187950fbe7cde5058f367c379efa298b98195216180e44f1489a56c972d8596ae036bb3f70b6dc74f62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b8d1bb95a0e4961f3fda00695f2453bad83dd180cbc9e7f3dcf5821f16bd1900dde4668ef0281d242fea1b09ed18b23eae7dd5e1b8306f05fea4c46e0140958"} 17:02:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:02:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:02:49 INFO - Contents: 17:02:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec6a0c0d3f2bc0c45926aa541f0c242f74b73fb95fabe187950fbe7cde5058f367c379efa298b98195216180e44f1489a56c972d8596ae036bb3f70b6dc74f62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b8d1bb95a0e4961f3fda00695f2453bad83dd180cbc9e7f3dcf5821f16bd1900dde4668ef0281d242fea1b09ed18b23eae7dd5e1b8306f05fea4c46e0140958"} 17:02:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:02:49 INFO - Copying logs to upload dir... 17:02:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:02:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.707409 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-05-05 17:02:49.323307) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 17:02:49.327102) ========= 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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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/ec6a0c0d3f2bc0c45926aa541f0c242f74b73fb95fabe187950fbe7cde5058f367c379efa298b98195216180e44f1489a56c972d8596ae036bb3f70b6dc74f62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b8d1bb95a0e4961f3fda00695f2453bad83dd180cbc9e7f3dcf5821f16bd1900dde4668ef0281d242fea1b09ed18b23eae7dd5e1b8306f05fea4c46e0140958"} build_url:https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/S5eUP-mdSEGheeqAfWlB3A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec6a0c0d3f2bc0c45926aa541f0c242f74b73fb95fabe187950fbe7cde5058f367c379efa298b98195216180e44f1489a56c972d8596ae036bb3f70b6dc74f62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9b8d1bb95a0e4961f3fda00695f2453bad83dd180cbc9e7f3dcf5821f16bd1900dde4668ef0281d242fea1b09ed18b23eae7dd5e1b8306f05fea4c46e0140958"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-05 17:02:49.364806) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:02:49.365133) ========= 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.cmhpYz3T2w/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.TjOtXMYPHy/Listeners TMPDIR=/var/folders/pk/x1kn_b9j39qdgrwqw737_qrh00000w/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.005122 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-05 17:02:49.415560) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 17:02:49.415947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-05 17:02:49.416352) ========= ========= Total master_lag: 0.26 =========