builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0135 starttime: 1460728508.01 results: success (0) buildid: 20160415050139 builduid: 095ccbffc2034b02a84f5da0b824ff4e revision: 8f7045b63b07c01309ab451ad120eacfdaa420d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.013971) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.014406) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.014676) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.037721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.038021) ========= 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.TfloN6mGoF/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.ufXmj58UJb/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-15 06:55:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.5M=0.001s 2016-04-15 06:55:08 (22.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.402311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.460107) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.460434) ========= 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.TfloN6mGoF/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.ufXmj58UJb/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.027152 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:08.509148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 06:55:08.509492) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8f7045b63b07c01309ab451ad120eacfdaa420d1 --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 8f7045b63b07c01309ab451ad120eacfdaa420d1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TfloN6mGoF/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.ufXmj58UJb/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-15 06:55:08,584 truncating revision to first 12 chars 2016-04-15 06:55:08,584 Setting DEBUG logging. 2016-04-15 06:55:08,584 attempt 1/10 2016-04-15 06:55:08,584 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8f7045b63b07?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 06:55:10,234 unpacking tar archive at: fx-team-8f7045b63b07/testing/mozharness/ program finished with exit code 0 elapsedTime=1.891301 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-15 06:55:10.725617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:10.725944) ========= script_repo_revision: 8f7045b63b07c01309ab451ad120eacfdaa420d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:10.726323) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:10.726584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 06:55:10.743430) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-15 06:55:10.743718) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.TfloN6mGoF/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.ufXmj58UJb/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:10 INFO - MultiFileLogger online at 20160415 06:55:10 in /builds/slave/test 06:55:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:55:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:55:10 INFO - {'append_to_log': False, 06:55:10 INFO - 'base_work_dir': '/builds/slave/test', 06:55:10 INFO - 'blob_upload_branch': 'Fx-Team', 06:55:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:55:10 INFO - 'branch': 'Fx-Team', 06:55:10 INFO - 'buildbot_json_path': 'buildprops.json', 06:55:10 INFO - 'config_files': ('talos/mac_config.py',), 06:55:10 INFO - 'default_actions': ('clobber', 06:55:10 INFO - 'read-buildbot-config', 06:55:10 INFO - 'download-and-extract', 06:55:10 INFO - 'populate-webroot', 06:55:10 INFO - 'create-virtualenv', 06:55:10 INFO - 'install', 06:55:10 INFO - 'run-tests'), 06:55:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:55:10 INFO - 'download_minidump_stackwalk': True, 06:55:10 INFO - 'download_symbols': 'ondemand', 06:55:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:55:10 INFO - 'tooltool.py': '/tools/tooltool.py', 06:55:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:55:10 INFO - '/tools/misc-python/virtualenv.py')}, 06:55:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:55:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:55:10 INFO - 'installer_path': 'installer.exe', 06:55:10 INFO - 'log_level': 'info', 06:55:10 INFO - 'log_name': 'talos', 06:55:10 INFO - 'log_to_console': True, 06:55:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:55:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:55:10 INFO - 'opt_config_files': (), 06:55:10 INFO - 'pip_index': False, 06:55:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:55:10 INFO - 'cmd': ('bash', 06:55:10 INFO - '-c', 06:55:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:55:10 INFO - 'enabled': True, 06:55:10 INFO - 'halt_on_failure': False, 06:55:10 INFO - 'name': 'check_screen_resolution'},), 06:55:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:55:10 INFO - 'cmd': ('bash', 06:55:10 INFO - '-c', 06:55:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:55:10 INFO - 'enabled': True, 06:55:10 INFO - 'halt_on_failure': False, 06:55:10 INFO - 'name': 'check_screen_resolution'},), 06:55:10 INFO - 'run_cmd_checks_enabled': True, 06:55:10 INFO - 'sps_profile': False, 06:55:10 INFO - 'sps_profile_interval': 0, 06:55:10 INFO - 'suite': 'dromaeojs', 06:55:10 INFO - 'system_bits': '32', 06:55:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:55:10 INFO - 'title': 't-yosemite-r7-0135', 06:55:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:55:10 INFO - 'use_talos_json': True, 06:55:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:55:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:55:10 INFO - 'work_dir': 'build'} 06:55:10 INFO - ##### 06:55:10 INFO - ##### Running clobber step. 06:55:10 INFO - ##### 06:55:10 INFO - Running pre-action listener: _resource_record_pre_action 06:55:10 INFO - Running main action method: clobber 06:55:10 INFO - rmtree: /builds/slave/test/build 06:55:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:55:13 INFO - Running post-action listener: _resource_record_post_action 06:55:13 INFO - ##### 06:55:13 INFO - ##### Running read-buildbot-config step. 06:55:13 INFO - ##### 06:55:13 INFO - Running pre-action listener: _resource_record_pre_action 06:55:13 INFO - Running main action method: read_buildbot_config 06:55:13 INFO - Using buildbot properties: 06:55:13 INFO - { 06:55:13 INFO - "project": "", 06:55:13 INFO - "product": "firefox", 06:55:13 INFO - "script_repo_revision": "production", 06:55:13 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:55:13 INFO - "repository": "", 06:55:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:55:13 INFO - "buildid": "20160415050139", 06:55:13 INFO - "pgo_build": "False", 06:55:13 INFO - "basedir": "/builds/slave/test", 06:55:13 INFO - "buildnumber": 728, 06:55:13 INFO - "slavename": "t-yosemite-r7-0135", 06:55:13 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:55:13 INFO - "platform": "yosemite_r7", 06:55:13 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:55:13 INFO - "branch": "fx-team", 06:55:13 INFO - "repo_path": "integration/fx-team", 06:55:13 INFO - "revision": "8f7045b63b07c01309ab451ad120eacfdaa420d1", 06:55:13 INFO - "stage_platform": "macosx64", 06:55:13 INFO - "builduid": "095ccbffc2034b02a84f5da0b824ff4e", 06:55:13 INFO - "slavebuilddir": "test" 06:55:13 INFO - } 06:55:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:55:13 INFO - Running post-action listener: _resource_record_post_action 06:55:13 INFO - ##### 06:55:13 INFO - ##### Running download-and-extract step. 06:55:13 INFO - ##### 06:55:13 INFO - Running pre-action listener: _resource_record_pre_action 06:55:13 INFO - Running main action method: download_and_extract 06:55:13 INFO - mkdir: /builds/slave/test/build/tests 06:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:13 INFO - https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:55:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:55:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:55:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:14 INFO - Downloaded 1199 bytes. 06:55:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:55:14 INFO - Using the following test package requirements: 06:55:14 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:55:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:55:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:55:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'jsshell-mac.zip'], 06:55:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:55:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:55:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:55:14 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:55:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:55:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:55:14 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:55:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:55:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:14 INFO - https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:55:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:55:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:55:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:17 INFO - Downloaded 18034022 bytes. 06:55:17 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'] 06:55:17 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 06:55:21 INFO - Return code: 0 06:55:21 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 06:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:21 INFO - https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:22 INFO - Downloaded 18034022 bytes. 06:55:22 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'] 06:55:22 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 06:55:26 INFO - Return code: 0 06:55: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')]} 06:55:26 INFO - https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:27 INFO - Downloaded 10841076 bytes. 06:55:27 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'] 06:55:27 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 06:55:27 INFO - Return code: 0 06:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:27 INFO - https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eMmExvuNQCKLM1MBHfZj2A/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 06:55:30 INFO - Downloaded 109946942 bytes. 06:55:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:55:30 INFO - mkdir: /builds/slave/test/properties 06:55:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:30 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:30 INFO - Contents: 06:55:30 INFO - build_url:https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:55:31 INFO - Running post-action listener: _resource_record_post_action 06:55:31 INFO - Running post-action listener: set_extra_try_arguments 06:55:31 INFO - ##### 06:55:31 INFO - ##### Running populate-webroot step. 06:55:31 INFO - ##### 06:55:31 INFO - Running pre-action listener: _resource_record_pre_action 06:55:31 INFO - Running main action method: populate_webroot 06:55:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:31 INFO - '--tppagecycles', 06:55:31 INFO - '7'], 06:55:31 INFO - 'tests': ['tsvgm']}}, 06:55:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['damp', 'tps']}, 06:55:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'tests': ['damp', 'tps']}, 06:55:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['dromaeo_dom']}, 06:55:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['a11yr', 06:55:31 INFO - 'ts_paint', 06:55:31 INFO - 'tpaint', 06:55:31 INFO - 'sessionrestore', 06:55:31 INFO - 'sessionrestore_no_auto_restore', 06:55:31 INFO - 'tabpaint']}, 06:55:31 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:31 INFO - 'ts_paint', 06:55:31 INFO - 'tpaint', 06:55:31 INFO - 'sessionrestore', 06:55:31 INFO - 'sessionrestore_no_auto_restore', 06:55:31 INFO - 'tabpaint']}, 06:55:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:31 INFO - 'ts_paint', 06:55:31 INFO - 'tpaint', 06:55:31 INFO - 'sessionrestore', 06:55:31 INFO - 'sessionrestore_no_auto_restore', 06:55:31 INFO - 'tabpaint']}, 06:55:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:31 INFO - 'ts_paint', 06:55:31 INFO - 'tpaint', 06:55:31 INFO - 'sessionrestore', 06:55:31 INFO - 'sessionrestore_no_auto_restore', 06:55:31 INFO - 'tabpaint']}, 06:55:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['a11yr', 06:55:31 INFO - 'ts_paint', 06:55:31 INFO - 'tpaint', 06:55:31 INFO - 'sessionrestore', 06:55:31 INFO - 'sessionrestore_no_auto_restore', 06:55:31 INFO - 'tabpaint']}, 06:55:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['a11yr', 06:55:31 INFO - 'ts_paint', 06:55:31 INFO - 'tpaint', 06:55:31 INFO - 'sessionrestore', 06:55:31 INFO - 'sessionrestore_no_auto_restore', 06:55:31 INFO - 'tabpaint']}, 06:55:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['tsvgx', 06:55:31 INFO - 'tsvgr_opacity', 06:55:31 INFO - 'tart', 06:55:31 INFO - 'tscrollx', 06:55:31 INFO - 'cart']}, 06:55:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:31 INFO - 'tsvgr_opacity', 06:55:31 INFO - 'tart', 06:55:31 INFO - 'tscrollx', 06:55:31 INFO - 'cart']}, 06:55:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'talos_options': ['--disable-e10s'], 06:55:31 INFO - 'tests': ['tp5o']}, 06:55:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'tests': ['tp5o']}, 06:55:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'talos_options': ['--disable-e10s', 06:55:31 INFO - '--xperf_path', 06:55:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:31 INFO - 'tests': ['tp5n']}, 06:55:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:55:31 INFO - 'talos_options': ['--xperf_path', 06:55:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:31 INFO - 'tests': ['tp5n']}}, 06:55:31 INFO - 'talos.zip': {'path': '', 06:55:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:31 INFO - Running post-action listener: _resource_record_post_action 06:55:31 INFO - ##### 06:55:31 INFO - ##### Running create-virtualenv step. 06:55:31 INFO - ##### 06:55:31 INFO - Running pre-action listener: _resource_record_pre_action 06:55:31 INFO - Running main action method: create_virtualenv 06:55:31 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:31 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 06:55:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:31 INFO - Using real prefix '/tools/python27' 06:55:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:32 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:35 INFO - Installing pip.................done. 06:55:35 INFO - Return code: 0 06:55:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:35 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:35 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 06:55:35 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 06:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:35 INFO - 'HOME': '/Users/cltbld', 06:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:35 INFO - 'LOGNAME': 'cltbld', 06:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:35 INFO - 'MOZ_NO_REMOTE': '1', 06:55:35 INFO - 'NO_EM_RESTART': '1', 06:55:35 INFO - 'PAGER': '/bin/cat', 06:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:35 INFO - 'PWD': '/builds/slave/test', 06:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:35 INFO - 'SHELL': '/bin/bash', 06:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:35 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:35 INFO - 'USER': 'cltbld', 06:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:35 INFO - 'XPC_FLAGS': '0x0', 06:55:35 INFO - 'XPC_SERVICE_NAME': '0', 06:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:35 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 06:55:35 INFO - Cleaning up... 06:55:35 INFO - Return code: 0 06:55:35 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:35 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:35 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 06:55:35 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 06:55:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:35 INFO - 'HOME': '/Users/cltbld', 06:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:35 INFO - 'LOGNAME': 'cltbld', 06:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:35 INFO - 'MOZ_NO_REMOTE': '1', 06:55:35 INFO - 'NO_EM_RESTART': '1', 06:55:35 INFO - 'PAGER': '/bin/cat', 06:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:35 INFO - 'PWD': '/builds/slave/test', 06:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:35 INFO - 'SHELL': '/bin/bash', 06:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:35 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:35 INFO - 'USER': 'cltbld', 06:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:35 INFO - 'XPC_FLAGS': '0x0', 06:55:35 INFO - 'XPC_SERVICE_NAME': '0', 06:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:35 INFO - Downloading/unpacking psutil>=0.7.1 06:55:35 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 06:55:35 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 06:55:35 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 06:55:35 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 06:55:35 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 06:55:35 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 06:55:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:38 INFO - Installing collected packages: psutil 06:55:38 INFO - Running setup.py install for psutil 06:55:38 INFO - building 'psutil._psutil_osx' extension 06:55:38 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 06:55:39 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 06:55:39 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 06:55:39 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 06:55:39 INFO - building 'psutil._psutil_posix' extension 06:55:39 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 06:55:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:55:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:55:39 INFO - ^ 06:55:39 INFO - 1 warning generated. 06:55:39 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 06:55:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:39 INFO - Successfully installed psutil 06:55:39 INFO - Cleaning up... 06:55:40 INFO - Return code: 0 06:55:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:55:40 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')]} 06:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:40 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')]} 06:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:40 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:40 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 06:55:40 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 06:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:40 INFO - 'HOME': '/Users/cltbld', 06:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:40 INFO - 'LOGNAME': 'cltbld', 06:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:40 INFO - 'MOZ_NO_REMOTE': '1', 06:55:40 INFO - 'NO_EM_RESTART': '1', 06:55:40 INFO - 'PAGER': '/bin/cat', 06:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:40 INFO - 'PWD': '/builds/slave/test', 06:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:40 INFO - 'SHELL': '/bin/bash', 06:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:40 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:40 INFO - 'USER': 'cltbld', 06:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:40 INFO - 'XPC_FLAGS': '0x0', 06:55:40 INFO - 'XPC_SERVICE_NAME': '0', 06:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:55:40 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 06:55:40 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 06:55:40 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 06:55:40 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 06:55:40 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 06:55:40 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 06:55:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:55:42 INFO - Installing collected packages: mozsystemmonitor 06:55:42 INFO - Running setup.py install for mozsystemmonitor 06:55:43 INFO - Successfully installed mozsystemmonitor 06:55:43 INFO - Cleaning up... 06:55:43 INFO - Return code: 0 06:55:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:43 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')]} 06:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:43 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')]} 06:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:43 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:43 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 06:55:43 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 06:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:43 INFO - 'HOME': '/Users/cltbld', 06:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:43 INFO - 'LOGNAME': 'cltbld', 06:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:43 INFO - 'MOZ_NO_REMOTE': '1', 06:55:43 INFO - 'NO_EM_RESTART': '1', 06:55:43 INFO - 'PAGER': '/bin/cat', 06:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:43 INFO - 'PWD': '/builds/slave/test', 06:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:43 INFO - 'SHELL': '/bin/bash', 06:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:43 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:43 INFO - 'USER': 'cltbld', 06:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:43 INFO - 'XPC_FLAGS': '0x0', 06:55:43 INFO - 'XPC_SERVICE_NAME': '0', 06:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:43 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:43 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 06:55:43 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 06:55:43 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 06:55:43 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 06:55:43 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 06:55:43 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 06:55:45 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55: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 06:55:46 INFO - Downloading docopt-0.6.1.tar.gz 06:55:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:47 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:47 INFO - Running setup.py install for blobuploader 06:55:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:47 INFO - Running setup.py install for requests 06:55:47 INFO - Running setup.py install for docopt 06:55:47 INFO - Successfully installed blobuploader requests docopt 06:55:47 INFO - Cleaning up... 06:55:47 INFO - Return code: 0 06:55:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:47 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:47 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 06:55:47 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 06:55:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:47 INFO - 'HOME': '/Users/cltbld', 06:55:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:47 INFO - 'LOGNAME': 'cltbld', 06:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:47 INFO - 'MOZ_NO_REMOTE': '1', 06:55:47 INFO - 'NO_EM_RESTART': '1', 06:55:47 INFO - 'PAGER': '/bin/cat', 06:55:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:47 INFO - 'PWD': '/builds/slave/test', 06:55:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:47 INFO - 'SHELL': '/bin/bash', 06:55:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:47 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:47 INFO - 'USER': 'cltbld', 06:55:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:47 INFO - 'XPC_FLAGS': '0x0', 06:55:47 INFO - 'XPC_SERVICE_NAME': '0', 06:55:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-6EXzpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Oriza9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-0ChxTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-W1gYiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BTX5mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-PwNk2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-UVtK9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FQrzL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8kgHDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-d7irbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-a5YoTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-z56Q16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aDgaez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aZnKWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4PAWH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-3ZRPX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:49 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Z4jAB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:50 INFO - Running setup.py install for manifestparser 06:55:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozcrash 06:55:50 INFO - Running setup.py install for mozdebug 06:55:50 INFO - Running setup.py install for mozdevice 06:55:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozfile 06:55:50 INFO - Running setup.py install for mozhttpd 06:55:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:50 INFO - Running setup.py install for mozinfo 06:55:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for mozInstall 06:55:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for mozleak 06:55:51 INFO - Running setup.py install for mozlog 06:55:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for moznetwork 06:55:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:51 INFO - Running setup.py install for mozprocess 06:55:51 INFO - Running setup.py install for mozprofile 06:55:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:52 INFO - Running setup.py install for mozrunner 06:55:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:52 INFO - Running setup.py install for mozscreenshot 06:55:52 INFO - Running setup.py install for moztest 06:55:52 INFO - Running setup.py install for mozversion 06:55:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:52 INFO - Cleaning up... 06:55:52 INFO - Return code: 0 06:55:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:52 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:52 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 06:55:52 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 06:55:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:52 INFO - 'HOME': '/Users/cltbld', 06:55:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:52 INFO - 'LOGNAME': 'cltbld', 06:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:52 INFO - 'MOZ_NO_REMOTE': '1', 06:55:52 INFO - 'NO_EM_RESTART': '1', 06:55:52 INFO - 'PAGER': '/bin/cat', 06:55:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:52 INFO - 'PWD': '/builds/slave/test', 06:55:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:52 INFO - 'SHELL': '/bin/bash', 06:55:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:52 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:52 INFO - 'USER': 'cltbld', 06:55:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:52 INFO - 'XPC_FLAGS': '0x0', 06:55:52 INFO - 'XPC_SERVICE_NAME': '0', 06:55:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:52 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Vl4KJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ztMMZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-EecWKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-qJU3Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-pLmcnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Rs2tc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-kQfvBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-KxeTb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-XXmKFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:53 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)) 06:55:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:53 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-hq1Dbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-FN0qNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-EIcQRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DYP4LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-i2CxRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-2Qk6zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-sUXCOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:54 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)) 06:55:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:54 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DXRAwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 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)) 06:55:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:54 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 06:55:54 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 06:55:54 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 06:55:54 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 06:55:54 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 06:55:54 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 06:55:57 INFO - Downloading blessings-1.6.tar.gz 06:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:57 INFO - Installing collected packages: blessings 06:55:57 INFO - Running setup.py install for blessings 06:55:57 INFO - Successfully installed blessings 06:55:57 INFO - Cleaning up... 06:55:57 INFO - Return code: 0 06:55:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:57 INFO - Reading from file tmpfile_stdout 06:55:57 INFO - Current package versions: 06:55:57 INFO - blessings == 1.6 06:55:57 INFO - blobuploader == 1.2.4 06:55:57 INFO - docopt == 0.6.1 06:55:57 INFO - manifestparser == 1.1 06:55:57 INFO - mozInstall == 1.12 06:55:57 INFO - mozcrash == 0.17 06:55:57 INFO - mozdebug == 0.1 06:55:57 INFO - mozdevice == 0.48 06:55:57 INFO - mozfile == 1.2 06:55:57 INFO - mozhttpd == 0.7 06:55:57 INFO - mozinfo == 0.9 06:55:57 INFO - mozleak == 0.1 06:55:57 INFO - mozlog == 3.1 06:55:57 INFO - moznetwork == 0.27 06:55:57 INFO - mozprocess == 0.22 06:55:57 INFO - mozprofile == 0.28 06:55:57 INFO - mozrunner == 6.11 06:55:57 INFO - mozscreenshot == 0.1 06:55:57 INFO - mozsystemmonitor == 0.0 06:55:57 INFO - moztest == 0.7 06:55:57 INFO - mozversion == 1.4 06:55:57 INFO - psutil == 3.1.1 06:55:57 INFO - requests == 1.2.3 06:55:57 INFO - wsgiref == 0.1.2 06:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:57 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:57 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 06:55:57 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 06:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:57 INFO - 'HOME': '/Users/cltbld', 06:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:57 INFO - 'LOGNAME': 'cltbld', 06:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:57 INFO - 'MOZ_NO_REMOTE': '1', 06:55:57 INFO - 'NO_EM_RESTART': '1', 06:55:57 INFO - 'PAGER': '/bin/cat', 06:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:57 INFO - 'PWD': '/builds/slave/test', 06:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:57 INFO - 'SHELL': '/bin/bash', 06:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:57 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:57 INFO - 'USER': 'cltbld', 06:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:57 INFO - 'XPC_FLAGS': '0x0', 06:55:57 INFO - 'XPC_SERVICE_NAME': '0', 06:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 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)) 06:55:58 INFO - Cleaning up... 06:55:58 INFO - Return code: 0 06:55:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:58 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:55:58 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 06:55:58 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 06:55:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:55:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:58 INFO - 'HOME': '/Users/cltbld', 06:55:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:58 INFO - 'LOGNAME': 'cltbld', 06:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:58 INFO - 'MOZ_NO_REMOTE': '1', 06:55:58 INFO - 'NO_EM_RESTART': '1', 06:55:58 INFO - 'PAGER': '/bin/cat', 06:55:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:58 INFO - 'PWD': '/builds/slave/test', 06:55:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:58 INFO - 'SHELL': '/bin/bash', 06:55:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:55:58 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:55:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:58 INFO - 'USER': 'cltbld', 06:55:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:58 INFO - 'XPC_FLAGS': '0x0', 06:55:58 INFO - 'XPC_SERVICE_NAME': '0', 06:55:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:58 INFO - Downloading/unpacking jsonschema 06:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:56:00 INFO - Downloading/unpacking functools32 (from jsonschema) 06:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:56:01 INFO - Downloading functools32-3.2.3-2.tar.gz 06:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:56:01 INFO - warning: no files found matching '*.txt' 06:56:01 INFO - no previously-included directories found matching 'build' 06:56:01 INFO - no previously-included directories found matching 'dist' 06:56:01 INFO - no previously-included directories found matching '.git*' 06:56:01 INFO - Installing collected packages: jsonschema, functools32 06:56:01 INFO - Running setup.py install for functools32 06:56:01 INFO - warning: no files found matching '*.txt' 06:56:01 INFO - no previously-included directories found matching 'build' 06:56:01 INFO - no previously-included directories found matching 'dist' 06:56:01 INFO - no previously-included directories found matching '.git*' 06:56:01 INFO - Successfully installed jsonschema functools32 06:56:01 INFO - Cleaning up... 06:56:01 INFO - Return code: 0 06:56:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:56:01 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')]} 06:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:01 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')]} 06:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:56:01 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 0x10cf4ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf5c420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8c19c822d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, '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.TfloN6mGoF/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.ufXmj58UJb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 06:56:01 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 06:56:01 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 06:56:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:56:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:01 INFO - 'HOME': '/Users/cltbld', 06:56:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:01 INFO - 'LOGNAME': 'cltbld', 06:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:01 INFO - 'MOZ_NO_REMOTE': '1', 06:56:01 INFO - 'NO_EM_RESTART': '1', 06:56:01 INFO - 'PAGER': '/bin/cat', 06:56:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:01 INFO - 'PWD': '/builds/slave/test', 06:56:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:01 INFO - 'SHELL': '/bin/bash', 06:56:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:56:01 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:56:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:01 INFO - 'USER': 'cltbld', 06:56:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:01 INFO - 'XPC_FLAGS': '0x0', 06:56:01 INFO - 'XPC_SERVICE_NAME': '0', 06:56:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:56:01 INFO - Downloading/unpacking flake8 06:56:01 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 06:56:01 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 06:56:01 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 06:56:01 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 06:56:01 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 06:56:01 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 06:56:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:56:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:56:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56: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 06:56:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 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 06:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:56:05 INFO - no previously-included directories found matching 'docs/_build' 06:56:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:56:05 INFO - Running setup.py install for pep8 06:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:56:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:56:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:56:05 INFO - no previously-included directories found matching 'docs/_build' 06:56:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:56:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:56:05 INFO - Cleaning up... 06:56:05 INFO - Return code: 0 06:56:05 INFO - Running post-action listener: _resource_record_post_action 06:56:05 INFO - Running post-action listener: _start_resource_monitoring 06:56:06 INFO - Starting resource monitoring. 06:56:06 INFO - ##### 06:56:06 INFO - ##### Running install step. 06:56:06 INFO - ##### 06:56:06 INFO - Running pre-action listener: _resource_record_pre_action 06:56:06 INFO - Running main action method: install 06:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:56:06 INFO - Reading from file tmpfile_stdout 06:56:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:56:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:56:06 INFO - Reading from file tmpfile_stdout 06:56:06 INFO - Output received: 06:56:06 INFO - Usage: mozinstall [options] installer 06:56:06 INFO - Options: 06:56:06 INFO - -h, --help show this help message and exit 06:56:06 INFO - -d DEST, --destination=DEST 06:56:06 INFO - Directory to install application into. [default: 06:56:06 INFO - "/builds/slave/test"] 06:56:06 INFO - --app=APP Application being installed. [default: firefox] 06:56:06 INFO - mkdir: /builds/slave/test/build/application 06:56:06 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'] 06:56:06 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 06:56:39 INFO - Reading from file tmpfile_stdout 06:56:39 INFO - Output received: 06:56:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:56:39 INFO - Running post-action listener: _resource_record_post_action 06:56:39 INFO - ##### 06:56:39 INFO - ##### Running run-tests step. 06:56:39 INFO - ##### 06:56:39 INFO - Running pre-action listener: _resource_record_pre_action 06:56:39 INFO - Running main action method: run_tests 06:56:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:39 INFO - 2016-04-15 06:56:39.479 screenresolution[1643:7628] starting screenresolution argv=screenresolution get 06:56:39 INFO - 2016-04-15 06:56:39.482 screenresolution[1643:7628] Display 0: 1600x1200x32@60 06:56:39 INFO - 2016-04-15 06:56:39.488 screenresolution[1644:7630] starting screenresolution argv=screenresolution list 06:56:39 INFO - Available Modes on Display 0 06:56:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:39 INFO - Intel Iris: 06:56:39 INFO - Chipset Model: Intel Iris 06:56:39 INFO - Type: GPU 06:56:39 INFO - Bus: Built-In 06:56:39 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:39 INFO - Vendor: Intel (0x8086) 06:56:39 INFO - Device ID: 0x0a2e 06:56:39 INFO - Revision ID: 0x0009 06:56:39 INFO - Displays: 06:56:39 INFO - Display: 06:56:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:39 INFO - Display Serial Number: 1600x1200 60 06:56:39 INFO - Main Display: Yes 06:56:39 INFO - Mirror: Off 06:56:39 INFO - Online: Yes 06:56:39 INFO - Rotation: Supported 06:56:39 INFO - Return code: 0 06:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:39 INFO - Python 2.7.3 06:56:39 INFO - Return code: 0 06:56:39 INFO - grabbing minidump binary from tooltool 06:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:56:39 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 0x10cdebe00>, '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 0x10cc14db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cde6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:39 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 06:56:39 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 06:56:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:39 INFO - Return code: 0 06:56:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:56:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:56:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:56:41 INFO - Return code: 0 06:56:41 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:56:41 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TfloN6mGoF/Render', 06:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:41 INFO - 'HOME': '/Users/cltbld', 06:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:41 INFO - 'LOGNAME': 'cltbld', 06:56:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:41 INFO - 'MOZ_NO_REMOTE': '1', 06:56:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:41 INFO - 'NO_EM_RESTART': '1', 06:56:41 INFO - 'PAGER': '/bin/cat', 06:56:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:41 INFO - 'PWD': '/builds/slave/test', 06:56:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:41 INFO - 'SHELL': '/bin/bash', 06:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ufXmj58UJb/Listeners', 06:56:41 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 06:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:41 INFO - 'USER': 'cltbld', 06:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:41 INFO - 'XPC_FLAGS': '0x0', 06:56:41 INFO - 'XPC_SERVICE_NAME': '0', 06:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:56:41 INFO - mozversion application_buildid: 20160415050139 06:56:41 INFO - mozversion application_changeset: 8f7045b63b07c01309ab451ad120eacfdaa420d1 06:56:41 INFO - mozversion application_display_name: Nightly 06:56:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:41 INFO - mozversion application_name: Firefox 06:56:41 INFO - mozversion application_remotingname: firefox 06:56:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:56:41 INFO - mozversion application_vendor: Mozilla 06:56:41 INFO - mozversion application_version: 48.0a1 06:56:41 INFO - mozversion platform_buildid: 20160415050139 06:56:41 INFO - mozversion platform_changeset: 8f7045b63b07c01309ab451ad120eacfdaa420d1 06:56:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:56:41 INFO - mozversion platform_version: 48.0a1 06:56:41 INFO - using testdate: 1460728601 06:56:41 INFO - actual date: 1460728601 06:56:41 INFO - starting webserver on 'localhost:49276' 06:56:41 INFO - SUITE-START | Running 2 tests 06:56:41 INFO - TEST-START | dromaeo_css 06:56:41 INFO - operating with platform_type : mac_ 06:56:41 INFO - Initialising browser for dromaeo_css test... 06:56:41 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpPktJTf/profile http://localhost:49276/getInfo.html) 06:56:43 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 06:56:43 INFO - PROCESS | 1662 | colorDepth:24 06:56:43 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 06:56:43 INFO - PROCESS | 1662 | __metrics 06:56:43 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:56:43 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:56:44 INFO - TEST-INFO | 1662: exit 0 06:56:44 INFO - Browser initialized. 06:56:44 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:44 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpPktJTf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:56 INFO - PROCESS | 1664 | RSS: Main: 238813184 06:56:56 INFO - PROCESS | 1664 | 06:57:47 INFO - PROCESS | 1664 | 1460728667248 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] 06:59:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 06:59:59 INFO - PROCESS | 1664 | RSS: Main: 353619968 06:59:59 INFO - PROCESS | 1664 | 07:03:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 07:03:02 INFO - PROCESS | 1664 | RSS: Main: 371027968 07:03:02 INFO - PROCESS | 1664 | 07:06:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 07:06:04 INFO - PROCESS | 1664 | RSS: Main: 363454464 07:06:04 INFO - PROCESS | 1664 | 07:09:06 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 07:09:07 INFO - PROCESS | 1664 | RSS: Main: 374235136 07:09:07 INFO - PROCESS | 1664 | 07:12:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 07:12:11 INFO - PROCESS | 1664 | RSS: Main: 345976832 07:12:11 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 07:15:14 INFO - PROCESS | 1664 | RSS: Main: 384184320 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | __start_tp_report 07:15:14 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 07:15:14 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 07:15:14 INFO - PROCESS | 1664 | |i|pagename|runs| 07:15:14 INFO - PROCESS | 1664 | |0;dojo.html;3374.52756614074;3432.725381969441;3457.170279133008;3461.948070778937;3516.6834984851357;5557.527610153132;5648.237487939127;5680.204771332012;5689.51639110675;5696.515796157327;5667.489925906668;5675.716214189284;5680.517156041731;5846.649201047941;5852.707364631773;5085.567726743231;5087.211482220262;5116.20698791686;5126.333576635032;5296.152615581508;5248.737563121847;5271.130263506517;5298.947010529884;5327.893442131155;5350.678959262437;5123.1546794778815;5213.035588416117;5213.765380557865;5222.00781851447;5227.137522308814;5156.510131537498;5257.737113144366;5278.261043453919;5287.603429742746;5287.947120528784;5179.896402071938;5191.454897235773;5205.635605507616;5221.347331583552;5227.3465816772905;5616.017196990551;5629.183768353607;5655.604107712462;5668.185761724783;5716.599838011341;6064.090386442025;6114.969425152845;6137.683438940217;6229.2836323822885;6265.122882796412;6223.408776166257;6242.812715618538;6249.6875156242;6268;6278.591891527082;5175.767090480862;5581.162825576115;5777.8555536111935;5791.536677065825;5795.246617939641;6132.570720049643;6174.25908890927;6235.563510554309;6243;6260.874782504416;6140.846478837975;6159.784407545714;6168.506519478431;6171.722272497748;6181.227346581677;6225.595336303126;6268.4671802896355;6269.686515674198;6286.434220920048;6289.842753931097;6044.153818465418;6100.157317757059;6133.977404287557;6241.375862413813;6261.24865016201;6212.72042758077;6243;6249.593776404519;6265.530085243534;6267.467265282411;4914;4918.827841025547;4932;4934.383202099738;4965.155923493015;4361.214981303332;4405.801738921757;4446.73319600825;4495.842645507391;4519.79660915253;5679.886402271932;5685.857853553694;5686.9715651421475;5687.971560142173;5698.572607054488;6221.62670239778;6255.093011513305;6262.718177682015;6287.49700023997;6291.182146321041;5539.723013849291;5613.607047506717;5671.120976248688;5672.574556908248;5721.22763426932;5319.38827034896;5337.5463085637375;5345.064613692666;5346.732663366816;5353.839384818461;6140.105498721099;6218.129461875341;6289.433950944437;6296.2759282681245;6296.685165741603;6166.660833654192;6230.283517395557;6255.812325630239;6271.592346497463;6297.055441683784;6284.340144284784;6300.369963003663;6310.05349197624;6323.810285691437;6327.841803954938;5753.482186603226;5985.880282394241;6167.229096362955;6191.380861913773;6203.410675985774;6207.224096987877;6249.812505624838;6255.374462553708;6273.843153921189;6282.968585157045;6005.459508644243;6011.031964919876;6053.969730151321;6054.697265136638;6076.72654730547;5899.174115623902;5996.190514280691;6101.883383139835;6108.297545782114;6120.17377654011;5820.447057529528;5894.204282421818;5901.144334071621;5930.169776231417;5931.90259801938;6018.909716354346;6035.969820150871;6065.332813390612;6069.51443884497;6114.144019837137;5489.451054894478;5776.942230577809;5824.563157763269;5860.794872179454;5935.465808077293 07:15:14 INFO - PROCESS | 1664 | |1;ext.html;527.9868003299914;528.1945033823418;528.7541293298615;537.23980567497;585.5023230254285;29946.700532994662;30529.847350763244;37411.438828417595;38694.613053869456;38700;41177;41679.79160104195;41825.16349673005;41872.37191442123;41959.160816783646;9407.905920940788;9649.372790768577;9658.565364558577;9659.130678238957;9693.22454203662;9445.669401570947;9547.23622110233;9558.235341172689;9565.473898935556;9568.186704130123;9592.232621390307;9668.033196680311;9673.22614190863;9675.225981921465;9681.225501959827;9583.520823958808;9623.951880240624;9640.276979226515;9642.228621710246;9649.421034737938;9580.993995630497;9700.320977531575;9705.563249653782;9707.029297070307;9721.951390243074;39846.60153398487;40296.798516007526;40307;40371.394429083586;40411.39382909259;3195.2331440454122;3211.855466504013;3365.7812242204177;3593.6406359363855;3802.1065049713297;28611.85694071537;28841.56737648937;29184.41631167386;29270.70729292701;29296.8535157325;2702.608121822325;2728.9863550682317;2745.9862700686567;2751.545994910837;2881.250874772574;436510;437965;438315;439711;439954;57961.71019144877;58395;58462.415375845696;58521.414785852445;58589.41410585925;66358.66820665865;67785.32214677888;67932.64134717279;67995;68013.65993170002;16555.834441655672;16661.33354665824;16679;16687.582810429838;16720.080395578116;12706.491740330282;12750.107492475623;12774.680632984064;12791.296478693575;12794.616161515169;18330;18439.81560184408;18910.716339254923;18911.527211819815;18967.051647417575;7868.2131786822;8094.473859199134;8104.189581041966;8123.106458289583;8186.590670466453;837.476577139288;932.8805433479852;1005.4671024357102;1084.1056128693858;1167.0896700573567;28962.85518572436;29735.455537887185;29895.804167833045;29951;30136.698633013828;1031.4017869635593;1031.9329243599143;1057.8201705710048;1066.6426747039673;1196.6529706385224;15246.923765381323;15341.616459588377;15391.306956234805;15586.220688965506;15664.686706266039;603946;605616;605913;607435;607883;57262.71368643214;59444.40555594475;59501;59521;59606.70196648989;1339.3571085878832;1376.1742954227384;1382.2121390807145;1489.1660670024821;1495.9326830292664;23052.538949221256;29073;29247.415051699274;29357.55963660504;30013.399732005673;46300.53699463097;46667;47309;47510.762446187546;47681.28478072901;383436.0828195841;387973;388073;388317;388433;23822.285331440085;25475.745242548077;25909.870450647628;26206.737932621192;26357.604635930093;43365;44188;44300;44875;45312;30141.698583013887;35020.47469287912;36090.45864311985;36098.63901360953;36319.818400907825;35963;36047;36532.269354612225;36611.81694091512;36735.63264367322;30617.08148755541;35718.46422303616;35912.92261232167;37023.07442313856;38431.80784096062;26171.084012059488;26551.601725974513;29860.701392985793;30707;30947.69052309448;23427.414314642272;23528.411789705395;23685.05259789589;23924;24054.87972560196 07:15:14 INFO - PROCESS | 1664 | |2;jquery.html;392.5034830938863;394.7986526871295;396.33811534736986;398.0883776152611;404.12910178565204;13956.93021534891;18222.088895555204;19760.802391976093;20764.480887977807;20816.64691795034;16106.436274730388;16327.346906123741;18140.18369173387;19983.60032799343;20609.793902060974;5948.821535353946;6128.479079278267;6147.692615369236;6170.382961703816;6171.382861713815;5894;6135.938640613604;6159.538034647397;6162.907556386658;6194.845128871769;6108.938910610881;6127.203463549732;6136.877262454748;6137.877242455148;6156.984097623887;5962.910556341659;6095.329513753483;6107.083937409379;6120.387961203888;6122.632642041492;5151.896962060775;5313.176457649032;5334.1732031535175;5335.67985920846;5340.332458442695;25061.62407563888;26267.474650506883;26590.202293931212;26644.46711065787;26701;2336.6962294901555;2504.7745702886646;2516.257703977331;2659.521286168489;2931.0767108360797;14709.55871323862;14867.107973521623;14909.478168264059;15094.396224151022;15466.845331546765;1770.6989811732037;1820.1991123905439;1827.2873579304082;1841.0058568373063;1849.398945342769;105868.41197382046;108315.45842270738;108595;109509;109634;11018.50416731249;11339.206255562032;11354.772904542027;11467.827982580267;11705.765884682429;14206.147631142165;14225.64435889111;14248.572542823731;14284.785728214085;14286;7653.6938522459595;7822;7932.444728868923;8258.587070646443;8777.166169213915;8696.956365236212;8712.607932643046;8740.300775937909;8746.693865714797;8892.066333035067;6702.497312701566;6715.630640314732;6716.966415167893;6739.831504212336;6743.5953842769595;1856.851451883846;1874.062968515742;1876.7372567840514;1888.2824526679774;1926.49911023135;911.5943405184629;968.5109019944882;1017.6641708236265;1023.9385636861812;1042.6142327338932;21162.470938226666;21699.78300217009;21734.02196901143;21817.890910545346;21994.780052199272;939.112384107948;951.6716732727198;964.5129209749172;971.8590804333473;1081.8160912644712;10106.29255952091;10538.473076346152;10597.311174773615;11380.601678941197;11527.365994870195;593706;609243;613060;620910;622060;75645.86531202037;79394;114485;116812.41593792147;117683;1003.3377970539555;1008.6419321141036;1053.2995557953875;1053.4100903494068;1056.7569459024467;17533.912330438776;18072.457826265232;18095.276188952823;18595.907020464812;18642.44072677822;45166;47353.86907589098;49608.50391496183;50711.746441267554;52198.478015220884;53253.73373133109;60061.39938600558;60316.698416507636;61384.693076534335;61655;7763.767086987399;8109.594520273845;8128.268455839003;8177.182281772013;8322.70870519529;10725.624603138853;11378.54485820558;12293.709160538016;12398;12782.23306601607;9099.77055621377;10633.946830265799;10948.069414099891;11275.32348059119;11385.373804440835;8964;10748;10846.13230941507;11067.557297708001;11230.101591872794;10972.451377430936;11347.716307092389;11388.088952883914;11408.543658253577;11438.771224575295;6880.174379074543;7317.938898859742;7508.737194198176;7997.600119993861;8419.915800841913;8074;9789.608415663579;10931.289466184673;11248.775024499628;11282.43587820622 07:15:14 INFO - PROCESS | 1664 | |3;mootools.html;1426.8858491320696;1603.6632307215484;1609.9678006439872;1860.6650802855481;1962.597667478167;6506.869862602745;8578.828423431527;8796.032436431995;8808.55957202139;8815.51514666693;8478.957605211965;8639;8645.178708022728;8652.524111173883;8653.264472519844;2423.1640084170976;2455.2511483997373;2455.72986971433;2458.21337172105;2460.5694003549397;2120.3638908327516;2407.4841790329147;2437.878106094697;2438.4391589934326;2453.865037422941;2431.3556907419547;2451.3136321829916;2464.2114523352534;2469.444375015616;2469.8518088914634;2033.674612062063;2040.9591808163827;2402.327348342467;2436.135172013936;2441.8779061047053;2379.262428647125;2406.109739396417;2417.528581926525;2417.8481151774936;2421.285720712394;8521.318294536422;8622.956885215597;8652.394332396734;8722.607482663232;8745.47527148373;5224.817131400421;5412.864678383033;5424.945750542483;5430.484104010113;5459.2902922619805;3406.2846802171575;3510.2628448025944;3602.171500554887;3623.184783423735;3631.5460567429072;1018.2464975917842;1029.4389557691077;1033.9276250662456;1051.1433181956756;1052.7210289273273;11112.777744445066;11286.717832054264;11293.322400655987;11299.209055366127;11319.886801131966;4701.106789709944;4815.890657706569;4823.131836269435;4905.9264111038365;4929.334539837076;9930;9957.352772069793;9959.302848800515;9961.103500684972;9975.301728878909;5444.3194600674915;5457.590680698963;5469.343678758574;5470.234167216593;5472.370677372073;4259.190753756776;4443.200223959654;4550.49944506104;4845.2732090186755;4950.628702847301;3969.563348031714;4011.415490881144;4051.6961227907436;4091.6931230157857;4099.1801639672185;1334.9199048057149;1357.5520078374113;1358.6875018745743;1370.3422357268566;1371.3349025722516;713.1762813949896;830.9916900831035;840.5629072882067;907.2923119966437;911.3119594706087;5582.8325150245555;5719.656820590778;5823.155642431909;5864.354920958691;5904.291485021739;510.2015345983524;556.4268803132779;577.9479846813723;585.6222736335125;704.5948579566667;3820.083180036771;3875.4961854958674;4023.1350259694304;4058.7158898876796;4096.897577560585;10187.643432479828;10447.00753428423;10449.320794148356;10549.156067514581;10565.313254638424;10155.441450720133;10252.077313041862;10375.014373634493;10530.526126324334;10546.09982254886;6845.315468453115;7624.27569380908;8004.159563245776;8033.1966803320365;8130.593470326578;5170.948290517047;5738.741756620879;5766.971165144148;5974.761009559743;6042.305134909541;9179.724608261762;9565.04349565038;9696.9030309696;9706.077922597342;9730.805383892424;9232.122948319899;9665.27510436706;9779.315447918578;9800.019998000143;9801.950990245003;6348.238211414659;7081.858362832818;7257.818554536178;7349.419874726959;7357.337839594462;7902.130765615892;7941.086775020946;8014.278714915686;8118.675252989814;8132.878006829784;7084.964575177091;7271.927280727125;7304.744333948286;7351.632418379167;7385.224551422239;7075.787726368218;7138.250483699137;7158;7279.27207279289;7296.270372962661;6733.326667333227;6809;6846.281140480178;6865.244823069358;6871.759488417882;4565.840195593139;4770.761461926959;4789.712617242976;4848.224284114524;4943.30793688891;4708.529147085264;4739.952600474089;4769.451513076041;4821.710697358169;4959.330490383752 07:15:14 INFO - PROCESS | 1664 | |4;prototype.html;326.0739499820509;326.7712601179175;327.59869160278663;335.4481877311822;337.16215205215053;5382.788872503685;5611.186377975201;5749.683767392792;5766.538676905848;5826.796062137826;4920.70475771453;5631.155326700997;5771.220885180499;5778.24882765241;5789.363170051291;4140.8136633851545;4253.383259427381;4290.270653988814;4422.425084738979;4454.8886277842985;4355.695101342907;4361.6510679145595;4403.295472724365;4406.823727050914;4412.271975124101;4358.716683415583;4358.825646974117;4388.714733542325;4406.427164468614;4441.200583894898;4089.3661482470416;4127.834886604533;4170.52039015514;4253;4350.73895566267;3752.3808571585655;3762.623737626243;3763.7929913854728;3772.660460558563;3773.735838491307;5453.563714902798;5457.645253058578;5500.944990550083;5505.9724701376235;5510.531604813596;4243.575642435762;4556.658250631216;4701.576858082789;5004.774785134678;5008.749562521896;5196.844094677166;5881.823545293648;5931.614445061057;5964.224650795412;6007.549433792483;3709.5919448860604;4069.9621596492707;4190.958090419118;4194.580541945811;4200.222958752641;5773.509251713567;6075.088736689488;6303.55875088744;6307.067213745584;6363.204599425072;4216.51510076339;4230.407742915994;4235.174141042528;4259.552746961586;4259.74441533509;3633.927321453556;4297.763623000703;4300.634446072119;4329.350597410351;4334.913301733947;4061.7156799023783;4454.599086082203;4948.257761335828;4950.455449900508;5001.774920128603;4971.900561988812;5178.6374953752875;6134;6141.539384546088;6155.553444940436;1432.4771458417601;1462.7878957551095;1464.4727897956727;1465.2820118142033;1466.296177834624;905.6015353244551;919.6781126605769;924.3206243411088;963.210167662524;969.0454901921602;4715.7642117893965;5737.024705800024;5795.9420405796245;5830.7084645767545;5849.912251316234;6381.170447841843;6402.719456108797;6427.839304017437;6439.549231553746;6444.323346048691;4697.95302046982;5548.530903747875;5783.161441590946;5807.361190269067;5814.313848983747;3316.2538428853795;3335.7490940897164;3360.445526488102;3372.662733726657;3374.9493757593655;6267.843303917347;6692.631905245161;6715.966420167965;6717.16035495563;6800.761973330909;5484.506394424521;6580.868382632416;6598.967005164944;6601;6611.966940165268;5300.734963251899;6674.199096108498;6690.264070952191;6729.49528785343;6752.426043786333;6323.241211054703;6340.1440805490665;6346.3019067903415;6378.968105159444;6384.07430922523;5650.050732497282;5925.288965324189;6247.5001999840815;6259.937400625936;6287.056941458818;6311.936880631135;6627.469802415699;6727.932720672927;6772.966135169293;6845.178578570603;3815.9887629777577;3950.565437801897;4149.8962525937095;4201.621854033152;4214.30463973441;6311.960345379053;6382.425581697669;6391;6423.618921931807;6450.7097180627925;5569.359523654832;5597.272354593877;6150.692465376624;6182.443580077815;6190.81427557174;6122.051082082285;6144.784932527519;6153.5692501526255;6159.84600384994;6185.381461853779;5628.690422026828;5688.829335119953;5889.352171261072;6006.249218847644;6009.338972712911;4892.828750993698;5341.252224688469;5601.915971260516;5955.3746856581165;6191.721372538156;5329.413764485981;6022.337542870193;6059.697015149137;6061.393860613904;6062.636241825505 07:15:14 INFO - PROCESS | 1664 | |5;yui.html;688.8828899087155;695.224824320882;699.6501749125438;717.573044038797;721.3832173491668;14971.251437428125;15658.921705391485;15838.683226335495;15920;15932.84067159328;14569.417223311082;14571.562853114423;14662.853371466283;14744.705105897876;14752.6311842204;755.8488302339526;772.7527191298786;912.4844462878469;939.2908354192575;940.5579377692474;877.934154938379;932.2774849491665;935.1536859142487;935.5041827831226;938.0244545672492;955.2787645327768;967.9467629280387;970.0832713086137;971.577363846729;971.6016433262364;781.3866115099677;945.8581212818063;959.5298303831142;959.7648576098866;985.3250523391499;733.8348871503922;734.1813877526573;736.7900148457663;737.2737853214579;738.7119023580808;15131.546053618298;15181.468648597245;15194.392224311014;15215.695686086216;15233.390664373412;12800.423980920881;13041.608751737464;13072.477100915952;13104.80342794859;13294.667633309147;10087.243456740774;10154.98450154986;10579.259451838374;10687.14502839771;10807.5676972921;3530.9416506184198;3564.625714300013;3566.375884220277;3641.0715267606856;3659.908502287464;82879;83714.16285837124;84881.72677409844;86357.56821215917;86438.56780716057;8169.223923727236;9705;9771.755706107262;10352.06831385164;10469.790604187874;21593.676094858274;21892.78107218939;21897.343079707633;21903.9048047597;21911.233106841504;6523.641199733966;7439.665215065335;7678.692852285958;7750.186230445835;7760.92239077602;4045.0898547826505;4082.3468245080644;4082.6733861291027;4098.221337945781;4098.7130900836655;3539.43369060949;3644.2711457708565;3646.070252085701;3646.08847788053;3648.343298206348;627.4572494792063;635.7202830754453;640.3660376227594;646.8188907106017;654.860542655785;513.7996181489223;514.4079075262058;596.4274296675154;602.9276486821609;611.4160976267742;6711.228208756055;7691.5769632670745;7900.170482099412;7930.722424715223;7954.880676789853;553.9086050801653;572.6592677356966;594.3016955077767;599.9760009599568;611.9265688117455;3606.5852426971232;3706.2772759312215;3782.6217378261954;3787.242551489658;3811.866584669523;71822.64088679523;87505.56247218723;88110;89257.52053554902;89872.5506372464;59216;59353.70323148443;61282.38717612767;62281.688591556755;63885;65787;66315.66842165854;66984.33015669878;67431.32568674348;70234;7324.816879578053;7644.694212231449;8024.0772311184965;8195.221453961864;8233.094359620318;31023.844880776356;43430.914227144574;44268.55731442644;44488;45389.31916021196;52347.47652523426;59014.63941442294;61179.470513237524;64271.67864160649;64900;10418;10662.73343166427;10826.350418974887;11018;11640.126990475579;11828.763424731285;12000.819987700366;12032.819507707567;12209.084318675958;12320.630381088582;9766.951165244413;11334;11461.426928653367;11494.367809770543;11808.881911180779;11435.771284574095;11525.068595659766;11761.941190293994;11812.70468238301;12086.742598615121;11407.600733974272;11719;12019.519219231133;12057.879421205676;12338.938305308417;9431.434113953184;9559.569819358006;9632.27757918145;9649.710508684751;9840;8185.590720463834;9415.387999779992;9690.46702431373;9814.65648702292;9821.36161149523 07:15:14 INFO - PROCESS | 1664 | __end_tp_report 07:15:14 INFO - PROCESS | 1664 | __start_cc_report 07:15:14 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1174 07:15:14 INFO - PROCESS | 1664 | __end_cc_report 07:15:14 INFO - PROCESS | 1664 | __startTimestamp1460729714610__endTimestamp 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | ------- Summary: start ------- 07:15:14 INFO - PROCESS | 1664 | Number of tests: 6 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5725.43 Median:5899.17 stddev:621.07 (10.5%) stddev-sans-first:594.96 07:15:14 INFO - PROCESS | 1664 | Values: 3374.5 3432.7 3457.2 3461.9 3516.7 5557.5 5648.2 5680.2 5689.5 5696.5 5667.5 5675.7 5680.5 5846.6 5852.7 5085.6 5087.2 5116.2 5126.3 5296.2 5248.7 5271.1 5298.9 5327.9 5350.7 5123.2 5213.0 5213.8 5222.0 5227.1 5156.5 5257.7 5278.3 5287.6 5287.9 5179.9 5191.5 5205.6 5221.3 5227.3 5616.0 5629.2 5655.6 5668.2 5716.6 6064.1 6115.0 6137.7 6229.3 6265.1 6223.4 6242.8 6249.7 6268.0 6278.6 5175.8 5581.2 5777.9 5791.5 5795.2 6132.6 6174.3 6235.6 6243.0 6260.9 6140.8 6159.8 6168.5 6171.7 6181.2 6225.6 6268.5 6269.7 6286.4 6289.8 6044.2 6100.2 6134.0 6241.4 6261.2 6212.7 6243.0 6249.6 6265.5 6267.5 4914.0 4918.8 4932.0 4934.4 4965.2 4361.2 4405.8 4446.7 4495.8 4519.8 5679.9 5685.9 5687.0 5688.0 5698.6 6221.6 6255.1 6262.7 6287.5 6291.2 5539.7 5613.6 5671.1 5672.6 5721.2 5319.4 5337.5 5345.1 5346.7 5353.8 6140.1 6218.1 6289.4 6296.3 6296.7 6166.7 6230.3 6255.8 6271.6 6297.1 6284.3 6300.4 6310.1 6323.8 6327.8 5753.5 5985.9 6167.2 6191.4 6203.4 6207.2 6249.8 6255.4 6273.8 6283.0 6005.5 6011.0 6054.0 6054.7 6076.7 5899.2 5996.2 6101.9 6108.3 6120.2 5820.4 5894.2 5901.1 5930.2 5931.9 6018.9 6036.0 6065.3 6069.5 6114.1 5489.5 5776.9 5824.6 5860.8 5935.5 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:61866.45 Median:210933.95 stddev:129687.40 (61.5%) stddev-sans-first:129969.43 07:15:14 INFO - PROCESS | 1664 | Values: 528.0 528.2 528.8 537.2 585.5 29946.7 30529.8 37411.4 38694.6 38700.0 41177.0 41679.8 41825.2 41872.4 41959.2 9407.9 9649.4 9658.6 9659.1 9693.2 9445.7 9547.2 9558.2 9565.5 9568.2 9592.2 9668.0 9673.2 9675.2 9681.2 9583.5 9624.0 9640.3 9642.2 9649.4 9581.0 9700.3 9705.6 9707.0 9722.0 39846.6 40296.8 40307.0 40371.4 40411.4 3195.2 3211.9 3365.8 3593.6 3802.1 28611.9 28841.6 29184.4 29270.7 29296.9 2702.6 2729.0 2746.0 2751.5 2881.3 436510.0 437965.0 438315.0 439711.0 439954.0 57961.7 58395.0 58462.4 58521.4 58589.4 66358.7 67785.3 67932.6 67995.0 68013.7 16555.8 16661.3 16679.0 16687.6 16720.1 12706.5 12750.1 12774.7 12791.3 12794.6 18330.0 18439.8 18910.7 18911.5 18967.1 7868.2 8094.5 8104.2 8123.1 8186.6 837.5 932.9 1005.5 1084.1 1167.1 28962.9 29735.5 29895.8 29951.0 30136.7 1031.4 1031.9 1057.8 1066.6 1196.7 15246.9 15341.6 15391.3 15586.2 15664.7 603946.0 605616.0 605913.0 607435.0 607883.0 57262.7 59444.4 59501.0 59521.0 59606.7 1339.4 1376.2 1382.2 1489.2 1495.9 23052.5 29073.0 29247.4 29357.6 30013.4 46300.5 46667.0 47309.0 47510.8 47681.3 383436.1 387973.0 388073.0 388317.0 388433.0 23822.3 25475.7 25909.9 26206.7 26357.6 43365.0 44188.0 44300.0 44875.0 45312.0 30141.7 35020.5 36090.5 36098.6 36319.8 35963.0 36047.0 36532.3 36611.8 36735.6 30617.1 35718.5 35912.9 37023.1 38431.8 26171.1 26551.6 29860.7 30707.0 30947.7 23427.4 23528.4 23685.1 23924.0 24054.9 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:33814.35 Median:13788.94 stddev:101030.60 (732.7%) stddev-sans-first:101282.85 07:15:14 INFO - PROCESS | 1664 | Values: 392.5 394.8 396.3 398.1 404.1 13956.9 18222.1 19760.8 20764.5 20816.6 16106.4 16327.3 18140.2 19983.6 20609.8 5948.8 6128.5 6147.7 6170.4 6171.4 5894.0 6135.9 6159.5 6162.9 6194.8 6108.9 6127.2 6136.9 6137.9 6157.0 5962.9 6095.3 6107.1 6120.4 6122.6 5151.9 5313.2 5334.2 5335.7 5340.3 25061.6 26267.5 26590.2 26644.5 26701.0 2336.7 2504.8 2516.3 2659.5 2931.1 14709.6 14867.1 14909.5 15094.4 15466.8 1770.7 1820.2 1827.3 1841.0 1849.4 105868.4 108315.5 108595.0 109509.0 109634.0 11018.5 11339.2 11354.8 11467.8 11705.8 14206.1 14225.6 14248.6 14284.8 14286.0 7653.7 7822.0 7932.4 8258.6 8777.2 8697.0 8712.6 8740.3 8746.7 8892.1 6702.5 6715.6 6717.0 6739.8 6743.6 1856.9 1874.1 1876.7 1888.3 1926.5 911.6 968.5 1017.7 1023.9 1042.6 21162.5 21699.8 21734.0 21817.9 21994.8 939.1 951.7 964.5 971.9 1081.8 10106.3 10538.5 10597.3 11380.6 11527.4 593706.0 609243.0 613060.0 620910.0 622060.0 75645.9 79394.0 114485.0 116812.4 117683.0 1003.3 1008.6 1053.3 1053.4 1056.8 17533.9 18072.5 18095.3 18595.9 18642.4 45166.0 47353.9 49608.5 50711.7 52198.5 53253.7 60061.4 60316.7 61384.7 61655.0 7763.8 8109.6 8128.3 8177.2 8322.7 10725.6 11378.5 12293.7 12398.0 12782.2 9099.8 10633.9 10948.1 11275.3 11385.4 8964.0 10748.0 10846.1 11067.6 11230.1 10972.5 11347.7 11388.1 11408.5 11438.8 6880.2 7317.9 7508.7 7997.6 8419.9 8074.0 9789.6 10931.3 11248.8 11282.4 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:5594.46 Median:2840.57 stddev:3090.27 (108.8%) stddev-sans-first:3083.06 07:15:14 INFO - PROCESS | 1664 | Values: 1426.9 1603.7 1610.0 1860.7 1962.6 6506.9 8578.8 8796.0 8808.6 8815.5 8479.0 8639.0 8645.2 8652.5 8653.3 2423.2 2455.3 2455.7 2458.2 2460.6 2120.4 2407.5 2437.9 2438.4 2453.9 2431.4 2451.3 2464.2 2469.4 2469.9 2033.7 2041.0 2402.3 2436.1 2441.9 2379.3 2406.1 2417.5 2417.8 2421.3 8521.3 8623.0 8652.4 8722.6 8745.5 5224.8 5412.9 5424.9 5430.5 5459.3 3406.3 3510.3 3602.2 3623.2 3631.5 1018.2 1029.4 1033.9 1051.1 1052.7 11112.8 11286.7 11293.3 11299.2 11319.9 4701.1 4815.9 4823.1 4905.9 4929.3 9930.0 9957.4 9959.3 9961.1 9975.3 5444.3 5457.6 5469.3 5470.2 5472.4 4259.2 4443.2 4550.5 4845.3 4950.6 3969.6 4011.4 4051.7 4091.7 4099.2 1334.9 1357.6 1358.7 1370.3 1371.3 713.2 831.0 840.6 907.3 911.3 5582.8 5719.7 5823.2 5864.4 5904.3 510.2 556.4 577.9 585.6 704.6 3820.1 3875.5 4023.1 4058.7 4096.9 10187.6 10447.0 10449.3 10549.2 10565.3 10155.4 10252.1 10375.0 10530.5 10546.1 6845.3 7624.3 8004.2 8033.2 8130.6 5170.9 5738.7 5767.0 5974.8 6042.3 9179.7 9565.0 9696.9 9706.1 9730.8 9232.1 9665.3 9779.3 9800.0 9802.0 6348.2 7081.9 7257.8 7349.4 7357.3 7902.1 7941.1 8014.3 8118.7 8132.9 7085.0 7271.9 7304.7 7351.6 7385.2 7075.8 7138.3 7158.0 7279.3 7296.3 6733.3 6809.0 6846.3 6865.2 6871.8 4565.8 4770.8 4789.7 4848.2 4943.3 4708.5 4740.0 4769.5 4821.7 4959.3 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:4982.83 Median:5606.55 stddev:1559.24 (27.8%) stddev-sans-first:1523.94 07:15:14 INFO - PROCESS | 1664 | Values: 326.1 326.8 327.6 335.4 337.2 5382.8 5611.2 5749.7 5766.5 5826.8 4920.7 5631.2 5771.2 5778.2 5789.4 4140.8 4253.4 4290.3 4422.4 4454.9 4355.7 4361.7 4403.3 4406.8 4412.3 4358.7 4358.8 4388.7 4406.4 4441.2 4089.4 4127.8 4170.5 4253.0 4350.7 3752.4 3762.6 3763.8 3772.7 3773.7 5453.6 5457.6 5500.9 5506.0 5510.5 4243.6 4556.7 4701.6 5004.8 5008.7 5196.8 5881.8 5931.6 5964.2 6007.5 3709.6 4070.0 4191.0 4194.6 4200.2 5773.5 6075.1 6303.6 6307.1 6363.2 4216.5 4230.4 4235.2 4259.6 4259.7 3633.9 4297.8 4300.6 4329.4 4334.9 4061.7 4454.6 4948.3 4950.5 5001.8 4971.9 5178.6 6134.0 6141.5 6155.6 1432.5 1462.8 1464.5 1465.3 1466.3 905.6 919.7 924.3 963.2 969.0 4715.8 5737.0 5795.9 5830.7 5849.9 6381.2 6402.7 6427.8 6439.5 6444.3 4698.0 5548.5 5783.2 5807.4 5814.3 3316.3 3335.7 3360.4 3372.7 3374.9 6267.8 6692.6 6716.0 6717.2 6800.8 5484.5 6580.9 6599.0 6601.0 6612.0 5300.7 6674.2 6690.3 6729.5 6752.4 6323.2 6340.1 6346.3 6379.0 6384.1 5650.1 5925.3 6247.5 6259.9 6287.1 6311.9 6627.5 6727.9 6773.0 6845.2 3816.0 3950.6 4149.9 4201.6 4214.3 6312.0 6382.4 6391.0 6423.6 6450.7 5569.4 5597.3 6150.7 6182.4 6190.8 6122.1 6144.8 6153.6 6159.8 6185.4 5628.7 5688.8 5889.4 6006.2 6009.3 4892.8 5341.3 5601.9 5955.4 6191.7 5329.4 6022.3 6059.7 6061.4 6062.6 07:15:14 INFO - PROCESS | 1664 | 07:15:14 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17307.61 Median:598.20 stddev:23691.67 (3960.5%) stddev-sans-first:23725.27 07:15:14 INFO - PROCESS | 1664 | Values: 688.9 695.2 699.7 717.6 721.4 14971.3 15658.9 15838.7 15920.0 15932.8 14569.4 14571.6 14662.9 14744.7 14752.6 755.8 772.8 912.5 939.3 940.6 877.9 932.3 935.2 935.5 938.0 955.3 967.9 970.1 971.6 971.6 781.4 945.9 959.5 959.8 985.3 733.8 734.2 736.8 737.3 738.7 15131.5 15181.5 15194.4 15215.7 15233.4 12800.4 13041.6 13072.5 13104.8 13294.7 10087.2 10155.0 10579.3 10687.1 10807.6 3530.9 3564.6 3566.4 3641.1 3659.9 82879.0 83714.2 84881.7 86357.6 86438.6 8169.2 9705.0 9771.8 10352.1 10469.8 21593.7 21892.8 21897.3 21903.9 21911.2 6523.6 7439.7 7678.7 7750.2 7760.9 4045.1 4082.3 4082.7 4098.2 4098.7 3539.4 3644.3 3646.1 3646.1 3648.3 627.5 635.7 640.4 646.8 654.9 513.8 514.4 596.4 602.9 611.4 6711.2 7691.6 7900.2 7930.7 7954.9 553.9 572.7 594.3 600.0 611.9 3606.6 3706.3 3782.6 3787.2 3811.9 71822.6 87505.6 88110.0 89257.5 89872.6 59216.0 59353.7 61282.4 62281.7 63885.0 65787.0 66315.7 66984.3 67431.3 70234.0 7324.8 7644.7 8024.1 8195.2 8233.1 31023.8 43430.9 44268.6 44488.0 45389.3 52347.5 59014.6 61179.5 64271.7 64900.0 10418.0 10662.7 10826.4 11018.0 11640.1 11828.8 12000.8 12032.8 12209.1 12320.6 9767.0 11334.0 11461.4 11494.4 11808.9 11435.8 11525.1 11761.9 11812.7 12086.7 11407.6 11719.0 12019.5 12057.9 12338.9 9431.4 9559.6 9632.3 9649.7 9840.0 8185.6 9415.4 9690.5 9814.7 9821.4 07:15:14 INFO - PROCESS | 1664 | -------- Summary: end -------- 07:15:14 INFO - PROCESS | 1664 | 07:15:15 INFO - TEST-INFO | 1664: exit 0 07:15:15 INFO - TEST-OK | dromaeo_css | took 1113942ms 07:15:15 INFO - TEST-START | kraken 07:15:15 INFO - operating with platform_type : mac_ 07:15:15 INFO - Initialising browser for kraken test... 07:15:15 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpf74ITo/profile http://localhost:49276/getInfo.html) 07:15:17 INFO - PROCESS | 1673 | __metrics Screen width/height:1600/1200 07:15:17 INFO - PROCESS | 1673 | colorDepth:24 07:15:17 INFO - PROCESS | 1673 | Browser inner width/height: 1024/689 07:15:17 INFO - PROCESS | 1673 | __metrics 07:15:17 INFO - PROCESS | 1673 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:15:17 ERROR - PROCESS | 1673 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:15:18 INFO - TEST-INFO | 1673: exit 0 07:15:18 INFO - Browser initialized. 07:15:18 INFO - Running cycle 1/1 for kraken test... 07:15:18 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpf74ITo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:15:30 INFO - PROCESS | 1675 | RSS: Main: 238886912 07:15:30 INFO - PROCESS | 1675 | 07:15:32 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 07:15:33 INFO - PROCESS | 1675 | RSS: Main: 286228480 07:15:33 INFO - PROCESS | 1675 | 07:15:36 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 07:15:36 INFO - PROCESS | 1675 | RSS: Main: 299126784 07:15:36 INFO - PROCESS | 1675 | 07:15:40 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 07:15:40 INFO - PROCESS | 1675 | RSS: Main: 390488064 07:15:40 INFO - PROCESS | 1675 | 07:15:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 07:15:43 INFO - PROCESS | 1675 | RSS: Main: 288317440 07:15:43 INFO - PROCESS | 1675 | 07:15:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:46 INFO - PROCESS | 1675 | RSS: Main: 292864000 07:15:46 INFO - PROCESS | 1675 | 07:15:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:49 INFO - PROCESS | 1675 | RSS: Main: 330850304 07:15:49 INFO - PROCESS | 1675 | 07:15:52 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:53 INFO - PROCESS | 1675 | RSS: Main: 330952704 07:15:53 INFO - PROCESS | 1675 | 07:15:56 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 07:15:56 INFO - PROCESS | 1675 | RSS: Main: 330358784 07:15:56 INFO - PROCESS | 1675 | 07:15:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:59 INFO - PROCESS | 1675 | RSS: Main: 320413696 07:15:59 INFO - PROCESS | 1675 | 07:16:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:16:01 INFO - PROCESS | 1675 | RSS: Main: 327880704 07:16:01 INFO - PROCESS | 1675 | 07:16:03 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:16:04 INFO - PROCESS | 1675 | RSS: Main: 330043392 07:16:04 INFO - PROCESS | 1675 | 07:16:07 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:16:08 INFO - PROCESS | 1675 | RSS: Main: 335659008 07:16:08 INFO - PROCESS | 1675 | 07:16:10 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:16:11 INFO - PROCESS | 1675 | RSS: Main: 333107200 07:16:11 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 07:16:13 INFO - PROCESS | 1675 | RSS: Main: 396423168 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | __start_tp_report 07:16:13 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 07:16:13 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 07:16:13 INFO - PROCESS | 1675 | |i|pagename|runs| 07:16:13 INFO - PROCESS | 1675 | |0;ai-astar;111;109;111;111;111;112;117;112;111;113 07:16:13 INFO - PROCESS | 1675 | |1;audio-beat-detection;160;125;146;179;120;144;141;115;173;120 07:16:13 INFO - PROCESS | 1675 | |2;audio-dft;188;186;186;185;186;183;182;187;184;184 07:16:13 INFO - PROCESS | 1675 | |3;audio-fft;78;74;74;149;56;55;54;67;131;56 07:16:13 INFO - PROCESS | 1675 | |4;audio-oscillator;93;98;134;83;116;122;121;76;109;164 07:16:13 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;87;84;87;85;86;83;87;83;86;84 07:16:13 INFO - PROCESS | 1675 | |6;imaging-darkroom;93;93;104;133;93;93;93;94;93;93 07:16:13 INFO - PROCESS | 1675 | |7;imaging-desaturate;85;87;102;113;131;139;84;84;86;99 07:16:13 INFO - PROCESS | 1675 | |8;json-parse-financial;60;59;59;58;58;58;59;73;59;58 07:16:13 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;67;67;74;78;69;70;67;67;70 07:16:13 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;82;82;81;94;105;76;82;79;81;83 07:16:13 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;141;153;156;148;146;146;128;148;178;167 07:16:13 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;170;169;169;170;170;168;165;172;168;165 07:16:13 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;68;59;86;95;97;95;71;69;66 07:16:13 INFO - PROCESS | 1675 | __end_tp_report 07:16:13 INFO - PROCESS | 1675 | __start_cc_report 07:16:13 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,2013 07:16:13 INFO - PROCESS | 1675 | __end_cc_report 07:16:13 INFO - PROCESS | 1675 | __startTimestamp1460729773587__endTimestamp 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | ------- Summary: start ------- 07:16:13 INFO - PROCESS | 1675 | Number of tests: 14 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:111.80 Median:111.50 stddev:2.10 (1.9%) stddev-sans-first:2.20 07:16:13 INFO - PROCESS | 1675 | Values: 111.0 109.0 111.0 111.0 111.0 112.0 117.0 112.0 111.0 113.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:145.00 stddev:22.75 (15.7%) stddev-sans-first:23.22 07:16:13 INFO - PROCESS | 1675 | Values: 160.0 125.0 146.0 179.0 120.0 144.0 141.0 115.0 173.0 120.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:185.10 Median:186.00 stddev:1.85 (1.0%) stddev-sans-first:1.64 07:16:13 INFO - PROCESS | 1675 | Values: 188.0 186.0 186.0 185.0 186.0 183.0 182.0 187.0 184.0 184.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:79.40 Median:61.50 stddev:33.43 (54.4%) stddev-sans-first:35.45 07:16:13 INFO - PROCESS | 1675 | Values: 78.0 74.0 74.0 149.0 56.0 55.0 54.0 67.0 131.0 56.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:120.00 stddev:26.01 (21.7%) stddev-sans-first:26.70 07:16:13 INFO - PROCESS | 1675 | Values: 93.0 98.0 134.0 83.0 116.0 122.0 121.0 76.0 109.0 164.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:85.20 Median:86.00 stddev:1.62 (1.9%) stddev-sans-first:1.58 07:16:13 INFO - PROCESS | 1675 | Values: 87.0 84.0 87.0 85.0 86.0 83.0 87.0 83.0 86.0 84.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:93.00 stddev:12.70 (13.7%) stddev-sans-first:13.33 07:16:13 INFO - PROCESS | 1675 | Values: 93.0 93.0 104.0 133.0 93.0 93.0 93.0 94.0 93.0 93.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:84.50 stddev:20.41 (24.2%) stddev-sans-first:20.81 07:16:13 INFO - PROCESS | 1675 | Values: 85.0 87.0 102.0 113.0 131.0 139.0 84.0 84.0 86.0 99.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:59.00 stddev:4.58 (7.8%) stddev-sans-first:4.86 07:16:13 INFO - PROCESS | 1675 | Values: 60.0 59.0 59.0 58.0 58.0 58.0 59.0 73.0 59.0 58.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:4.21 (6.1%) stddev-sans-first:3.82 07:16:13 INFO - PROCESS | 1675 | Values: 63.0 67.0 67.0 74.0 78.0 69.0 70.0 67.0 67.0 70.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:82.00 stddev:8.55 (10.4%) stddev-sans-first:9.02 07:16:13 INFO - PROCESS | 1675 | Values: 82.0 82.0 81.0 94.0 105.0 76.0 82.0 79.0 81.0 83.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:150.50 stddev:13.79 (9.2%) stddev-sans-first:14.13 07:16:13 INFO - PROCESS | 1675 | Values: 141.0 153.0 156.0 148.0 146.0 146.0 128.0 148.0 178.0 167.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.60 Median:169.50 stddev:2.22 (1.3%) stddev-sans-first:2.30 07:16:13 INFO - PROCESS | 1675 | Values: 170.0 169.0 169.0 170.0 170.0 168.0 165.0 172.0 168.0 165.0 07:16:13 INFO - PROCESS | 1675 | 07:16:13 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.30 Median:78.50 stddev:14.35 (18.3%) stddev-sans-first:14.73 07:16:13 INFO - PROCESS | 1675 | Values: 67.0 68.0 59.0 86.0 95.0 97.0 95.0 71.0 69.0 66.0 07:16:13 INFO - PROCESS | 1675 | -------- Summary: end -------- 07:16:13 INFO - PROCESS | 1675 | 07:16:14 INFO - TEST-INFO | 1675: exit 0 07:16:14 INFO - TEST-OK | kraken | took 59216ms 07:16:14 INFO - SUITE-END | took 1173s 07:16:14 INFO - Completed test suite (00:19:33) 07:16:14 INFO - javascript benchmark 07:16:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3374.52756614074, 3432.725381969441, 3457.170279133008, 3461.948070778937, 3516.6834984851357, 5557.527610153132, 5648.237487939127, 5680.204771332012, 5689.51639110675, 5696.515796157327, 5667.489925906668, 5675.716214189284, 5680.517156041731, 5846.649201047941, 5852.707364631773, 5085.567726743231, 5087.211482220262, 5116.20698791686, 5126.333576635032, 5296.152615581508, 5248.737563121847, 5271.130263506517, 5298.947010529884, 5327.893442131155, 5350.678959262437, 5123.1546794778815, 5213.035588416117, 5213.765380557865, 5222.00781851447, 5227.137522308814, 5156.510131537498, 5257.737113144366, 5278.261043453919, 5287.603429742746, 5287.947120528784, 5179.896402071938, 5191.454897235773, 5205.635605507616, 5221.347331583552, 5227.3465816772905, 5616.017196990551, 5629.183768353607, 5655.604107712462, 5668.185761724783, 5716.599838011341, 6064.090386442025, 6114.969425152845, 6137.683438940217, 6229.2836323822885, 6265.122882796412, 6223.408776166257, 6242.812715618538, 6249.6875156242, 6268.0, 6278.591891527082, 5175.767090480862, 5581.162825576115, 5777.8555536111935, 5791.536677065825, 5795.246617939641, 6132.570720049643, 6174.25908890927, 6235.563510554309, 6243.0, 6260.874782504416, 6140.846478837975, 6159.784407545714, 6168.506519478431, 6171.722272497748, 6181.227346581677, 6225.595336303126, 6268.4671802896355, 6269.686515674198, 6286.434220920048, 6289.842753931097, 6044.153818465418, 6100.157317757059, 6133.977404287557, 6241.375862413813, 6261.24865016201, 6212.72042758077, 6243.0, 6249.593776404519, 6265.530085243534, 6267.467265282411, 4914.0, 4918.827841025547, 4932.0, 4934.383202099738, 4965.155923493015, 4361.214981303332, 4405.801738921757, 4446.73319600825, 4495.842645507391, 4519.79660915253, 5679.886402271932, 5685.857853553694, 5686.9715651421475, 5687.971560142173, 5698.572607054488, 6221.62670239778, 6255.093011513305, 6262.718177682015, 6287.49700023997, 6291.182146321041, 5539.723013849291, 5613.607047506717, 5671.120976248688, 5672.574556908248, 5721.22763426932, 5319.38827034896, 5337.5463085637375, 5345.064613692666, 5346.732663366816, 5353.839384818461, 6140.105498721099, 6218.129461875341, 6289.433950944437, 6296.2759282681245, 6296.685165741603, 6166.660833654192, 6230.283517395557, 6255.812325630239, 6271.592346497463, 6297.055441683784, 6284.340144284784, 6300.369963003663, 6310.05349197624, 6323.810285691437, 6327.841803954938, 5753.482186603226, 5985.880282394241, 6167.229096362955, 6191.380861913773, 6203.410675985774, 6207.224096987877, 6249.812505624838, 6255.374462553708, 6273.843153921189, 6282.968585157045, 6005.459508644243, 6011.031964919876, 6053.969730151321, 6054.697265136638, 6076.72654730547, 5899.174115623902, 5996.190514280691, 6101.883383139835, 6108.297545782114, 6120.17377654011, 5820.447057529528, 5894.204282421818, 5901.144334071621, 5930.169776231417, 5931.90259801938, 6018.909716354346, 6035.969820150871, 6065.332813390612, 6069.51443884497, 6114.144019837137, 5489.451054894478, 5776.942230577809, 5824.563157763269, 5860.794872179454, 5935.465808077293], "value": 5686.629977595422, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.9868003299914, 528.1945033823418, 528.7541293298615, 537.23980567497, 585.5023230254285, 29946.700532994662, 30529.847350763244, 37411.438828417595, 38694.613053869456, 38700.0, 41177.0, 41679.79160104195, 41825.16349673005, 41872.37191442123, 41959.160816783646, 9407.905920940788, 9649.372790768577, 9658.565364558577, 9659.130678238957, 9693.22454203662, 9445.669401570947, 9547.23622110233, 9558.235341172689, 9565.473898935556, 9568.186704130123, 9592.232621390307, 9668.033196680311, 9673.22614190863, 9675.225981921465, 9681.225501959827, 9583.520823958808, 9623.951880240624, 9640.276979226515, 9642.228621710246, 9649.421034737938, 9580.993995630497, 9700.320977531575, 9705.563249653782, 9707.029297070307, 9721.951390243074, 39846.60153398487, 40296.798516007526, 40307.0, 40371.394429083586, 40411.39382909259, 3195.2331440454122, 3211.855466504013, 3365.7812242204177, 3593.6406359363855, 3802.1065049713297, 28611.85694071537, 28841.56737648937, 29184.41631167386, 29270.70729292701, 29296.8535157325, 2702.608121822325, 2728.9863550682317, 2745.9862700686567, 2751.545994910837, 2881.250874772574, 436510.0, 437965.0, 438315.0, 439711.0, 439954.0, 57961.71019144877, 58395.0, 58462.415375845696, 58521.414785852445, 58589.41410585925, 66358.66820665865, 67785.32214677888, 67932.64134717279, 67995.0, 68013.65993170002, 16555.834441655672, 16661.33354665824, 16679.0, 16687.582810429838, 16720.080395578116, 12706.491740330282, 12750.107492475623, 12774.680632984064, 12791.296478693575, 12794.616161515169, 18330.0, 18439.81560184408, 18910.716339254923, 18911.527211819815, 18967.051647417575, 7868.2131786822, 8094.473859199134, 8104.189581041966, 8123.106458289583, 8186.590670466453, 837.476577139288, 932.8805433479852, 1005.4671024357102, 1084.1056128693858, 1167.0896700573567, 28962.85518572436, 29735.455537887185, 29895.804167833045, 29951.0, 30136.698633013828, 1031.4017869635593, 1031.9329243599143, 1057.8201705710048, 1066.6426747039673, 1196.6529706385224, 15246.923765381323, 15341.616459588377, 15391.306956234805, 15586.220688965506, 15664.686706266039, 603946.0, 605616.0, 605913.0, 607435.0, 607883.0, 57262.71368643214, 59444.40555594475, 59501.0, 59521.0, 59606.70196648989, 1339.3571085878832, 1376.1742954227384, 1382.2121390807145, 1489.1660670024821, 1495.9326830292664, 23052.538949221256, 29073.0, 29247.415051699274, 29357.55963660504, 30013.399732005673, 46300.53699463097, 46667.0, 47309.0, 47510.762446187546, 47681.28478072901, 383436.0828195841, 387973.0, 388073.0, 388317.0, 388433.0, 23822.285331440085, 25475.745242548077, 25909.870450647628, 26206.737932621192, 26357.604635930093, 43365.0, 44188.0, 44300.0, 44875.0, 45312.0, 30141.698583013887, 35020.47469287912, 36090.45864311985, 36098.63901360953, 36319.818400907825, 35963.0, 36047.0, 36532.269354612225, 36611.81694091512, 36735.63264367322, 30617.08148755541, 35718.46422303616, 35912.92261232167, 37023.07442313856, 38431.80784096062, 26171.084012059488, 26551.601725974513, 29860.701392985793, 30707.0, 30947.69052309448, 23427.414314642272, 23528.411789705395, 23685.05259789589, 23924.0, 24054.87972560196], "value": 19277.789504587738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.5034830938863, 394.7986526871295, 396.33811534736986, 398.0883776152611, 404.12910178565204, 13956.93021534891, 18222.088895555204, 19760.802391976093, 20764.480887977807, 20816.64691795034, 16106.436274730388, 16327.346906123741, 18140.18369173387, 19983.60032799343, 20609.793902060974, 5948.821535353946, 6128.479079278267, 6147.692615369236, 6170.382961703816, 6171.382861713815, 5894.0, 6135.938640613604, 6159.538034647397, 6162.907556386658, 6194.845128871769, 6108.938910610881, 6127.203463549732, 6136.877262454748, 6137.877242455148, 6156.984097623887, 5962.910556341659, 6095.329513753483, 6107.083937409379, 6120.387961203888, 6122.632642041492, 5151.896962060775, 5313.176457649032, 5334.1732031535175, 5335.67985920846, 5340.332458442695, 25061.62407563888, 26267.474650506883, 26590.202293931212, 26644.46711065787, 26701.0, 2336.6962294901555, 2504.7745702886646, 2516.257703977331, 2659.521286168489, 2931.0767108360797, 14709.55871323862, 14867.107973521623, 14909.478168264059, 15094.396224151022, 15466.845331546765, 1770.6989811732037, 1820.1991123905439, 1827.2873579304082, 1841.0058568373063, 1849.398945342769, 105868.41197382046, 108315.45842270738, 108595.0, 109509.0, 109634.0, 11018.50416731249, 11339.206255562032, 11354.772904542027, 11467.827982580267, 11705.765884682429, 14206.147631142165, 14225.64435889111, 14248.572542823731, 14284.785728214085, 14286.0, 7653.6938522459595, 7822.0, 7932.444728868923, 8258.587070646443, 8777.166169213915, 8696.956365236212, 8712.607932643046, 8740.300775937909, 8746.693865714797, 8892.066333035067, 6702.497312701566, 6715.630640314732, 6716.966415167893, 6739.831504212336, 6743.5953842769595, 1856.851451883846, 1874.062968515742, 1876.7372567840514, 1888.2824526679774, 1926.49911023135, 911.5943405184629, 968.5109019944882, 1017.6641708236265, 1023.9385636861812, 1042.6142327338932, 21162.470938226666, 21699.78300217009, 21734.02196901143, 21817.890910545346, 21994.780052199272, 939.112384107948, 951.6716732727198, 964.5129209749172, 971.8590804333473, 1081.8160912644712, 10106.29255952091, 10538.473076346152, 10597.311174773615, 11380.601678941197, 11527.365994870195, 593706.0, 609243.0, 613060.0, 620910.0, 622060.0, 75645.86531202037, 79394.0, 114485.0, 116812.41593792147, 117683.0, 1003.3377970539555, 1008.6419321141036, 1053.2995557953875, 1053.4100903494068, 1056.7569459024467, 17533.912330438776, 18072.457826265232, 18095.276188952823, 18595.907020464812, 18642.44072677822, 45166.0, 47353.86907589098, 49608.50391496183, 50711.746441267554, 52198.478015220884, 53253.73373133109, 60061.39938600558, 60316.698416507636, 61384.693076534335, 61655.0, 7763.767086987399, 8109.594520273845, 8128.268455839003, 8177.182281772013, 8322.70870519529, 10725.624603138853, 11378.54485820558, 12293.709160538016, 12398.0, 12782.23306601607, 9099.77055621377, 10633.946830265799, 10948.069414099891, 11275.32348059119, 11385.373804440835, 8964.0, 10748.0, 10846.13230941507, 11067.557297708001, 11230.101591872794, 10972.451377430936, 11347.716307092389, 11388.088952883914, 11408.543658253577, 11438.771224575295, 6880.174379074543, 7317.938898859742, 7508.737194198176, 7997.600119993861, 8419.915800841913, 8074.0, 9789.608415663579, 10931.289466184673, 11248.775024499628, 11282.43587820622], "value": 9587.477081861505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.8858491320696, 1603.6632307215484, 1609.9678006439872, 1860.6650802855481, 1962.597667478167, 6506.869862602745, 8578.828423431527, 8796.032436431995, 8808.55957202139, 8815.51514666693, 8478.957605211965, 8639.0, 8645.178708022728, 8652.524111173883, 8653.264472519844, 2423.1640084170976, 2455.2511483997373, 2455.72986971433, 2458.21337172105, 2460.5694003549397, 2120.3638908327516, 2407.4841790329147, 2437.878106094697, 2438.4391589934326, 2453.865037422941, 2431.3556907419547, 2451.3136321829916, 2464.2114523352534, 2469.444375015616, 2469.8518088914634, 2033.674612062063, 2040.9591808163827, 2402.327348342467, 2436.135172013936, 2441.8779061047053, 2379.262428647125, 2406.109739396417, 2417.528581926525, 2417.8481151774936, 2421.285720712394, 8521.318294536422, 8622.956885215597, 8652.394332396734, 8722.607482663232, 8745.47527148373, 5224.817131400421, 5412.864678383033, 5424.945750542483, 5430.484104010113, 5459.2902922619805, 3406.2846802171575, 3510.2628448025944, 3602.171500554887, 3623.184783423735, 3631.5460567429072, 1018.2464975917842, 1029.4389557691077, 1033.9276250662456, 1051.1433181956756, 1052.7210289273273, 11112.777744445066, 11286.717832054264, 11293.322400655987, 11299.209055366127, 11319.886801131966, 4701.106789709944, 4815.890657706569, 4823.131836269435, 4905.9264111038365, 4929.334539837076, 9930.0, 9957.352772069793, 9959.302848800515, 9961.103500684972, 9975.301728878909, 5444.3194600674915, 5457.590680698963, 5469.343678758574, 5470.234167216593, 5472.370677372073, 4259.190753756776, 4443.200223959654, 4550.49944506104, 4845.2732090186755, 4950.628702847301, 3969.563348031714, 4011.415490881144, 4051.6961227907436, 4091.6931230157857, 4099.1801639672185, 1334.9199048057149, 1357.5520078374113, 1358.6875018745743, 1370.3422357268566, 1371.3349025722516, 713.1762813949896, 830.9916900831035, 840.5629072882067, 907.2923119966437, 911.3119594706087, 5582.8325150245555, 5719.656820590778, 5823.155642431909, 5864.354920958691, 5904.291485021739, 510.2015345983524, 556.4268803132779, 577.9479846813723, 585.6222736335125, 704.5948579566667, 3820.083180036771, 3875.4961854958674, 4023.1350259694304, 4058.7158898876796, 4096.897577560585, 10187.643432479828, 10447.00753428423, 10449.320794148356, 10549.156067514581, 10565.313254638424, 10155.441450720133, 10252.077313041862, 10375.014373634493, 10530.526126324334, 10546.09982254886, 6845.315468453115, 7624.27569380908, 8004.159563245776, 8033.1966803320365, 8130.593470326578, 5170.948290517047, 5738.741756620879, 5766.971165144148, 5974.761009559743, 6042.305134909541, 9179.724608261762, 9565.04349565038, 9696.9030309696, 9706.077922597342, 9730.805383892424, 9232.122948319899, 9665.27510436706, 9779.315447918578, 9800.019998000143, 9801.950990245003, 6348.238211414659, 7081.858362832818, 7257.818554536178, 7349.419874726959, 7357.337839594462, 7902.130765615892, 7941.086775020946, 8014.278714915686, 8118.675252989814, 8132.878006829784, 7084.964575177091, 7271.927280727125, 7304.744333948286, 7351.632418379167, 7385.224551422239, 7075.787726368218, 7138.250483699137, 7158.0, 7279.27207279289, 7296.270372962661, 6733.326667333227, 6809.0, 6846.281140480178, 6865.244823069358, 6871.759488417882, 4565.840195593139, 4770.761461926959, 4789.712617242976, 4848.224284114524, 4943.30793688891, 4708.529147085264, 4739.952600474089, 4769.451513076041, 4821.710697358169, 4959.330490383752], "value": 4483.320126849774, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.0739499820509, 326.7712601179175, 327.59869160278663, 335.4481877311822, 337.16215205215053, 5382.788872503685, 5611.186377975201, 5749.683767392792, 5766.538676905848, 5826.796062137826, 4920.70475771453, 5631.155326700997, 5771.220885180499, 5778.24882765241, 5789.363170051291, 4140.8136633851545, 4253.383259427381, 4290.270653988814, 4422.425084738979, 4454.8886277842985, 4355.695101342907, 4361.6510679145595, 4403.295472724365, 4406.823727050914, 4412.271975124101, 4358.716683415583, 4358.825646974117, 4388.714733542325, 4406.427164468614, 4441.200583894898, 4089.3661482470416, 4127.834886604533, 4170.52039015514, 4253.0, 4350.73895566267, 3752.3808571585655, 3762.623737626243, 3763.7929913854728, 3772.660460558563, 3773.735838491307, 5453.563714902798, 5457.645253058578, 5500.944990550083, 5505.9724701376235, 5510.531604813596, 4243.575642435762, 4556.658250631216, 4701.576858082789, 5004.774785134678, 5008.749562521896, 5196.844094677166, 5881.823545293648, 5931.614445061057, 5964.224650795412, 6007.549433792483, 3709.5919448860604, 4069.9621596492707, 4190.958090419118, 4194.580541945811, 4200.222958752641, 5773.509251713567, 6075.088736689488, 6303.55875088744, 6307.067213745584, 6363.204599425072, 4216.51510076339, 4230.407742915994, 4235.174141042528, 4259.552746961586, 4259.74441533509, 3633.927321453556, 4297.763623000703, 4300.634446072119, 4329.350597410351, 4334.913301733947, 4061.7156799023783, 4454.599086082203, 4948.257761335828, 4950.455449900508, 5001.774920128603, 4971.900561988812, 5178.6374953752875, 6134.0, 6141.539384546088, 6155.553444940436, 1432.4771458417601, 1462.7878957551095, 1464.4727897956727, 1465.2820118142033, 1466.296177834624, 905.6015353244551, 919.6781126605769, 924.3206243411088, 963.210167662524, 969.0454901921602, 4715.7642117893965, 5737.024705800024, 5795.9420405796245, 5830.7084645767545, 5849.912251316234, 6381.170447841843, 6402.719456108797, 6427.839304017437, 6439.549231553746, 6444.323346048691, 4697.95302046982, 5548.530903747875, 5783.161441590946, 5807.361190269067, 5814.313848983747, 3316.2538428853795, 3335.7490940897164, 3360.445526488102, 3372.662733726657, 3374.9493757593655, 6267.843303917347, 6692.631905245161, 6715.966420167965, 6717.16035495563, 6800.761973330909, 5484.506394424521, 6580.868382632416, 6598.967005164944, 6601.0, 6611.966940165268, 5300.734963251899, 6674.199096108498, 6690.264070952191, 6729.49528785343, 6752.426043786333, 6323.241211054703, 6340.1440805490665, 6346.3019067903415, 6378.968105159444, 6384.07430922523, 5650.050732497282, 5925.288965324189, 6247.5001999840815, 6259.937400625936, 6287.056941458818, 6311.936880631135, 6627.469802415699, 6727.932720672927, 6772.966135169293, 6845.178578570603, 3815.9887629777577, 3950.565437801897, 4149.8962525937095, 4201.621854033152, 4214.30463973441, 6311.960345379053, 6382.425581697669, 6391.0, 6423.618921931807, 6450.7097180627925, 5569.359523654832, 5597.272354593877, 6150.692465376624, 6182.443580077815, 6190.81427557174, 6122.051082082285, 6144.784932527519, 6153.5692501526255, 6159.84600384994, 6185.381461853779, 5628.690422026828, 5688.829335119953, 5889.352171261072, 6006.249218847644, 6009.338972712911, 4892.828750993698, 5341.252224688469, 5601.915971260516, 5955.3746856581165, 6191.721372538156, 5329.413764485981, 6022.337542870193, 6059.697015149137, 6061.393860613904, 6062.636241825505], "value": 4482.818061430566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.8828899087155, 695.224824320882, 699.6501749125438, 717.573044038797, 721.3832173491668, 14971.251437428125, 15658.921705391485, 15838.683226335495, 15920.0, 15932.84067159328, 14569.417223311082, 14571.562853114423, 14662.853371466283, 14744.705105897876, 14752.6311842204, 755.8488302339526, 772.7527191298786, 912.4844462878469, 939.2908354192575, 940.5579377692474, 877.934154938379, 932.2774849491665, 935.1536859142487, 935.5041827831226, 938.0244545672492, 955.2787645327768, 967.9467629280387, 970.0832713086137, 971.577363846729, 971.6016433262364, 781.3866115099677, 945.8581212818063, 959.5298303831142, 959.7648576098866, 985.3250523391499, 733.8348871503922, 734.1813877526573, 736.7900148457663, 737.2737853214579, 738.7119023580808, 15131.546053618298, 15181.468648597245, 15194.392224311014, 15215.695686086216, 15233.390664373412, 12800.423980920881, 13041.608751737464, 13072.477100915952, 13104.80342794859, 13294.667633309147, 10087.243456740774, 10154.98450154986, 10579.259451838374, 10687.14502839771, 10807.5676972921, 3530.9416506184198, 3564.625714300013, 3566.375884220277, 3641.0715267606856, 3659.908502287464, 82879.0, 83714.16285837124, 84881.72677409844, 86357.56821215917, 86438.56780716057, 8169.223923727236, 9705.0, 9771.755706107262, 10352.06831385164, 10469.790604187874, 21593.676094858274, 21892.78107218939, 21897.343079707633, 21903.9048047597, 21911.233106841504, 6523.641199733966, 7439.665215065335, 7678.692852285958, 7750.186230445835, 7760.92239077602, 4045.0898547826505, 4082.3468245080644, 4082.6733861291027, 4098.221337945781, 4098.7130900836655, 3539.43369060949, 3644.2711457708565, 3646.070252085701, 3646.08847788053, 3648.343298206348, 627.4572494792063, 635.7202830754453, 640.3660376227594, 646.8188907106017, 654.860542655785, 513.7996181489223, 514.4079075262058, 596.4274296675154, 602.9276486821609, 611.4160976267742, 6711.228208756055, 7691.5769632670745, 7900.170482099412, 7930.722424715223, 7954.880676789853, 553.9086050801653, 572.6592677356966, 594.3016955077767, 599.9760009599568, 611.9265688117455, 3606.5852426971232, 3706.2772759312215, 3782.6217378261954, 3787.242551489658, 3811.866584669523, 71822.64088679523, 87505.56247218723, 88110.0, 89257.52053554902, 89872.5506372464, 59216.0, 59353.70323148443, 61282.38717612767, 62281.688591556755, 63885.0, 65787.0, 66315.66842165854, 66984.33015669878, 67431.32568674348, 70234.0, 7324.816879578053, 7644.694212231449, 8024.0772311184965, 8195.221453961864, 8233.094359620318, 31023.844880776356, 43430.914227144574, 44268.55731442644, 44488.0, 45389.31916021196, 52347.47652523426, 59014.63941442294, 61179.470513237524, 64271.67864160649, 64900.0, 10418.0, 10662.73343166427, 10826.350418974887, 11018.0, 11640.126990475579, 11828.763424731285, 12000.819987700366, 12032.819507707567, 12209.084318675958, 12320.630381088582, 9766.951165244413, 11334.0, 11461.426928653367, 11494.367809770543, 11808.881911180779, 11435.771284574095, 11525.068595659766, 11761.941190293994, 11812.70468238301, 12086.742598615121, 11407.600733974272, 11719.0, 12019.519219231133, 12057.879421205676, 12338.938305308417, 9431.434113953184, 9559.569819358006, 9632.27757918145, 9649.710508684751, 9840.0, 8185.590720463834, 9415.387999779992, 9690.46702431373, 9814.65648702292, 9821.36161149523], "value": 6813.2057681916895, "unit": "score"}], "name": "dromaeo_css", "value": 7239.247752624963, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 111.0, 111.0, 112.0, 117.0, 112.0, 111.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 125.0, 146.0, 179.0, 120.0, 144.0, 141.0, 115.0, 173.0, 120.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 186.0, 186.0, 185.0, 186.0, 183.0, 182.0, 187.0, 184.0, 184.0], "value": 185.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 149.0, 56.0, 55.0, 54.0, 67.0, 131.0, 56.0], "value": 79.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 98.0, 134.0, 83.0, 116.0, 122.0, 121.0, 76.0, 109.0, 164.0], "value": 111.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 86.0, 83.0, 87.0, 83.0, 86.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 104.0, 133.0, 93.0, 93.0, 93.0, 94.0, 93.0, 93.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 102.0, 113.0, 131.0, 139.0, 84.0, 84.0, 86.0, 99.0], "value": 101.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 58.0, 58.0, 58.0, 59.0, 73.0, 59.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 67.0, 74.0, 78.0, 69.0, 70.0, 67.0, 67.0, 70.0], "value": 69.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 94.0, 105.0, 76.0, 82.0, 79.0, 81.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 153.0, 156.0, 148.0, 146.0, 146.0, 128.0, 148.0, 178.0, 167.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 169.0, 170.0, 170.0, 168.0, 165.0, 172.0, 168.0, 165.0], "value": 168.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 59.0, 86.0, 95.0, 97.0, 95.0, 71.0, 69.0, 66.0], "value": 77.3, "unit": "score"}], "name": "kraken", "value": 1525.3999999999999, "alertThreshold": 2.0}]} 07:16:14 INFO - Return code: 0 07:16:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:16:14 ERROR - # TBPL SUCCESS # 07:16:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:16:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:16:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:16:14 INFO - 2016-04-15 07:16:14.873 screenresolution[1679:10040] starting screenresolution argv=screenresolution get 07:16:14 INFO - 2016-04-15 07:16:14.876 screenresolution[1679:10040] Display 0: 1600x1200x32@60 07:16:14 INFO - 2016-04-15 07:16:14.881 screenresolution[1680:10043] starting screenresolution argv=screenresolution list 07:16:14 INFO - Available Modes on Display 0 07:16:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:16:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:16:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:16:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:16:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:16:15 INFO - Intel Iris: 07:16:15 INFO - Chipset Model: Intel Iris 07:16:15 INFO - Type: GPU 07:16:15 INFO - Bus: Built-In 07:16:15 INFO - VRAM (Dynamic, Max): 1536 MB 07:16:15 INFO - Vendor: Intel (0x8086) 07:16:15 INFO - Device ID: 0x0a2e 07:16:15 INFO - Revision ID: 0x0009 07:16:15 INFO - Displays: 07:16:15 INFO - Display: 07:16:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:16:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:16:15 INFO - Display Serial Number: 1600x1200 60 07:16:15 INFO - Main Display: Yes 07:16:15 INFO - Mirror: Off 07:16:15 INFO - Online: Yes 07:16:15 INFO - Rotation: Supported 07:16:15 INFO - Return code: 0 07:16:15 INFO - Running post-action listener: _resource_record_post_action 07:16:15 INFO - Running post-run listener: _resource_record_post_run 07:16:16 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37574144; Write bytes: 693395968; Read time: 395; Write time: 1981 07:16:16 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 388030976; Write bytes: 381154816; Read time: 28532; Write time: 724 07:16:16 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 35759616; Write bytes: 295709696; Read time: 375; Write time: 1219 07:16:16 INFO - Running post-run listener: _upload_blobber_files 07:16:16 INFO - Blob upload gear active. 07:16:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:16:16 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 07:16:16 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'] 07:16:16 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 07:16:16 INFO - (blobuploader) - INFO - Open directory for files ... 07:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:16:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:17 INFO - (blobuploader) - INFO - Done attempting. 07:16:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:16:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:16:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:16:19 INFO - (blobuploader) - INFO - Done attempting. 07:16:19 INFO - (blobuploader) - INFO - Iteration through files over. 07:16:19 INFO - Return code: 0 07:16:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:16:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:16:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e646201e26759a248ebfd2b8f9ee820650ab260f4cc02dd259724a02153a5bfa6fe96aaa0298c04abcda927f76aa1702e2a4f78a486a32091a5004f29a2ef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfcd7fcba8a09018751ae4cd89bb7db5c42783515002e53696b45c9391620829a70821ef1d2f84bc4584d0d71a4accec577de5efbe7da10c5f1891ec0cc97cb4"} 07:16:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:16:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:16:19 INFO - Contents: 07:16:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e646201e26759a248ebfd2b8f9ee820650ab260f4cc02dd259724a02153a5bfa6fe96aaa0298c04abcda927f76aa1702e2a4f78a486a32091a5004f29a2ef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfcd7fcba8a09018751ae4cd89bb7db5c42783515002e53696b45c9391620829a70821ef1d2f84bc4584d0d71a4accec577de5efbe7da10c5f1891ec0cc97cb4"} 07:16:19 INFO - Running post-run listener: copy_logs_to_upload_dir 07:16:19 INFO - Copying logs to upload dir... 07:16:19 INFO - mkdir: /builds/slave/test/build/upload/logs 07:16:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.305015 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-15 07:16:19.103437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 07:16:19.111313) ========= 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.TfloN6mGoF/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.ufXmj58UJb/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e646201e26759a248ebfd2b8f9ee820650ab260f4cc02dd259724a02153a5bfa6fe96aaa0298c04abcda927f76aa1702e2a4f78a486a32091a5004f29a2ef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfcd7fcba8a09018751ae4cd89bb7db5c42783515002e53696b45c9391620829a70821ef1d2f84bc4584d0d71a4accec577de5efbe7da10c5f1891ec0cc97cb4"} build_url:https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011014 build_url: 'https://queue.taskcluster.net/v1/task/eMmExvuNQCKLM1MBHfZj2A/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08e646201e26759a248ebfd2b8f9ee820650ab260f4cc02dd259724a02153a5bfa6fe96aaa0298c04abcda927f76aa1702e2a4f78a486a32091a5004f29a2ef4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cfcd7fcba8a09018751ae4cd89bb7db5c42783515002e53696b45c9391620829a70821ef1d2f84bc4584d0d71a4accec577de5efbe7da10c5f1891ec0cc97cb4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 07:16:19.141499) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:16:19.141819) ========= 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.TfloN6mGoF/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.ufXmj58UJb/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005248 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 07:16:19.190915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 07:16:19.191224) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 07:16:19.191564) ========= ========= Total master_lag: 0.48 =========