builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0180 starttime: 1461586042.69 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.693704) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.694118) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.694440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.713444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.713979) ========= 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.608JMxrnTX/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.rRCWlUAfZy/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-25 05:07:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.5M=0.001s 2016-04-25 05:07:22 (15.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.186423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.918454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.918812) ========= 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.608JMxrnTX/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.rRCWlUAfZy/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.020107 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:22.970781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:07:22.971588) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --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 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.608JMxrnTX/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.rRCWlUAfZy/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-25 05:07:23,052 truncating revision to first 12 chars 2016-04-25 05:07:23,052 Setting DEBUG logging. 2016-04-25 05:07:23,052 attempt 1/10 2016-04-25 05:07:23,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 05:07:24,158 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354398 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:07:24.348740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:24.349540) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:24.350398) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:24.350893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:24.371890) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-25 05:07:24.372298) ========= /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.608JMxrnTX/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.rRCWlUAfZy/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:07:24 INFO - MultiFileLogger online at 20160425 05:07:24 in /builds/slave/test 05:07:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:24 INFO - {'append_to_log': False, 05:07:24 INFO - 'base_work_dir': '/builds/slave/test', 05:07:24 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:24 INFO - 'branch': 'Fx-Team', 05:07:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:24 INFO - 'config_files': ('talos/mac_config.py',), 05:07:24 INFO - 'default_actions': ('clobber', 05:07:24 INFO - 'read-buildbot-config', 05:07:24 INFO - 'download-and-extract', 05:07:24 INFO - 'populate-webroot', 05:07:24 INFO - 'create-virtualenv', 05:07:24 INFO - 'install', 05:07:24 INFO - 'run-tests'), 05:07:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:24 INFO - 'download_minidump_stackwalk': True, 05:07:24 INFO - 'download_symbols': 'ondemand', 05:07:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:24 INFO - 'installer_path': 'installer.exe', 05:07:24 INFO - 'log_level': 'info', 05:07:24 INFO - 'log_name': 'talos', 05:07:24 INFO - 'log_to_console': True, 05:07:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:24 INFO - 'opt_config_files': (), 05:07:24 INFO - 'pip_index': False, 05:07:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:24 INFO - 'cmd': ('bash', 05:07:24 INFO - '-c', 05:07:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:24 INFO - 'enabled': True, 05:07:24 INFO - 'halt_on_failure': False, 05:07:24 INFO - 'name': 'check_screen_resolution'},), 05:07:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:24 INFO - 'cmd': ('bash', 05:07:24 INFO - '-c', 05:07:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:24 INFO - 'enabled': True, 05:07:24 INFO - 'halt_on_failure': False, 05:07:24 INFO - 'name': 'check_screen_resolution'},), 05:07:24 INFO - 'run_cmd_checks_enabled': True, 05:07:24 INFO - 'sps_profile': False, 05:07:24 INFO - 'sps_profile_interval': 0, 05:07:24 INFO - 'suite': 'dromaeojs-e10s', 05:07:24 INFO - 'system_bits': '32', 05:07:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:24 INFO - 'title': 't-yosemite-r7-0180', 05:07:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:24 INFO - 'use_talos_json': True, 05:07:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:24 INFO - 'work_dir': 'build'} 05:07:24 INFO - ##### 05:07:24 INFO - ##### Running clobber step. 05:07:24 INFO - ##### 05:07:24 INFO - Running pre-action listener: _resource_record_pre_action 05:07:24 INFO - Running main action method: clobber 05:07:24 INFO - rmtree: /builds/slave/test/build 05:07:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:25 INFO - Running post-action listener: _resource_record_post_action 05:07:25 INFO - ##### 05:07:25 INFO - ##### Running read-buildbot-config step. 05:07:25 INFO - ##### 05:07:25 INFO - Running pre-action listener: _resource_record_pre_action 05:07:25 INFO - Running main action method: read_buildbot_config 05:07:25 INFO - Using buildbot properties: 05:07:25 INFO - { 05:07:25 INFO - "project": "", 05:07:25 INFO - "product": "firefox", 05:07:25 INFO - "script_repo_revision": "production", 05:07:25 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:07:25 INFO - "repository": "", 05:07:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:07:25 INFO - "buildid": "20160422035423", 05:07:25 INFO - "pgo_build": "False", 05:07:25 INFO - "basedir": "/builds/slave/test", 05:07:25 INFO - "buildnumber": 640, 05:07:25 INFO - "slavename": "t-yosemite-r7-0180", 05:07:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:07:25 INFO - "platform": "yosemite_r7", 05:07:25 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:07:25 INFO - "branch": "fx-team", 05:07:25 INFO - "repo_path": "integration/fx-team", 05:07:25 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:07:25 INFO - "stage_platform": "macosx64", 05:07:25 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:07:25 INFO - "slavebuilddir": "test" 05:07:25 INFO - } 05:07:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:07:25 INFO - Running post-action listener: _resource_record_post_action 05:07:25 INFO - ##### 05:07:25 INFO - ##### Running download-and-extract step. 05:07:25 INFO - ##### 05:07:25 INFO - Running pre-action listener: _resource_record_pre_action 05:07:25 INFO - Running main action method: download_and_extract 05:07:25 INFO - mkdir: /builds/slave/test/build/tests 05:07:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:25 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:07:26 INFO - Downloaded 1199 bytes. 05:07:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:26 INFO - Using the following test package requirements: 05:07:26 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:07:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'jsshell-mac.zip'], 05:07:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:07:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:07:26 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:07:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:07:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:26 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07: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')]} 05:07:26 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:29 INFO - Downloaded 18105795 bytes. 05:07:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:32 INFO - Return code: 0 05:07:32 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:07: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')]} 05:07:32 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:34 INFO - Downloaded 18105795 bytes. 05:07:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:37 INFO - Return code: 0 05:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:37 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:07:38 INFO - Downloaded 10845952 bytes. 05:07:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:07:38 INFO - Return code: 0 05:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:38 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:07:41 INFO - Downloaded 110035353 bytes. 05:07:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:41 INFO - mkdir: /builds/slave/test/properties 05:07:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:41 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:41 INFO - Contents: 05:07:41 INFO - build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:42 INFO - Running post-action listener: _resource_record_post_action 05:07:42 INFO - Running post-action listener: set_extra_try_arguments 05:07:42 INFO - ##### 05:07:42 INFO - ##### Running populate-webroot step. 05:07:42 INFO - ##### 05:07:42 INFO - Running pre-action listener: _resource_record_pre_action 05:07:42 INFO - Running main action method: populate_webroot 05:07:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:42 INFO - '--tppagecycles', 05:07:42 INFO - '7'], 05:07:42 INFO - 'tests': ['tsvgm']}}, 05:07:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['damp', 'tps']}, 05:07:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'tests': ['damp', 'tps']}, 05:07:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['dromaeo_dom']}, 05:07:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['a11yr', 05:07:42 INFO - 'ts_paint', 05:07:42 INFO - 'tpaint', 05:07:42 INFO - 'sessionrestore', 05:07:42 INFO - 'sessionrestore_no_auto_restore', 05:07:42 INFO - 'tabpaint']}, 05:07:42 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:42 INFO - 'ts_paint', 05:07:42 INFO - 'tpaint', 05:07:42 INFO - 'sessionrestore', 05:07:42 INFO - 'sessionrestore_no_auto_restore', 05:07:42 INFO - 'tabpaint']}, 05:07:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:42 INFO - 'ts_paint', 05:07:42 INFO - 'tpaint', 05:07:42 INFO - 'sessionrestore', 05:07:42 INFO - 'sessionrestore_no_auto_restore', 05:07:42 INFO - 'tabpaint']}, 05:07:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:42 INFO - 'ts_paint', 05:07:42 INFO - 'tpaint', 05:07:42 INFO - 'sessionrestore', 05:07:42 INFO - 'sessionrestore_no_auto_restore', 05:07:42 INFO - 'tabpaint']}, 05:07:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['a11yr', 05:07:42 INFO - 'ts_paint', 05:07:42 INFO - 'tpaint', 05:07:42 INFO - 'sessionrestore', 05:07:42 INFO - 'sessionrestore_no_auto_restore', 05:07:42 INFO - 'tabpaint']}, 05:07:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['a11yr', 05:07:42 INFO - 'ts_paint', 05:07:42 INFO - 'tpaint', 05:07:42 INFO - 'sessionrestore', 05:07:42 INFO - 'sessionrestore_no_auto_restore', 05:07:42 INFO - 'tabpaint']}, 05:07:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['tsvgx', 05:07:42 INFO - 'tsvgr_opacity', 05:07:42 INFO - 'tart', 05:07:42 INFO - 'tscrollx', 05:07:42 INFO - 'cart']}, 05:07:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:42 INFO - 'tsvgr_opacity', 05:07:42 INFO - 'tart', 05:07:42 INFO - 'tscrollx', 05:07:42 INFO - 'cart']}, 05:07:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'talos_options': ['--disable-e10s'], 05:07:42 INFO - 'tests': ['tp5o']}, 05:07:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'tests': ['tp5o']}, 05:07:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'talos_options': ['--disable-e10s', 05:07:42 INFO - '--xperf_path', 05:07:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:42 INFO - 'tests': ['tp5n']}, 05:07:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:42 INFO - 'talos_options': ['--xperf_path', 05:07:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:42 INFO - 'tests': ['tp5n']}}, 05:07:42 INFO - 'talos.zip': {'path': '', 05:07:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:42 INFO - Running post-action listener: _resource_record_post_action 05:07:42 INFO - ##### 05:07:42 INFO - ##### Running create-virtualenv step. 05:07:42 INFO - ##### 05:07:42 INFO - Running pre-action listener: _resource_record_pre_action 05:07:42 INFO - Running main action method: create_virtualenv 05:07:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:42 INFO - Using real prefix '/tools/python27' 05:07:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:07:46 INFO - Installing pip.................done. 05:07:46 INFO - Return code: 0 05:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:07: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', 'pip>=1.5'] in /builds/slave/test/build 05:07: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 pip>=1.5 05:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:46 INFO - 'HOME': '/Users/cltbld', 05:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PAGER': '/bin/cat', 05:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:07:46 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - 'XPC_FLAGS': '0x0', 05:07:46 INFO - 'XPC_SERVICE_NAME': '0', 05:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:46 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:07:46 INFO - Cleaning up... 05:07:46 INFO - Return code: 0 05:07:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:07: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')]} 05:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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')]} 05:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07: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', '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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:07: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:07: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 psutil>=0.7.1 05:07:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:07:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:46 INFO - 'HOME': '/Users/cltbld', 05:07:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:46 INFO - 'LOGNAME': 'cltbld', 05:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:46 INFO - 'MOZ_NO_REMOTE': '1', 05:07:46 INFO - 'NO_EM_RESTART': '1', 05:07:46 INFO - 'PAGER': '/bin/cat', 05:07:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:46 INFO - 'PWD': '/builds/slave/test', 05:07:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:46 INFO - 'SHELL': '/bin/bash', 05:07:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:07:46 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:07:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:46 INFO - 'USER': 'cltbld', 05:07:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:46 INFO - 'XPC_FLAGS': '0x0', 05:07:46 INFO - 'XPC_SERVICE_NAME': '0', 05:07:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:46 INFO - Downloading/unpacking psutil>=0.7.1 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07: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 05:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:49 INFO - Installing collected packages: psutil 05:07:49 INFO - Running setup.py install for psutil 05:07:49 INFO - building 'psutil._psutil_osx' extension 05:07:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:07:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:07:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:07:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:07:49 INFO - building 'psutil._psutil_posix' extension 05:07:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:07:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:07:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:07:49 INFO - ^ 05:07:50 INFO - 1 warning generated. 05:07:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:07:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:07:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:07:50 INFO - Successfully installed psutil 05:07:50 INFO - Cleaning up... 05:07:50 INFO - Return code: 0 05:07:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:50 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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:07:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:07:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:50 INFO - 'HOME': '/Users/cltbld', 05:07:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:50 INFO - 'LOGNAME': 'cltbld', 05:07:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:50 INFO - 'MOZ_NO_REMOTE': '1', 05:07:50 INFO - 'NO_EM_RESTART': '1', 05:07:50 INFO - 'PAGER': '/bin/cat', 05:07:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:50 INFO - 'PWD': '/builds/slave/test', 05:07:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:50 INFO - 'SHELL': '/bin/bash', 05:07:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:07:50 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:07:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:50 INFO - 'USER': 'cltbld', 05:07:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:50 INFO - 'XPC_FLAGS': '0x0', 05:07:50 INFO - 'XPC_SERVICE_NAME': '0', 05:07:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:07:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:07:53 INFO - Installing collected packages: mozsystemmonitor 05:07:53 INFO - Running setup.py install for mozsystemmonitor 05:07:53 INFO - Successfully installed mozsystemmonitor 05:07:53 INFO - Cleaning up... 05:07:53 INFO - Return code: 0 05:07:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:53 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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:07:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:07:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:07:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:07:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:53 INFO - 'HOME': '/Users/cltbld', 05:07:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:53 INFO - 'LOGNAME': 'cltbld', 05:07:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:53 INFO - 'MOZ_NO_REMOTE': '1', 05:07:53 INFO - 'NO_EM_RESTART': '1', 05:07:53 INFO - 'PAGER': '/bin/cat', 05:07:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:53 INFO - 'PWD': '/builds/slave/test', 05:07:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:53 INFO - 'SHELL': '/bin/bash', 05:07:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:07:53 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:07:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:53 INFO - 'USER': 'cltbld', 05:07:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:53 INFO - 'XPC_FLAGS': '0x0', 05:07:53 INFO - 'XPC_SERVICE_NAME': '0', 05:07:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:53 INFO - Downloading/unpacking blobuploader==1.2.4 05:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:55 INFO - Downloading blobuploader-1.2.4.tar.gz 05:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:07:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:07:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:07:56 INFO - Downloading docopt-0.6.1.tar.gz 05:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 05:07:57 INFO - Running setup.py install for blobuploader 05:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:07:57 INFO - Running setup.py install for requests 05:07:57 INFO - Running setup.py install for docopt 05:07:57 INFO - Successfully installed blobuploader requests docopt 05:07:57 INFO - Cleaning up... 05:07:57 INFO - Return code: 0 05:07:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:07:57 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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:07:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:07:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:07:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:07:57 INFO - 'HOME': '/Users/cltbld', 05:07:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:07:57 INFO - 'LOGNAME': 'cltbld', 05:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:07:57 INFO - 'MOZ_NO_REMOTE': '1', 05:07:57 INFO - 'NO_EM_RESTART': '1', 05:07:57 INFO - 'PAGER': '/bin/cat', 05:07:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:07:57 INFO - 'PWD': '/builds/slave/test', 05:07:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:07:57 INFO - 'SHELL': '/bin/bash', 05:07:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:07:57 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:07:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:07:57 INFO - 'USER': 'cltbld', 05:07:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:07:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:07:57 INFO - 'XPC_FLAGS': '0x0', 05:07:57 INFO - 'XPC_SERVICE_NAME': '0', 05:07:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-NvnP6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3UbKlE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-WVdR4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-TDj0rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-90c3IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-eYD0Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-v7jOUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:07:58 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-YEODYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-s9W3Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tSJUiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-txaglp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-PPpCIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-OEKssE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_fGXlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-TU8xqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-GKwqvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:07:59 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-6LyXAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:00 INFO - Running setup.py install for manifestparser 05:08:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozcrash 05:08:00 INFO - Running setup.py install for mozdebug 05:08:00 INFO - Running setup.py install for mozdevice 05:08:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozfile 05:08:00 INFO - Running setup.py install for mozhttpd 05:08:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:00 INFO - Running setup.py install for mozinfo 05:08:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Running setup.py install for mozInstall 05:08:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Running setup.py install for mozleak 05:08:01 INFO - Running setup.py install for mozlog 05:08:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Running setup.py install for moznetwork 05:08:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Running setup.py install for mozprocess 05:08:01 INFO - Running setup.py install for mozprofile 05:08:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:02 INFO - Running setup.py install for mozrunner 05:08:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:02 INFO - Running setup.py install for mozscreenshot 05:08:02 INFO - Running setup.py install for moztest 05:08:02 INFO - Running setup.py install for mozversion 05:08:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:02 INFO - Cleaning up... 05:08:02 INFO - Return code: 0 05:08:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:02 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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:08:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:02 INFO - 'HOME': '/Users/cltbld', 05:08:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:02 INFO - 'LOGNAME': 'cltbld', 05:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:02 INFO - 'MOZ_NO_REMOTE': '1', 05:08:02 INFO - 'NO_EM_RESTART': '1', 05:08:02 INFO - 'PAGER': '/bin/cat', 05:08:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:02 INFO - 'PWD': '/builds/slave/test', 05:08:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:02 INFO - 'SHELL': '/bin/bash', 05:08:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:08:02 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:08:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:02 INFO - 'USER': 'cltbld', 05:08:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:02 INFO - 'XPC_FLAGS': '0x0', 05:08:02 INFO - 'XPC_SERVICE_NAME': '0', 05:08:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:02 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-vrpQfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-yeYSJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-1Z3cnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-87OmKy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-3dVwI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-CRUcLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-6IT59R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-8VNsWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-AvPKUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4BjmtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:03 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-_w0RHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-ja1sUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-4OPRq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-7X5Jlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Wz2Nt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-BonZCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:04 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-L7Wc32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - Downloading blessings-1.6.tar.gz 05:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:07 INFO - Installing collected packages: blessings 05:08:07 INFO - Running setup.py install for blessings 05:08:07 INFO - Successfully installed blessings 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:07 INFO - Reading from file tmpfile_stdout 05:08:07 INFO - Current package versions: 05:08:07 INFO - blessings == 1.6 05:08:07 INFO - blobuploader == 1.2.4 05:08:07 INFO - docopt == 0.6.1 05:08:07 INFO - manifestparser == 1.1 05:08:07 INFO - mozInstall == 1.12 05:08:07 INFO - mozcrash == 0.17 05:08:07 INFO - mozdebug == 0.1 05:08:07 INFO - mozdevice == 0.48 05:08:07 INFO - mozfile == 1.2 05:08:07 INFO - mozhttpd == 0.7 05:08:07 INFO - mozinfo == 0.9 05:08:07 INFO - mozleak == 0.1 05:08:07 INFO - mozlog == 3.1 05:08:07 INFO - moznetwork == 0.27 05:08:07 INFO - mozprocess == 0.22 05:08:07 INFO - mozprofile == 0.28 05:08:07 INFO - mozrunner == 6.11 05:08:07 INFO - mozscreenshot == 0.1 05:08:07 INFO - mozsystemmonitor == 0.0 05:08:07 INFO - moztest == 0.7 05:08:07 INFO - mozversion == 1.4 05:08:07 INFO - psutil == 3.1.1 05:08:07 INFO - requests == 1.2.3 05:08:07 INFO - wsgiref == 0.1.2 05:08:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:07 INFO - 'HOME': '/Users/cltbld', 05:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:07 INFO - 'LOGNAME': 'cltbld', 05:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:07 INFO - 'MOZ_NO_REMOTE': '1', 05:08:07 INFO - 'NO_EM_RESTART': '1', 05:08:07 INFO - 'PAGER': '/bin/cat', 05:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:07 INFO - 'PWD': '/builds/slave/test', 05:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:07 INFO - 'SHELL': '/bin/bash', 05:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:08:07 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:07 INFO - 'USER': 'cltbld', 05:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:07 INFO - 'XPC_FLAGS': '0x0', 05:08:07 INFO - 'XPC_SERVICE_NAME': '0', 05:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:08 INFO - Cleaning up... 05:08:08 INFO - Return code: 0 05:08:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 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 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:08 INFO - 'HOME': '/Users/cltbld', 05:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:08 INFO - 'LOGNAME': 'cltbld', 05:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:08 INFO - 'MOZ_NO_REMOTE': '1', 05:08:08 INFO - 'NO_EM_RESTART': '1', 05:08:08 INFO - 'PAGER': '/bin/cat', 05:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:08 INFO - 'PWD': '/builds/slave/test', 05:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:08 INFO - 'SHELL': '/bin/bash', 05:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:08:08 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:08 INFO - 'USER': 'cltbld', 05:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:08 INFO - 'XPC_FLAGS': '0x0', 05:08:08 INFO - 'XPC_SERVICE_NAME': '0', 05:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Downloading/unpacking jsonschema 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:10 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:11 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:11 INFO - warning: no files found matching '*.txt' 05:08:11 INFO - no previously-included directories found matching 'build' 05:08:11 INFO - no previously-included directories found matching 'dist' 05:08:11 INFO - no previously-included directories found matching '.git*' 05:08:11 INFO - Installing collected packages: jsonschema, functools32 05:08:11 INFO - Running setup.py install for functools32 05:08:11 INFO - warning: no files found matching '*.txt' 05:08:11 INFO - no previously-included directories found matching 'build' 05:08:11 INFO - no previously-included directories found matching 'dist' 05:08:11 INFO - no previously-included directories found matching '.git*' 05:08:11 INFO - Successfully installed jsonschema functools32 05:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ea2aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ea3a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb41c85850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, '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.608JMxrnTX/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.rRCWlUAfZy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:11 INFO - 'HOME': '/Users/cltbld', 05:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:11 INFO - 'LOGNAME': 'cltbld', 05:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:11 INFO - 'MOZ_NO_REMOTE': '1', 05:08:11 INFO - 'NO_EM_RESTART': '1', 05:08:11 INFO - 'PAGER': '/bin/cat', 05:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:11 INFO - 'PWD': '/builds/slave/test', 05:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:11 INFO - 'SHELL': '/bin/bash', 05:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:08:11 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:11 INFO - 'USER': 'cltbld', 05:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:11 INFO - 'XPC_FLAGS': '0x0', 05:08:11 INFO - 'XPC_SERVICE_NAME': '0', 05:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 INFO - Downloading/unpacking flake8 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:15 INFO - no previously-included directories found matching 'docs/_build' 05:08:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:15 INFO - Running setup.py install for pep8 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:15 INFO - no previously-included directories found matching 'docs/_build' 05:08:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:15 INFO - Cleaning up... 05:08:15 INFO - Return code: 0 05:08:15 INFO - Running post-action listener: _resource_record_post_action 05:08:15 INFO - Running post-action listener: _start_resource_monitoring 05:08:15 INFO - Starting resource monitoring. 05:08:15 INFO - ##### 05:08:15 INFO - ##### Running install step. 05:08:15 INFO - ##### 05:08:15 INFO - Running pre-action listener: _resource_record_pre_action 05:08:15 INFO - Running main action method: install 05:08:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:16 INFO - Reading from file tmpfile_stdout 05:08:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:16 INFO - Reading from file tmpfile_stdout 05:08:16 INFO - Output received: 05:08:16 INFO - Usage: mozinstall [options] installer 05:08:16 INFO - Options: 05:08:16 INFO - -h, --help show this help message and exit 05:08:16 INFO - -d DEST, --destination=DEST 05:08:16 INFO - Directory to install application into. [default: 05:08:16 INFO - "/builds/slave/test"] 05:08:16 INFO - --app=APP Application being installed. [default: firefox] 05:08:16 INFO - mkdir: /builds/slave/test/build/application 05:08:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:08:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:08:49 INFO - Reading from file tmpfile_stdout 05:08:49 INFO - Output received: 05:08:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:08:49 INFO - Running post-action listener: _resource_record_post_action 05:08:49 INFO - ##### 05:08:49 INFO - ##### Running run-tests step. 05:08:49 INFO - ##### 05:08:49 INFO - Running pre-action listener: _resource_record_pre_action 05:08:49 INFO - Running main action method: run_tests 05:08:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:08:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:08:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:08:49 INFO - 2016-04-25 05:08:49.945 screenresolution[2001:13760] starting screenresolution argv=screenresolution get 05:08:49 INFO - 2016-04-25 05:08:49.948 screenresolution[2001:13760] Display 0: 1600x1200x32@60 05:08:49 INFO - 2016-04-25 05:08:49.954 screenresolution[2002:13762] starting screenresolution argv=screenresolution list 05:08:49 INFO - Available Modes on Display 0 05:08:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:08:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:08:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:08:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:08:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:08:50 INFO - Intel Iris: 05:08:50 INFO - Chipset Model: Intel Iris 05:08:50 INFO - Type: GPU 05:08:50 INFO - Bus: Built-In 05:08:50 INFO - VRAM (Dynamic, Max): 1536 MB 05:08:50 INFO - Vendor: Intel (0x8086) 05:08:50 INFO - Device ID: 0x0a2e 05:08:50 INFO - Revision ID: 0x0009 05:08:50 INFO - Displays: 05:08:50 INFO - Display: 05:08:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:08:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:08:50 INFO - Display Serial Number: 1600x1200 60 05:08:50 INFO - Main Display: Yes 05:08:50 INFO - Mirror: Off 05:08:50 INFO - Online: Yes 05:08:50 INFO - Rotation: Supported 05:08:50 INFO - Return code: 0 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:08:50 INFO - Python 2.7.3 05:08:50 INFO - Return code: 0 05:08:50 INFO - grabbing minidump binary from tooltool 05:08:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:50 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 0x10e8c9e00>, '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 0x10e732db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e8c4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:08:50 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:08:50 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:08:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:08:50 INFO - Return code: 0 05:08:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:08:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:08:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:08:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:08:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:08:51 INFO - Return code: 0 05:08:51 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/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:08:51 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/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:08:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.608JMxrnTX/Render', 05:08:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:51 INFO - 'HOME': '/Users/cltbld', 05:08:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:51 INFO - 'LOGNAME': 'cltbld', 05:08:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:08:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:08:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:51 INFO - 'MOZ_NO_REMOTE': '1', 05:08:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:08:51 INFO - 'NO_EM_RESTART': '1', 05:08:51 INFO - 'PAGER': '/bin/cat', 05:08:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:51 INFO - 'PWD': '/builds/slave/test', 05:08:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:08:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:51 INFO - 'SHELL': '/bin/bash', 05:08:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRCWlUAfZy/Listeners', 05:08:51 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 05:08:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:51 INFO - 'USER': 'cltbld', 05:08:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:51 INFO - 'XPC_FLAGS': '0x0', 05:08:51 INFO - 'XPC_SERVICE_NAME': '0', 05:08:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:51 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/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:08:51 INFO - mozversion application_buildid: 20160422035423 05:08:51 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:08:51 INFO - mozversion application_display_name: Nightly 05:08:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:08:51 INFO - mozversion application_name: Firefox 05:08:51 INFO - mozversion application_remotingname: firefox 05:08:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:08:51 INFO - mozversion application_vendor: Mozilla 05:08:51 INFO - mozversion application_version: 48.0a1 05:08:51 INFO - mozversion platform_buildid: 20160422035423 05:08:51 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:08:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:08:51 INFO - mozversion platform_version: 48.0a1 05:08:51 INFO - using testdate: 1461586131 05:08:51 INFO - actual date: 1461586131 05:08:51 INFO - starting webserver on 'localhost:51367' 05:08:51 INFO - SUITE-START | Running 2 tests 05:08:51 INFO - TEST-START | dromaeo_css 05:08:51 INFO - operating with platform_type : mac_ 05:08:51 INFO - Initialising browser for dromaeo_css test... 05:08:51 INFO - TEST-INFO | started process 2020 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpDow2hH/profile http://localhost:51367/getInfo.html) 05:08:54 INFO - PROCESS | 2020 | __metrics Screen width/height:1600/1200 05:08:54 INFO - PROCESS | 2020 | colorDepth:24 05:08:54 INFO - PROCESS | 2020 | Browser inner width/height: 1024/689 05:08:54 INFO - PROCESS | 2020 | __metrics 05:08:54 ERROR - PROCESS | 2020 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:08:55 INFO - TEST-INFO | 2020: exit 0 05:08:55 INFO - Browser initialized. 05:08:55 INFO - Running cycle 1/1 for dromaeo_css test... 05:08:55 INFO - TEST-INFO | started process 2023 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpDow2hH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:07 INFO - PROCESS | 2023 | RSS: Main: 247918592 05:09:07 INFO - PROCESS | 2023 | 05:09:57 INFO - PROCESS | 2023 | 1461586197012 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:12:08 INFO - PROCESS | 2023 | Cycle 1(1): loaded http://localhost:51367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51367/tests/dromaeo/cssquery-ext.html) 05:12:09 INFO - PROCESS | 2023 | RSS: Main: 261570560 05:12:09 INFO - PROCESS | 2023 | 05:15:11 INFO - PROCESS | 2023 | Cycle 1(1): loaded http://localhost:51367/tests/dromaeo/cssquery-ext.html (next: http://localhost:51367/tests/dromaeo/cssquery-jquery.html) 05:15:12 INFO - PROCESS | 2023 | RSS: Main: 274001920 05:15:12 INFO - PROCESS | 2023 | 05:18:13 INFO - PROCESS | 2023 | Cycle 1(1): loaded http://localhost:51367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51367/tests/dromaeo/cssquery-mootools.html) 05:18:14 INFO - PROCESS | 2023 | RSS: Main: 275312640 05:18:14 INFO - PROCESS | 2023 | 05:21:16 INFO - PROCESS | 2023 | Cycle 1(1): loaded http://localhost:51367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51367/tests/dromaeo/cssquery-prototype.html) 05:21:16 INFO - PROCESS | 2023 | RSS: Main: 277049344 05:21:16 INFO - PROCESS | 2023 | 05:24:19 INFO - PROCESS | 2023 | Cycle 1(1): loaded http://localhost:51367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51367/tests/dromaeo/cssquery-yui.html) 05:24:20 INFO - PROCESS | 2023 | RSS: Main: 279965696 05:24:20 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | Cycle 1(1): loaded http://localhost:51367/tests/dromaeo/cssquery-yui.html (next: http://localhost:51367/tests/dromaeo/cssquery-dojo.html) 05:27:22 INFO - PROCESS | 2023 | RSS: Main: 280936448 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | __start_tp_report 05:27:22 INFO - PROCESS | 2023 | _x_x_mozilla_page_load 05:27:22 INFO - PROCESS | 2023 | _x_x_mozilla_page_load_details 05:27:22 INFO - PROCESS | 2023 | |i|pagename|runs| 05:27:22 INFO - PROCESS | 2023 | |0;dojo.html;3429.2969941162064;3437.518747375368;3484.303139372126;3497.982510087449;3555.9466608000866;5071.543561079502;5782.017057100298;5843.357230704624;5859.091840764683;5860.882782344351;5728.770849166029;5809.244798176232;5810.82567522975;5931.673757943311;5967;4332.068605249887;5195.740212989354;5256.474352564751;5284.8150314739;5343.358796944372;295.0434230266793;5144.922826157611;5262.736863156846;5272.630915835893;5342.2253773202865;5218.478152184789;5235.450277720861;5245.947540524603;5246;5262.657927234755;4621.74580398078;5159.896802063975;5179.948200517984;5320.76056577455;5353.866153346158;5109.4379618241965;5168.3281173447585;5191.740412979336;5234.450382709799;5250.3962044364625;5622.465865742748;5711.371749107595;5751.281089863767;5787.305523337184;5821.301443826768;6131.866048757612;6185.134081228632;6199.287081985584;6277.811665650038;6286.49708023357;6196.504279657616;6249.375062493759;6253.437190652863;6254.499640028786;6273.059041143865;5956.970215148896;5982.282126144803;5987.970060149715;5997.75394798303;6050.515958723336;5563;5807.651540907559;6306.306306306303;6318.71565779541;6371.553991220663;5271.314729085195;6246.15676883624;6252.218472690914;6259.937400626027;6270.122182894398;6180.1459462944595;6210.441060304594;6263;6295.590786598948;6301.212348456443;6108.8581424937165;6230;6231.3145553989025;6242.188515492957;6308.621482710961;6140.412224875342;6179.752809887555;6225.84821807967;6249.843753906189;6256.186695729526;4959.975200123977;4999.450060493343;5017.37282839645;5020.297158397827;5029.748512574357;4423.137488189836;4453.398791163217;4505.864824055284;4518.593326600621;4560.817567297271;5890;5964.701764911737;5973.432523910222;5993.970030149909;5994;6260.373962603794;6261.937380626136;6273.404026617555;6275.6862156891975;6286.371362863677;4820.276958456259;5833.620814647119;5917.349091599921;5947.464728174398;5983.461488465972;5464.398916119224;5493.423190565013;5493.505584497414;5507.697076660742;5508.889822203533;5721.342045664718;5948.602078511546;6227.906581401192;6424.935750642434;6438.517111216677;6194.34959329282;6234.781782637586;6240.219972503437;6257.749690012349;6442.420182183626;6380.330065343258;6428.164338635947;6437.452816510649;6455.322191169859;6566.573172743756;6099.481544068626;6124.441964285778;6211.3167551570195;6216.53375996793;6225.097360882737;6200.131981522501;6254.906176407267;6260;6261.749530018748;6274.6548939808745;6076.906156891802;6137.754489820357;6168.722407491584;6177.536684748752;6190.938090619216;6067;6122.265328160649;6150.477209437248;6184.257889053342;6185.165002724574;5934.347221805684;6023.728932198149;6047;6115.388461153849;6136.028952951454;5995.1906492624685;6191.201194201654;6213.285472170758;6226.097215903759;6256.530760192913;5967.164596956342;6087.969560152171;6116.174316467398;6142.40669208518;6148.1085242640465 05:27:22 INFO - PROCESS | 2023 | |1;ext.html;483.8983813399186;509.71455984648577;513.6686836990141;524.3210042994322;621.260699767277;38137.80931095344;39050.82847514579;39053.609463905355;39117.804410977944;39173.80413097934;39799.20401591966;40190.7990460048;40621;40712.38931416031;40739.981500462505;9422.858657120149;9525.476098814597;9610.759731006745;9659.034096590354;9668.806623867518;9581.712548623553;9655.662051828187;9675.903240967606;9693.321467497279;9742.51287435629;9688.564014619324;9695.806083878353;9706.223502119814;9716.076972687619;9761.853572196387;7648.158702542716;9143.588538515716;9666.323357364987;9695.466749328783;9770.022997700244;9597.376170548961;9685.370450920667;9714.9514252429;9715.70852874415;9721.805563888682;29756.70243297561;38897.83306500781;39303.60696393028;39391.80304098461;39442.21115577672;2749.6975332713387;2821.647294088239;3078.1688943985;3091.458994675923;3421.1447138215444;25703.48593028129;25787.871060644764;25907.611385829226;26402.73597264041;26625.934962601474;2636.1696065739425;2642.1545105566224;2650.0989663514497;2732.631094802216;2827.067067867599;258927;279564;293406;321292.3935380331;321428.39285803423;28361.71638283632;32419.51370729441;33777.83111084478;33799;35141.94574162728;32496.675033249838;33750;34730.82634586811;34756;35071.64928350735;14959.626009349853;15059.849401506064;15162.469313573973;15163;15209;12544;12815.551455699193;12864.614061578168;12883.677908052374;12922.030847686274;6794.320567943265;7958.124606293303;8086.676532938734;8128.146544612849;8136.715214967566;3372.1232479555492;3413.2490852012515;3422.3155368926314;3422.7261819054415;3427.0575591712477;956.8803899512561;1045.9738506537244;1053.6154303679255;1089.3790539392628;1099.9670009899717;29579.964701235353;29607.85196074006;29863.80544778228;30057.849710751307;30425;979.4319294808994;1073.6081330314535;1073.9355638661705;1141.9086473082134;1173.372245848467;13960.2321872298;14979.850201498064;15342.616434589225;15549.689006219813;15619.531414057596;615312;628382;635722;636892;638771;57942;59146.817063658484;60137;60265.69867150636;60618;1430.0847457627126;1460.2552698124034;1471.4923351443736;1473.6536913825244;1476.4094362254968;24615.63076553889;28915;29195.416091677624;29695.40609187761;29976.40047199;51012.74493627508;51049.48950510447;51300.74349628228;51425.97148057093;51551;568057;571968;574190;574443;574447;26217;26627.866860665574;26969.865150674123;41320.79339603403;42880.070396831594;43942.780286098365;44388;44941;47428;47613;33248.335033299685;35662.93011209668;35995;36080;36924;36523.452148218326;36711.63288367189;36901.44647830338;36955;37444.251114977;33197.83401082979;36151.638483615876;36504.634953651184;37382.813085934395;37543.43684844784;27074.864625676746;29817.850910745306;30743.609373911957;31175.532367014966;32509.837450812596;24360.512789743752;24890.631015294333;24916;25661;26518.071867484545 05:27:22 INFO - PROCESS | 2023 | |2;jquery.html;395.80209895052474;396.2609732848239;401.69270508061334;402.4064504855337;407.4031543788349;12158.878411215885;20002.799972000277;20415.979201039925;20541;21066.473338166554;17687.204075816586;19892.60214795707;20280.59438811223;20557.69163462549;21965.890170549166;5907.350191478934;5949.791757288495;6050.576459647827;6116.877662446748;6126.0810878368375;5133.794648214067;6002.399760024006;6025.0661147522205;6036.426539478743;6096.51227901769;5746.683932383718;6073.089036644495;6079.78720744774;6084.421979911901;6088.4215999479975;5749.942500574983;6018.428249316308;6027.457528822383;6077.392260773953;6088.45203931646;5183.3261675981885;5253.921191182136;5278.683279003272;5297.311349524575;5332.280142180794;26413;26592.86703566489;26788.062417815283;27234.04680836161;27364.863175684193;2196.6375548034557;2321.408040949547;2369.620860662303;2682.7719643830296;3004.759619230478;14689.265536723227;15010.549683509513;15092.849071509254;15122.319495622723;15183.544493665097;1517.1352329172375;1704.369383328164;1706.8037175724826;1739.8869073510307;1793.2289115680253;106458.46770766097;107384;108066.45966770116;108869.45565272203;123186;9203.40177888435;10611.469426528643;10998.075336816026;11258.831117533244;11508.769824603629;11060.778784424427;14553.417863285349;14568.635784105481;14577.489787857587;14594.759445447256;8669;8803.955980220058;8815.294776417872;8852.424592401474;8969.416987895765;7086.362227399456;8659.78350541229;8750.168733970262;8839.646414143492;8859.202671759573;6384.170057892445;6525.64108974011;6857.794266172023;7009.369156775812;7029.191642961125;1874.2034635279952;1885.9245630174914;1910.9808901910803;1921.3083290015584;1947.5325921778672;803.5781214862244;967.908048735369;1021.2238698588977;1021.6543055431424;1037.2479952034864;19849.801501985083;19892.204311827365;21097.89451052735;21896.671549926763;21964.89017554902;846.8645016797283;913.8896241067135;928.2481190235931;968.6997030920437;1047.659510659039;11041.558337666564;11496.885031149748;11564.24832385909;11721.238119522204;11770.58802941893;557374;563740;597229;609591;627735;82389.76415353775;96668;118978.62042759097;125270;130469.60538748803;1029.5727273181697;1042.9582816687248;1049.9212559057949;1052.2844465763355;1055.4300677634146;14898.478553250585;18609.9069504657;19180.040997949767;19191.61616767629;19260.22959081621;48410;48632.02735945332;49028.754856226915;49516;49931.50068499269;66382.66808665925;67393.66303168453;67880;67917.20182801191;67990;7927.960360198162;8029.959850200712;8172.877406838783;8293.502389856629;8396.454230475;12198.878011219775;12431.44058517387;12715.618531444072;13010.80483792725;13100.934495327463;10130.632364630681;10841.51213195424;11393.943030284796;11505.539778408769;11533.480993355486;10749;10963.56145754161;11096.039471134574;11264.605738799102;11465.197436179387;9927.40435573868;11298.83051754208;11399.34709467106;11593.304401735923;11795.823062653895;8059.5164290142775;8063.072746634212;8168.877466837884;8219.095899450936;8275.751727447945;10264.963496359731;10718.410487423267;10935.179861510578;11012.119030477703;11031.448427578749 05:27:22 INFO - PROCESS | 2023 | |3;mootools.html;1595.433621064522;1630.4863967850126;1871.8099823206846;1949.2690241159573;1949.8064677238108;8067;8637.309015278779;8695.826083478343;8888.866667;8917.286617070635;7807.4144439167;8158.265756081952;8830.470171789697;8931.821363572724;9020.90979090209;2074.751029876417;2464.6179842124498;2482.553140434721;2485.962710559343;2490.5392502387117;2435.9512809743796;2459.655648209252;2461.544614246361;2489.9253022409357;2497.7627125423055;2151.9031643576;2421.7285924889397;2432.1487479382163;2485.515324511721;2494.239257026606;2028.8478364122675;2441.377448750557;2462.655228268044;2463.187148241085;2464.4824586836694;2419.4677171022345;2433.707955045406;2448.3511869354634;2449.363165576945;2457.4347899982927;8789.956050219707;8859.64561417549;8968.865467018;9021.864672029924;9055.366124371296;5353.759080841332;5426.810061647863;5467.863303417406;5516.420775818561;5523.696196709179;3534.7172226222096;3550.5206797082324;3567.839447224881;3609.9458508122398;3624.3476174288617;995.4922989275449;1000.7698229407205;1011.0546638892658;1023.8822535408375;1039.0544604409952;11648.59229926957;11731.354775487345;11737.647870563982;11744.823827642593;11787.646370608896;4704.6236301096515;4824.992308990055;4854.344663470386;4928.408590969035;4940.456549779521;9860.704178874645;9876.65431709901;10050.59797608102;10077;10119.190464762802;5322.6806391615855;5459.481349271813;5464.726763661801;5467.671939683552;5486.670799752028;4424.668149888771;4784.545468180587;4942.20924652054;4968.627352948543;5015.297858299841;4095.722953383895;4102.979485102555;4103.938440923389;4119.629233369011;4164.792659890263;1358.3547814788094;1387.3826147364325;1393.665520275147;1399.2583930516842;1401.9579412617638;813.1502579804119;826.5825757992176;868.68727258187;892.4065496444921;906.2206502407923;5426.077566813651;5439.129739241703;5483;5503.449655034545;5522.061249587579;445.1630933844352;451.55070704649086;453.68922288232665;458.52084571622737;472.4826315184867;3929.6659783918117;4034.0923292259595;4045.130296986162;4084.264832330209;4102.261592913304;10360.948195259127;10598.25812193139;10604.151667866552;10681.732956676145;10784.89215107839;8267.29727973117;9764.560594773253;10532.999365060306;10558.788824223626;10746.892531074745;6857.794266172023;8032.437729358889;8124.796880077927;8271.95864020676;8302.377321701017;5727.513161381163;5863.970680146572;5936.1095835625;5940.910886336795;5978.461938425563;9782.9021709782;9827.901720982698;9832.754181145528;9933;10054.447005414773;7561.281678240558;8983.550822458981;9668.806623867624;9889.25830562725;9898.851517227104;6879.862402751817;7344.559326440431;7578.772636820904;8026.317762989977;8369.581520923808;8162.5510596915365;8174.918250817415;8328.666853326042;8337.458065225741;8417;7344.70621175147;7463.552186868806;7561.508501947355;7584.355329796808;7641.847163056819;7311.707531698885;7320.853582928418;7445.441591880739;7496.0255166827965;7566.054243219598;6978.685959131953;7041.647917604202;7125.714971401293;7146.32109949554;7177.354038136593;4811.759412029314;4862.41651001882;4942.827001054946;4993.325901003318;5228.372595288438;4936.75316234194;5042.899142017212;5061.797528098835;5064.721440320818;5218.608604354613 05:27:22 INFO - PROCESS | 2023 | |4;prototype.html;283.7758171044875;312.673256447013;330.9238875058735;331.7777089350135;332.7554247627993;5801.970990145054;5869.970650146749;6010.595761695324;6225.501959843213;6269.623822570643;5869.471747542721;6103.023516237403;6131.233595800525;6177.393877591825;6254.312025677184;4682.859514214562;4686.695364801294;4694.577488026077;4703.576678098971;4705.188797074364;3579.210394802599;4687.296905464191;4688.179568575486;4713.151632706112;4722;4613.561711637389;4623.237165867645;4657.743824089674;4671;4676.532346765313;3837.9253808933404;4416.425864637608;4656.998745269783;4662.927526668851;4678.906421871544;3793.374093274634;3990.3615421532418;4018.1561872006623;4052.696047796427;4056.371262454324;5454.59090568205;5907.793227237069;5953.493953013999;6000.489958353545;6002.129691194796;5461.5357694596005;5495.230667706524;5497.202905578709;5497.230387745719;5503.284573005523;5514.593778586475;6307.117003619497;6602.1747281589805;6627.80116596498;6638.900416493757;4272.230998420283;4311.698181127323;4499.212637788407;4509.03055842992;4510.639148868083;6701.816637097389;6888.724451022003;6960.686769095403;6965.756198533027;6993.230744618088;3825.9426108608395;3878.9612103879163;4174.582541745862;4186.979065104655;4529.026259354255;4645.767711614406;4660.766961651904;4663.417072865892;4664.65015123867;4667.159911215946;4600.861974140781;5421.783128674888;5464.26232458621;5485.670859748348;5487.478689524489;5742.540596752333;6228.439440450381;6305.96847015762;6455.5468921809415;6619.702113404908;1483.3250870853735;1504.7968524249304;1598.1940407339632;1605.3658804772049;1619.1661294433377;1041.7239431550645;1055.9862531969395;1064.21248276275;1066.5147357952112;1083.263380900995;5303.443138470482;6175.660338681326;6187.762447510426;6191.442770150708;6238.532110091761;6876.17485901685;6879.58722476653;6879.690413931385;6905.343992320722;6912;4975.527324904128;5216.817411390583;5922.262190247785;6159.907601385983;6274.215723034621;2793;3618.118578339249;3628.8367023484006;3634.83643236055;3638.8180590970346;7032.578045317297;7099.6450177490915;7109.8933515997305;7119.89320160198;7193.55419157489;5802.419758024248;7011.579305241702;7016.964915175494;7041.40148087408;7053.435725141976;5613.691246981373;5984.940150598438;7060.646967651597;7110.644467776694;7172.13934327884;5783.450572195635;6474.417302442803;6823.1812182538415;6843.863122737418;6860.691268892812;5816.952948469147;6197.907031394623;6532.934670653232;6639.3692599203;6688.097106890507;6178.443940045418;7003.439724822104;7093.893591596234;7103.696780996861;7106.786796396116;3797.4493698414126;3882.6893848491486;4325.286327755885;4379.759113248802;4576.88557786058;5456.345238571397;5907.763689452374;6440.29156792743;6589.27517973013;6857.965710171417;6644.700988455627;6653.833654158491;6672.065910772592;6689.799306020827;6703.631300278532;6111.816645500642;6347.333529979471;6643.56816806906;6655.939876675321;6667.766628167991;6451.3548645135115;6475.514336424692;6481.8703625928165;6526.24948130971;6565.474762019123;5339.3058902342445;5783.681897495678;6495.935040649533;6619.635920024445;6687.057694614354;5756.754865602335;6250.843728906813;6510.772122975863;6526.608403495806;6533.811173257012 05:27:22 INFO - PROCESS | 2023 | |5;yui.html;662.7084083003479;699.6431819771915;734.5042096584806;741.9517731347462;754.1666458563287;14756.778648320284;15161.620959476018;15214.619634509128;15476.38094476221;16428.425005124824;15628;15882.3647054118;15938.840611593881;15958.680826383465;16012.59968500788;902.5938327752505;912.393258483108;915.9084091590821;916.408916249019;919.2554031234688;699.601227300439;893.5175005497024;922.0687106022932;924.8381533231691;925.282905748044;925.6852670092168;962.1052421248237;967.89837067108;968.8449848024318;970.9805803883918;937.4843835890301;961.1589858873485;961.5913236874301;962.2206013129353;964.5466630683568;686.1731613405834;689.2039694153261;707.5471698113212;714.6248219684655;718.1023720349563;13725.862741372559;13792.448302068005;13902.791458128137;13977.58067257984;14013.229272390014;11998.760024799543;12028;12133.817992730115;12167.391630418444;12365.69085772854;9865.1614612758;10025.248106391977;10123.493825308706;10209.13222376099;10732.528991682486;4064.5122585289955;4066.430699702044;4071.063655359284;4082.448869402622;4388.188185185751;80756.19243807605;82323.58838205831;82584.17415825884;82701;83185;9129.497877616795;9344.112309330603;9382.202512786489;9442.905570944202;9463.858042129374;21554.922253887242;21777.56444871094;21801.345959620918;21829;21893.67159492609;7520.511166774142;7661.502002369828;7761.72833950809;7762.340201082971;7853.293203611703;3734.626537346244;3775.565809931838;3790.886273411802;3801.790901500444;3846.8845934622004;3617.5297211362354;3721;3724.217914237986;3729.1236559408517;3743.344914639927;672.0792514255501;674.1236392689484;684.551618689759;684.8082536889679;698.3749544157951;535.946405359461;575.6143383932775;587.9294484661868;592.6947621974687;613.163032460688;7710.845783084307;7889.0927543333255;8105.635246413807;8120.715774947848;8218.547979861165;568.903286441306;571.6770024935898;575.923023945225;588.0532342927883;597.6175247841385;3773.811309434517;3785.2240290740333;3845.615438456188;3900.8829735107993;3927.8232479538487;72621;85279.14720852712;92078.53960730153;93121.60317595242;93513.53243233741;64394.67802660957;69382.65308673526;74945;75443.62278188574;76162;50737;69365.65317173382;69411.65294173599;70000;70848.93726594003;7465.850682986418;7541.350156217045;7795.259450352434;7808.648610812641;7810.960945195237;41689.58310416978;41825.58174418217;42752.57247427486;43719;44376.77811610921;58110.7094464525;63380.36619633929;63907.680461597396;64037;64165.35834641594;9126.817463650823;9146.725598232064;9881.20950323958;10217.846732298873;10286.537105830404;9024.781654476561;10647.148228141885;10686.57253709874;10826.242163048511;10843.915608439092;10046.648367307109;10096;10148.276717084056;10310.690679279634;10367.585296588353;11096.278741882075;11156.609518666808;11486.712832179262;11616.535338586362;11700.765984680429;11259.887401125883;11343.432828358715;11343.659690209306;11598.826017609912;11759.000484958533;9272.536373181449;9389.624415023323;9494.287928405536;9529.999350068143;9640.42157470554;9210.95394523023;9483.762905927131;9703.66037188695;9764.462954537568;9796.118349348593 05:27:22 INFO - PROCESS | 2023 | __end_tp_report 05:27:22 INFO - PROCESS | 2023 | __start_cc_report 05:27:22 INFO - PROCESS | 2023 | _x_x_mozilla_cycle_collect,397 05:27:22 INFO - PROCESS | 2023 | __end_cc_report 05:27:22 INFO - PROCESS | 2023 | __startTimestamp1461587242887__endTimestamp 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | ------- Summary: start ------- 05:27:22 INFO - PROCESS | 2023 | Number of tests: 6 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | [#0] dojo.html Cycles:165 Average:5750.83 Median:6023.73 stddev:773.65 (12.8%) stddev-sans-first:754.28 05:27:22 INFO - PROCESS | 2023 | Values: 3429.3 3437.5 3484.3 3498.0 3555.9 5071.5 5782.0 5843.4 5859.1 5860.9 5728.8 5809.2 5810.8 5931.7 5967.0 4332.1 5195.7 5256.5 5284.8 5343.4 295.0 5144.9 5262.7 5272.6 5342.2 5218.5 5235.5 5245.9 5246.0 5262.7 4621.7 5159.9 5179.9 5320.8 5353.9 5109.4 5168.3 5191.7 5234.5 5250.4 5622.5 5711.4 5751.3 5787.3 5821.3 6131.9 6185.1 6199.3 6277.8 6286.5 6196.5 6249.4 6253.4 6254.5 6273.1 5957.0 5982.3 5988.0 5997.8 6050.5 5563.0 5807.7 6306.3 6318.7 6371.6 5271.3 6246.2 6252.2 6259.9 6270.1 6180.1 6210.4 6263.0 6295.6 6301.2 6108.9 6230.0 6231.3 6242.2 6308.6 6140.4 6179.8 6225.8 6249.8 6256.2 4960.0 4999.5 5017.4 5020.3 5029.7 4423.1 4453.4 4505.9 4518.6 4560.8 5890.0 5964.7 5973.4 5994.0 5994.0 6260.4 6261.9 6273.4 6275.7 6286.4 4820.3 5833.6 5917.3 5947.5 5983.5 5464.4 5493.4 5493.5 5507.7 5508.9 5721.3 5948.6 6227.9 6424.9 6438.5 6194.3 6234.8 6240.2 6257.7 6442.4 6380.3 6428.2 6437.5 6455.3 6566.6 6099.5 6124.4 6211.3 6216.5 6225.1 6200.1 6254.9 6260.0 6261.7 6274.7 6076.9 6137.8 6168.7 6177.5 6190.9 6067.0 6122.3 6150.5 6184.3 6185.2 5934.3 6023.7 6047.0 6115.4 6136.0 5995.2 6191.2 6213.3 6226.1 6256.5 5967.2 6088.0 6116.2 6142.4 6148.1 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | [#1] ext.html Cycles:180 Average:62001.07 Median:36037.50 stddev:139892.23 (388.2%) stddev-sans-first:140208.41 05:27:22 INFO - PROCESS | 2023 | Values: 483.9 509.7 513.7 524.3 621.3 38137.8 39050.8 39053.6 39117.8 39173.8 39799.2 40190.8 40621.0 40712.4 40740.0 9422.9 9525.5 9610.8 9659.0 9668.8 9581.7 9655.7 9675.9 9693.3 9742.5 9688.6 9695.8 9706.2 9716.1 9761.9 7648.2 9143.6 9666.3 9695.5 9770.0 9597.4 9685.4 9715.0 9715.7 9721.8 29756.7 38897.8 39303.6 39391.8 39442.2 2749.7 2821.6 3078.2 3091.5 3421.1 25703.5 25787.9 25907.6 26402.7 26625.9 2636.2 2642.2 2650.1 2732.6 2827.1 258927.0 279564.0 293406.0 321292.4 321428.4 28361.7 32419.5 33777.8 33799.0 35141.9 32496.7 33750.0 34730.8 34756.0 35071.6 14959.6 15059.8 15162.5 15163.0 15209.0 12544.0 12815.6 12864.6 12883.7 12922.0 6794.3 7958.1 8086.7 8128.1 8136.7 3372.1 3413.2 3422.3 3422.7 3427.1 956.9 1046.0 1053.6 1089.4 1100.0 29580.0 29607.9 29863.8 30057.8 30425.0 979.4 1073.6 1073.9 1141.9 1173.4 13960.2 14979.9 15342.6 15549.7 15619.5 615312.0 628382.0 635722.0 636892.0 638771.0 57942.0 59146.8 60137.0 60265.7 60618.0 1430.1 1460.3 1471.5 1473.7 1476.4 24615.6 28915.0 29195.4 29695.4 29976.4 51012.7 51049.5 51300.7 51426.0 51551.0 568057.0 571968.0 574190.0 574443.0 574447.0 26217.0 26627.9 26969.9 41320.8 42880.1 43942.8 44388.0 44941.0 47428.0 47613.0 33248.3 35662.9 35995.0 36080.0 36924.0 36523.5 36711.6 36901.4 36955.0 37444.3 33197.8 36151.6 36504.6 37382.8 37543.4 27074.9 29817.9 30743.6 31175.5 32509.8 24360.5 24890.6 24916.0 25661.0 26518.1 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | [#2] jquery.html Cycles:180 Average:33923.40 Median:12143.65 stddev:98127.50 (808.1%) stddev-sans-first:98370.48 05:27:22 INFO - PROCESS | 2023 | Values: 395.8 396.3 401.7 402.4 407.4 12158.9 20002.8 20416.0 20541.0 21066.5 17687.2 19892.6 20280.6 20557.7 21965.9 5907.4 5949.8 6050.6 6116.9 6126.1 5133.8 6002.4 6025.1 6036.4 6096.5 5746.7 6073.1 6079.8 6084.4 6088.4 5749.9 6018.4 6027.5 6077.4 6088.5 5183.3 5253.9 5278.7 5297.3 5332.3 26413.0 26592.9 26788.1 27234.0 27364.9 2196.6 2321.4 2369.6 2682.8 3004.8 14689.3 15010.5 15092.8 15122.3 15183.5 1517.1 1704.4 1706.8 1739.9 1793.2 106458.5 107384.0 108066.5 108869.5 123186.0 9203.4 10611.5 10998.1 11258.8 11508.8 11060.8 14553.4 14568.6 14577.5 14594.8 8669.0 8804.0 8815.3 8852.4 8969.4 7086.4 8659.8 8750.2 8839.6 8859.2 6384.2 6525.6 6857.8 7009.4 7029.2 1874.2 1885.9 1911.0 1921.3 1947.5 803.6 967.9 1021.2 1021.7 1037.2 19849.8 19892.2 21097.9 21896.7 21964.9 846.9 913.9 928.2 968.7 1047.7 11041.6 11496.9 11564.2 11721.2 11770.6 557374.0 563740.0 597229.0 609591.0 627735.0 82389.8 96668.0 118978.6 125270.0 130469.6 1029.6 1043.0 1049.9 1052.3 1055.4 14898.5 18609.9 19180.0 19191.6 19260.2 48410.0 48632.0 49028.8 49516.0 49931.5 66382.7 67393.7 67880.0 67917.2 67990.0 7928.0 8030.0 8172.9 8293.5 8396.5 12198.9 12431.4 12715.6 13010.8 13100.9 10130.6 10841.5 11393.9 11505.5 11533.5 10749.0 10963.6 11096.0 11264.6 11465.2 9927.4 11298.8 11399.3 11593.3 11795.8 8059.5 8063.1 8168.9 8219.1 8275.8 10265.0 10718.4 10935.2 11012.1 11031.4 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | [#3] mootools.html Cycles:180 Average:5686.44 Median:5029.10 stddev:3142.81 (62.5%) stddev-sans-first:3136.59 05:27:22 INFO - PROCESS | 2023 | Values: 1595.4 1630.5 1871.8 1949.3 1949.8 8067.0 8637.3 8695.8 8888.9 8917.3 7807.4 8158.3 8830.5 8931.8 9020.9 2074.8 2464.6 2482.6 2486.0 2490.5 2436.0 2459.7 2461.5 2489.9 2497.8 2151.9 2421.7 2432.1 2485.5 2494.2 2028.8 2441.4 2462.7 2463.2 2464.5 2419.5 2433.7 2448.4 2449.4 2457.4 8790.0 8859.6 8968.9 9021.9 9055.4 5353.8 5426.8 5467.9 5516.4 5523.7 3534.7 3550.5 3567.8 3609.9 3624.3 995.5 1000.8 1011.1 1023.9 1039.1 11648.6 11731.4 11737.6 11744.8 11787.6 4704.6 4825.0 4854.3 4928.4 4940.5 9860.7 9876.7 10050.6 10077.0 10119.2 5322.7 5459.5 5464.7 5467.7 5486.7 4424.7 4784.5 4942.2 4968.6 5015.3 4095.7 4103.0 4103.9 4119.6 4164.8 1358.4 1387.4 1393.7 1399.3 1402.0 813.2 826.6 868.7 892.4 906.2 5426.1 5439.1 5483.0 5503.4 5522.1 445.2 451.6 453.7 458.5 472.5 3929.7 4034.1 4045.1 4084.3 4102.3 10360.9 10598.3 10604.2 10681.7 10784.9 8267.3 9764.6 10533.0 10558.8 10746.9 6857.8 8032.4 8124.8 8272.0 8302.4 5727.5 5864.0 5936.1 5940.9 5978.5 9782.9 9827.9 9832.8 9933.0 10054.4 7561.3 8983.6 9668.8 9889.3 9898.9 6879.9 7344.6 7578.8 8026.3 8369.6 8162.6 8174.9 8328.7 8337.5 8417.0 7344.7 7463.6 7561.5 7584.4 7641.8 7311.7 7320.9 7445.4 7496.0 7566.1 6978.7 7041.6 7125.7 7146.3 7177.4 4811.8 4862.4 4942.8 4993.3 5228.4 4936.8 5042.9 5061.8 5064.7 5218.6 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | [#4] prototype.html Cycles:180 Average:5324.86 Median:5869.72 stddev:1673.90 (28.5%) stddev-sans-first:1635.28 05:27:22 INFO - PROCESS | 2023 | Values: 283.8 312.7 330.9 331.8 332.8 5802.0 5870.0 6010.6 6225.5 6269.6 5869.5 6103.0 6131.2 6177.4 6254.3 4682.9 4686.7 4694.6 4703.6 4705.2 3579.2 4687.3 4688.2 4713.2 4722.0 4613.6 4623.2 4657.7 4671.0 4676.5 3837.9 4416.4 4657.0 4662.9 4678.9 3793.4 3990.4 4018.2 4052.7 4056.4 5454.6 5907.8 5953.5 6000.5 6002.1 5461.5 5495.2 5497.2 5497.2 5503.3 5514.6 6307.1 6602.2 6627.8 6638.9 4272.2 4311.7 4499.2 4509.0 4510.6 6701.8 6888.7 6960.7 6965.8 6993.2 3825.9 3879.0 4174.6 4187.0 4529.0 4645.8 4660.8 4663.4 4664.7 4667.2 4600.9 5421.8 5464.3 5485.7 5487.5 5742.5 6228.4 6306.0 6455.5 6619.7 1483.3 1504.8 1598.2 1605.4 1619.2 1041.7 1056.0 1064.2 1066.5 1083.3 5303.4 6175.7 6187.8 6191.4 6238.5 6876.2 6879.6 6879.7 6905.3 6912.0 4975.5 5216.8 5922.3 6159.9 6274.2 2793.0 3618.1 3628.8 3634.8 3638.8 7032.6 7099.6 7109.9 7119.9 7193.6 5802.4 7011.6 7017.0 7041.4 7053.4 5613.7 5984.9 7060.6 7110.6 7172.1 5783.5 6474.4 6823.2 6843.9 6860.7 5817.0 6197.9 6532.9 6639.4 6688.1 6178.4 7003.4 7093.9 7103.7 7106.8 3797.4 3882.7 4325.3 4379.8 4576.9 5456.3 5907.8 6440.3 6589.3 6858.0 6644.7 6653.8 6672.1 6689.8 6703.6 6111.8 6347.3 6643.6 6655.9 6667.8 6451.4 6475.5 6481.9 6526.2 6565.5 5339.3 5783.7 6495.9 6619.6 6687.1 5756.8 6250.8 6510.8 6526.6 6533.8 05:27:22 INFO - PROCESS | 2023 | 05:27:22 INFO - PROCESS | 2023 | [#5] yui.html Cycles:180 Average:17502.91 Median:64280.02 stddev:24419.00 (38.0%) stddev-sans-first:24454.76 05:27:22 INFO - PROCESS | 2023 | Values: 662.7 699.6 734.5 742.0 754.2 14756.8 15161.6 15214.6 15476.4 16428.4 15628.0 15882.4 15938.8 15958.7 16012.6 902.6 912.4 915.9 916.4 919.3 699.6 893.5 922.1 924.8 925.3 925.7 962.1 967.9 968.8 971.0 937.5 961.2 961.6 962.2 964.5 686.2 689.2 707.5 714.6 718.1 13725.9 13792.4 13902.8 13977.6 14013.2 11998.8 12028.0 12133.8 12167.4 12365.7 9865.2 10025.2 10123.5 10209.1 10732.5 4064.5 4066.4 4071.1 4082.4 4388.2 80756.2 82323.6 82584.2 82701.0 83185.0 9129.5 9344.1 9382.2 9442.9 9463.9 21554.9 21777.6 21801.3 21829.0 21893.7 7520.5 7661.5 7761.7 7762.3 7853.3 3734.6 3775.6 3790.9 3801.8 3846.9 3617.5 3721.0 3724.2 3729.1 3743.3 672.1 674.1 684.6 684.8 698.4 535.9 575.6 587.9 592.7 613.2 7710.8 7889.1 8105.6 8120.7 8218.5 568.9 571.7 575.9 588.1 597.6 3773.8 3785.2 3845.6 3900.9 3927.8 72621.0 85279.1 92078.5 93121.6 93513.5 64394.7 69382.7 74945.0 75443.6 76162.0 50737.0 69365.7 69411.7 70000.0 70848.9 7465.9 7541.4 7795.3 7808.6 7811.0 41689.6 41825.6 42752.6 43719.0 44376.8 58110.7 63380.4 63907.7 64037.0 64165.4 9126.8 9146.7 9881.2 10217.8 10286.5 9024.8 10647.1 10686.6 10826.2 10843.9 10046.6 10096.0 10148.3 10310.7 10367.6 11096.3 11156.6 11486.7 11616.5 11700.8 11259.9 11343.4 11343.7 11598.8 11759.0 9272.5 9389.6 9494.3 9530.0 9640.4 9211.0 9483.8 9703.7 9764.5 9796.1 05:27:22 INFO - PROCESS | 2023 | -------- Summary: end -------- 05:27:22 INFO - PROCESS | 2023 | 05:27:23 INFO - TEST-INFO | 2023: exit 0 05:27:23 INFO - TEST-OK | dromaeo_css | took 1111744ms 05:27:23 INFO - TEST-START | kraken 05:27:23 INFO - operating with platform_type : mac_ 05:27:23 INFO - Initialising browser for kraken test... 05:27:23 INFO - TEST-INFO | started process 2030 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpEmesQa/profile http://localhost:51367/getInfo.html) 05:27:26 INFO - PROCESS | 2030 | __metrics Screen width/height:1600/1200 05:27:26 INFO - PROCESS | 2030 | colorDepth:24 05:27:26 INFO - PROCESS | 2030 | Browser inner width/height: 1024/689 05:27:26 INFO - PROCESS | 2030 | __metrics 05:27:26 ERROR - PROCESS | 2030 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:27:26 INFO - TEST-INFO | 2030: exit 0 05:27:26 INFO - Browser initialized. 05:27:26 INFO - Running cycle 1/1 for kraken test... 05:27:26 INFO - TEST-INFO | started process 2033 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpEmesQa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:38 INFO - PROCESS | 2033 | RSS: Main: 247934976 05:27:38 INFO - PROCESS | 2033 | 05:27:41 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51367/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:42 INFO - PROCESS | 2033 | RSS: Main: 260071424 05:27:42 INFO - PROCESS | 2033 | 05:27:45 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51367/tests/kraken/driver.html?testName=audio-dft) 05:27:45 INFO - PROCESS | 2033 | RSS: Main: 269352960 05:27:45 INFO - PROCESS | 2033 | 05:27:49 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51367/tests/kraken/driver.html?testName=audio-fft) 05:27:49 INFO - PROCESS | 2033 | RSS: Main: 272945152 05:27:49 INFO - PROCESS | 2033 | 05:27:51 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51367/tests/kraken/driver.html?testName=audio-oscillator) 05:27:52 INFO - PROCESS | 2033 | RSS: Main: 274075648 05:27:52 INFO - PROCESS | 2033 | 05:27:54 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:27:55 INFO - PROCESS | 2033 | RSS: Main: 274534400 05:27:55 INFO - PROCESS | 2033 | 05:27:58 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51367/tests/kraken/driver.html?testName=imaging-darkroom) 05:27:58 INFO - PROCESS | 2033 | RSS: Main: 275210240 05:27:58 INFO - PROCESS | 2033 | 05:28:01 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51367/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:02 INFO - PROCESS | 2033 | RSS: Main: 275283968 05:28:02 INFO - PROCESS | 2033 | 05:28:05 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51367/tests/kraken/driver.html?testName=json-parse-financial) 05:28:05 INFO - PROCESS | 2033 | RSS: Main: 275443712 05:28:05 INFO - PROCESS | 2033 | 05:28:07 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:08 INFO - PROCESS | 2033 | RSS: Main: 274780160 05:28:08 INFO - PROCESS | 2033 | 05:28:09 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:10 INFO - PROCESS | 2033 | RSS: Main: 275066880 05:28:10 INFO - PROCESS | 2033 | 05:28:12 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:13 INFO - PROCESS | 2033 | RSS: Main: 275165184 05:28:13 INFO - PROCESS | 2033 | 05:28:16 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:16 INFO - PROCESS | 2033 | RSS: Main: 275275776 05:28:16 INFO - PROCESS | 2033 | 05:28:20 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:20 INFO - PROCESS | 2033 | RSS: Main: 275206144 05:28:20 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | Cycle 1(1): loaded http://localhost:51367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51367/tests/kraken/driver.html?testName=ai-astar) 05:28:22 INFO - PROCESS | 2033 | RSS: Main: 276946944 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | __start_tp_report 05:28:22 INFO - PROCESS | 2033 | _x_x_mozilla_page_load 05:28:22 INFO - PROCESS | 2033 | _x_x_mozilla_page_load_details 05:28:22 INFO - PROCESS | 2033 | |i|pagename|runs| 05:28:22 INFO - PROCESS | 2033 | |0;ai-astar;166;143;127;97;113;144;108;162;96;152 05:28:22 INFO - PROCESS | 2033 | |1;audio-beat-detection;151;122;145;152;119;139;143;121;172;111 05:28:22 INFO - PROCESS | 2033 | |2;audio-dft;196;199;202;211;210;194;184;256;281;242 05:28:22 INFO - PROCESS | 2033 | |3;audio-fft;67;78;75;127;58;69;93;86;104;70 05:28:22 INFO - PROCESS | 2033 | |4;audio-oscillator;80;84;132;80;83;83;118;80;82;121 05:28:22 INFO - PROCESS | 2033 | |5;imaging-gaussian-blur;88;76;136;129;89;85;90;87;107;79 05:28:22 INFO - PROCESS | 2033 | |6;imaging-darkroom;152;149;96;96;105;96;96;96;96;95 05:28:22 INFO - PROCESS | 2033 | |7;imaging-desaturate;90;95;91;92;91;99;137;91;92;94 05:28:22 INFO - PROCESS | 2033 | |8;json-parse-financial;61;62;61;61;62;61;62;76;65;62 05:28:22 INFO - PROCESS | 2033 | |9;json-stringify-tinderbox;62;65;72;74;69;64;65;66;66;69 05:28:22 INFO - PROCESS | 2033 | |10;stanford-crypto-aes;98;104;71;90;111;107;78;95;112;107 05:28:22 INFO - PROCESS | 2033 | |11;stanford-crypto-ccm;139;141;142;136;140;127;157;134;192;176 05:28:22 INFO - PROCESS | 2033 | |12;stanford-crypto-pbkdf2;172;172;174;189;173;211;210;222;252;217 05:28:22 INFO - PROCESS | 2033 | |13;stanford-crypto-sha256-iterative;69;84;95;62;81;98;103;94;70;57 05:28:22 INFO - PROCESS | 2033 | __end_tp_report 05:28:22 INFO - PROCESS | 2033 | __start_cc_report 05:28:22 INFO - PROCESS | 2033 | _x_x_mozilla_cycle_collect,1022 05:28:22 INFO - PROCESS | 2033 | __end_cc_report 05:28:22 INFO - PROCESS | 2033 | __startTimestamp1461587302833__endTimestamp 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | ------- Summary: start ------- 05:28:22 INFO - PROCESS | 2033 | Number of tests: 14 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#0] ai-astar Cycles:10 Average:130.80 Median:157.00 stddev:26.22 (16.7%) stddev-sans-first:24.53 05:28:22 INFO - PROCESS | 2033 | Values: 166.0 143.0 127.0 97.0 113.0 144.0 108.0 162.0 96.0 152.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:144.00 stddev:18.94 (13.2%) stddev-sans-first:19.45 05:28:22 INFO - PROCESS | 2033 | Values: 151.0 122.0 145.0 152.0 119.0 139.0 143.0 121.0 172.0 111.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#2] audio-dft Cycles:10 Average:217.50 Median:210.50 stddev:31.50 (15.0%) stddev-sans-first:32.44 05:28:22 INFO - PROCESS | 2033 | Values: 196.0 199.0 202.0 211.0 210.0 194.0 184.0 256.0 281.0 242.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#3] audio-fft Cycles:10 Average:82.70 Median:72.50 stddev:20.60 (28.4%) stddev-sans-first:21.05 05:28:22 INFO - PROCESS | 2033 | Values: 67.0 78.0 75.0 127.0 58.0 69.0 93.0 86.0 104.0 70.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:81.00 stddev:20.61 (25.4%) stddev-sans-first:21.20 05:28:22 INFO - PROCESS | 2033 | Values: 80.0 84.0 132.0 80.0 83.0 83.0 118.0 80.0 82.0 121.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:86.00 stddev:20.67 (24.0%) stddev-sans-first:21.69 05:28:22 INFO - PROCESS | 2033 | Values: 88.0 76.0 136.0 129.0 89.0 85.0 90.0 87.0 107.0 79.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:96.00 stddev:22.75 (23.7%) stddev-sans-first:17.60 05:28:22 INFO - PROCESS | 2033 | Values: 152.0 149.0 96.0 96.0 105.0 96.0 96.0 96.0 96.0 95.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:92.00 stddev:14.23 (15.5%) stddev-sans-first:14.86 05:28:22 INFO - PROCESS | 2033 | Values: 90.0 95.0 91.0 92.0 91.0 99.0 137.0 91.0 92.0 94.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:62.00 stddev:4.62 (7.5%) stddev-sans-first:4.82 05:28:22 INFO - PROCESS | 2033 | Values: 61.0 62.0 61.0 61.0 62.0 61.0 62.0 76.0 65.0 62.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:3.74 (5.5%) stddev-sans-first:3.46 05:28:22 INFO - PROCESS | 2033 | Values: 62.0 65.0 72.0 74.0 69.0 64.0 65.0 66.0 66.0 69.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#10] stanford-crypto-aes Cycles:10 Average:97.30 Median:74.50 stddev:13.98 (18.8%) stddev-sans-first:14.83 05:28:22 INFO - PROCESS | 2033 | Values: 98.0 104.0 71.0 90.0 111.0 107.0 78.0 95.0 112.0 107.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#11] stanford-crypto-ccm Cycles:10 Average:148.40 Median:141.50 stddev:20.58 (14.5%) stddev-sans-first:21.54 05:28:22 INFO - PROCESS | 2033 | Values: 139.0 141.0 142.0 136.0 140.0 127.0 157.0 134.0 192.0 176.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.20 Median:210.50 stddev:27.46 (13.0%) stddev-sans-first:27.30 05:28:22 INFO - PROCESS | 2033 | Values: 172.0 172.0 174.0 189.0 173.0 211.0 210.0 222.0 252.0 217.0 05:28:22 INFO - PROCESS | 2033 | 05:28:22 INFO - PROCESS | 2033 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.30 Median:82.50 stddev:16.15 (19.6%) stddev-sans-first:16.51 05:28:22 INFO - PROCESS | 2033 | Values: 69.0 84.0 95.0 62.0 81.0 98.0 103.0 94.0 70.0 57.0 05:28:22 INFO - PROCESS | 2033 | -------- Summary: end -------- 05:28:22 INFO - PROCESS | 2033 | 05:28:23 INFO - TEST-INFO | 2033: exit 0 05:28:23 INFO - TEST-OK | kraken | took 60174ms 05:28:23 INFO - SUITE-END | took 1171s 05:28:24 INFO - Completed test suite (00:19:32) 05:28:24 INFO - javascript benchmark 05:28:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3429.2969941162064, 3437.518747375368, 3484.303139372126, 3497.982510087449, 3555.9466608000866, 5071.543561079502, 5782.017057100298, 5843.357230704624, 5859.091840764683, 5860.882782344351, 5728.770849166029, 5809.244798176232, 5810.82567522975, 5931.673757943311, 5967.0, 4332.068605249887, 5195.740212989354, 5256.474352564751, 5284.8150314739, 5343.358796944372, 295.0434230266793, 5144.922826157611, 5262.736863156846, 5272.630915835893, 5342.2253773202865, 5218.478152184789, 5235.450277720861, 5245.947540524603, 5246.0, 5262.657927234755, 4621.74580398078, 5159.896802063975, 5179.948200517984, 5320.76056577455, 5353.866153346158, 5109.4379618241965, 5168.3281173447585, 5191.740412979336, 5234.450382709799, 5250.3962044364625, 5622.465865742748, 5711.371749107595, 5751.281089863767, 5787.305523337184, 5821.301443826768, 6131.866048757612, 6185.134081228632, 6199.287081985584, 6277.811665650038, 6286.49708023357, 6196.504279657616, 6249.375062493759, 6253.437190652863, 6254.499640028786, 6273.059041143865, 5956.970215148896, 5982.282126144803, 5987.970060149715, 5997.75394798303, 6050.515958723336, 5563.0, 5807.651540907559, 6306.306306306303, 6318.71565779541, 6371.553991220663, 5271.314729085195, 6246.15676883624, 6252.218472690914, 6259.937400626027, 6270.122182894398, 6180.1459462944595, 6210.441060304594, 6263.0, 6295.590786598948, 6301.212348456443, 6108.8581424937165, 6230.0, 6231.3145553989025, 6242.188515492957, 6308.621482710961, 6140.412224875342, 6179.752809887555, 6225.84821807967, 6249.843753906189, 6256.186695729526, 4959.975200123977, 4999.450060493343, 5017.37282839645, 5020.297158397827, 5029.748512574357, 4423.137488189836, 4453.398791163217, 4505.864824055284, 4518.593326600621, 4560.817567297271, 5890.0, 5964.701764911737, 5973.432523910222, 5993.970030149909, 5994.0, 6260.373962603794, 6261.937380626136, 6273.404026617555, 6275.6862156891975, 6286.371362863677, 4820.276958456259, 5833.620814647119, 5917.349091599921, 5947.464728174398, 5983.461488465972, 5464.398916119224, 5493.423190565013, 5493.505584497414, 5507.697076660742, 5508.889822203533, 5721.342045664718, 5948.602078511546, 6227.906581401192, 6424.935750642434, 6438.517111216677, 6194.34959329282, 6234.781782637586, 6240.219972503437, 6257.749690012349, 6442.420182183626, 6380.330065343258, 6428.164338635947, 6437.452816510649, 6455.322191169859, 6566.573172743756, 6099.481544068626, 6124.441964285778, 6211.3167551570195, 6216.53375996793, 6225.097360882737, 6200.131981522501, 6254.906176407267, 6260.0, 6261.749530018748, 6274.6548939808745, 6076.906156891802, 6137.754489820357, 6168.722407491584, 6177.536684748752, 6190.938090619216, 6067.0, 6122.265328160649, 6150.477209437248, 6184.257889053342, 6185.165002724574, 5934.347221805684, 6023.728932198149, 6047.0, 6115.388461153849, 6136.028952951454, 5995.1906492624685, 6191.201194201654, 6213.285472170758, 6226.097215903759, 6256.530760192913, 5967.164596956342, 6087.969560152171, 6116.174316467398, 6142.40669208518, 6148.1085242640465], "value": 5705.073141945952, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.8983813399186, 509.71455984648577, 513.6686836990141, 524.3210042994322, 621.260699767277, 38137.80931095344, 39050.82847514579, 39053.609463905355, 39117.804410977944, 39173.80413097934, 39799.20401591966, 40190.7990460048, 40621.0, 40712.38931416031, 40739.981500462505, 9422.858657120149, 9525.476098814597, 9610.759731006745, 9659.034096590354, 9668.806623867518, 9581.712548623553, 9655.662051828187, 9675.903240967606, 9693.321467497279, 9742.51287435629, 9688.564014619324, 9695.806083878353, 9706.223502119814, 9716.076972687619, 9761.853572196387, 7648.158702542716, 9143.588538515716, 9666.323357364987, 9695.466749328783, 9770.022997700244, 9597.376170548961, 9685.370450920667, 9714.9514252429, 9715.70852874415, 9721.805563888682, 29756.70243297561, 38897.83306500781, 39303.60696393028, 39391.80304098461, 39442.21115577672, 2749.6975332713387, 2821.647294088239, 3078.1688943985, 3091.458994675923, 3421.1447138215444, 25703.48593028129, 25787.871060644764, 25907.611385829226, 26402.73597264041, 26625.934962601474, 2636.1696065739425, 2642.1545105566224, 2650.0989663514497, 2732.631094802216, 2827.067067867599, 258927.0, 279564.0, 293406.0, 321292.3935380331, 321428.39285803423, 28361.71638283632, 32419.51370729441, 33777.83111084478, 33799.0, 35141.94574162728, 32496.675033249838, 33750.0, 34730.82634586811, 34756.0, 35071.64928350735, 14959.626009349853, 15059.849401506064, 15162.469313573973, 15163.0, 15209.0, 12544.0, 12815.551455699193, 12864.614061578168, 12883.677908052374, 12922.030847686274, 6794.320567943265, 7958.124606293303, 8086.676532938734, 8128.146544612849, 8136.715214967566, 3372.1232479555492, 3413.2490852012515, 3422.3155368926314, 3422.7261819054415, 3427.0575591712477, 956.8803899512561, 1045.9738506537244, 1053.6154303679255, 1089.3790539392628, 1099.9670009899717, 29579.964701235353, 29607.85196074006, 29863.80544778228, 30057.849710751307, 30425.0, 979.4319294808994, 1073.6081330314535, 1073.9355638661705, 1141.9086473082134, 1173.372245848467, 13960.2321872298, 14979.850201498064, 15342.616434589225, 15549.689006219813, 15619.531414057596, 615312.0, 628382.0, 635722.0, 636892.0, 638771.0, 57942.0, 59146.817063658484, 60137.0, 60265.69867150636, 60618.0, 1430.0847457627126, 1460.2552698124034, 1471.4923351443736, 1473.6536913825244, 1476.4094362254968, 24615.63076553889, 28915.0, 29195.416091677624, 29695.40609187761, 29976.40047199, 51012.74493627508, 51049.48950510447, 51300.74349628228, 51425.97148057093, 51551.0, 568057.0, 571968.0, 574190.0, 574443.0, 574447.0, 26217.0, 26627.866860665574, 26969.865150674123, 41320.79339603403, 42880.070396831594, 43942.780286098365, 44388.0, 44941.0, 47428.0, 47613.0, 33248.335033299685, 35662.93011209668, 35995.0, 36080.0, 36924.0, 36523.452148218326, 36711.63288367189, 36901.44647830338, 36955.0, 37444.251114977, 33197.83401082979, 36151.638483615876, 36504.634953651184, 37382.813085934395, 37543.43684844784, 27074.864625676746, 29817.850910745306, 30743.609373911957, 31175.532367014966, 32509.837450812596, 24360.512789743752, 24890.631015294333, 24916.0, 25661.0, 26518.071867484545], "value": 17861.800701278622, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.80209895052474, 396.2609732848239, 401.69270508061334, 402.4064504855337, 407.4031543788349, 12158.878411215885, 20002.799972000277, 20415.979201039925, 20541.0, 21066.473338166554, 17687.204075816586, 19892.60214795707, 20280.59438811223, 20557.69163462549, 21965.890170549166, 5907.350191478934, 5949.791757288495, 6050.576459647827, 6116.877662446748, 6126.0810878368375, 5133.794648214067, 6002.399760024006, 6025.0661147522205, 6036.426539478743, 6096.51227901769, 5746.683932383718, 6073.089036644495, 6079.78720744774, 6084.421979911901, 6088.4215999479975, 5749.942500574983, 6018.428249316308, 6027.457528822383, 6077.392260773953, 6088.45203931646, 5183.3261675981885, 5253.921191182136, 5278.683279003272, 5297.311349524575, 5332.280142180794, 26413.0, 26592.86703566489, 26788.062417815283, 27234.04680836161, 27364.863175684193, 2196.6375548034557, 2321.408040949547, 2369.620860662303, 2682.7719643830296, 3004.759619230478, 14689.265536723227, 15010.549683509513, 15092.849071509254, 15122.319495622723, 15183.544493665097, 1517.1352329172375, 1704.369383328164, 1706.8037175724826, 1739.8869073510307, 1793.2289115680253, 106458.46770766097, 107384.0, 108066.45966770116, 108869.45565272203, 123186.0, 9203.40177888435, 10611.469426528643, 10998.075336816026, 11258.831117533244, 11508.769824603629, 11060.778784424427, 14553.417863285349, 14568.635784105481, 14577.489787857587, 14594.759445447256, 8669.0, 8803.955980220058, 8815.294776417872, 8852.424592401474, 8969.416987895765, 7086.362227399456, 8659.78350541229, 8750.168733970262, 8839.646414143492, 8859.202671759573, 6384.170057892445, 6525.64108974011, 6857.794266172023, 7009.369156775812, 7029.191642961125, 1874.2034635279952, 1885.9245630174914, 1910.9808901910803, 1921.3083290015584, 1947.5325921778672, 803.5781214862244, 967.908048735369, 1021.2238698588977, 1021.6543055431424, 1037.2479952034864, 19849.801501985083, 19892.204311827365, 21097.89451052735, 21896.671549926763, 21964.89017554902, 846.8645016797283, 913.8896241067135, 928.2481190235931, 968.6997030920437, 1047.659510659039, 11041.558337666564, 11496.885031149748, 11564.24832385909, 11721.238119522204, 11770.58802941893, 557374.0, 563740.0, 597229.0, 609591.0, 627735.0, 82389.76415353775, 96668.0, 118978.62042759097, 125270.0, 130469.60538748803, 1029.5727273181697, 1042.9582816687248, 1049.9212559057949, 1052.2844465763355, 1055.4300677634146, 14898.478553250585, 18609.9069504657, 19180.040997949767, 19191.61616767629, 19260.22959081621, 48410.0, 48632.02735945332, 49028.754856226915, 49516.0, 49931.50068499269, 66382.66808665925, 67393.66303168453, 67880.0, 67917.20182801191, 67990.0, 7927.960360198162, 8029.959850200712, 8172.877406838783, 8293.502389856629, 8396.454230475, 12198.878011219775, 12431.44058517387, 12715.618531444072, 13010.80483792725, 13100.934495327463, 10130.632364630681, 10841.51213195424, 11393.943030284796, 11505.539778408769, 11533.480993355486, 10749.0, 10963.56145754161, 11096.039471134574, 11264.605738799102, 11465.197436179387, 9927.40435573868, 11298.83051754208, 11399.34709467106, 11593.304401735923, 11795.823062653895, 8059.5164290142775, 8063.072746634212, 8168.877466837884, 8219.095899450936, 8275.751727447945, 10264.963496359731, 10718.410487423267, 10935.179861510578, 11012.119030477703, 11031.448427578749], "value": 9687.338079288766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1595.433621064522, 1630.4863967850126, 1871.8099823206846, 1949.2690241159573, 1949.8064677238108, 8067.0, 8637.309015278779, 8695.826083478343, 8888.866667, 8917.286617070635, 7807.4144439167, 8158.265756081952, 8830.470171789697, 8931.821363572724, 9020.90979090209, 2074.751029876417, 2464.6179842124498, 2482.553140434721, 2485.962710559343, 2490.5392502387117, 2435.9512809743796, 2459.655648209252, 2461.544614246361, 2489.9253022409357, 2497.7627125423055, 2151.9031643576, 2421.7285924889397, 2432.1487479382163, 2485.515324511721, 2494.239257026606, 2028.8478364122675, 2441.377448750557, 2462.655228268044, 2463.187148241085, 2464.4824586836694, 2419.4677171022345, 2433.707955045406, 2448.3511869354634, 2449.363165576945, 2457.4347899982927, 8789.956050219707, 8859.64561417549, 8968.865467018, 9021.864672029924, 9055.366124371296, 5353.759080841332, 5426.810061647863, 5467.863303417406, 5516.420775818561, 5523.696196709179, 3534.7172226222096, 3550.5206797082324, 3567.839447224881, 3609.9458508122398, 3624.3476174288617, 995.4922989275449, 1000.7698229407205, 1011.0546638892658, 1023.8822535408375, 1039.0544604409952, 11648.59229926957, 11731.354775487345, 11737.647870563982, 11744.823827642593, 11787.646370608896, 4704.6236301096515, 4824.992308990055, 4854.344663470386, 4928.408590969035, 4940.456549779521, 9860.704178874645, 9876.65431709901, 10050.59797608102, 10077.0, 10119.190464762802, 5322.6806391615855, 5459.481349271813, 5464.726763661801, 5467.671939683552, 5486.670799752028, 4424.668149888771, 4784.545468180587, 4942.20924652054, 4968.627352948543, 5015.297858299841, 4095.722953383895, 4102.979485102555, 4103.938440923389, 4119.629233369011, 4164.792659890263, 1358.3547814788094, 1387.3826147364325, 1393.665520275147, 1399.2583930516842, 1401.9579412617638, 813.1502579804119, 826.5825757992176, 868.68727258187, 892.4065496444921, 906.2206502407923, 5426.077566813651, 5439.129739241703, 5483.0, 5503.449655034545, 5522.061249587579, 445.1630933844352, 451.55070704649086, 453.68922288232665, 458.52084571622737, 472.4826315184867, 3929.6659783918117, 4034.0923292259595, 4045.130296986162, 4084.264832330209, 4102.261592913304, 10360.948195259127, 10598.25812193139, 10604.151667866552, 10681.732956676145, 10784.89215107839, 8267.29727973117, 9764.560594773253, 10532.999365060306, 10558.788824223626, 10746.892531074745, 6857.794266172023, 8032.437729358889, 8124.796880077927, 8271.95864020676, 8302.377321701017, 5727.513161381163, 5863.970680146572, 5936.1095835625, 5940.910886336795, 5978.461938425563, 9782.9021709782, 9827.901720982698, 9832.754181145528, 9933.0, 10054.447005414773, 7561.281678240558, 8983.550822458981, 9668.806623867624, 9889.25830562725, 9898.851517227104, 6879.862402751817, 7344.559326440431, 7578.772636820904, 8026.317762989977, 8369.581520923808, 8162.5510596915365, 8174.918250817415, 8328.666853326042, 8337.458065225741, 8417.0, 7344.70621175147, 7463.552186868806, 7561.508501947355, 7584.355329796808, 7641.847163056819, 7311.707531698885, 7320.853582928418, 7445.441591880739, 7496.0255166827965, 7566.054243219598, 6978.685959131953, 7041.647917604202, 7125.714971401293, 7146.32109949554, 7177.354038136593, 4811.759412029314, 4862.41651001882, 4942.827001054946, 4993.325901003318, 5228.372595288438, 4936.75316234194, 5042.899142017212, 5061.797528098835, 5064.721440320818, 5218.608604354613], "value": 4527.449663998388, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.7758171044875, 312.673256447013, 330.9238875058735, 331.7777089350135, 332.7554247627993, 5801.970990145054, 5869.970650146749, 6010.595761695324, 6225.501959843213, 6269.623822570643, 5869.471747542721, 6103.023516237403, 6131.233595800525, 6177.393877591825, 6254.312025677184, 4682.859514214562, 4686.695364801294, 4694.577488026077, 4703.576678098971, 4705.188797074364, 3579.210394802599, 4687.296905464191, 4688.179568575486, 4713.151632706112, 4722.0, 4613.561711637389, 4623.237165867645, 4657.743824089674, 4671.0, 4676.532346765313, 3837.9253808933404, 4416.425864637608, 4656.998745269783, 4662.927526668851, 4678.906421871544, 3793.374093274634, 3990.3615421532418, 4018.1561872006623, 4052.696047796427, 4056.371262454324, 5454.59090568205, 5907.793227237069, 5953.493953013999, 6000.489958353545, 6002.129691194796, 5461.5357694596005, 5495.230667706524, 5497.202905578709, 5497.230387745719, 5503.284573005523, 5514.593778586475, 6307.117003619497, 6602.1747281589805, 6627.80116596498, 6638.900416493757, 4272.230998420283, 4311.698181127323, 4499.212637788407, 4509.03055842992, 4510.639148868083, 6701.816637097389, 6888.724451022003, 6960.686769095403, 6965.756198533027, 6993.230744618088, 3825.9426108608395, 3878.9612103879163, 4174.582541745862, 4186.979065104655, 4529.026259354255, 4645.767711614406, 4660.766961651904, 4663.417072865892, 4664.65015123867, 4667.159911215946, 4600.861974140781, 5421.783128674888, 5464.26232458621, 5485.670859748348, 5487.478689524489, 5742.540596752333, 6228.439440450381, 6305.96847015762, 6455.5468921809415, 6619.702113404908, 1483.3250870853735, 1504.7968524249304, 1598.1940407339632, 1605.3658804772049, 1619.1661294433377, 1041.7239431550645, 1055.9862531969395, 1064.21248276275, 1066.5147357952112, 1083.263380900995, 5303.443138470482, 6175.660338681326, 6187.762447510426, 6191.442770150708, 6238.532110091761, 6876.17485901685, 6879.58722476653, 6879.690413931385, 6905.343992320722, 6912.0, 4975.527324904128, 5216.817411390583, 5922.262190247785, 6159.907601385983, 6274.215723034621, 2793.0, 3618.118578339249, 3628.8367023484006, 3634.83643236055, 3638.8180590970346, 7032.578045317297, 7099.6450177490915, 7109.8933515997305, 7119.89320160198, 7193.55419157489, 5802.419758024248, 7011.579305241702, 7016.964915175494, 7041.40148087408, 7053.435725141976, 5613.691246981373, 5984.940150598438, 7060.646967651597, 7110.644467776694, 7172.13934327884, 5783.450572195635, 6474.417302442803, 6823.1812182538415, 6843.863122737418, 6860.691268892812, 5816.952948469147, 6197.907031394623, 6532.934670653232, 6639.3692599203, 6688.097106890507, 6178.443940045418, 7003.439724822104, 7093.893591596234, 7103.696780996861, 7106.786796396116, 3797.4493698414126, 3882.6893848491486, 4325.286327755885, 4379.759113248802, 4576.88557786058, 5456.345238571397, 5907.763689452374, 6440.29156792743, 6589.27517973013, 6857.965710171417, 6644.700988455627, 6653.833654158491, 6672.065910772592, 6689.799306020827, 6703.631300278532, 6111.816645500642, 6347.333529979471, 6643.56816806906, 6655.939876675321, 6667.766628167991, 6451.3548645135115, 6475.514336424692, 6481.8703625928165, 6526.24948130971, 6565.474762019123, 5339.3058902342445, 5783.681897495678, 6495.935040649533, 6619.635920024445, 6687.057694614354, 5756.754865602335, 6250.843728906813, 6510.772122975863, 6526.608403495806, 6533.811173257012], "value": 4781.116268538539, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.7084083003479, 699.6431819771915, 734.5042096584806, 741.9517731347462, 754.1666458563287, 14756.778648320284, 15161.620959476018, 15214.619634509128, 15476.38094476221, 16428.425005124824, 15628.0, 15882.3647054118, 15938.840611593881, 15958.680826383465, 16012.59968500788, 902.5938327752505, 912.393258483108, 915.9084091590821, 916.408916249019, 919.2554031234688, 699.601227300439, 893.5175005497024, 922.0687106022932, 924.8381533231691, 925.282905748044, 925.6852670092168, 962.1052421248237, 967.89837067108, 968.8449848024318, 970.9805803883918, 937.4843835890301, 961.1589858873485, 961.5913236874301, 962.2206013129353, 964.5466630683568, 686.1731613405834, 689.2039694153261, 707.5471698113212, 714.6248219684655, 718.1023720349563, 13725.862741372559, 13792.448302068005, 13902.791458128137, 13977.58067257984, 14013.229272390014, 11998.760024799543, 12028.0, 12133.817992730115, 12167.391630418444, 12365.69085772854, 9865.1614612758, 10025.248106391977, 10123.493825308706, 10209.13222376099, 10732.528991682486, 4064.5122585289955, 4066.430699702044, 4071.063655359284, 4082.448869402622, 4388.188185185751, 80756.19243807605, 82323.58838205831, 82584.17415825884, 82701.0, 83185.0, 9129.497877616795, 9344.112309330603, 9382.202512786489, 9442.905570944202, 9463.858042129374, 21554.922253887242, 21777.56444871094, 21801.345959620918, 21829.0, 21893.67159492609, 7520.511166774142, 7661.502002369828, 7761.72833950809, 7762.340201082971, 7853.293203611703, 3734.626537346244, 3775.565809931838, 3790.886273411802, 3801.790901500444, 3846.8845934622004, 3617.5297211362354, 3721.0, 3724.217914237986, 3729.1236559408517, 3743.344914639927, 672.0792514255501, 674.1236392689484, 684.551618689759, 684.8082536889679, 698.3749544157951, 535.946405359461, 575.6143383932775, 587.9294484661868, 592.6947621974687, 613.163032460688, 7710.845783084307, 7889.0927543333255, 8105.635246413807, 8120.715774947848, 8218.547979861165, 568.903286441306, 571.6770024935898, 575.923023945225, 588.0532342927883, 597.6175247841385, 3773.811309434517, 3785.2240290740333, 3845.615438456188, 3900.8829735107993, 3927.8232479538487, 72621.0, 85279.14720852712, 92078.53960730153, 93121.60317595242, 93513.53243233741, 64394.67802660957, 69382.65308673526, 74945.0, 75443.62278188574, 76162.0, 50737.0, 69365.65317173382, 69411.65294173599, 70000.0, 70848.93726594003, 7465.850682986418, 7541.350156217045, 7795.259450352434, 7808.648610812641, 7810.960945195237, 41689.58310416978, 41825.58174418217, 42752.57247427486, 43719.0, 44376.77811610921, 58110.7094464525, 63380.36619633929, 63907.680461597396, 64037.0, 64165.35834641594, 9126.817463650823, 9146.725598232064, 9881.20950323958, 10217.846732298873, 10286.537105830404, 9024.781654476561, 10647.148228141885, 10686.57253709874, 10826.242163048511, 10843.915608439092, 10046.648367307109, 10096.0, 10148.276717084056, 10310.690679279634, 10367.585296588353, 11096.278741882075, 11156.609518666808, 11486.712832179262, 11616.535338586362, 11700.765984680429, 11259.887401125883, 11343.432828358715, 11343.659690209306, 11598.826017609912, 11759.000484958533, 9272.536373181449, 9389.624415023323, 9494.287928405536, 9529.999350068143, 9640.42157470554, 9210.95394523023, 9483.762905927131, 9703.66037188695, 9764.462954537568, 9796.118349348593], "value": 6788.878162108472, "unit": "score"}], "name": "dromaeo_css", "value": 7248.832480082513, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 143.0, 127.0, 97.0, 113.0, 144.0, 108.0, 162.0, 96.0, 152.0], "value": 130.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 145.0, 152.0, 119.0, 139.0, 143.0, 121.0, 172.0, 111.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 199.0, 202.0, 211.0, 210.0, 194.0, 184.0, 256.0, 281.0, 242.0], "value": 217.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 78.0, 75.0, 127.0, 58.0, 69.0, 93.0, 86.0, 104.0, 70.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 84.0, 132.0, 80.0, 83.0, 83.0, 118.0, 80.0, 82.0, 121.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 76.0, 136.0, 129.0, 89.0, 85.0, 90.0, 87.0, 107.0, 79.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 96.0, 96.0, 105.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 107.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 91.0, 92.0, 91.0, 99.0, 137.0, 91.0, 92.0, 94.0], "value": 97.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0, 76.0, 65.0, 62.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 72.0, 74.0, 69.0, 64.0, 65.0, 66.0, 66.0, 69.0], "value": 67.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 104.0, 71.0, 90.0, 111.0, 107.0, 78.0, 95.0, 112.0, 107.0], "value": 97.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 142.0, 136.0, 140.0, 127.0, 157.0, 134.0, 192.0, 176.0], "value": 148.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 174.0, 189.0, 173.0, 211.0, 210.0, 222.0, 252.0, 217.0], "value": 199.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 95.0, 62.0, 81.0, 98.0, 103.0, 94.0, 70.0, 57.0], "value": 81.3, "unit": "score"}], "name": "kraken", "value": 1621.0000000000002, "alertThreshold": 2.0}]} 05:28:24 INFO - Return code: 0 05:28:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:24 ERROR - # TBPL SUCCESS # 05:28:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:24 INFO - 2016-04-25 05:28:24.142 screenresolution[2038:16472] starting screenresolution argv=screenresolution get 05:28:24 INFO - 2016-04-25 05:28:24.144 screenresolution[2038:16472] Display 0: 1600x1200x32@60 05:28:24 INFO - 2016-04-25 05:28:24.150 screenresolution[2039:16475] starting screenresolution argv=screenresolution list 05:28:24 INFO - Available Modes on Display 0 05:28:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:24 INFO - Intel Iris: 05:28:24 INFO - Chipset Model: Intel Iris 05:28:24 INFO - Type: GPU 05:28:24 INFO - Bus: Built-In 05:28:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:24 INFO - Vendor: Intel (0x8086) 05:28:24 INFO - Device ID: 0x0a2e 05:28:24 INFO - Revision ID: 0x0009 05:28:24 INFO - Displays: 05:28:24 INFO - Display: 05:28:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:24 INFO - Display Serial Number: 1600x1200 60 05:28:24 INFO - Main Display: Yes 05:28:24 INFO - Mirror: Off 05:28:24 INFO - Online: Yes 05:28:24 INFO - Rotation: Supported 05:28:24 INFO - Return code: 0 05:28:24 INFO - Running post-action listener: _resource_record_post_action 05:28:24 INFO - Running post-run listener: _resource_record_post_run 05:28:25 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 795136; Write bytes: 695946240; Read time: 10; Write time: 1848 05:28:25 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 395428352; Write bytes: 397465600; Read time: 30035; Write time: 717 05:28:25 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 795136; Write bytes: 297473024; Read time: 10; Write time: 1127 05:28:25 INFO - Running post-run listener: _upload_blobber_files 05:28:25 INFO - Blob upload gear active. 05:28:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:28:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:28:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:28:25 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:26 INFO - (blobuploader) - INFO - Done attempting. 05:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:27 INFO - (blobuploader) - INFO - Done attempting. 05:28:27 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:27 INFO - Return code: 0 05:28:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a266a74b5ae90a78784a386a69023d7e5c2ecfcf2d98ed3ef487ce55fe8e9e7c2c10101d0403388f559a00b404ce37b7f43905893b521dc1af8c75b08fa3bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441b2d13b91116d1408a804ef0eeb8d17fee2902c4ee0ab7e1e9932d8f3bc4f5766df131963cb8b38acf2509be25bb65f7ffd3e3e7e8edd01e69707ac42c3f59"} 05:28:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:27 INFO - Contents: 05:28:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a266a74b5ae90a78784a386a69023d7e5c2ecfcf2d98ed3ef487ce55fe8e9e7c2c10101d0403388f559a00b404ce37b7f43905893b521dc1af8c75b08fa3bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441b2d13b91116d1408a804ef0eeb8d17fee2902c4ee0ab7e1e9932d8f3bc4f5766df131963cb8b38acf2509be25bb65f7ffd3e3e7e8edd01e69707ac42c3f59"} 05:28:27 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:27 INFO - Copying logs to upload dir... 05:28:27 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.109426 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-25 05:28:27.542432) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:27.545656) ========= 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.608JMxrnTX/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.rRCWlUAfZy/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/9a266a74b5ae90a78784a386a69023d7e5c2ecfcf2d98ed3ef487ce55fe8e9e7c2c10101d0403388f559a00b404ce37b7f43905893b521dc1af8c75b08fa3bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441b2d13b91116d1408a804ef0eeb8d17fee2902c4ee0ab7e1e9932d8f3bc4f5766df131963cb8b38acf2509be25bb65f7ffd3e3e7e8edd01e69707ac42c3f59"} build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011070 build_url: 'https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9a266a74b5ae90a78784a386a69023d7e5c2ecfcf2d98ed3ef487ce55fe8e9e7c2c10101d0403388f559a00b404ce37b7f43905893b521dc1af8c75b08fa3bef", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/441b2d13b91116d1408a804ef0eeb8d17fee2902c4ee0ab7e1e9932d8f3bc4f5766df131963cb8b38acf2509be25bb65f7ffd3e3e7e8edd01e69707ac42c3f59"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:27.581081) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:27.581492) ========= 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.608JMxrnTX/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.rRCWlUAfZy/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005241 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:27.631615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:27.631976) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:27.633451) ========= ========= Total master_lag: 0.20 =========