builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0116 starttime: 1461942798.44 results: success (0) buildid: 20160429061745 builduid: f048a527190b43d78f6b5784399857a0 revision: 3b652d51edf728e672db99d59525f15fc93c4dc4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:18.442949) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:18.443427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:18.443741) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:18.558209) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:18.558508) ========= 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.2JYD0DgPab/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.87DWKdwGM2/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-29 08:13:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-04-29 08:13:19 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.491044 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:19.085655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:19.086082) ========= 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.2JYD0DgPab/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.87DWKdwGM2/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.027677 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:19.136125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:19.136934) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3b652d51edf728e672db99d59525f15fc93c4dc4 --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 3b652d51edf728e672db99d59525f15fc93c4dc4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2JYD0DgPab/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.87DWKdwGM2/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-29 08:13:19,211 truncating revision to first 12 chars 2016-04-29 08:13:19,211 Setting DEBUG logging. 2016-04-29 08:13:19,211 attempt 1/10 2016-04-29 08:13:19,211 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3b652d51edf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-29 08:13:19,944 unpacking tar archive at: fx-team-3b652d51edf7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.979219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:20.133488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:20.133798) ========= script_repo_revision: 3b652d51edf728e672db99d59525f15fc93c4dc4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:20.134288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:20.134615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-29 08:13:20.149856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-04-29 08:13:20.150197) ========= /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.2JYD0DgPab/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.87DWKdwGM2/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:13:20 INFO - MultiFileLogger online at 20160429 08:13:20 in /builds/slave/test 08:13:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:13:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:13:20 INFO - {'append_to_log': False, 08:13:20 INFO - 'base_work_dir': '/builds/slave/test', 08:13:20 INFO - 'blob_upload_branch': 'Fx-Team', 08:13:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:13:20 INFO - 'branch': 'Fx-Team', 08:13:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:13:20 INFO - 'config_files': ('talos/mac_config.py',), 08:13:20 INFO - 'default_actions': ('clobber', 08:13:20 INFO - 'read-buildbot-config', 08:13:20 INFO - 'download-and-extract', 08:13:20 INFO - 'populate-webroot', 08:13:20 INFO - 'create-virtualenv', 08:13:20 INFO - 'install', 08:13:20 INFO - 'run-tests'), 08:13:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:13:20 INFO - 'download_minidump_stackwalk': True, 08:13:20 INFO - 'download_symbols': 'ondemand', 08:13:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:13:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:13:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:13:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:13:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:13:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:13:20 INFO - 'installer_path': 'installer.exe', 08:13:20 INFO - 'log_level': 'info', 08:13:20 INFO - 'log_name': 'talos', 08:13:20 INFO - 'log_to_console': True, 08:13:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:13:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:13:20 INFO - 'opt_config_files': (), 08:13:20 INFO - 'pip_index': False, 08:13:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:20 INFO - 'cmd': ('bash', 08:13:20 INFO - '-c', 08:13:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:20 INFO - 'enabled': True, 08:13:20 INFO - 'halt_on_failure': False, 08:13:20 INFO - 'name': 'check_screen_resolution'},), 08:13:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:13:20 INFO - 'cmd': ('bash', 08:13:20 INFO - '-c', 08:13:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:13:20 INFO - 'enabled': True, 08:13:20 INFO - 'halt_on_failure': False, 08:13:20 INFO - 'name': 'check_screen_resolution'},), 08:13:20 INFO - 'run_cmd_checks_enabled': True, 08:13:20 INFO - 'sps_profile': False, 08:13:20 INFO - 'sps_profile_interval': 0, 08:13:20 INFO - 'suite': 'dromaeojs-e10s', 08:13:20 INFO - 'system_bits': '32', 08:13:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:13:20 INFO - 'title': 't-yosemite-r7-0116', 08:13:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:13:20 INFO - 'use_talos_json': True, 08:13:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:13:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:13:20 INFO - 'work_dir': 'build'} 08:13:20 INFO - ##### 08:13:20 INFO - ##### Running clobber step. 08:13:20 INFO - ##### 08:13:20 INFO - Running pre-action listener: _resource_record_pre_action 08:13:20 INFO - Running main action method: clobber 08:13:20 INFO - rmtree: /builds/slave/test/build 08:13:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:13:22 INFO - Running post-action listener: _resource_record_post_action 08:13:22 INFO - ##### 08:13:22 INFO - ##### Running read-buildbot-config step. 08:13:22 INFO - ##### 08:13:22 INFO - Running pre-action listener: _resource_record_pre_action 08:13:22 INFO - Running main action method: read_buildbot_config 08:13:22 INFO - Using buildbot properties: 08:13:22 INFO - { 08:13:22 INFO - "project": "", 08:13:22 INFO - "product": "firefox", 08:13:22 INFO - "script_repo_revision": "production", 08:13:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:13:22 INFO - "repository": "", 08:13:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:13:22 INFO - "buildid": "20160429061745", 08:13:22 INFO - "pgo_build": "False", 08:13:22 INFO - "basedir": "/builds/slave/test", 08:13:22 INFO - "buildnumber": 657, 08:13:22 INFO - "slavename": "t-yosemite-r7-0116", 08:13:22 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 08:13:22 INFO - "platform": "yosemite_r7", 08:13:22 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 08:13:22 INFO - "branch": "fx-team", 08:13:22 INFO - "repo_path": "integration/fx-team", 08:13:22 INFO - "revision": "3b652d51edf728e672db99d59525f15fc93c4dc4", 08:13:22 INFO - "stage_platform": "macosx64", 08:13:22 INFO - "builduid": "f048a527190b43d78f6b5784399857a0", 08:13:22 INFO - "slavebuilddir": "test" 08:13:22 INFO - } 08:13:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 08:13:22 INFO - Running post-action listener: _resource_record_post_action 08:13:22 INFO - ##### 08:13:22 INFO - ##### Running download-and-extract step. 08:13:22 INFO - ##### 08:13:22 INFO - Running pre-action listener: _resource_record_pre_action 08:13:22 INFO - Running main action method: download_and_extract 08:13:22 INFO - mkdir: /builds/slave/test/build/tests 08:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:22 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:13:26 INFO - Downloaded 1199 bytes. 08:13:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 08:13:26 INFO - Using the following test package requirements: 08:13:26 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:13:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 08:13:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 08:13:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'jsshell-mac.zip'], 08:13:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 08:13:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 08:13:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 08:13:26 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 08:13:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 08:13:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 08:13:26 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 08:13:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:13:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:26 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:13:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:13:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:13:32 INFO - Downloaded 18124291 bytes. 08:13:32 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'] 08:13:32 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 08:13:35 INFO - Return code: 0 08:13:35 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 08:13:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:13:35 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 08:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:14:05 INFO - Downloaded 18124291 bytes. 08:14:05 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'] 08:14:05 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 08:14:09 INFO - Return code: 0 08:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:09 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:14:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:14:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 08:14:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:14:10 INFO - Downloaded 10840145 bytes. 08:14:10 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'] 08:14:10 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 08:14:10 INFO - Return code: 0 08:14: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')]} 08:14:10 INFO - https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:14:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:14:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:14:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 08:14:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NlVfCiGbQkShLL1bKfxoeA/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 08:14:15 INFO - Downloaded 110280174 bytes. 08:14:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:14:15 INFO - mkdir: /builds/slave/test/properties 08:14:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:15 INFO - Contents: 08:14:15 INFO - build_url:https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 08:14:16 INFO - Running post-action listener: _resource_record_post_action 08:14:16 INFO - Running post-action listener: set_extra_try_arguments 08:14:16 INFO - ##### 08:14:16 INFO - ##### Running populate-webroot step. 08:14:16 INFO - ##### 08:14:16 INFO - Running pre-action listener: _resource_record_pre_action 08:14:16 INFO - Running main action method: populate_webroot 08:14:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:16 INFO - '--tppagecycles', 08:14:16 INFO - '7'], 08:14:16 INFO - 'tests': ['tsvgm']}}, 08:14:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['damp', 'tps']}, 08:14:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'tests': ['damp', 'tps']}, 08:14:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['dromaeo_dom']}, 08:14:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['a11yr', 08:14:16 INFO - 'ts_paint', 08:14:16 INFO - 'tpaint', 08:14:16 INFO - 'sessionrestore', 08:14:16 INFO - 'sessionrestore_no_auto_restore', 08:14:16 INFO - 'tabpaint']}, 08:14:16 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:16 INFO - 'ts_paint', 08:14:16 INFO - 'tpaint', 08:14:16 INFO - 'sessionrestore', 08:14:16 INFO - 'sessionrestore_no_auto_restore', 08:14:16 INFO - 'tabpaint']}, 08:14:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:16 INFO - 'ts_paint', 08:14:16 INFO - 'tpaint', 08:14:16 INFO - 'sessionrestore', 08:14:16 INFO - 'sessionrestore_no_auto_restore', 08:14:16 INFO - 'tabpaint']}, 08:14:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:16 INFO - 'ts_paint', 08:14:16 INFO - 'tpaint', 08:14:16 INFO - 'sessionrestore', 08:14:16 INFO - 'sessionrestore_no_auto_restore', 08:14:16 INFO - 'tabpaint']}, 08:14:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['a11yr', 08:14:16 INFO - 'ts_paint', 08:14:16 INFO - 'tpaint', 08:14:16 INFO - 'sessionrestore', 08:14:16 INFO - 'sessionrestore_no_auto_restore', 08:14:16 INFO - 'tabpaint']}, 08:14:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['a11yr', 08:14:16 INFO - 'ts_paint', 08:14:16 INFO - 'tpaint', 08:14:16 INFO - 'sessionrestore', 08:14:16 INFO - 'sessionrestore_no_auto_restore', 08:14:16 INFO - 'tabpaint']}, 08:14:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['tsvgx', 08:14:16 INFO - 'tsvgr_opacity', 08:14:16 INFO - 'tart', 08:14:16 INFO - 'tscrollx', 08:14:16 INFO - 'cart']}, 08:14:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:16 INFO - 'tsvgr_opacity', 08:14:16 INFO - 'tart', 08:14:16 INFO - 'tscrollx', 08:14:16 INFO - 'cart']}, 08:14:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'talos_options': ['--disable-e10s'], 08:14:16 INFO - 'tests': ['tp5o']}, 08:14:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'tests': ['tp5o']}, 08:14:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'talos_options': ['--disable-e10s', 08:14:16 INFO - '--xperf_path', 08:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:16 INFO - 'tests': ['tp5n']}, 08:14:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:16 INFO - 'talos_options': ['--xperf_path', 08:14:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:16 INFO - 'tests': ['tp5n']}}, 08:14:16 INFO - 'talos.zip': {'path': '', 08:14:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:16 INFO - Running post-action listener: _resource_record_post_action 08:14:16 INFO - ##### 08:14:16 INFO - ##### Running create-virtualenv step. 08:14:16 INFO - ##### 08:14:16 INFO - Running pre-action listener: _resource_record_pre_action 08:14:16 INFO - Running main action method: create_virtualenv 08:14:16 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:14:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:16 INFO - Using real prefix '/tools/python27' 08:14:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:17 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:19 INFO - Installing pip.................done. 08:14:19 INFO - Return code: 0 08:14:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:19 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:19 INFO - 'HOME': '/Users/cltbld', 08:14:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:19 INFO - 'LOGNAME': 'cltbld', 08:14:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:19 INFO - 'MOZ_NO_REMOTE': '1', 08:14:19 INFO - 'NO_EM_RESTART': '1', 08:14:19 INFO - 'PAGER': '/bin/cat', 08:14:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:19 INFO - 'PWD': '/builds/slave/test', 08:14:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:19 INFO - 'SHELL': '/bin/bash', 08:14:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:19 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:19 INFO - 'USER': 'cltbld', 08:14:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:19 INFO - 'XPC_FLAGS': '0x0', 08:14:19 INFO - 'XPC_SERVICE_NAME': '0', 08:14:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:14:20 INFO - Cleaning up... 08:14:20 INFO - Return code: 0 08:14:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:20 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:14:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:14:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:20 INFO - 'HOME': '/Users/cltbld', 08:14:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:20 INFO - 'LOGNAME': 'cltbld', 08:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:20 INFO - 'MOZ_NO_REMOTE': '1', 08:14:20 INFO - 'NO_EM_RESTART': '1', 08:14:20 INFO - 'PAGER': '/bin/cat', 08:14:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:20 INFO - 'PWD': '/builds/slave/test', 08:14:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:20 INFO - 'SHELL': '/bin/bash', 08:14:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:20 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:20 INFO - 'USER': 'cltbld', 08:14:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:20 INFO - 'XPC_FLAGS': '0x0', 08:14:20 INFO - 'XPC_SERVICE_NAME': '0', 08:14:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:20 INFO - Downloading/unpacking psutil>=0.7.1 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:23 INFO - Installing collected packages: psutil 08:14:23 INFO - Running setup.py install for psutil 08:14:23 INFO - building 'psutil._psutil_osx' extension 08:14:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:14:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:14:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:14:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:14:24 INFO - building 'psutil._psutil_posix' extension 08:14:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:14:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:14:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:14:24 INFO - ^ 08:14:24 INFO - 1 warning generated. 08:14:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:14:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:24 INFO - Successfully installed psutil 08:14:24 INFO - Cleaning up... 08:14:24 INFO - Return code: 0 08:14:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:24 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:24 INFO - 'HOME': '/Users/cltbld', 08:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:24 INFO - 'LOGNAME': 'cltbld', 08:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:24 INFO - 'MOZ_NO_REMOTE': '1', 08:14:24 INFO - 'NO_EM_RESTART': '1', 08:14:24 INFO - 'PAGER': '/bin/cat', 08:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:24 INFO - 'PWD': '/builds/slave/test', 08:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:24 INFO - 'SHELL': '/bin/bash', 08:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:24 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:24 INFO - 'USER': 'cltbld', 08:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:24 INFO - 'XPC_FLAGS': '0x0', 08:14:24 INFO - 'XPC_SERVICE_NAME': '0', 08:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:14:27 INFO - Installing collected packages: mozsystemmonitor 08:14:27 INFO - Running setup.py install for mozsystemmonitor 08:14:27 INFO - Successfully installed mozsystemmonitor 08:14:27 INFO - Cleaning up... 08:14:28 INFO - Return code: 0 08:14:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14: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')]} 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14: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')]} 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:28 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:28 INFO - 'HOME': '/Users/cltbld', 08:14:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:28 INFO - 'LOGNAME': 'cltbld', 08:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:28 INFO - 'MOZ_NO_REMOTE': '1', 08:14:28 INFO - 'NO_EM_RESTART': '1', 08:14:28 INFO - 'PAGER': '/bin/cat', 08:14:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:28 INFO - 'PWD': '/builds/slave/test', 08:14:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:28 INFO - 'SHELL': '/bin/bash', 08:14:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:28 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:28 INFO - 'USER': 'cltbld', 08:14:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:28 INFO - 'XPC_FLAGS': '0x0', 08:14:28 INFO - 'XPC_SERVICE_NAME': '0', 08:14:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:28 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14: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 08:14:31 INFO - Downloading docopt-0.6.1.tar.gz 08:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:31 INFO - Running setup.py install for blobuploader 08:14:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:32 INFO - Running setup.py install for requests 08:14:32 INFO - Running setup.py install for docopt 08:14:32 INFO - Successfully installed blobuploader requests docopt 08:14:32 INFO - Cleaning up... 08:14:32 INFO - Return code: 0 08:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:32 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:32 INFO - 'HOME': '/Users/cltbld', 08:14:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:32 INFO - 'LOGNAME': 'cltbld', 08:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:32 INFO - 'MOZ_NO_REMOTE': '1', 08:14:32 INFO - 'NO_EM_RESTART': '1', 08:14:32 INFO - 'PAGER': '/bin/cat', 08:14:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:32 INFO - 'PWD': '/builds/slave/test', 08:14:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:32 INFO - 'SHELL': '/bin/bash', 08:14:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:32 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:32 INFO - 'USER': 'cltbld', 08:14:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:32 INFO - 'XPC_FLAGS': '0x0', 08:14:32 INFO - 'XPC_SERVICE_NAME': '0', 08:14:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-R0xQcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-78BuAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-_UcwJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OmxH97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-6hVwAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-qPKaKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-JHoCZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-VaKvyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-r12Jof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:33 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-yovl2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7bYVvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-9g8K2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OeFLsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-F2k5ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-GWFsyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-7mHgHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:34 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-nWtCZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:34 INFO - Running setup.py install for manifestparser 08:14:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:34 INFO - Running setup.py install for mozcrash 08:14:35 INFO - Running setup.py install for mozdebug 08:14:35 INFO - Running setup.py install for mozdevice 08:14:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Running setup.py install for mozfile 08:14:35 INFO - Running setup.py install for mozhttpd 08:14:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Running setup.py install for mozinfo 08:14:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Running setup.py install for mozInstall 08:14:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:35 INFO - Running setup.py install for mozleak 08:14:36 INFO - Running setup.py install for mozlog 08:14:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:36 INFO - Running setup.py install for moznetwork 08:14:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:36 INFO - Running setup.py install for mozprocess 08:14:36 INFO - Running setup.py install for mozprofile 08:14:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:36 INFO - Running setup.py install for mozrunner 08:14:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:36 INFO - Running setup.py install for mozscreenshot 08:14:37 INFO - Running setup.py install for moztest 08:14:37 INFO - Running setup.py install for mozversion 08:14:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:37 INFO - Cleaning up... 08:14:37 INFO - Return code: 0 08:14:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:37 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:37 INFO - 'HOME': '/Users/cltbld', 08:14:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:37 INFO - 'LOGNAME': 'cltbld', 08:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:37 INFO - 'MOZ_NO_REMOTE': '1', 08:14:37 INFO - 'NO_EM_RESTART': '1', 08:14:37 INFO - 'PAGER': '/bin/cat', 08:14:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:37 INFO - 'PWD': '/builds/slave/test', 08:14:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:37 INFO - 'SHELL': '/bin/bash', 08:14:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:37 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:37 INFO - 'USER': 'cltbld', 08:14:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:37 INFO - 'XPC_FLAGS': '0x0', 08:14:37 INFO - 'XPC_SERVICE_NAME': '0', 08:14:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-g7ttKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-tDhFMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-oRF7aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:37 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-sgl7Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-yxR6xS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-bg6Mmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-qO9GfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-zyw7TM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-dwVCAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OOo2J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-OND5ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-z0JagN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-1LMJl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:38 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Lnnb1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-ou5fpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-k4Fihp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:39 INFO - Running setup.py (path:/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/pip-Boanfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:41 INFO - Downloading blessings-1.6.tar.gz 08:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:41 INFO - Installing collected packages: blessings 08:14:41 INFO - Running setup.py install for blessings 08:14:42 INFO - Successfully installed blessings 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:42 INFO - Reading from file tmpfile_stdout 08:14:42 INFO - Current package versions: 08:14:42 INFO - blessings == 1.6 08:14:42 INFO - blobuploader == 1.2.4 08:14:42 INFO - docopt == 0.6.1 08:14:42 INFO - manifestparser == 1.1 08:14:42 INFO - mozInstall == 1.12 08:14:42 INFO - mozcrash == 0.17 08:14:42 INFO - mozdebug == 0.1 08:14:42 INFO - mozdevice == 0.48 08:14:42 INFO - mozfile == 1.2 08:14:42 INFO - mozhttpd == 0.7 08:14:42 INFO - mozinfo == 0.9 08:14:42 INFO - mozleak == 0.1 08:14:42 INFO - mozlog == 3.1 08:14:42 INFO - moznetwork == 0.27 08:14:42 INFO - mozprocess == 0.22 08:14:42 INFO - mozprofile == 0.28 08:14:42 INFO - mozrunner == 6.11 08:14:42 INFO - mozscreenshot == 0.1 08:14:42 INFO - mozsystemmonitor == 0.0 08:14:42 INFO - moztest == 0.7 08:14:42 INFO - mozversion == 1.4 08:14:42 INFO - psutil == 3.1.1 08:14:42 INFO - requests == 1.2.3 08:14:42 INFO - wsgiref == 0.1.2 08:14:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:42 INFO - 'HOME': '/Users/cltbld', 08:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PAGER': '/bin/cat', 08:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:42 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - 'XPC_FLAGS': '0x0', 08:14:42 INFO - 'XPC_SERVICE_NAME': '0', 08:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:14:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:42 INFO - 'HOME': '/Users/cltbld', 08:14:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PAGER': '/bin/cat', 08:14:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:42 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - 'XPC_FLAGS': '0x0', 08:14:42 INFO - 'XPC_SERVICE_NAME': '0', 08:14:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Downloading/unpacking jsonschema 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:45 INFO - Downloading/unpacking functools32 (from jsonschema) 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:45 INFO - warning: no files found matching '*.txt' 08:14:45 INFO - no previously-included directories found matching 'build' 08:14:45 INFO - no previously-included directories found matching 'dist' 08:14:45 INFO - no previously-included directories found matching '.git*' 08:14:45 INFO - Installing collected packages: jsonschema, functools32 08:14:45 INFO - Running setup.py install for functools32 08:14:46 INFO - warning: no files found matching '*.txt' 08:14:46 INFO - no previously-included directories found matching 'build' 08:14:46 INFO - no previously-included directories found matching 'dist' 08:14:46 INFO - no previously-included directories found matching '.git*' 08:14:46 INFO - Successfully installed jsonschema functools32 08:14:46 INFO - Cleaning up... 08:14:46 INFO - Return code: 0 08:14:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105cb0420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd94bc97db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, '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.2JYD0DgPab/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.87DWKdwGM2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:14:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:14:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:14:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:14:46 INFO - 'HOME': '/Users/cltbld', 08:14:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:14:46 INFO - 'LOGNAME': 'cltbld', 08:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:46 INFO - 'MOZ_NO_REMOTE': '1', 08:14:46 INFO - 'NO_EM_RESTART': '1', 08:14:46 INFO - 'PAGER': '/bin/cat', 08:14:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:46 INFO - 'PWD': '/builds/slave/test', 08:14:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:14:46 INFO - 'SHELL': '/bin/bash', 08:14:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:14:46 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:14:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:14:46 INFO - 'USER': 'cltbld', 08:14:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:14:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:46 INFO - 'XPC_FLAGS': '0x0', 08:14:46 INFO - 'XPC_SERVICE_NAME': '0', 08:14:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:46 INFO - Downloading/unpacking flake8 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:14:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:14:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:50 INFO - no previously-included directories found matching 'docs/_build' 08:14:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:14:50 INFO - Running setup.py install for pep8 08:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:14:50 INFO - no previously-included directories found matching 'docs/_build' 08:14:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:14:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:14:50 INFO - Cleaning up... 08:14:50 INFO - Return code: 0 08:14:50 INFO - Running post-action listener: _resource_record_post_action 08:14:50 INFO - Running post-action listener: _start_resource_monitoring 08:14:50 INFO - Starting resource monitoring. 08:14:50 INFO - ##### 08:14:50 INFO - ##### Running install step. 08:14:50 INFO - ##### 08:14:50 INFO - Running pre-action listener: _resource_record_pre_action 08:14:50 INFO - Running main action method: install 08:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:50 INFO - Reading from file tmpfile_stdout 08:14:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:50 INFO - Reading from file tmpfile_stdout 08:14:50 INFO - Output received: 08:14:50 INFO - Usage: mozinstall [options] installer 08:14:50 INFO - Options: 08:14:50 INFO - -h, --help show this help message and exit 08:14:50 INFO - -d DEST, --destination=DEST 08:14:50 INFO - Directory to install application into. [default: 08:14:50 INFO - "/builds/slave/test"] 08:14:50 INFO - --app=APP Application being installed. [default: firefox] 08:14:50 INFO - mkdir: /builds/slave/test/build/application 08:14:50 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'] 08:14:50 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 08:15:24 INFO - Reading from file tmpfile_stdout 08:15:24 INFO - Output received: 08:15:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:15:24 INFO - Running post-action listener: _resource_record_post_action 08:15:24 INFO - ##### 08:15:24 INFO - ##### Running run-tests step. 08:15:24 INFO - ##### 08:15:24 INFO - Running pre-action listener: _resource_record_pre_action 08:15:24 INFO - Running main action method: run_tests 08:15:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:15:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:15:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:15:24 INFO - 2016-04-29 08:15:24.269 screenresolution[1650:8142] starting screenresolution argv=screenresolution get 08:15:24 INFO - 2016-04-29 08:15:24.271 screenresolution[1650:8142] Display 0: 1600x1200x32@60 08:15:24 INFO - 2016-04-29 08:15:24.277 screenresolution[1651:8144] starting screenresolution argv=screenresolution list 08:15:24 INFO - Available Modes on Display 0 08:15:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:15:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:15:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:15:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:15:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:15:24 INFO - Intel Iris: 08:15:24 INFO - Chipset Model: Intel Iris 08:15:24 INFO - Type: GPU 08:15:24 INFO - Bus: Built-In 08:15:24 INFO - VRAM (Dynamic, Max): 1536 MB 08:15:24 INFO - Vendor: Intel (0x8086) 08:15:24 INFO - Device ID: 0x0a2e 08:15:24 INFO - Revision ID: 0x0009 08:15:24 INFO - Displays: 08:15:24 INFO - Display: 08:15:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:15:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:15:24 INFO - Display Serial Number: 1600x1200 60 08:15:24 INFO - Main Display: Yes 08:15:24 INFO - Mirror: Off 08:15:24 INFO - Online: Yes 08:15:24 INFO - Rotation: Supported 08:15:24 INFO - Return code: 0 08:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:24 INFO - Python 2.7.3 08:15:24 INFO - Return code: 0 08:15:24 INFO - grabbing minidump binary from tooltool 08:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:15:24 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 0x105b3fe00>, '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 0x1059a8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105b3ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:15:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:15:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:24 INFO - Return code: 0 08:15:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:15:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:15:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:15:25 INFO - Return code: 0 08:15:25 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/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:15:25 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/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0116 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:15:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2JYD0DgPab/Render', 08:15:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:15:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:15:25 INFO - 'HOME': '/Users/cltbld', 08:15:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:15:25 INFO - 'LOGNAME': 'cltbld', 08:15:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:25 INFO - 'MOZ_NO_REMOTE': '1', 08:15:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:25 INFO - 'NO_EM_RESTART': '1', 08:15:25 INFO - 'PAGER': '/bin/cat', 08:15:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:25 INFO - 'PWD': '/builds/slave/test', 08:15:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:15:25 INFO - 'SHELL': '/bin/bash', 08:15:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.87DWKdwGM2/Listeners', 08:15:25 INFO - 'TMPDIR': '/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/', 08:15:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:15:25 INFO - 'USER': 'cltbld', 08:15:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:15:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:25 INFO - 'XPC_FLAGS': '0x0', 08:15:25 INFO - 'XPC_SERVICE_NAME': '0', 08:15:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:15:25 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/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0116', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:15:25 INFO - mozversion application_buildid: 20160429061745 08:15:25 INFO - mozversion application_changeset: 3b652d51edf728e672db99d59525f15fc93c4dc4 08:15:25 INFO - mozversion application_display_name: Nightly 08:15:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:25 INFO - mozversion application_name: Firefox 08:15:25 INFO - mozversion application_remotingname: firefox 08:15:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:15:25 INFO - mozversion application_vendor: Mozilla 08:15:25 INFO - mozversion application_version: 49.0a1 08:15:25 INFO - mozversion platform_buildid: 20160429061745 08:15:25 INFO - mozversion platform_changeset: 3b652d51edf728e672db99d59525f15fc93c4dc4 08:15:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:15:25 INFO - mozversion platform_version: 49.0a1 08:15:25 INFO - using testdate: 1461942925 08:15:25 INFO - actual date: 1461942925 08:15:25 INFO - starting webserver on 'localhost:49276' 08:15:25 INFO - SUITE-START | Running 2 tests 08:15:25 INFO - TEST-START | dromaeo_css 08:15:25 INFO - operating with platform_type : mac_ 08:15:25 INFO - Initialising browser for dromaeo_css test... 08:15:25 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpSiveLb/profile http://localhost:49276/getInfo.html) 08:15:28 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 08:15:28 INFO - PROCESS | 1669 | colorDepth:24 08:15:28 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 08:15:28 INFO - PROCESS | 1669 | __metrics 08:15:28 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:15:29 INFO - TEST-INFO | 1669: exit 0 08:15:29 INFO - Browser initialized. 08:15:29 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:29 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmpSiveLb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:41 INFO - PROCESS | 1673 | RSS: Main: 250011648 08:15:41 INFO - PROCESS | 1673 | 08:16:31 INFO - PROCESS | 1673 | 1461942991008 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:18:41 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 08:18:42 INFO - PROCESS | 1673 | RSS: Main: 265187328 08:18:42 INFO - PROCESS | 1673 | 08:21:44 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 08:21:45 INFO - PROCESS | 1673 | RSS: Main: 276848640 08:21:45 INFO - PROCESS | 1673 | 08:24:47 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 08:24:48 INFO - PROCESS | 1673 | RSS: Main: 278765568 08:24:48 INFO - PROCESS | 1673 | 08:27:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 08:27:50 INFO - PROCESS | 1673 | RSS: Main: 280928256 08:27:50 INFO - PROCESS | 1673 | 08:30:53 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 08:30:53 INFO - PROCESS | 1673 | RSS: Main: 283156480 08:30:53 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 08:33:56 INFO - PROCESS | 1673 | RSS: Main: 284479488 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | __start_tp_report 08:33:56 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 08:33:56 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 08:33:56 INFO - PROCESS | 1673 | |i|pagename|runs| 08:33:56 INFO - PROCESS | 1673 | |0;dojo.html;2880.8415537145447;3432.5366075579796;3456.360573293941;3461.6711412415816;3480.390931586972;5804.448577385152;5818.505427038702;5839.357670656235;5874.823755287338;5921.141434492001;5666.121751128571;5722.685252311121;5809.3900140485275;5848.853778655525;5933.199018132551;5220.26916231727;5288.576913846883;5331.466853314676;5353.223782551528;5379.38137114231;132.2702084310471;5321.707306098163;5336.706481143536;5338.813141540047;5379.892402151954;5248.580113590903;5263.657862238962;5290.523852853243;5307.920381194285;5308.70802105884;5211.557017653504;5341.332333458317;5358.758855851496;5363.6245462817615;5406.405295417501;5207.010667973073;5210.4268530461995;5293.947060529384;5318.468153184689;5349.786008559653;4395.890102747425;5397.433269506684;5726.5705072119345;5747.023006088975;5850.444207800252;4808.990112076468;6144.709610981699;6222.3466536013975;6254.249490061222;6258.718357673915;6192.59748116371;6220.657863817488;6238.656873871935;6248.4064013918605;6251.687415629201;5947.078202878518;5979.073243647285;5979.790707325266;5990.5507086968655;6035.426634469718;6167.969160154171;6241.812745617548;6258.405451482102;6323.841903952346;6329;6179;6225.564210505221;6228.065790131426;6255.78104766331;6265.592736472206;6167.105769663463;6236.781712640036;6241.21984751906;6259.123722678829;6280.057991301342;5463.726813659301;5980.521558275327;6155.353687862799;6195.19462469876;6250.74997000124;6086.786962456381;6155.938440615626;6228.5951413158;6232.875342493216;6265.561410701207;4628.83799067031;4852.539008794159;4972.353594032825;5003.324551185616;5003.399592048904;4427.358033085249;4429.224885645;4479.641628669699;4528.411306530196;4536.002079542495;5329.8934021319355;5788.623739456922;5845.210896528914;5867.14926335679;5904.025835737055;6203.503719702413;6205.47253483459;6208.379162083756;6225.128482012522;6239.500839932794;4517.480489743656;4739.549742774431;4971.950280497149;5911.704414779244;5981.282246130492;5460.672359658353;5469.8085567005755;5500.339959204921;5505.587080968863;5508.283923089973;6386.904196437057;6399.360063993563;6401.711922963478;6406.263279722798;6407.359264073555;6141.977005061692;6165.691715414301;6213;6228.844278892882;6232.875342493216;6370.140031095742;6371.331010244043;6374.713137908898;6408.423241908251;6416.51876109303;6125.663088529996;6234.625922444668;6240.251169859646;6241.531885108726;6259.374062593704;6074.3318234994995;6167.290761562478;6195.19462469876;6226.346233645583;6240.719167637377;6169.105479705508;6177.320494745484;6198.969005154945;6232.127502149612;6236.563440559117;6057.394260573908;6098.613770999223;6195.752169913153;6216.968915155576;6226.59527130735;5897.734601943009;5953.910691339547;6033.758649653964;6082.72627731762;6112.625067133501;5119.74401279942;6120.9693951531735;6176.104464852661;6182.227221597301;6195.380461953949;5992.43071908168;6043.12374705674;6044.667543284985;6080.270367555921;6137.693115344304 08:33:56 INFO - PROCESS | 1673 | |1;ext.html;490.3478373762896;528.4134610582254;570.8744076303212;593.2080672302476;608.05751085817;33054.66945330546;39286.8035659822;39290.8035459823;39362;39485;40615.796921015426;40911.59088409115;41466.58533414665;41503.79248103763;41642.7917860411;9331.860022099658;9539.284553658468;9561;9583.95208023959;9584.616615335413;9489.05109489049;9699.321047526675;9717.659881904136;9718.757031074208;9739.659111931083;9673.95163024184;9759.41443513388;9773.218142548614;9775.608975641002;9803.754906127333;9650.71047868565;9748.366356186896;9756.219502439822;9769.462679552622;9799.314048016642;9520.23838092951;9591.232701383873;9638.987906269811;9674.854877176847;9691.854622180674;38619.613803862165;38920.610793892265;39274.60725392738;39297.80351098255;39387;2806.031918987946;2807.9157625271273;3155.495120780664;3206.1824234820206;3445.603755568117;27428.725712742817;27473.86263068672;27489.587656185173;27938.02216922398;28246;2711.823731457449;2737.9726202737916;2743.986280068587;2798.6221860048836;2933.2813460702264;309219;371971;377206;378547.10726446466;378694;60587;60782.87259945969;60918.39081609216;60954.39045609487;61012.08481872775;51016.74491627518;61198.38801611927;61989.070163947574;62293.688531557054;63117.68441157765;17010.82989170117;17173.656526869392;17360.045197514257;17363.21865516055;17366;13234.867651323557;13244.867551324363;13287.468501259842;13288.800667989988;13295.800562991562;19576.804231957783;19684.60630787376;19948.50128746793;19968.400947971582;20037.799622003884;8113.350931925432;8174;8194.426390152752;8199.672013119409;8265.504069755714;943.6791490893129;944.2964991081689;1024.7847951930178;1085.7448499602588;1136.9943150284362;29710.702892971225;29961.400771984438;30320.574354051623;30492;30532.69467305343;906.4515967839494;1031.5718976624767;1117.1956191542076;1130.3952385473733;1194.9342786146672;15361.846381536265;15467;15549.533513994598;15731.842681573267;15882.76175857363;452895;469529;470818;470876;635178;57438;57539;58455.53861153505;58490.12264816031;58527;1368.4252613902186;1377.22875189894;1452.4553292515307;1463.3195564062762;1469.2506821521101;26073.696315184545;27767.750451230146;28973;29061.273468163465;29843.850780745957;50076.749616253146;50924;50938.49061509486;50938.74530627323;51080.23379649383;560327;575644;576577;578571;580392;26860.194194174204;27238;27290.908363665232;27616.44767104687;27622.309442264104;42209.57790422056;42320;43010.924726882076;43785;44313.44902928382;35657;36118.45822312615;36249.09377265589;36905.26189476142;37226;33737.493937590465;35616.82191589026;36348.818255908554;36550.45174322334;36692;30713.692863071083;35272.82363588166;35363;35932.4610130843;36742.8162859184;30740;31455.37089258248;31457.8427107863;31922.36155276835;32187.67812321847;24287.878560607085;24361.39096522601;24502.509949800547;25250.242492725247;25314 08:33:56 INFO - PROCESS | 1673 | |2;jquery.html;378.49281962170693;385.67217864814893;393.40082564375825;398.3765407137829;407.7553467919247;19449.513762155937;20141.39575812728;20187.798122018776;20190.59618807623;20501.794982050174;16773;20612.9693515324;20772.272970446036;21435.571288574218;21521.24675636353;5712.971435142818;5799.21710569072;5980.820575382745;6017;6042;5836.708164591774;5904.202932604107;5917.674527900964;5931.872944140599;5970.0746384310505;4995.5753760930365;5057.519535644108;5849.473547380735;5914.467697907187;5922.58541902067;5828.300603927534;5832.6500409975115;5865.794697185599;5893.233879595625;5917.467427931485;5157.871053223662;5191.714455704935;5202.2456743771945;5212.869678258036;5226.823964607933;12181.695457613541;23412.414689632726;23534.23493238014;24833;25650.358741031436;2080.8855512946784;2182.1380554680973;2446.54738873309;2457.8525288482747;2478.2689106713565;9725.805483890354;9816.165625921805;9965.15296199824;10061.647842325483;10102.292839501239;1527.030335736804;1569.7723830044579;1732.6794543009585;1772.5391398236422;1933.3619905431315;102847.48576257071;119012.40493797562;123058;132908;135438;11342.262752921033;11566.710832229262;11715.1799374043;11731;11733.120015998835;14869.033512821848;14923.477678281426;14959.551213463395;14961.476348327757;14983;8688.348373871984;8800.207981281588;8808;8835.116488351114;8878.644854205888;8732.519711415805;8767.868481972775;8849.955750221208;8895.021547629885;8938.955305223562;4571.451425828922;4637.768111594407;4699.365585645894;4702.95297047032;4732.455767586703;1684.3936182974119;1969.4190213886939;2021.2521367094268;2056.3008577083565;2067.927622533204;897.721706271045;902.5442151713343;903.512103464122;983.852422136671;1029.2743615750878;19550.804491955183;19769.503988969864;20644.58710825775;20871;21381.57236855254;866.1165611076666;939.8308304505118;955.7132860141929;956.3879117364892;1032.5714828346152;8702.608382622797;10795.46022698862;11046.33721976684;11069.280496767684;11077.556897724;542418;554694;556384;563246;564628;91322;112666.43666781613;112877;127070.36464817617;130563.12465938866;940.9905900940903;954.2556805691572;993.2401712689798;997.9800403992025;1073.0610715623673;15833.050016999017;17679.558011049827;18699.439016829518;18945.052747362854;19364;51352.295409181635;51581;51684.741576291875;52514;53478.73260633828;76025.61987190029;76189.23810761822;77139;78742;79855;8025.438219324591;8165.38759593021;8217.383696222687;8407.621657025571;8408.453450525696;9412.717618471457;10687.679369618923;12727.427265772878;12748;13081.411336490071;11075.169362298022;11112;11190.66428007161;11460;11493.965543101162;10979.890201097887;11082.833757493483;11279.210455268052;11347.829782553103;11410;4908.263760435963;5931.6441013539325;8833.205011548991;11545.82681259765;11791.410429478321;6969.512134150561;8197;8405.495670259805;8526.786830329043;8628.482291062557;10594.682159535227;11327.773444531229;11493.597724079616;11506.712332191762;11579.536818527502 08:33:56 INFO - PROCESS | 1673 | |3;mootools.html;1421.4882642248792;1567.3730507796886;1629.0795700429258;1939.2049259803475;1965.0371318054158;7177.318154775295;7467.25327467253;7854.92145078549;8842.867356989642;8868.201861832442;7647.655855486502;8332.958335208315;8640.35197360199;8718.73843784686;8751.649934002633;2420.1771397724815;2444.6455263986713;2454.1165180534995;2454.2391858523824;2457.6436416719566;2056.290579749991;2397.523982691721;2450.840695354805;2464.346948058766;2464.470138920132;2438.548868459332;2447.437089469423;2459.446624509489;2459.9016039358403;2460.2619214235747;2423.430493833948;2428;2437.695288088989;2444.8533088014774;2446.1805295226122;2394.305651361103;2419.2984034629935;2431.003288651644;2432.878356082189;2441.9389515262083;8804.383693141483;8866.290696744309;8877.778055548599;8879.156480134377;8887.466751994836;5315.734213289359;5504.339479262474;5515.751791169407;5541.473560011793;5555.027870122713;3275.5905511811025;3439.3121375724704;3637.963620363789;3642.763220390666;3683.4658974448553;1014.1430491234895;1045.383223897904;1049.0663309654415;1053.536443964653;1070.6680928912062;11156.888431115665;11309.604163854226;11334.659960201125;11364.943175284154;11400.885991140065;3970.4639873616693;4472.016156445577;4622.006268652189;4653.092646933883;4719.221328480762;9235.353525253167;9236.953815230881;9257.981622021573;9263.120003599648;9266.768330791649;5381.354237491526;5411.918821217685;5412.5940554458575;5412.864678382994;5421.83734487966;4503.482099558527;4838.854834354975;4874.36633237684;5029.622778291643;5082.9579936113005;3837.5586807516934;3852.9229415411537;3924.529056513237;3948.5459172195565;4027.959720402817;1230.1573422205638;1257.0886107571937;1261.7413430246777;1267.7971524556026;1277.4826195390697;811.350919264586;891.4606662968811;912.3268822350444;946.7301818981557;947.9714509756991;5743.966086104541;5954.55340849438;6013.669248191304;6097.481714054266;6180.215523910804;430.1590390786006;452.4480134236226;456.85152325494346;472.92433210686124;480.9110314591812;3932.272529581979;3983.183447393277;3986.282469155522;4075.9388609170887;4088.693347998912;10271.229657775697;10659.626913058006;10761.677149685522;10815;10903.291286066538;8172.468789528662;10089.596416143419;10648.467576621139;10742.892571074346;10785.13718902486;7282.563046217244;7436.776896693108;8079.151689072681;8147.103818579952;8149.470284431493;5718.199452076629;5725.484706376446;5789.56578256624;5828.475437210672;5890.263717035371;9803.705888823346;9815.263855211031;9994.20046396272;10040.497975101362;10170.338927969658;9918;10070.597176112873;10217.33587316822;10301.9484902575;10316.587336506456;6362.300146983921;6854.931450685429;6988.05661235747;7068.823279418056;7071.646417678992;8212.83574328498;8260.917390826015;8290.129536398592;8338.583070846555;8342.916570834213;7284.890726638999;7453.627318634155;7465.738699145504;7577.621118944141;7620.8475830484185;7232.0959880015;7260.419166466564;7284.016657751347;7314.524555903849;7365.226651201761;7039;7054.964725176546;7089.929100708927;7108.502404831612;7111.60886151246;4380.080183161572;4821.276808478756;4827.403848552393;4956.231784073474;4970.204767237225;4202.180574787887;4998.525140111684;5033;5055.848324550269;5219.32148820666 08:33:56 INFO - PROCESS | 1673 | |4;prototype.html;319.2848020434227;320.1116900600834;328.10427532835376;328.48755940732457;330.3211899546433;4354.477462704472;5424.674519528826;5448.991936491747;5521.171824226368;5572.359178694452;4357.389965404838;4955.8106054546915;5241;5295.655782374152;5402.459754024596;3982.681385489161;4049.068714195737;4140.695680860535;4159.916801663965;4219.2616292148905;3412.436947903593;3445.810480423576;4142.295809712341;4164.00191861859;4181.28918083925;3752.949174231206;4077.3068578341754;4108.794560271989;4130.710850240484;4142.399352093959;3720.6093360197196;3885.6000999125763;4181.540030596632;4188.602082802144;4231.931849409185;2986.4325778102093;3571.0715214044276;3596.7482276240676;3599.5500562429697;3619.004773687257;4368.388425620416;5185.688858668492;5289.206619007141;5290.074237008546;5299.761510732026;4518.977405112953;4632.513586073481;4761.2143996240575;4766.856994290177;4800.967791924753;4584.495705472429;4665.650076244296;5175.861310511719;5813.767449302023;5867.3839246879315;3947.5855035221175;3953.8731461533325;3966.643002129822;3993.1813978134414;3995.7402768819934;5641.830745077655;5827.708614569297;6054.606450580743;6108.602940808878;6131.47882429994;3748.194138260287;3839.0786211309087;4008.4767788240865;4053.6351728344002;4059.594040595917;4071.7353372030725;4111.958880411217;4115.526714427879;4124.278251306009;4139.958600414017;4566.178087944136;4746.0745154694505;4773.284007398918;4784.186688263004;4833.589144922721;5615.354234263031;5902.822915312548;5909.497692696083;5913.970430147908;5957.404259574095;1393.6794537256487;1462.1300326306043;1483.903546269489;1489.143742348154;1495.2000679636342;899.7660608241904;948.6821914658528;958.9280803939732;973.634886917406;982.4645568165367;5639.210510528529;5797.565182611321;5888.735006924613;5910.645361278251;5966.910496342558;6111.938880611226;6532.379423954717;6532.412082912466;6563.3764792344655;6583.539152259296;5226.040234911908;5423.240746295522;5488.91766623501;5687.772489100473;5904.61619994699;2930.868110935013;3478.513008178857;3489.720822334258;3492.4633161408897;3514.2268700885766;6598.769043083469;6702.463802895757;6852.349026842442;6908.412784913238;6920.861582768316;6632.2372927114;6794.048833163361;6797.1843378794865;6798.966005169942;6808;5711.485966263056;5979.491743201789;6155.722382718333;6834.624095674786;6903.206131294865;6001.459868611846;6357.872842543031;6577.934220657732;6616.8345791355605;6624.900626490703;6311.715972781328;6507.837304067436;6517.348265173445;6543.869122617426;6546.18172728409;5534.865352602787;6166.568340216321;6246.843828904313;6837.495750934786;6857.839780469136;4232.280512312976;4272.166927449118;4275.781402300329;4279.400883876197;4315.762633055212;5373.596980226577;5552.500274975271;6384.425401713868;6588.670566471561;6605.933940660724;5561.277033985556;5573.665580065209;6349.365063493614;6402.967985160044;6432.2602900667025;5594;6115.318287470981;6371.649559274099;6377;6445.2265728112925;5378.7579558920725;5660.264165658438;5778.208755285875;6225.875482490415;6259.906101408392;5160.638755287094;5596.468335508121;5866.2373891393845;5894.498967587803;6108.51131909455;5516.393196748435;5762.337331206797;5792.218050563289;5799.187394113936;5821.330546987151 08:33:56 INFO - PROCESS | 1673 | |5;yui.html;663.3863676099606;689.8896176611743;705.3334598804129;727.5416487612803;750.5346685055265;14449.349779259932;14568.198749068797;14972.775408368883;15077.62305942352;15119.941604087719;14219.644508887257;14343.282835858217;14349.856501435008;14371.275446946382;14374.712505749878;576.6943519934441;769.8229407236339;902.5848109869452;935.2658163341778;945.7871978804783;933.0249888866151;934.3739694404732;936.2276122199179;938.5307346326837;940.4921342475055;968.5157421289356;970.839811431113;972.1299437003877;974.44456659704;976.1848856205078;949.8052899155656;960.7646126699003;965.6089283840056;967.5404183013047;968.5157421289356;674.1472037872096;677.9457643388566;707.8442742596671;715.9176694680126;717.2612209424301;14678;14694.926525367304;14706.926465367711;14774.40902363915;14945.252737363197;12492.687682807911;12608.432620532098;12633.557825476064;12727.045471589669;12863.935680321632;9269.655899894546;9640.903590964072;10068.69793906184;10129.797404051951;10357;3452.982735086334;3472.861085556575;3473.1838018065732;3493.615702272748;3585.3008663310666;78060.21939780586;79034.6048269755;79049;81331.5933420335;81719.18280817175;9369.718908432758;9442.95278523603;9479.763005924908;9674.516274186262;9842.950785246172;21401.57196856054;22130.114795408324;22182;22422.663660045113;22538.985745641487;6406.967965160145;7104.183018952784;7435.553866768011;7566.394688424913;7577.393808495307;3978.980105099456;4037.2934736421007;4039.5152581690386;4041.4341992121126;4054.8580799671868;3630.7640003399692;3682.705383569308;3691.1141326081547;3696.0020794385364;3703.0742314421395;568.7895478672917;584.9707514624251;593.8218534439651;601.3415310235285;612.1796792298342;483.10862971466315;517.6117911566325;524.7481209019692;551.178743671934;576.8442520519436;6894.724211031603;7986.920130798734;7993.640286187136;8138.755837324889;8201.179882011751;557.3701717059697;568.0428478014559;581.7353104337516;586.7095787585173;611.0437165835453;3774.0564858785306;3852.056246219694;3858.530510585305;3883.339832228528;3901.3367727486398;62491;94429;94670;95352;97139.54290685646;62520.06219906705;80051.59974200209;80324.79512807312;81798.59100704458;82131.5893420529;72276;72628.82113536603;73167.26832731605;73240;73766.63116684489;7487.737929172453;7594.278543538355;7752.030996125484;7779;7884.205109244586;36032.55869765285;37639.435408468344;39747.80126099351;40727.38908916428;42756.78621606872;56376.154357683845;60549;61146.38853611407;61150;62116.37883621106;10421.843672345072;10431.269811113452;10478;10513.316634418738;10776.137908967421;8566;10948.069414099891;11040.116790656568;11092.611758588411;11363.375014373958;10253.538590763583;10400.21998350142;10445.059944605022;10457.9477102614;10516.26386152962;10442.269041167045;10504.632337868137;10711;10846.18653600999;11382.54469821198;8521.360897932556;9157.763701900158;9975.251856110675;10024.198064154996;10421.270511064153;8662.480251184948;8786.912130878609;8825.205731484197;8978.236849867835;9057.728268151966;7182.098351869188;8610.61252243638;8655.653773849228;8841.292696584387;8850.557472126497 08:33:56 INFO - PROCESS | 1673 | __end_tp_report 08:33:56 INFO - PROCESS | 1673 | __start_cc_report 08:33:56 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,416 08:33:56 INFO - PROCESS | 1673 | __end_cc_report 08:33:56 INFO - PROCESS | 1673 | __startTimestamp1461944036346__endTimestamp 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | ------- Summary: start ------- 08:33:56 INFO - PROCESS | 1673 | Number of tests: 6 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5722.64 Median:6035.43 stddev:796.29 (13.2%) stddev-sans-first:766.89 08:33:56 INFO - PROCESS | 1673 | Values: 2880.8 3432.5 3456.4 3461.7 3480.4 5804.4 5818.5 5839.4 5874.8 5921.1 5666.1 5722.7 5809.4 5848.9 5933.2 5220.3 5288.6 5331.5 5353.2 5379.4 132.3 5321.7 5336.7 5338.8 5379.9 5248.6 5263.7 5290.5 5307.9 5308.7 5211.6 5341.3 5358.8 5363.6 5406.4 5207.0 5210.4 5293.9 5318.5 5349.8 4395.9 5397.4 5726.6 5747.0 5850.4 4809.0 6144.7 6222.3 6254.2 6258.7 6192.6 6220.7 6238.7 6248.4 6251.7 5947.1 5979.1 5979.8 5990.6 6035.4 6168.0 6241.8 6258.4 6323.8 6329.0 6179.0 6225.6 6228.1 6255.8 6265.6 6167.1 6236.8 6241.2 6259.1 6280.1 5463.7 5980.5 6155.4 6195.2 6250.7 6086.8 6155.9 6228.6 6232.9 6265.6 4628.8 4852.5 4972.4 5003.3 5003.4 4427.4 4429.2 4479.6 4528.4 4536.0 5329.9 5788.6 5845.2 5867.1 5904.0 6203.5 6205.5 6208.4 6225.1 6239.5 4517.5 4739.5 4972.0 5911.7 5981.3 5460.7 5469.8 5500.3 5505.6 5508.3 6386.9 6399.4 6401.7 6406.3 6407.4 6142.0 6165.7 6213.0 6228.8 6232.9 6370.1 6371.3 6374.7 6408.4 6416.5 6125.7 6234.6 6240.3 6241.5 6259.4 6074.3 6167.3 6195.2 6226.3 6240.7 6169.1 6177.3 6199.0 6232.1 6236.6 6057.4 6098.6 6195.8 6217.0 6226.6 5897.7 5953.9 6033.8 6082.7 6112.6 5119.7 6121.0 6176.1 6182.2 6195.4 5992.4 6043.1 6044.7 6080.3 6137.7 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:62162.14 Median:377876.55 stddev:130318.88 (34.5%) stddev-sans-first:130602.20 08:33:56 INFO - PROCESS | 1673 | Values: 490.3 528.4 570.9 593.2 608.1 33054.7 39286.8 39290.8 39362.0 39485.0 40615.8 40911.6 41466.6 41503.8 41642.8 9331.9 9539.3 9561.0 9584.0 9584.6 9489.1 9699.3 9717.7 9718.8 9739.7 9674.0 9759.4 9773.2 9775.6 9803.8 9650.7 9748.4 9756.2 9769.5 9799.3 9520.2 9591.2 9639.0 9674.9 9691.9 38619.6 38920.6 39274.6 39297.8 39387.0 2806.0 2807.9 3155.5 3206.2 3445.6 27428.7 27473.9 27489.6 27938.0 28246.0 2711.8 2738.0 2744.0 2798.6 2933.3 309219.0 371971.0 377206.0 378547.1 378694.0 60587.0 60782.9 60918.4 60954.4 61012.1 51016.7 61198.4 61989.1 62293.7 63117.7 17010.8 17173.7 17360.0 17363.2 17366.0 13234.9 13244.9 13287.5 13288.8 13295.8 19576.8 19684.6 19948.5 19968.4 20037.8 8113.4 8174.0 8194.4 8199.7 8265.5 943.7 944.3 1024.8 1085.7 1137.0 29710.7 29961.4 30320.6 30492.0 30532.7 906.5 1031.6 1117.2 1130.4 1194.9 15361.8 15467.0 15549.5 15731.8 15882.8 452895.0 469529.0 470818.0 470876.0 635178.0 57438.0 57539.0 58455.5 58490.1 58527.0 1368.4 1377.2 1452.5 1463.3 1469.3 26073.7 27767.8 28973.0 29061.3 29843.9 50076.7 50924.0 50938.5 50938.7 51080.2 560327.0 575644.0 576577.0 578571.0 580392.0 26860.2 27238.0 27290.9 27616.4 27622.3 42209.6 42320.0 43010.9 43785.0 44313.4 35657.0 36118.5 36249.1 36905.3 37226.0 33737.5 35616.8 36348.8 36550.5 36692.0 30713.7 35272.8 35363.0 35932.5 36742.8 30740.0 31455.4 31457.8 31922.4 32187.7 24287.9 24361.4 24502.5 25250.2 25314.0 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:33385.68 Median:389.54 stddev:93117.80 (23904.8%) stddev-sans-first:93346.03 08:33:56 INFO - PROCESS | 1673 | Values: 378.5 385.7 393.4 398.4 407.8 19449.5 20141.4 20187.8 20190.6 20501.8 16773.0 20613.0 20772.3 21435.6 21521.2 5713.0 5799.2 5980.8 6017.0 6042.0 5836.7 5904.2 5917.7 5931.9 5970.1 4995.6 5057.5 5849.5 5914.5 5922.6 5828.3 5832.7 5865.8 5893.2 5917.5 5157.9 5191.7 5202.2 5212.9 5226.8 12181.7 23412.4 23534.2 24833.0 25650.4 2080.9 2182.1 2446.5 2457.9 2478.3 9725.8 9816.2 9965.2 10061.6 10102.3 1527.0 1569.8 1732.7 1772.5 1933.4 102847.5 119012.4 123058.0 132908.0 135438.0 11342.3 11566.7 11715.2 11731.0 11733.1 14869.0 14923.5 14959.6 14961.5 14983.0 8688.3 8800.2 8808.0 8835.1 8878.6 8732.5 8767.9 8850.0 8895.0 8939.0 4571.5 4637.8 4699.4 4703.0 4732.5 1684.4 1969.4 2021.3 2056.3 2067.9 897.7 902.5 903.5 983.9 1029.3 19550.8 19769.5 20644.6 20871.0 21381.6 866.1 939.8 955.7 956.4 1032.6 8702.6 10795.5 11046.3 11069.3 11077.6 542418.0 554694.0 556384.0 563246.0 564628.0 91322.0 112666.4 112877.0 127070.4 130563.1 941.0 954.3 993.2 998.0 1073.1 15833.1 17679.6 18699.4 18945.1 19364.0 51352.3 51581.0 51684.7 52514.0 53478.7 76025.6 76189.2 77139.0 78742.0 79855.0 8025.4 8165.4 8217.4 8407.6 8408.5 9412.7 10687.7 12727.4 12748.0 13081.4 11075.2 11112.0 11190.7 11460.0 11494.0 10979.9 11082.8 11279.2 11347.8 11410.0 4908.3 5931.6 8833.2 11545.8 11791.4 6969.5 8197.0 8405.5 8526.8 8628.5 10594.7 11327.8 11493.6 11506.7 11579.5 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5619.75 Median:4856.61 stddev:3115.84 (64.2%) stddev-sans-first:3108.61 08:33:56 INFO - PROCESS | 1673 | Values: 1421.5 1567.4 1629.1 1939.2 1965.0 7177.3 7467.3 7854.9 8842.9 8868.2 7647.7 8333.0 8640.4 8718.7 8751.6 2420.2 2444.6 2454.1 2454.2 2457.6 2056.3 2397.5 2450.8 2464.3 2464.5 2438.5 2447.4 2459.4 2459.9 2460.3 2423.4 2428.0 2437.7 2444.9 2446.2 2394.3 2419.3 2431.0 2432.9 2441.9 8804.4 8866.3 8877.8 8879.2 8887.5 5315.7 5504.3 5515.8 5541.5 5555.0 3275.6 3439.3 3638.0 3642.8 3683.5 1014.1 1045.4 1049.1 1053.5 1070.7 11156.9 11309.6 11334.7 11364.9 11400.9 3970.5 4472.0 4622.0 4653.1 4719.2 9235.4 9237.0 9258.0 9263.1 9266.8 5381.4 5411.9 5412.6 5412.9 5421.8 4503.5 4838.9 4874.4 5029.6 5083.0 3837.6 3852.9 3924.5 3948.5 4028.0 1230.2 1257.1 1261.7 1267.8 1277.5 811.4 891.5 912.3 946.7 948.0 5744.0 5954.6 6013.7 6097.5 6180.2 430.2 452.4 456.9 472.9 480.9 3932.3 3983.2 3986.3 4075.9 4088.7 10271.2 10659.6 10761.7 10815.0 10903.3 8172.5 10089.6 10648.5 10742.9 10785.1 7282.6 7436.8 8079.2 8147.1 8149.5 5718.2 5725.5 5789.6 5828.5 5890.3 9803.7 9815.3 9994.2 10040.5 10170.3 9918.0 10070.6 10217.3 10301.9 10316.6 6362.3 6854.9 6988.1 7068.8 7071.6 8212.8 8260.9 8290.1 8338.6 8342.9 7284.9 7453.6 7465.7 7577.6 7620.8 7232.1 7260.4 7284.0 7314.5 7365.2 7039.0 7055.0 7089.9 7108.5 7111.6 4380.1 4821.3 4827.4 4956.2 4970.2 4202.2 4998.5 5033.0 5055.8 5219.3 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:4902.39 Median:5468.95 stddev:1586.31 (29.0%) stddev-sans-first:1553.01 08:33:56 INFO - PROCESS | 1673 | Values: 319.3 320.1 328.1 328.5 330.3 4354.5 5424.7 5449.0 5521.2 5572.4 4357.4 4955.8 5241.0 5295.7 5402.5 3982.7 4049.1 4140.7 4159.9 4219.3 3412.4 3445.8 4142.3 4164.0 4181.3 3752.9 4077.3 4108.8 4130.7 4142.4 3720.6 3885.6 4181.5 4188.6 4231.9 2986.4 3571.1 3596.7 3599.6 3619.0 4368.4 5185.7 5289.2 5290.1 5299.8 4519.0 4632.5 4761.2 4766.9 4801.0 4584.5 4665.7 5175.9 5813.8 5867.4 3947.6 3953.9 3966.6 3993.2 3995.7 5641.8 5827.7 6054.6 6108.6 6131.5 3748.2 3839.1 4008.5 4053.6 4059.6 4071.7 4112.0 4115.5 4124.3 4140.0 4566.2 4746.1 4773.3 4784.2 4833.6 5615.4 5902.8 5909.5 5914.0 5957.4 1393.7 1462.1 1483.9 1489.1 1495.2 899.8 948.7 958.9 973.6 982.5 5639.2 5797.6 5888.7 5910.6 5966.9 6111.9 6532.4 6532.4 6563.4 6583.5 5226.0 5423.2 5488.9 5687.8 5904.6 2930.9 3478.5 3489.7 3492.5 3514.2 6598.8 6702.5 6852.3 6908.4 6920.9 6632.2 6794.0 6797.2 6799.0 6808.0 5711.5 5979.5 6155.7 6834.6 6903.2 6001.5 6357.9 6577.9 6616.8 6624.9 6311.7 6507.8 6517.3 6543.9 6546.2 5534.9 6166.6 6246.8 6837.5 6857.8 4232.3 4272.2 4275.8 4279.4 4315.8 5373.6 5552.5 6384.4 6588.7 6605.9 5561.3 5573.7 6349.4 6403.0 6432.3 5594.0 6115.3 6371.6 6377.0 6445.2 5378.8 5660.3 5778.2 6225.9 6259.9 5160.6 5596.5 5866.2 5894.5 6108.5 5516.4 5762.3 5792.2 5799.2 5821.3 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:17520.17 Median:30878.72 stddev:24994.28 (80.9%) stddev-sans-first:25032.35 08:33:56 INFO - PROCESS | 1673 | Values: 663.4 689.9 705.3 727.5 750.5 14449.3 14568.2 14972.8 15077.6 15119.9 14219.6 14343.3 14349.9 14371.3 14374.7 576.7 769.8 902.6 935.3 945.8 933.0 934.4 936.2 938.5 940.5 968.5 970.8 972.1 974.4 976.2 949.8 960.8 965.6 967.5 968.5 674.1 677.9 707.8 715.9 717.3 14678.0 14694.9 14706.9 14774.4 14945.3 12492.7 12608.4 12633.6 12727.0 12863.9 9269.7 9640.9 10068.7 10129.8 10357.0 3453.0 3472.9 3473.2 3493.6 3585.3 78060.2 79034.6 79049.0 81331.6 81719.2 9369.7 9443.0 9479.8 9674.5 9843.0 21401.6 22130.1 22182.0 22422.7 22539.0 6407.0 7104.2 7435.6 7566.4 7577.4 3979.0 4037.3 4039.5 4041.4 4054.9 3630.8 3682.7 3691.1 3696.0 3703.1 568.8 585.0 593.8 601.3 612.2 483.1 517.6 524.7 551.2 576.8 6894.7 7986.9 7993.6 8138.8 8201.2 557.4 568.0 581.7 586.7 611.0 3774.1 3852.1 3858.5 3883.3 3901.3 62491.0 94429.0 94670.0 95352.0 97139.5 62520.1 80051.6 80324.8 81798.6 82131.6 72276.0 72628.8 73167.3 73240.0 73766.6 7487.7 7594.3 7752.0 7779.0 7884.2 36032.6 37639.4 39747.8 40727.4 42756.8 56376.2 60549.0 61146.4 61150.0 62116.4 10421.8 10431.3 10478.0 10513.3 10776.1 8566.0 10948.1 11040.1 11092.6 11363.4 10253.5 10400.2 10445.1 10457.9 10516.3 10442.3 10504.6 10711.0 10846.2 11382.5 8521.4 9157.8 9975.3 10024.2 10421.3 8662.5 8786.9 8825.2 8978.2 9057.7 7182.1 8610.6 8655.7 8841.3 8850.6 08:33:56 INFO - PROCESS | 1673 | -------- Summary: end -------- 08:33:56 INFO - PROCESS | 1673 | 08:33:56 INFO - TEST-INFO | 1673: exit 0 08:33:57 INFO - TEST-OK | dromaeo_css | took 1111070ms 08:33:57 INFO - TEST-START | kraken 08:33:57 INFO - operating with platform_type : mac_ 08:33:57 INFO - Initialising browser for kraken test... 08:33:57 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmptKupvq/profile http://localhost:49276/getInfo.html) 08:33:59 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 08:33:59 INFO - PROCESS | 1681 | colorDepth:24 08:33:59 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 08:33:59 INFO - PROCESS | 1681 | __metrics 08:34:00 ERROR - PROCESS | 1681 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 08:34:00 INFO - TEST-INFO | 1681: exit 0 08:34:00 INFO - Browser initialized. 08:34:00 INFO - Running cycle 1/1 for kraken test... 08:34:00 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/T/tmptKupvq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:12 INFO - PROCESS | 1684 | RSS: Main: 250159104 08:34:12 INFO - PROCESS | 1684 | 08:34:15 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:16 INFO - PROCESS | 1684 | RSS: Main: 262131712 08:34:16 INFO - PROCESS | 1684 | 08:34:18 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 08:34:19 INFO - PROCESS | 1684 | RSS: Main: 266801152 08:34:19 INFO - PROCESS | 1684 | 08:34:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 08:34:23 INFO - PROCESS | 1684 | RSS: Main: 267190272 08:34:23 INFO - PROCESS | 1684 | 08:34:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 08:34:26 INFO - PROCESS | 1684 | RSS: Main: 267739136 08:34:26 INFO - PROCESS | 1684 | 08:34:28 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:29 INFO - PROCESS | 1684 | RSS: Main: 268185600 08:34:29 INFO - PROCESS | 1684 | 08:34:32 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:32 INFO - PROCESS | 1684 | RSS: Main: 268316672 08:34:32 INFO - PROCESS | 1684 | 08:34:35 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:36 INFO - PROCESS | 1684 | RSS: Main: 268484608 08:34:36 INFO - PROCESS | 1684 | 08:34:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 08:34:40 INFO - PROCESS | 1684 | RSS: Main: 268673024 08:34:40 INFO - PROCESS | 1684 | 08:34:41 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:42 INFO - PROCESS | 1684 | RSS: Main: 268152832 08:34:42 INFO - PROCESS | 1684 | 08:34:44 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:44 INFO - PROCESS | 1684 | RSS: Main: 268328960 08:34:44 INFO - PROCESS | 1684 | 08:34:47 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:47 INFO - PROCESS | 1684 | RSS: Main: 268648448 08:34:47 INFO - PROCESS | 1684 | 08:34:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:51 INFO - PROCESS | 1684 | RSS: Main: 268767232 08:34:51 INFO - PROCESS | 1684 | 08:34:54 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:55 INFO - PROCESS | 1684 | RSS: Main: 268820480 08:34:55 INFO - PROCESS | 1684 | 08:34:56 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 08:34:57 INFO - PROCESS | 1684 | RSS: Main: 270118912 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | __start_tp_report 08:34:57 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 08:34:57 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 08:34:57 INFO - PROCESS | 1684 | |i|pagename|runs| 08:34:57 INFO - PROCESS | 1684 | |0;ai-astar;115;109;115;114;115;128;114;138;116;114 08:34:57 INFO - PROCESS | 1684 | |1;audio-beat-detection;155;121;144;168;122;139;122;160;178;154 08:34:57 INFO - PROCESS | 1684 | |2;audio-dft;199;218;232;217;247;272;188;271;272;206 08:34:57 INFO - PROCESS | 1684 | |3;audio-fft;65;75;72;140;61;56;57;66;131;58 08:34:57 INFO - PROCESS | 1684 | |4;audio-oscillator;81;84;122;105;118;130;106;95;105;164 08:34:57 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;89;86;101;112;88;84;89;99;134;86 08:34:57 INFO - PROCESS | 1684 | |6;imaging-darkroom;94;94;120;119;151;149;95;95;94;94 08:34:57 INFO - PROCESS | 1684 | |7;imaging-desaturate;115;150;91;141;143;121;90;114;144;113 08:34:57 INFO - PROCESS | 1684 | |8;json-parse-financial;63;63;62;63;61;60;63;80;62;59 08:34:57 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;63;67;71;72;74;70;66;66;68;93 08:34:57 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;83;83;93;82;85;82;82;86;86;82 08:34:57 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;138;138;138;134;140;164;153;126;190;166 08:34:57 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;188;207;205;229;177;186;166;206;228;171 08:34:57 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;61;64;103;99;86;71;65;68;66;69 08:34:57 INFO - PROCESS | 1684 | __end_tp_report 08:34:57 INFO - PROCESS | 1684 | __start_cc_report 08:34:57 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1080 08:34:57 INFO - PROCESS | 1684 | __end_cc_report 08:34:57 INFO - PROCESS | 1684 | __startTimestamp1461944097146__endTimestamp 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | ------- Summary: start ------- 08:34:57 INFO - PROCESS | 1684 | Number of tests: 14 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:117.80 Median:115.00 stddev:8.56 (7.4%) stddev-sans-first:9.02 08:34:57 INFO - PROCESS | 1684 | Values: 115.0 109.0 115.0 114.0 115.0 128.0 114.0 138.0 116.0 114.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:154.50 stddev:20.22 (13.1%) stddev-sans-first:21.20 08:34:57 INFO - PROCESS | 1684 | Values: 155.0 121.0 144.0 168.0 122.0 139.0 122.0 160.0 178.0 154.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:232.20 Median:239.50 stddev:31.74 (13.3%) stddev-sans-first:31.31 08:34:57 INFO - PROCESS | 1684 | Values: 199.0 218.0 232.0 217.0 247.0 272.0 188.0 271.0 272.0 206.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:78.10 Median:63.00 stddev:30.96 (49.1%) stddev-sans-first:32.47 08:34:57 INFO - PROCESS | 1684 | Values: 65.0 75.0 72.0 140.0 61.0 56.0 57.0 66.0 131.0 58.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:147.00 stddev:24.32 (16.5%) stddev-sans-first:23.24 08:34:57 INFO - PROCESS | 1684 | Values: 81.0 84.0 122.0 105.0 118.0 130.0 106.0 95.0 105.0 164.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:87.00 stddev:15.75 (18.1%) stddev-sans-first:16.45 08:34:57 INFO - PROCESS | 1684 | Values: 89.0 86.0 101.0 112.0 88.0 84.0 89.0 99.0 134.0 86.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:110.50 Median:94.00 stddev:23.22 (24.7%) stddev-sans-first:23.85 08:34:57 INFO - PROCESS | 1684 | Values: 94.0 94.0 120.0 119.0 151.0 149.0 95.0 95.0 94.0 94.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:122.20 Median:143.50 stddev:21.73 (15.1%) stddev-sans-first:22.89 08:34:57 INFO - PROCESS | 1684 | Values: 115.0 150.0 91.0 141.0 143.0 121.0 90.0 114.0 144.0 113.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:63.00 stddev:5.93 (9.4%) stddev-sans-first:6.28 08:34:57 INFO - PROCESS | 1684 | Values: 63.0 63.0 62.0 63.0 61.0 60.0 63.0 80.0 62.0 59.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:70.50 stddev:8.39 (11.9%) stddev-sans-first:8.39 08:34:57 INFO - PROCESS | 1684 | Values: 63.0 67.0 71.0 72.0 74.0 70.0 66.0 66.0 68.0 93.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.00 stddev:3.44 (4.1%) stddev-sans-first:3.61 08:34:57 INFO - PROCESS | 1684 | Values: 83.0 83.0 93.0 82.0 85.0 82.0 82.0 86.0 86.0 82.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:146.50 stddev:19.46 (13.3%) stddev-sans-first:20.25 08:34:57 INFO - PROCESS | 1684 | Values: 138.0 138.0 138.0 134.0 140.0 164.0 153.0 126.0 190.0 166.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.30 Median:205.50 stddev:22.27 (10.8%) stddev-sans-first:23.42 08:34:57 INFO - PROCESS | 1684 | Values: 188.0 207.0 205.0 229.0 177.0 186.0 166.0 206.0 228.0 171.0 08:34:57 INFO - PROCESS | 1684 | 08:34:57 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:68.50 stddev:15.20 (22.2%) stddev-sans-first:15.23 08:34:57 INFO - PROCESS | 1684 | Values: 61.0 64.0 103.0 99.0 86.0 71.0 65.0 68.0 66.0 69.0 08:34:57 INFO - PROCESS | 1684 | -------- Summary: end -------- 08:34:57 INFO - PROCESS | 1684 | 08:34:58 INFO - TEST-INFO | 1684: exit 0 08:34:58 INFO - TEST-OK | kraken | took 61058ms 08:34:58 INFO - SUITE-END | took 1172s 08:34:58 INFO - Completed test suite (00:19:32) 08:34:58 INFO - javascript benchmark 08:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2880.8415537145447, 3432.5366075579796, 3456.360573293941, 3461.6711412415816, 3480.390931586972, 5804.448577385152, 5818.505427038702, 5839.357670656235, 5874.823755287338, 5921.141434492001, 5666.121751128571, 5722.685252311121, 5809.3900140485275, 5848.853778655525, 5933.199018132551, 5220.26916231727, 5288.576913846883, 5331.466853314676, 5353.223782551528, 5379.38137114231, 132.2702084310471, 5321.707306098163, 5336.706481143536, 5338.813141540047, 5379.892402151954, 5248.580113590903, 5263.657862238962, 5290.523852853243, 5307.920381194285, 5308.70802105884, 5211.557017653504, 5341.332333458317, 5358.758855851496, 5363.6245462817615, 5406.405295417501, 5207.010667973073, 5210.4268530461995, 5293.947060529384, 5318.468153184689, 5349.786008559653, 4395.890102747425, 5397.433269506684, 5726.5705072119345, 5747.023006088975, 5850.444207800252, 4808.990112076468, 6144.709610981699, 6222.3466536013975, 6254.249490061222, 6258.718357673915, 6192.59748116371, 6220.657863817488, 6238.656873871935, 6248.4064013918605, 6251.687415629201, 5947.078202878518, 5979.073243647285, 5979.790707325266, 5990.5507086968655, 6035.426634469718, 6167.969160154171, 6241.812745617548, 6258.405451482102, 6323.841903952346, 6329.0, 6179.0, 6225.564210505221, 6228.065790131426, 6255.78104766331, 6265.592736472206, 6167.105769663463, 6236.781712640036, 6241.21984751906, 6259.123722678829, 6280.057991301342, 5463.726813659301, 5980.521558275327, 6155.353687862799, 6195.19462469876, 6250.74997000124, 6086.786962456381, 6155.938440615626, 6228.5951413158, 6232.875342493216, 6265.561410701207, 4628.83799067031, 4852.539008794159, 4972.353594032825, 5003.324551185616, 5003.399592048904, 4427.358033085249, 4429.224885645, 4479.641628669699, 4528.411306530196, 4536.002079542495, 5329.8934021319355, 5788.623739456922, 5845.210896528914, 5867.14926335679, 5904.025835737055, 6203.503719702413, 6205.47253483459, 6208.379162083756, 6225.128482012522, 6239.500839932794, 4517.480489743656, 4739.549742774431, 4971.950280497149, 5911.704414779244, 5981.282246130492, 5460.672359658353, 5469.8085567005755, 5500.339959204921, 5505.587080968863, 5508.283923089973, 6386.904196437057, 6399.360063993563, 6401.711922963478, 6406.263279722798, 6407.359264073555, 6141.977005061692, 6165.691715414301, 6213.0, 6228.844278892882, 6232.875342493216, 6370.140031095742, 6371.331010244043, 6374.713137908898, 6408.423241908251, 6416.51876109303, 6125.663088529996, 6234.625922444668, 6240.251169859646, 6241.531885108726, 6259.374062593704, 6074.3318234994995, 6167.290761562478, 6195.19462469876, 6226.346233645583, 6240.719167637377, 6169.105479705508, 6177.320494745484, 6198.969005154945, 6232.127502149612, 6236.563440559117, 6057.394260573908, 6098.613770999223, 6195.752169913153, 6216.968915155576, 6226.59527130735, 5897.734601943009, 5953.910691339547, 6033.758649653964, 6082.72627731762, 6112.625067133501, 5119.74401279942, 6120.9693951531735, 6176.104464852661, 6182.227221597301, 6195.380461953949, 5992.43071908168, 6043.12374705674, 6044.667543284985, 6080.270367555921, 6137.693115344304], "value": 5675.347567509416, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.3478373762896, 528.4134610582254, 570.8744076303212, 593.2080672302476, 608.05751085817, 33054.66945330546, 39286.8035659822, 39290.8035459823, 39362.0, 39485.0, 40615.796921015426, 40911.59088409115, 41466.58533414665, 41503.79248103763, 41642.7917860411, 9331.860022099658, 9539.284553658468, 9561.0, 9583.95208023959, 9584.616615335413, 9489.05109489049, 9699.321047526675, 9717.659881904136, 9718.757031074208, 9739.659111931083, 9673.95163024184, 9759.41443513388, 9773.218142548614, 9775.608975641002, 9803.754906127333, 9650.71047868565, 9748.366356186896, 9756.219502439822, 9769.462679552622, 9799.314048016642, 9520.23838092951, 9591.232701383873, 9638.987906269811, 9674.854877176847, 9691.854622180674, 38619.613803862165, 38920.610793892265, 39274.60725392738, 39297.80351098255, 39387.0, 2806.031918987946, 2807.9157625271273, 3155.495120780664, 3206.1824234820206, 3445.603755568117, 27428.725712742817, 27473.86263068672, 27489.587656185173, 27938.02216922398, 28246.0, 2711.823731457449, 2737.9726202737916, 2743.986280068587, 2798.6221860048836, 2933.2813460702264, 309219.0, 371971.0, 377206.0, 378547.10726446466, 378694.0, 60587.0, 60782.87259945969, 60918.39081609216, 60954.39045609487, 61012.08481872775, 51016.74491627518, 61198.38801611927, 61989.070163947574, 62293.688531557054, 63117.68441157765, 17010.82989170117, 17173.656526869392, 17360.045197514257, 17363.21865516055, 17366.0, 13234.867651323557, 13244.867551324363, 13287.468501259842, 13288.800667989988, 13295.800562991562, 19576.804231957783, 19684.60630787376, 19948.50128746793, 19968.400947971582, 20037.799622003884, 8113.350931925432, 8174.0, 8194.426390152752, 8199.672013119409, 8265.504069755714, 943.6791490893129, 944.2964991081689, 1024.7847951930178, 1085.7448499602588, 1136.9943150284362, 29710.702892971225, 29961.400771984438, 30320.574354051623, 30492.0, 30532.69467305343, 906.4515967839494, 1031.5718976624767, 1117.1956191542076, 1130.3952385473733, 1194.9342786146672, 15361.846381536265, 15467.0, 15549.533513994598, 15731.842681573267, 15882.76175857363, 452895.0, 469529.0, 470818.0, 470876.0, 635178.0, 57438.0, 57539.0, 58455.53861153505, 58490.12264816031, 58527.0, 1368.4252613902186, 1377.22875189894, 1452.4553292515307, 1463.3195564062762, 1469.2506821521101, 26073.696315184545, 27767.750451230146, 28973.0, 29061.273468163465, 29843.850780745957, 50076.749616253146, 50924.0, 50938.49061509486, 50938.74530627323, 51080.23379649383, 560327.0, 575644.0, 576577.0, 578571.0, 580392.0, 26860.194194174204, 27238.0, 27290.908363665232, 27616.44767104687, 27622.309442264104, 42209.57790422056, 42320.0, 43010.924726882076, 43785.0, 44313.44902928382, 35657.0, 36118.45822312615, 36249.09377265589, 36905.26189476142, 37226.0, 33737.493937590465, 35616.82191589026, 36348.818255908554, 36550.45174322334, 36692.0, 30713.692863071083, 35272.82363588166, 35363.0, 35932.4610130843, 36742.8162859184, 30740.0, 31455.37089258248, 31457.8427107863, 31922.36155276835, 32187.67812321847, 24287.878560607085, 24361.39096522601, 24502.509949800547, 25250.242492725247, 25314.0], "value": 19453.263160423267, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.49281962170693, 385.67217864814893, 393.40082564375825, 398.3765407137829, 407.7553467919247, 19449.513762155937, 20141.39575812728, 20187.798122018776, 20190.59618807623, 20501.794982050174, 16773.0, 20612.9693515324, 20772.272970446036, 21435.571288574218, 21521.24675636353, 5712.971435142818, 5799.21710569072, 5980.820575382745, 6017.0, 6042.0, 5836.708164591774, 5904.202932604107, 5917.674527900964, 5931.872944140599, 5970.0746384310505, 4995.5753760930365, 5057.519535644108, 5849.473547380735, 5914.467697907187, 5922.58541902067, 5828.300603927534, 5832.6500409975115, 5865.794697185599, 5893.233879595625, 5917.467427931485, 5157.871053223662, 5191.714455704935, 5202.2456743771945, 5212.869678258036, 5226.823964607933, 12181.695457613541, 23412.414689632726, 23534.23493238014, 24833.0, 25650.358741031436, 2080.8855512946784, 2182.1380554680973, 2446.54738873309, 2457.8525288482747, 2478.2689106713565, 9725.805483890354, 9816.165625921805, 9965.15296199824, 10061.647842325483, 10102.292839501239, 1527.030335736804, 1569.7723830044579, 1732.6794543009585, 1772.5391398236422, 1933.3619905431315, 102847.48576257071, 119012.40493797562, 123058.0, 132908.0, 135438.0, 11342.262752921033, 11566.710832229262, 11715.1799374043, 11731.0, 11733.120015998835, 14869.033512821848, 14923.477678281426, 14959.551213463395, 14961.476348327757, 14983.0, 8688.348373871984, 8800.207981281588, 8808.0, 8835.116488351114, 8878.644854205888, 8732.519711415805, 8767.868481972775, 8849.955750221208, 8895.021547629885, 8938.955305223562, 4571.451425828922, 4637.768111594407, 4699.365585645894, 4702.95297047032, 4732.455767586703, 1684.3936182974119, 1969.4190213886939, 2021.2521367094268, 2056.3008577083565, 2067.927622533204, 897.721706271045, 902.5442151713343, 903.512103464122, 983.852422136671, 1029.2743615750878, 19550.804491955183, 19769.503988969864, 20644.58710825775, 20871.0, 21381.57236855254, 866.1165611076666, 939.8308304505118, 955.7132860141929, 956.3879117364892, 1032.5714828346152, 8702.608382622797, 10795.46022698862, 11046.33721976684, 11069.280496767684, 11077.556897724, 542418.0, 554694.0, 556384.0, 563246.0, 564628.0, 91322.0, 112666.43666781613, 112877.0, 127070.36464817617, 130563.12465938866, 940.9905900940903, 954.2556805691572, 993.2401712689798, 997.9800403992025, 1073.0610715623673, 15833.050016999017, 17679.558011049827, 18699.439016829518, 18945.052747362854, 19364.0, 51352.295409181635, 51581.0, 51684.741576291875, 52514.0, 53478.73260633828, 76025.61987190029, 76189.23810761822, 77139.0, 78742.0, 79855.0, 8025.438219324591, 8165.38759593021, 8217.383696222687, 8407.621657025571, 8408.453450525696, 9412.717618471457, 10687.679369618923, 12727.427265772878, 12748.0, 13081.411336490071, 11075.169362298022, 11112.0, 11190.66428007161, 11460.0, 11493.965543101162, 10979.890201097887, 11082.833757493483, 11279.210455268052, 11347.829782553103, 11410.0, 4908.263760435963, 5931.6441013539325, 8833.205011548991, 11545.82681259765, 11791.410429478321, 6969.512134150561, 8197.0, 8405.495670259805, 8526.786830329043, 8628.482291062557, 10594.682159535227, 11327.773444531229, 11493.597724079616, 11506.712332191762, 11579.536818527502], "value": 9400.69476729875, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.4882642248792, 1567.3730507796886, 1629.0795700429258, 1939.2049259803475, 1965.0371318054158, 7177.318154775295, 7467.25327467253, 7854.92145078549, 8842.867356989642, 8868.201861832442, 7647.655855486502, 8332.958335208315, 8640.35197360199, 8718.73843784686, 8751.649934002633, 2420.1771397724815, 2444.6455263986713, 2454.1165180534995, 2454.2391858523824, 2457.6436416719566, 2056.290579749991, 2397.523982691721, 2450.840695354805, 2464.346948058766, 2464.470138920132, 2438.548868459332, 2447.437089469423, 2459.446624509489, 2459.9016039358403, 2460.2619214235747, 2423.430493833948, 2428.0, 2437.695288088989, 2444.8533088014774, 2446.1805295226122, 2394.305651361103, 2419.2984034629935, 2431.003288651644, 2432.878356082189, 2441.9389515262083, 8804.383693141483, 8866.290696744309, 8877.778055548599, 8879.156480134377, 8887.466751994836, 5315.734213289359, 5504.339479262474, 5515.751791169407, 5541.473560011793, 5555.027870122713, 3275.5905511811025, 3439.3121375724704, 3637.963620363789, 3642.763220390666, 3683.4658974448553, 1014.1430491234895, 1045.383223897904, 1049.0663309654415, 1053.536443964653, 1070.6680928912062, 11156.888431115665, 11309.604163854226, 11334.659960201125, 11364.943175284154, 11400.885991140065, 3970.4639873616693, 4472.016156445577, 4622.006268652189, 4653.092646933883, 4719.221328480762, 9235.353525253167, 9236.953815230881, 9257.981622021573, 9263.120003599648, 9266.768330791649, 5381.354237491526, 5411.918821217685, 5412.5940554458575, 5412.864678382994, 5421.83734487966, 4503.482099558527, 4838.854834354975, 4874.36633237684, 5029.622778291643, 5082.9579936113005, 3837.5586807516934, 3852.9229415411537, 3924.529056513237, 3948.5459172195565, 4027.959720402817, 1230.1573422205638, 1257.0886107571937, 1261.7413430246777, 1267.7971524556026, 1277.4826195390697, 811.350919264586, 891.4606662968811, 912.3268822350444, 946.7301818981557, 947.9714509756991, 5743.966086104541, 5954.55340849438, 6013.669248191304, 6097.481714054266, 6180.215523910804, 430.1590390786006, 452.4480134236226, 456.85152325494346, 472.92433210686124, 480.9110314591812, 3932.272529581979, 3983.183447393277, 3986.282469155522, 4075.9388609170887, 4088.693347998912, 10271.229657775697, 10659.626913058006, 10761.677149685522, 10815.0, 10903.291286066538, 8172.468789528662, 10089.596416143419, 10648.467576621139, 10742.892571074346, 10785.13718902486, 7282.563046217244, 7436.776896693108, 8079.151689072681, 8147.103818579952, 8149.470284431493, 5718.199452076629, 5725.484706376446, 5789.56578256624, 5828.475437210672, 5890.263717035371, 9803.705888823346, 9815.263855211031, 9994.20046396272, 10040.497975101362, 10170.338927969658, 9918.0, 10070.597176112873, 10217.33587316822, 10301.9484902575, 10316.587336506456, 6362.300146983921, 6854.931450685429, 6988.05661235747, 7068.823279418056, 7071.646417678992, 8212.83574328498, 8260.917390826015, 8290.129536398592, 8338.583070846555, 8342.916570834213, 7284.890726638999, 7453.627318634155, 7465.738699145504, 7577.621118944141, 7620.8475830484185, 7232.0959880015, 7260.419166466564, 7284.016657751347, 7314.524555903849, 7365.226651201761, 7039.0, 7054.964725176546, 7089.929100708927, 7108.502404831612, 7111.60886151246, 4380.080183161572, 4821.276808478756, 4827.403848552393, 4956.231784073474, 4970.204767237225, 4202.180574787887, 4998.525140111684, 5033.0, 5055.848324550269, 5219.32148820666], "value": 4476.170957264846, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.2848020434227, 320.1116900600834, 328.10427532835376, 328.48755940732457, 330.3211899546433, 4354.477462704472, 5424.674519528826, 5448.991936491747, 5521.171824226368, 5572.359178694452, 4357.389965404838, 4955.8106054546915, 5241.0, 5295.655782374152, 5402.459754024596, 3982.681385489161, 4049.068714195737, 4140.695680860535, 4159.916801663965, 4219.2616292148905, 3412.436947903593, 3445.810480423576, 4142.295809712341, 4164.00191861859, 4181.28918083925, 3752.949174231206, 4077.3068578341754, 4108.794560271989, 4130.710850240484, 4142.399352093959, 3720.6093360197196, 3885.6000999125763, 4181.540030596632, 4188.602082802144, 4231.931849409185, 2986.4325778102093, 3571.0715214044276, 3596.7482276240676, 3599.5500562429697, 3619.004773687257, 4368.388425620416, 5185.688858668492, 5289.206619007141, 5290.074237008546, 5299.761510732026, 4518.977405112953, 4632.513586073481, 4761.2143996240575, 4766.856994290177, 4800.967791924753, 4584.495705472429, 4665.650076244296, 5175.861310511719, 5813.767449302023, 5867.3839246879315, 3947.5855035221175, 3953.8731461533325, 3966.643002129822, 3993.1813978134414, 3995.7402768819934, 5641.830745077655, 5827.708614569297, 6054.606450580743, 6108.602940808878, 6131.47882429994, 3748.194138260287, 3839.0786211309087, 4008.4767788240865, 4053.6351728344002, 4059.594040595917, 4071.7353372030725, 4111.958880411217, 4115.526714427879, 4124.278251306009, 4139.958600414017, 4566.178087944136, 4746.0745154694505, 4773.284007398918, 4784.186688263004, 4833.589144922721, 5615.354234263031, 5902.822915312548, 5909.497692696083, 5913.970430147908, 5957.404259574095, 1393.6794537256487, 1462.1300326306043, 1483.903546269489, 1489.143742348154, 1495.2000679636342, 899.7660608241904, 948.6821914658528, 958.9280803939732, 973.634886917406, 982.4645568165367, 5639.210510528529, 5797.565182611321, 5888.735006924613, 5910.645361278251, 5966.910496342558, 6111.938880611226, 6532.379423954717, 6532.412082912466, 6563.3764792344655, 6583.539152259296, 5226.040234911908, 5423.240746295522, 5488.91766623501, 5687.772489100473, 5904.61619994699, 2930.868110935013, 3478.513008178857, 3489.720822334258, 3492.4633161408897, 3514.2268700885766, 6598.769043083469, 6702.463802895757, 6852.349026842442, 6908.412784913238, 6920.861582768316, 6632.2372927114, 6794.048833163361, 6797.1843378794865, 6798.966005169942, 6808.0, 5711.485966263056, 5979.491743201789, 6155.722382718333, 6834.624095674786, 6903.206131294865, 6001.459868611846, 6357.872842543031, 6577.934220657732, 6616.8345791355605, 6624.900626490703, 6311.715972781328, 6507.837304067436, 6517.348265173445, 6543.869122617426, 6546.18172728409, 5534.865352602787, 6166.568340216321, 6246.843828904313, 6837.495750934786, 6857.839780469136, 4232.280512312976, 4272.166927449118, 4275.781402300329, 4279.400883876197, 4315.762633055212, 5373.596980226577, 5552.500274975271, 6384.425401713868, 6588.670566471561, 6605.933940660724, 5561.277033985556, 5573.665580065209, 6349.365063493614, 6402.967985160044, 6432.2602900667025, 5594.0, 6115.318287470981, 6371.649559274099, 6377.0, 6445.2265728112925, 5378.7579558920725, 5660.264165658438, 5778.208755285875, 6225.875482490415, 6259.906101408392, 5160.638755287094, 5596.468335508121, 5866.2373891393845, 5894.498967587803, 6108.51131909455, 5516.393196748435, 5762.337331206797, 5792.218050563289, 5799.187394113936, 5821.330546987151], "value": 4402.023594352867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.3863676099606, 689.8896176611743, 705.3334598804129, 727.5416487612803, 750.5346685055265, 14449.349779259932, 14568.198749068797, 14972.775408368883, 15077.62305942352, 15119.941604087719, 14219.644508887257, 14343.282835858217, 14349.856501435008, 14371.275446946382, 14374.712505749878, 576.6943519934441, 769.8229407236339, 902.5848109869452, 935.2658163341778, 945.7871978804783, 933.0249888866151, 934.3739694404732, 936.2276122199179, 938.5307346326837, 940.4921342475055, 968.5157421289356, 970.839811431113, 972.1299437003877, 974.44456659704, 976.1848856205078, 949.8052899155656, 960.7646126699003, 965.6089283840056, 967.5404183013047, 968.5157421289356, 674.1472037872096, 677.9457643388566, 707.8442742596671, 715.9176694680126, 717.2612209424301, 14678.0, 14694.926525367304, 14706.926465367711, 14774.40902363915, 14945.252737363197, 12492.687682807911, 12608.432620532098, 12633.557825476064, 12727.045471589669, 12863.935680321632, 9269.655899894546, 9640.903590964072, 10068.69793906184, 10129.797404051951, 10357.0, 3452.982735086334, 3472.861085556575, 3473.1838018065732, 3493.615702272748, 3585.3008663310666, 78060.21939780586, 79034.6048269755, 79049.0, 81331.5933420335, 81719.18280817175, 9369.718908432758, 9442.95278523603, 9479.763005924908, 9674.516274186262, 9842.950785246172, 21401.57196856054, 22130.114795408324, 22182.0, 22422.663660045113, 22538.985745641487, 6406.967965160145, 7104.183018952784, 7435.553866768011, 7566.394688424913, 7577.393808495307, 3978.980105099456, 4037.2934736421007, 4039.5152581690386, 4041.4341992121126, 4054.8580799671868, 3630.7640003399692, 3682.705383569308, 3691.1141326081547, 3696.0020794385364, 3703.0742314421395, 568.7895478672917, 584.9707514624251, 593.8218534439651, 601.3415310235285, 612.1796792298342, 483.10862971466315, 517.6117911566325, 524.7481209019692, 551.178743671934, 576.8442520519436, 6894.724211031603, 7986.920130798734, 7993.640286187136, 8138.755837324889, 8201.179882011751, 557.3701717059697, 568.0428478014559, 581.7353104337516, 586.7095787585173, 611.0437165835453, 3774.0564858785306, 3852.056246219694, 3858.530510585305, 3883.339832228528, 3901.3367727486398, 62491.0, 94429.0, 94670.0, 95352.0, 97139.54290685646, 62520.06219906705, 80051.59974200209, 80324.79512807312, 81798.59100704458, 82131.5893420529, 72276.0, 72628.82113536603, 73167.26832731605, 73240.0, 73766.63116684489, 7487.737929172453, 7594.278543538355, 7752.030996125484, 7779.0, 7884.205109244586, 36032.55869765285, 37639.435408468344, 39747.80126099351, 40727.38908916428, 42756.78621606872, 56376.154357683845, 60549.0, 61146.38853611407, 61150.0, 62116.37883621106, 10421.843672345072, 10431.269811113452, 10478.0, 10513.316634418738, 10776.137908967421, 8566.0, 10948.069414099891, 11040.116790656568, 11092.611758588411, 11363.375014373958, 10253.538590763583, 10400.21998350142, 10445.059944605022, 10457.9477102614, 10516.26386152962, 10442.269041167045, 10504.632337868137, 10711.0, 10846.18653600999, 11382.54469821198, 8521.360897932556, 9157.763701900158, 9975.251856110675, 10024.198064154996, 10421.270511064153, 8662.480251184948, 8786.912130878609, 8825.205731484197, 8978.236849867835, 9057.728268151966, 7182.098351869188, 8610.61252243638, 8655.653773849228, 8841.292696584387, 8850.557472126497], "value": 6645.92227369265, "unit": "score"}], "name": "dromaeo_css", "value": 7170.514278230823, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 115.0, 114.0, 115.0, 128.0, 114.0, 138.0, 116.0, 114.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 144.0, 168.0, 122.0, 139.0, 122.0, 160.0, 178.0, 154.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 218.0, 232.0, 217.0, 247.0, 272.0, 188.0, 271.0, 272.0, 206.0], "value": 232.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 72.0, 140.0, 61.0, 56.0, 57.0, 66.0, 131.0, 58.0], "value": 78.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 122.0, 105.0, 118.0, 130.0, 106.0, 95.0, 105.0, 164.0], "value": 111.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 101.0, 112.0, 88.0, 84.0, 89.0, 99.0, 134.0, 86.0], "value": 96.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 120.0, 119.0, 151.0, 149.0, 95.0, 95.0, 94.0, 94.0], "value": 110.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 150.0, 91.0, 141.0, 143.0, 121.0, 90.0, 114.0, 144.0, 113.0], "value": 122.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 61.0, 60.0, 63.0, 80.0, 62.0, 59.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 71.0, 72.0, 74.0, 70.0, 66.0, 66.0, 68.0, 93.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 93.0, 82.0, 85.0, 82.0, 82.0, 86.0, 86.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 138.0, 134.0, 140.0, 164.0, 153.0, 126.0, 190.0, 166.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 207.0, 205.0, 229.0, 177.0, 186.0, 166.0, 206.0, 228.0, 171.0], "value": 196.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 64.0, 103.0, 99.0, 86.0, 71.0, 65.0, 68.0, 66.0, 69.0], "value": 75.2, "unit": "score"}], "name": "kraken", "value": 1654.1000000000001, "alertThreshold": 2.0}]} 08:34:58 INFO - Return code: 0 08:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:34:58 ERROR - # TBPL SUCCESS # 08:34:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:34:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:34:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:34:58 INFO - 2016-04-29 08:34:58.470 screenresolution[1689:11091] starting screenresolution argv=screenresolution get 08:34:58 INFO - 2016-04-29 08:34:58.473 screenresolution[1689:11091] Display 0: 1600x1200x32@60 08:34:58 INFO - 2016-04-29 08:34:58.479 screenresolution[1690:11094] starting screenresolution argv=screenresolution list 08:34:58 INFO - Available Modes on Display 0 08:34:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:34:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:34:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:34:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:34:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:34:58 INFO - Intel Iris: 08:34:58 INFO - Chipset Model: Intel Iris 08:34:58 INFO - Type: GPU 08:34:58 INFO - Bus: Built-In 08:34:58 INFO - VRAM (Dynamic, Max): 1536 MB 08:34:58 INFO - Vendor: Intel (0x8086) 08:34:58 INFO - Device ID: 0x0a2e 08:34:58 INFO - Revision ID: 0x0009 08:34:58 INFO - Displays: 08:34:58 INFO - Display: 08:34:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:34:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:34:58 INFO - Display Serial Number: 1600x1200 60 08:34:58 INFO - Main Display: Yes 08:34:58 INFO - Mirror: Off 08:34:58 INFO - Online: Yes 08:34:58 INFO - Rotation: Supported 08:34:58 INFO - Return code: 0 08:34:58 INFO - Running post-action listener: _resource_record_post_action 08:34:58 INFO - Running post-run listener: _resource_record_post_run 08:34:59 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 43782656; Write bytes: 709933568; Read time: 494; Write time: 2111 08:34:59 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 383255040; Write bytes: 377157632; Read time: 28418; Write time: 755 08:34:59 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 42861056; Write bytes: 311681536; Read time: 480; Write time: 1315 08:34:59 INFO - Running post-run listener: _upload_blobber_files 08:34:59 INFO - Blob upload gear active. 08:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:59 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:34:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:35:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:00 INFO - (blobuploader) - INFO - Done attempting. 08:35:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:35:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:35:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:01 INFO - (blobuploader) - INFO - Done attempting. 08:35:01 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:01 INFO - Return code: 0 08:35:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24468656a5ff3428cdc3cf5e6a4f9bc032d62cdf09706f8bc932c8ea4b18665987064e3b467a287d0c7accc83f08fef423e88206a396d229a921ead8fecb63e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d2765498bfc6e31c5bd934ae6aeed1f4d27aa216554994210238d95000f42a968458d6c10b6747046a307adaf41d387a2ce6300a2f5ad7e2de67bbbf914eb"} 08:35:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:01 INFO - Contents: 08:35:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/24468656a5ff3428cdc3cf5e6a4f9bc032d62cdf09706f8bc932c8ea4b18665987064e3b467a287d0c7accc83f08fef423e88206a396d229a921ead8fecb63e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d2765498bfc6e31c5bd934ae6aeed1f4d27aa216554994210238d95000f42a968458d6c10b6747046a307adaf41d387a2ce6300a2f5ad7e2de67bbbf914eb"} 08:35:01 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:01 INFO - Copying logs to upload dir... 08:35:01 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1301.834465 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 41 secs) (at 2016-04-29 08:35:02.024275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 08:35:02.028414) ========= 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.2JYD0DgPab/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.87DWKdwGM2/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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/24468656a5ff3428cdc3cf5e6a4f9bc032d62cdf09706f8bc932c8ea4b18665987064e3b467a287d0c7accc83f08fef423e88206a396d229a921ead8fecb63e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d2765498bfc6e31c5bd934ae6aeed1f4d27aa216554994210238d95000f42a968458d6c10b6747046a307adaf41d387a2ce6300a2f5ad7e2de67bbbf914eb"} build_url:https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010989 build_url: 'https://queue.taskcluster.net/v1/task/NlVfCiGbQkShLL1bKfxoeA/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/24468656a5ff3428cdc3cf5e6a4f9bc032d62cdf09706f8bc932c8ea4b18665987064e3b467a287d0c7accc83f08fef423e88206a396d229a921ead8fecb63e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/989d2765498bfc6e31c5bd934ae6aeed1f4d27aa216554994210238d95000f42a968458d6c10b6747046a307adaf41d387a2ce6300a2f5ad7e2de67bbbf914eb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-29 08:35:02.056627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:35:02.057060) ========= 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.2JYD0DgPab/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.87DWKdwGM2/Listeners TMPDIR=/var/folders/_v/qcc1dbqn143dkpf_m98bdkkr00000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-29 08:35:02.105868) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 08:35:02.106229) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-29 08:35:02.106653) ========= ========= Total master_lag: 0.18 =========