builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0160 starttime: 1461586055.02 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.022703) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.023159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.023429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.042192) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.042610) ========= 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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-25 05:07:35-- 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% 5.33M=0.002s 2016-04-25 05:07:35 (5.33 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.306073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.368632) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.369403) ========= 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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.018551 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:35.422070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:07:35.422794) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 0361b7030d363459416d46e651a8c50c9536788f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bHrfvAa0s4/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.oC1HMfDhtN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-25 05:07:35,493 truncating revision to first 12 chars 2016-04-25 05:07:35,493 Setting DEBUG logging. 2016-04-25 05:07:35,493 attempt 1/10 2016-04-25 05:07:35,494 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0361b7030d36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-25 05:07:36,478 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.213345 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-25 05:07:36.657025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.657293) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.657642) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.657937) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.671809) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-25 05:07:36.672097) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bHrfvAa0s4/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.oC1HMfDhtN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:07:36 INFO - MultiFileLogger online at 20160425 05:07:36 in /builds/slave/test 05:07:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:07:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:36 INFO - {'append_to_log': False, 05:07:36 INFO - 'base_work_dir': '/builds/slave/test', 05:07:36 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:36 INFO - 'branch': 'Fx-Team', 05:07:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:36 INFO - 'config_files': ('talos/mac_config.py',), 05:07:36 INFO - 'default_actions': ('clobber', 05:07:36 INFO - 'read-buildbot-config', 05:07:36 INFO - 'download-and-extract', 05:07:36 INFO - 'populate-webroot', 05:07:36 INFO - 'create-virtualenv', 05:07:36 INFO - 'install', 05:07:36 INFO - 'run-tests'), 05:07:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:36 INFO - 'download_minidump_stackwalk': True, 05:07:36 INFO - 'download_symbols': 'ondemand', 05:07:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:36 INFO - 'installer_path': 'installer.exe', 05:07:36 INFO - 'log_level': 'info', 05:07:36 INFO - 'log_name': 'talos', 05:07:36 INFO - 'log_to_console': True, 05:07:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:36 INFO - 'opt_config_files': (), 05:07:36 INFO - 'pip_index': False, 05:07:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:36 INFO - 'cmd': ('bash', 05:07:36 INFO - '-c', 05:07:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:36 INFO - 'enabled': True, 05:07:36 INFO - 'halt_on_failure': False, 05:07:36 INFO - 'name': 'check_screen_resolution'},), 05:07:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:36 INFO - 'cmd': ('bash', 05:07:36 INFO - '-c', 05:07:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:36 INFO - 'enabled': True, 05:07:36 INFO - 'halt_on_failure': False, 05:07:36 INFO - 'name': 'check_screen_resolution'},), 05:07:36 INFO - 'run_cmd_checks_enabled': True, 05:07:36 INFO - 'sps_profile': False, 05:07:36 INFO - 'sps_profile_interval': 0, 05:07:36 INFO - 'suite': 'dromaeojs-e10s', 05:07:36 INFO - 'system_bits': '32', 05:07:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:36 INFO - 'title': 't-yosemite-r7-0160', 05:07:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:36 INFO - 'use_talos_json': True, 05:07:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:36 INFO - 'work_dir': 'build'} 05:07:36 INFO - ##### 05:07:36 INFO - ##### Running clobber step. 05:07:36 INFO - ##### 05:07:36 INFO - Running pre-action listener: _resource_record_pre_action 05:07:36 INFO - Running main action method: clobber 05:07:36 INFO - rmtree: /builds/slave/test/build 05:07:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:37 INFO - Running post-action listener: _resource_record_post_action 05:07:37 INFO - ##### 05:07:37 INFO - ##### Running read-buildbot-config step. 05:07:37 INFO - ##### 05:07:37 INFO - Running pre-action listener: _resource_record_pre_action 05:07:37 INFO - Running main action method: read_buildbot_config 05:07:37 INFO - Using buildbot properties: 05:07:37 INFO - { 05:07:37 INFO - "project": "", 05:07:37 INFO - "product": "firefox", 05:07:37 INFO - "script_repo_revision": "production", 05:07:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:07:37 INFO - "repository": "", 05:07:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:07:37 INFO - "buildid": "20160422035423", 05:07:37 INFO - "pgo_build": "False", 05:07:37 INFO - "basedir": "/builds/slave/test", 05:07:37 INFO - "buildnumber": 634, 05:07:37 INFO - "slavename": "t-yosemite-r7-0160", 05:07:37 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:07:37 INFO - "platform": "yosemite_r7", 05:07:37 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:07:37 INFO - "branch": "fx-team", 05:07:37 INFO - "repo_path": "integration/fx-team", 05:07:37 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:07:37 INFO - "stage_platform": "macosx64", 05:07:37 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:07:37 INFO - "slavebuilddir": "test" 05:07:37 INFO - } 05:07:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:07:37 INFO - Running post-action listener: _resource_record_post_action 05:07:37 INFO - ##### 05:07:37 INFO - ##### Running download-and-extract step. 05:07:37 INFO - ##### 05:07:37 INFO - Running pre-action listener: _resource_record_pre_action 05:07:37 INFO - Running main action method: download_and_extract 05:07:37 INFO - mkdir: /builds/slave/test/build/tests 05:07:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:37 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:07:38 INFO - Downloaded 1199 bytes. 05:07:38 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:38 INFO - Using the following test package requirements: 05:07:38 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:38 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:38 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:07:38 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'jsshell-mac.zip'], 05:07:38 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:07:38 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:38 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:07:38 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:07:38 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:07:38 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:38 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:38 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:38 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:45 INFO - Downloaded 18105795 bytes. 05:07:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:48 INFO - Return code: 0 05:07:48 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:07:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:48 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:07:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:07:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:07:50 INFO - Downloaded 18105795 bytes. 05:07:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:07:54 INFO - Return code: 0 05:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:54 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:07:55 INFO - Downloaded 10845952 bytes. 05:07:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:07:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:07:55 INFO - Return code: 0 05:07:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:55 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:08:02 INFO - Downloaded 110035353 bytes. 05:08:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:08:02 INFO - mkdir: /builds/slave/test/properties 05:08:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:02 INFO - Contents: 05:08:02 INFO - build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:08:04 INFO - Running post-action listener: _resource_record_post_action 05:08:04 INFO - Running post-action listener: set_extra_try_arguments 05:08:04 INFO - ##### 05:08:04 INFO - ##### Running populate-webroot step. 05:08:04 INFO - ##### 05:08:04 INFO - Running pre-action listener: _resource_record_pre_action 05:08:04 INFO - Running main action method: populate_webroot 05:08:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:04 INFO - '--tppagecycles', 05:08:04 INFO - '7'], 05:08:04 INFO - 'tests': ['tsvgm']}}, 05:08:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:08:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['damp', 'tps']}, 05:08:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'tests': ['damp', 'tps']}, 05:08:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['dromaeo_dom']}, 05:08:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['a11yr', 05:08:04 INFO - 'ts_paint', 05:08:04 INFO - 'tpaint', 05:08:04 INFO - 'sessionrestore', 05:08:04 INFO - 'sessionrestore_no_auto_restore', 05:08:04 INFO - 'tabpaint']}, 05:08:04 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:04 INFO - 'ts_paint', 05:08:04 INFO - 'tpaint', 05:08:04 INFO - 'sessionrestore', 05:08:04 INFO - 'sessionrestore_no_auto_restore', 05:08:04 INFO - 'tabpaint']}, 05:08:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:08:04 INFO - 'ts_paint', 05:08:04 INFO - 'tpaint', 05:08:04 INFO - 'sessionrestore', 05:08:04 INFO - 'sessionrestore_no_auto_restore', 05:08:04 INFO - 'tabpaint']}, 05:08:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:08:04 INFO - 'ts_paint', 05:08:04 INFO - 'tpaint', 05:08:04 INFO - 'sessionrestore', 05:08:04 INFO - 'sessionrestore_no_auto_restore', 05:08:04 INFO - 'tabpaint']}, 05:08:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['a11yr', 05:08:04 INFO - 'ts_paint', 05:08:04 INFO - 'tpaint', 05:08:04 INFO - 'sessionrestore', 05:08:04 INFO - 'sessionrestore_no_auto_restore', 05:08:04 INFO - 'tabpaint']}, 05:08:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['a11yr', 05:08:04 INFO - 'ts_paint', 05:08:04 INFO - 'tpaint', 05:08:04 INFO - 'sessionrestore', 05:08:04 INFO - 'sessionrestore_no_auto_restore', 05:08:04 INFO - 'tabpaint']}, 05:08:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['tsvgx', 05:08:04 INFO - 'tsvgr_opacity', 05:08:04 INFO - 'tart', 05:08:04 INFO - 'tscrollx', 05:08:04 INFO - 'cart']}, 05:08:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:04 INFO - 'tsvgr_opacity', 05:08:04 INFO - 'tart', 05:08:04 INFO - 'tscrollx', 05:08:04 INFO - 'cart']}, 05:08:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'talos_options': ['--disable-e10s'], 05:08:04 INFO - 'tests': ['tp5o']}, 05:08:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'tests': ['tp5o']}, 05:08:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'talos_options': ['--disable-e10s', 05:08:04 INFO - '--xperf_path', 05:08:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:04 INFO - 'tests': ['tp5n']}, 05:08:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:04 INFO - 'talos_options': ['--xperf_path', 05:08:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:04 INFO - 'tests': ['tp5n']}}, 05:08:04 INFO - 'talos.zip': {'path': '', 05:08:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:04 INFO - Running post-action listener: _resource_record_post_action 05:08:04 INFO - ##### 05:08:04 INFO - ##### Running create-virtualenv step. 05:08:04 INFO - ##### 05:08:04 INFO - Running pre-action listener: _resource_record_pre_action 05:08:04 INFO - Running main action method: create_virtualenv 05:08:04 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:08:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:04 INFO - Using real prefix '/tools/python27' 05:08:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:04 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:07 INFO - Installing pip.................done. 05:08:07 INFO - Return code: 0 05:08:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:08:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:07 INFO - 'HOME': '/Users/cltbld', 05:08:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:07 INFO - 'LOGNAME': 'cltbld', 05:08:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:07 INFO - 'MOZ_NO_REMOTE': '1', 05:08:07 INFO - 'NO_EM_RESTART': '1', 05:08:07 INFO - 'PAGER': '/bin/cat', 05:08:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:07 INFO - 'PWD': '/builds/slave/test', 05:08:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:07 INFO - 'SHELL': '/bin/bash', 05:08:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:07 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:07 INFO - 'USER': 'cltbld', 05:08:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:07 INFO - 'XPC_FLAGS': '0x0', 05:08:07 INFO - 'XPC_SERVICE_NAME': '0', 05:08:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:08:08 INFO - Cleaning up... 05:08:08 INFO - Return code: 0 05:08:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:08:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:08:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:08 INFO - 'HOME': '/Users/cltbld', 05:08:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:08 INFO - 'LOGNAME': 'cltbld', 05:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:08 INFO - 'MOZ_NO_REMOTE': '1', 05:08:08 INFO - 'NO_EM_RESTART': '1', 05:08:08 INFO - 'PAGER': '/bin/cat', 05:08:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:08 INFO - 'PWD': '/builds/slave/test', 05:08:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:08 INFO - 'SHELL': '/bin/bash', 05:08:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:08 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:08 INFO - 'USER': 'cltbld', 05:08:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:08 INFO - 'XPC_FLAGS': '0x0', 05:08:08 INFO - 'XPC_SERVICE_NAME': '0', 05:08:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:08 INFO - Downloading/unpacking psutil>=0.7.1 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:10 INFO - Installing collected packages: psutil 05:08:10 INFO - Running setup.py install for psutil 05:08:10 INFO - building 'psutil._psutil_osx' extension 05:08:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:08:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:08:11 INFO - building 'psutil._psutil_posix' extension 05:08:11 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:08:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:11 INFO - ^ 05:08:11 INFO - 1 warning generated. 05:08:11 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:08:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:11 INFO - Successfully installed psutil 05:08:11 INFO - Cleaning up... 05:08:11 INFO - Return code: 0 05:08:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:08:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:08:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:11 INFO - 'HOME': '/Users/cltbld', 05:08:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:11 INFO - 'LOGNAME': 'cltbld', 05:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:11 INFO - 'MOZ_NO_REMOTE': '1', 05:08:11 INFO - 'NO_EM_RESTART': '1', 05:08:11 INFO - 'PAGER': '/bin/cat', 05:08:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:11 INFO - 'PWD': '/builds/slave/test', 05:08:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:11 INFO - 'SHELL': '/bin/bash', 05:08:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:11 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:11 INFO - 'USER': 'cltbld', 05:08:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:11 INFO - 'XPC_FLAGS': '0x0', 05:08:11 INFO - 'XPC_SERVICE_NAME': '0', 05:08:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:14 INFO - Installing collected packages: mozsystemmonitor 05:08:14 INFO - Running setup.py install for mozsystemmonitor 05:08:14 INFO - Successfully installed mozsystemmonitor 05:08:14 INFO - Cleaning up... 05:08:14 INFO - Return code: 0 05:08:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:08:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:08:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:14 INFO - 'HOME': '/Users/cltbld', 05:08:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:14 INFO - 'LOGNAME': 'cltbld', 05:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:14 INFO - 'MOZ_NO_REMOTE': '1', 05:08:14 INFO - 'NO_EM_RESTART': '1', 05:08:14 INFO - 'PAGER': '/bin/cat', 05:08:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:14 INFO - 'PWD': '/builds/slave/test', 05:08:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:14 INFO - 'SHELL': '/bin/bash', 05:08:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:14 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:14 INFO - 'USER': 'cltbld', 05:08:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:14 INFO - 'XPC_FLAGS': '0x0', 05:08:14 INFO - 'XPC_SERVICE_NAME': '0', 05:08:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:17 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:18 INFO - Downloading docopt-0.6.1.tar.gz 05:08:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:18 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:18 INFO - Running setup.py install for blobuploader 05:08:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:18 INFO - Running setup.py install for requests 05:08:19 INFO - Running setup.py install for docopt 05:08:19 INFO - Successfully installed blobuploader requests docopt 05:08:19 INFO - Cleaning up... 05:08:19 INFO - Return code: 0 05:08:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:19 INFO - 'HOME': '/Users/cltbld', 05:08:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:19 INFO - 'LOGNAME': 'cltbld', 05:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:19 INFO - 'MOZ_NO_REMOTE': '1', 05:08:19 INFO - 'NO_EM_RESTART': '1', 05:08:19 INFO - 'PAGER': '/bin/cat', 05:08:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:19 INFO - 'PWD': '/builds/slave/test', 05:08:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:19 INFO - 'SHELL': '/bin/bash', 05:08:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:19 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:19 INFO - 'USER': 'cltbld', 05:08:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:19 INFO - 'XPC_FLAGS': '0x0', 05:08:19 INFO - 'XPC_SERVICE_NAME': '0', 05:08:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-3AhWDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-MYdmCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:19 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-pnekFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-GxHay3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-DA3MO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-uYGrfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-dUsEWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-3wbMpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-HA3CqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ULqgmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-RJVxoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:20 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-2JtNx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:21 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-fF_2Sp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:21 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ci9sq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:21 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-yKEgeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:21 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ncO0Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:21 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-6ZQUpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:21 INFO - Running setup.py install for manifestparser 05:08:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:21 INFO - Running setup.py install for mozcrash 05:08:21 INFO - Running setup.py install for mozdebug 05:08:21 INFO - Running setup.py install for mozdevice 05:08:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Running setup.py install for mozfile 05:08:22 INFO - Running setup.py install for mozhttpd 05:08:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Running setup.py install for mozinfo 05:08:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Running setup.py install for mozInstall 05:08:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:22 INFO - Running setup.py install for mozleak 05:08:22 INFO - Running setup.py install for mozlog 05:08:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:23 INFO - Running setup.py install for moznetwork 05:08:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:23 INFO - Running setup.py install for mozprocess 05:08:23 INFO - Running setup.py install for mozprofile 05:08:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:23 INFO - Running setup.py install for mozrunner 05:08:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:23 INFO - Running setup.py install for mozscreenshot 05:08:23 INFO - Running setup.py install for moztest 05:08:23 INFO - Running setup.py install for mozversion 05:08:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:24 INFO - Cleaning up... 05:08:24 INFO - Return code: 0 05:08:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:24 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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:24 INFO - 'HOME': '/Users/cltbld', 05:08:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:24 INFO - 'LOGNAME': 'cltbld', 05:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:24 INFO - 'MOZ_NO_REMOTE': '1', 05:08:24 INFO - 'NO_EM_RESTART': '1', 05:08:24 INFO - 'PAGER': '/bin/cat', 05:08:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:24 INFO - 'PWD': '/builds/slave/test', 05:08:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:24 INFO - 'SHELL': '/bin/bash', 05:08:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:24 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:24 INFO - 'USER': 'cltbld', 05:08:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:24 INFO - 'XPC_FLAGS': '0x0', 05:08:24 INFO - 'XPC_SERVICE_NAME': '0', 05:08:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-N89Qcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-2yQsOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-nmGcPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-FUCJ6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-12Fkto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-XEjEhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:08:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:24 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-MX4pqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-D8MHqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-PUH4E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-5R1gU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-ZAG9IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-D8a0in-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-nJIY4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-hgvrMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-HSjncQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:08:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:25 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-OOZsm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:26 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-FZFQVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:29 INFO - Downloading blessings-1.6.tar.gz 05:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:29 INFO - Installing collected packages: blessings 05:08:29 INFO - Running setup.py install for blessings 05:08:29 INFO - Successfully installed blessings 05:08:29 INFO - Cleaning up... 05:08:29 INFO - Return code: 0 05:08:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:30 INFO - Reading from file tmpfile_stdout 05:08:30 INFO - Current package versions: 05:08:30 INFO - blessings == 1.6 05:08:30 INFO - blobuploader == 1.2.4 05:08:30 INFO - docopt == 0.6.1 05:08:30 INFO - manifestparser == 1.1 05:08:30 INFO - mozInstall == 1.12 05:08:30 INFO - mozcrash == 0.17 05:08:30 INFO - mozdebug == 0.1 05:08:30 INFO - mozdevice == 0.48 05:08:30 INFO - mozfile == 1.2 05:08:30 INFO - mozhttpd == 0.7 05:08:30 INFO - mozinfo == 0.9 05:08:30 INFO - mozleak == 0.1 05:08:30 INFO - mozlog == 3.1 05:08:30 INFO - moznetwork == 0.27 05:08:30 INFO - mozprocess == 0.22 05:08:30 INFO - mozprofile == 0.28 05:08:30 INFO - mozrunner == 6.11 05:08:30 INFO - mozscreenshot == 0.1 05:08:30 INFO - mozsystemmonitor == 0.0 05:08:30 INFO - moztest == 0.7 05:08:30 INFO - mozversion == 1.4 05:08:30 INFO - psutil == 3.1.1 05:08:30 INFO - requests == 1.2.3 05:08:30 INFO - wsgiref == 0.1.2 05:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:30 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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:30 INFO - 'HOME': '/Users/cltbld', 05:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:30 INFO - 'LOGNAME': 'cltbld', 05:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:30 INFO - 'MOZ_NO_REMOTE': '1', 05:08:30 INFO - 'NO_EM_RESTART': '1', 05:08:30 INFO - 'PAGER': '/bin/cat', 05:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:30 INFO - 'PWD': '/builds/slave/test', 05:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:30 INFO - 'SHELL': '/bin/bash', 05:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:30 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:30 INFO - 'USER': 'cltbld', 05:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:30 INFO - 'XPC_FLAGS': '0x0', 05:08:30 INFO - 'XPC_SERVICE_NAME': '0', 05:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:08:30 INFO - Cleaning up... 05:08:30 INFO - Return code: 0 05:08:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:30 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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:08:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:30 INFO - 'HOME': '/Users/cltbld', 05:08:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:30 INFO - 'LOGNAME': 'cltbld', 05:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:30 INFO - 'MOZ_NO_REMOTE': '1', 05:08:30 INFO - 'NO_EM_RESTART': '1', 05:08:30 INFO - 'PAGER': '/bin/cat', 05:08:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:30 INFO - 'PWD': '/builds/slave/test', 05:08:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:30 INFO - 'SHELL': '/bin/bash', 05:08:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:30 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:30 INFO - 'USER': 'cltbld', 05:08:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:30 INFO - 'XPC_FLAGS': '0x0', 05:08:30 INFO - 'XPC_SERVICE_NAME': '0', 05:08:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:30 INFO - Downloading/unpacking jsonschema 05:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:32 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:33 INFO - warning: no files found matching '*.txt' 05:08:33 INFO - no previously-included directories found matching 'build' 05:08:33 INFO - no previously-included directories found matching 'dist' 05:08:33 INFO - no previously-included directories found matching '.git*' 05:08:33 INFO - Installing collected packages: jsonschema, functools32 05:08:33 INFO - Running setup.py install for functools32 05:08:33 INFO - warning: no files found matching '*.txt' 05:08:33 INFO - no previously-included directories found matching 'build' 05:08:33 INFO - no previously-included directories found matching 'dist' 05:08:33 INFO - no previously-included directories found matching '.git*' 05:08:33 INFO - Successfully installed jsonschema functools32 05:08:33 INFO - Cleaning up... 05:08:33 INFO - Return code: 0 05:08:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:34 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 0x1090dfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1090ef420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa4a5802e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, '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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:08:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:08:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:08:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:34 INFO - 'HOME': '/Users/cltbld', 05:08:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:34 INFO - 'LOGNAME': 'cltbld', 05:08:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:34 INFO - 'MOZ_NO_REMOTE': '1', 05:08:34 INFO - 'NO_EM_RESTART': '1', 05:08:34 INFO - 'PAGER': '/bin/cat', 05:08:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:34 INFO - 'PWD': '/builds/slave/test', 05:08:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:34 INFO - 'SHELL': '/bin/bash', 05:08:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:08:34 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:08:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:34 INFO - 'USER': 'cltbld', 05:08:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:34 INFO - 'XPC_FLAGS': '0x0', 05:08:34 INFO - 'XPC_SERVICE_NAME': '0', 05:08:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:34 INFO - Downloading/unpacking flake8 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:37 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:38 INFO - no previously-included directories found matching 'docs/_build' 05:08:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:38 INFO - Running setup.py install for pep8 05:08:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:38 INFO - no previously-included directories found matching 'docs/_build' 05:08:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:38 INFO - Cleaning up... 05:08:38 INFO - Return code: 0 05:08:38 INFO - Running post-action listener: _resource_record_post_action 05:08:38 INFO - Running post-action listener: _start_resource_monitoring 05:08:38 INFO - Starting resource monitoring. 05:08:38 INFO - ##### 05:08:38 INFO - ##### Running install step. 05:08:38 INFO - ##### 05:08:38 INFO - Running pre-action listener: _resource_record_pre_action 05:08:38 INFO - Running main action method: install 05:08:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:39 INFO - Reading from file tmpfile_stdout 05:08:39 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:39 INFO - Reading from file tmpfile_stdout 05:08:39 INFO - Output received: 05:08:39 INFO - Usage: mozinstall [options] installer 05:08:39 INFO - Options: 05:08:39 INFO - -h, --help show this help message and exit 05:08:39 INFO - -d DEST, --destination=DEST 05:08:39 INFO - Directory to install application into. [default: 05:08:39 INFO - "/builds/slave/test"] 05:08:39 INFO - --app=APP Application being installed. [default: firefox] 05:08:39 INFO - mkdir: /builds/slave/test/build/application 05:08:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:08:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:12 INFO - Reading from file tmpfile_stdout 05:09:12 INFO - Output received: 05:09:12 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:09:12 INFO - Running post-action listener: _resource_record_post_action 05:09:12 INFO - ##### 05:09:12 INFO - ##### Running run-tests step. 05:09:12 INFO - ##### 05:09:12 INFO - Running pre-action listener: _resource_record_pre_action 05:09:12 INFO - Running main action method: run_tests 05:09:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:12 INFO - 2016-04-25 05:09:12.902 screenresolution[6150:103465] starting screenresolution argv=screenresolution get 05:09:12 INFO - 2016-04-25 05:09:12.905 screenresolution[6150:103465] Display 0: 1600x1200x32@60 05:09:12 INFO - 2016-04-25 05:09:12.911 screenresolution[6151:103467] starting screenresolution argv=screenresolution list 05:09:12 INFO - Available Modes on Display 0 05:09:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:13 INFO - Intel Iris: 05:09:13 INFO - Chipset Model: Intel Iris 05:09:13 INFO - Type: GPU 05:09:13 INFO - Bus: Built-In 05:09:13 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:13 INFO - Vendor: Intel (0x8086) 05:09:13 INFO - Device ID: 0x0a2e 05:09:13 INFO - Revision ID: 0x0009 05:09:13 INFO - Displays: 05:09:13 INFO - Display: 05:09:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:13 INFO - Display Serial Number: 1600x1200 60 05:09:13 INFO - Main Display: Yes 05:09:13 INFO - Mirror: Off 05:09:13 INFO - Online: Yes 05:09:13 INFO - Rotation: Supported 05:09:13 INFO - Return code: 0 05:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:13 INFO - Python 2.7.3 05:09:13 INFO - Return code: 0 05:09:13 INFO - grabbing minidump binary from tooltool 05:09: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')]} 05:09:13 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 0x108f7ee00>, '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 0x108de7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108f79b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:09:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:09:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:13 INFO - Return code: 0 05:09:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:14 INFO - Return code: 0 05:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0160 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:09:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bHrfvAa0s4/Render', 05:09:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:14 INFO - 'HOME': '/Users/cltbld', 05:09:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:14 INFO - 'LOGNAME': 'cltbld', 05:09:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:14 INFO - 'MOZ_NO_REMOTE': '1', 05:09:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:14 INFO - 'NO_EM_RESTART': '1', 05:09:14 INFO - 'PAGER': '/bin/cat', 05:09:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:14 INFO - 'PWD': '/builds/slave/test', 05:09:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:14 INFO - 'SHELL': '/bin/bash', 05:09:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oC1HMfDhtN/Listeners', 05:09:14 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 05:09:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:14 INFO - 'USER': 'cltbld', 05:09:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:14 INFO - 'XPC_FLAGS': '0x0', 05:09:14 INFO - 'XPC_SERVICE_NAME': '0', 05:09:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:09:14 INFO - mozversion application_buildid: 20160422035423 05:09:14 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:09:14 INFO - mozversion application_display_name: Nightly 05:09:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:14 INFO - mozversion application_name: Firefox 05:09:14 INFO - mozversion application_remotingname: firefox 05:09:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:09:14 INFO - mozversion application_vendor: Mozilla 05:09:14 INFO - mozversion application_version: 48.0a1 05:09:14 INFO - mozversion platform_buildid: 20160422035423 05:09:14 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:09:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:09:14 INFO - mozversion platform_version: 48.0a1 05:09:14 INFO - using testdate: 1461586154 05:09:14 INFO - actual date: 1461586154 05:09:14 INFO - starting webserver on 'localhost:56615' 05:09:14 INFO - SUITE-START | Running 2 tests 05:09:14 INFO - TEST-START | dromaeo_css 05:09:14 INFO - operating with platform_type : mac_ 05:09:14 INFO - Initialising browser for dromaeo_css test... 05:09:14 INFO - TEST-INFO | started process 6169 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmp8sfwKJ/profile http://localhost:56615/getInfo.html) 05:09:17 INFO - PROCESS | 6169 | __metrics Screen width/height:1600/1200 05:09:17 INFO - PROCESS | 6169 | colorDepth:24 05:09:17 INFO - PROCESS | 6169 | Browser inner width/height: 1024/689 05:09:17 INFO - PROCESS | 6169 | __metrics 05:09:17 ERROR - PROCESS | 6169 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:09:18 INFO - TEST-INFO | 6169: exit 0 05:09:18 INFO - Browser initialized. 05:09:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:18 INFO - TEST-INFO | started process 6173 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmp8sfwKJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:30 INFO - PROCESS | 6173 | RSS: Main: 247906304 05:09:30 INFO - PROCESS | 6173 | 05:10:19 INFO - PROCESS | 6173 | 1461586219905 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:12:31 INFO - PROCESS | 6173 | Cycle 1(1): loaded http://localhost:56615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56615/tests/dromaeo/cssquery-ext.html) 05:12:32 INFO - PROCESS | 6173 | RSS: Main: 259956736 05:12:32 INFO - PROCESS | 6173 | 05:15:34 INFO - PROCESS | 6173 | Cycle 1(1): loaded http://localhost:56615/tests/dromaeo/cssquery-ext.html (next: http://localhost:56615/tests/dromaeo/cssquery-jquery.html) 05:15:35 INFO - PROCESS | 6173 | RSS: Main: 272039936 05:15:35 INFO - PROCESS | 6173 | 05:18:37 INFO - PROCESS | 6173 | Cycle 1(1): loaded http://localhost:56615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56615/tests/dromaeo/cssquery-mootools.html) 05:18:37 INFO - PROCESS | 6173 | RSS: Main: 274173952 05:18:37 INFO - PROCESS | 6173 | 05:21:39 INFO - PROCESS | 6173 | Cycle 1(1): loaded http://localhost:56615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56615/tests/dromaeo/cssquery-prototype.html) 05:21:40 INFO - PROCESS | 6173 | RSS: Main: 275734528 05:21:40 INFO - PROCESS | 6173 | 05:24:42 INFO - PROCESS | 6173 | Cycle 1(1): loaded http://localhost:56615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56615/tests/dromaeo/cssquery-yui.html) 05:24:43 INFO - PROCESS | 6173 | RSS: Main: 278568960 05:24:43 INFO - PROCESS | 6173 | 05:27:45 INFO - PROCESS | 6173 | Cycle 1(1): loaded http://localhost:56615/tests/dromaeo/cssquery-yui.html (next: http://localhost:56615/tests/dromaeo/cssquery-dojo.html) 05:27:46 INFO - PROCESS | 6173 | RSS: Main: 280072192 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | __start_tp_report 05:27:46 INFO - PROCESS | 6173 | _x_x_mozilla_page_load 05:27:46 INFO - PROCESS | 6173 | _x_x_mozilla_page_load_details 05:27:46 INFO - PROCESS | 6173 | |i|pagename|runs| 05:27:46 INFO - PROCESS | 6173 | |0;dojo.html;2709.5800150976597;3029.575859379686;3426.0749597608647;3476.7566270361067;3477.7565570410084;5821.708914554271;5826.213461182739;5852.619579727315;5855;5891.675957822318;5699.886002279952;5767.10609855472;5819.359870414251;5879.17691523186;5910.9113363299475;5186.533212010918;5231.764570594313;5247.291615631879;5278.181881808307;5302.946970530284;5301.496357845998;5332.946670533283;5352.036633405985;5352.973235133819;5394.568434525248;4314.813426307759;5005.799768009275;5113.897722045538;5200.089984252779;5268;5161.225816127573;5186.688798672092;5195.376554813409;5199.6360254782185;5228.320318358627;5064.620153488466;5180.456052114511;5183.896322073538;5194.896102077975;5338.706371149585;5285.947140528622;5633.492985631272;5692.857678558028;5723.885522289531;5782.479576838105;6111.419415155598;6147.661878596676;6189.876202475925;6193.535484838655;6207.193064901579;6160;6170.259568851721;6183.690815459209;6193.071039344134;6261.530385221081;5746.454086861741;5830.854228644275;5893.882122357529;5910.379410161957;5945.791897283661;6168.19813424252;6169.475594574512;6170.660613666291;6186.10301506279;6187.133801267826;6079.756809727562;6089.543284253698;6090.086487026982;6102.176206212193;6144.109104179869;6062.333143354227;6128.900367973393;6139.614800607318;6159.260888693386;6193.84515387119;6006.63960162383;6121;6138.754449821957;6170.598911070766;6171.814845554641;6131.202943617302;6147.354527774609;6178.62928224308;6195.876082478325;6197.628142311386;4907.9263811042865;4941.802327906916;4980.750962451935;4993.675411098267;5041.395032596039;4406.361077643788;4422.380866678667;4449.555044495589;4458.687891847604;4467.374567560544;5730.140478928194;5822.155787410802;5884.823455296348;5894.32215295238;5912.290525137011;6114.206128133723;6123.313546946588;6159.630422174684;6163.8150855474405;6211.844703882349;5821.79623713168;5822.912656310159;5832.533397328203;5851.1515830205235;5870.207521984563;5365.570754339644;5399.70301633414;5403.594730395236;5413.052715774724;5417.674939503642;5768.682722450221;6017.729202185912;6376.107344971615;6386.904196437057;6392.648404337806;6151.446369826737;6170.938290617037;6193.287771906108;6194.946859033885;6240.157578726814;6133.089845874549;6260.436560709558;6304.117423560797;6309.684515774285;6320.683965801783;6133.610107582747;6140;6183.474404675653;6207.317195108625;6208.317085120543;4756.571908528249;5132.6150538709;5665.546756259571;6150.446459818638;6169.784057557964;6082.513398927987;6129.297663865929;6144.477719393902;6175.5677102602385;6189.7929903668355;4927.841957140141;5850.561207909339;6161.537884658579;6167.784127555514;6181.041938499539;5940.79207227745;6070.150178974859;6081.179040829431;6102.298235702951;6176.629402235881;5991.191189189578;6117.248930028793;6121.178620692955;6125.754969801158;6154.476869465966;4981.4769449207315;6064.3026052002815;6084.543659225487;6108.053251745987;6112.633242005494 05:27:46 INFO - PROCESS | 6173 | |1;ext.html;498.72071639881693;509.60760214634723;535.4859335038363;560.011579562073;607.3683369295933;30073.947411840563;38097.23805523888;38247.61752382475;38248.80875595622;38447;39402.605973940255;39787.60212397875;39790.602093979054;39882.00294992627;39941.400878986766;9388.295877809174;9575.90424095757;9615.855762163574;9617.374870633386;9650.758731031745;8772.517511536864;9230.861537076915;9674.661386851461;9675.806483870318;9694.17599504043;7936.6825326986855;8678.435901666404;9704.22366210705;9713.805723885518;9750.171235444996;9645.903540964606;9695.563699633534;9705.563249653747;9733.17268032218;9751.317407781458;9537.47543885086;9626.37428567148;9658.275629327829;9661.323707340489;9664.613415463373;37837.810810946045;37887.431688524695;37930.62069379298;38389.808050959844;38419.61580384188;2737.7536021758137;3151.43274210642;3233.4503134467195;3247.301830106515;3452.654734526552;26010;26047.739522604912;26062.34844128912;26452.47095058107;26903.192904212905;2633.499635069331;2711.457708458316;2734.740199681027;2748.8900443982216;2767.5848622706553;362690.6116571841;362860;363214;368064;368153;46680.066398671835;52206.738966304925;62204.75590488256;62461.375386246465;62656;66606.00090998638;67478.61389009698;67656.66171669209;68478.65760671165;68629;14393.640158995899;17150.828491715172;17185.656286874193;17235.91382043082;17242.568935776704;11190.440477976068;13054.738905222031;13198.14212076212;13212.669683257804;13216.603501894959;15883;19159.52101197481;19236.84578925269;19347.613047738967;19439.80560194408;7384.2984916433925;8130.83738325242;8247.21651443112;8261.297789687824;8292.834143317099;875.5578432891476;961.3030552849128;1050.4327663062013;1062.1396668698378;1114.9498272577591;26092.73907260941;26951;29378;29727.851360743058;30087;1071.8338657508098;1088.298047759191;1139.5498777982816;1185.8458400407892;1214.6881368122406;14278;16081.52662603666;16319.755203671955;16494.917525412297;16526.338946442007;545381;625241;646968;647660;650422.747886267;50445.74777126091;59063.704681477175;59257.70371148117;59778.70110649419;59944;1458.795768592398;1469.1111877314286;1471.933762980647;1477.224457159978;1482.9925850370894;29015.274618134714;29317.560236596895;29582;30109.548356775103;30144.3971120572;50840.23739643982;51748.74125629348;51840;51944.480555193964;52004.95990080101;576336;590241;596060.2166880863;596979;599236;26077.478450431263;26208.08271710481;26270.60594091052;26461.867690661424;26463.33841653974;43046.35430468608;43688.56311436845;43810;44063.77968110139;44939.775301123285;36286.63713362938;36512.452313214795;36661.266774663825;37243.81378093092;37559.43660845144;35715;35752.64247357493;36034.819825900704;36925.63074369222;36952.63047369492;35502.644973549934;35993;36236.63763362438;36254.63745362618;36562.8171859139;31271;31987.360252794348;32305.676943231207;32380.028599142064;32387.51418728768;20083;23971.520569588858;24334.26997190087;24335.391615209053;24603.876980614983 05:27:46 INFO - PROCESS | 6173 | |2;jquery.html;355.48277256591655;384.90185002824273;398.4382021349897;401.78303715993366;408.83033541080454;18710.43868683938;20168.991550422455;20896.47758806027;21010.684839727397;21044;12073.698157546065;12228.633141005785;14797.778033329509;19862.70205946912;20433.284835030776;5043.016611760708;5314.813981510648;5456.208849716789;5474.972625136868;5520.91718624221;4157.293260145782;4253.723507971988;4964.056829202458;5163.561097306715;5403.2705584745945;5337;5342.465753424646;5345.973270133663;5416.1063424534905;5442.346918369782;5458.536024437927;5956.7319470623925;5988.550858685594;6008.939910600903;6025.6083354581815;5310.336207974004;5310.9734451327495;5333.226682131108;5346.572274218053;5348.893022139536;12979.41592628334;13190.73618527624;13204.273764942924;13221.140625859289;16635.584110397216;1970.5369238229005;1986.1558837494151;2138.786121387864;2258.830587705929;2340.941476463085;9193.908060919372;9368.110029547182;9723.708288751348;9900.90099099007;9935.80128397428;1667.749837524369;1679.9496015119566;1730.7403889416562;1748.8076311605714;1762.903040332794;71492.6425367875;108444;109071;116323.41838290755;125391;11237.775244495064;11618.6514404568;11678.824817627572;11784.234024788533;11977.101717371232;14861.92569037148;15057.849421505864;15110.39558417673;15196.544103676908;15209.239538023054;7283.672234749449;8693.521856297964;8798.516081615573;8877.556122193864;8926.642934282685;8740.257078148428;8746.51894145828;8751.868721969175;8777.210051095431;8863.601137948808;4584.358189853423;4688.437387513521;4694.530546945278;4696.553827386393;4725.1730947084125;1970.9014549272479;1979.2874565156533;2013.8288245499004;2016.7277417548737;2048.8258498027535;387.98836034919;398.62330098057635;426.8015372851639;809.114020147937;911.293747345799;11510;11881.168318217642;12018.879811201776;12042.976347010426;12044.759104817855;433.41488989864064;452.38475673084577;454.3752340531769;455.6332152617175;464.0903828496118;6036.63780173191;6085.148079268906;6111.449969502677;6178.7219575119225;6211.192544969125;590179;610235;653277;653619.7319013374;655594;146625.26687366495;147650.26174869057;147768;151196.48803512045;151211.22481611778;460.9746463944515;467.2547287077107;990.2869933647762;1064.973375665599;1075.1506310015156;18207.362742303954;18223.635527289644;18279.451616451526;18285.17716702725;18392.804467709557;43768;43991;45309.77345113253;46871.53128468672;53670;78575;78602.82095768682;80323.19676803157;81866.18133818585;82605;8010.279074883289;8015.799605009922;8103.6758529658155;8360.163983601591;8546.658133674584;7946.801329966797;9992.750906136733;11884.34636095023;12239.449224784728;12456.75086498283;10618.256722029384;10653.733656658645;10958.726031849268;11162.034520419498;11288.887111128784;8350.624221909908;9525.618975240914;10742.785144297226;11245;11273.605423810128;11288.379139147426;11424.543018279508;11497.827532587185;11536.903994120881;11592.362420066976;8000.51996880189;8080.515169089874;8344.624491897757;8351.33189344863;8430.831383372175;9314.95342523283;10286.228532859916;11112.222144450134;11162.832557511481;11326.94336528345 05:27:46 INFO - PROCESS | 6173 | |3;mootools.html;1325.2777236406157;1601.7437210046387;1799.6670615936052;1938.4087853204767;1951.541387773872;8053.516788992664;8668.34987375947;8740.825183496327;8918.286537077034;8925.152110549496;8756.211940925316;8802.559872006406;8891.777705557364;8942.776430589238;8992.955035224815;2468.8642124683092;2492.0903870087377;2495.8128140389454;2503.5618766715843;2505.949881002379;2434.8417352872093;2482.7517248275117;2483.341914392687;2485.6023036314195;2494.5634513960076;2471.258622413278;2474.6411770293385;2491.215267190838;2494.638277449769;2499.6250562415603;2437.8171637127107;2442.6091825307954;2450.2894160693377;2453.681021467207;2467.1858286765323;2422.854628722265;2431.978569001024;2434.5982912819363;2444.669969554105;2450.362905644545;8792.252658524034;8914.687985920462;8930.151635594673;9028.954855225682;9066.727998160066;5213.895722085575;5412.4587541245955;5420.376656684492;5434.75543600535;5448.400675925645;2982.3438843454405;3417.726581873444;3434.9656503434894;3542.5394698689265;3558.1994051338243;980.1423754215061;1004.0411407106196;1014;1017.1862509992051;1027.7790275090892;9782.51087445625;11473.967342939175;11556.191066625339;11589.710257243552;11592;4145.97927010363;4727.739974301447;4788.715757975416;4808.63935204861;4908.386451693538;9802;9868.013198680219;9894.653687120915;9902.80194396108;9973;5397.569644044332;5417.26866872975;5424.077906755861;5429.945700543023;5463.890722185613;4415.403920470695;4833.685810422382;4965.329680493087;5028.346314979102;5034.572061374751;4069.7761623110423;4081.1098411697544;4113.629773320416;4151.937720934188;4154.543000269968;1252.7181384188666;1333.7063048842608;1357.511295933463;1388.208721029024;1396.1343966740685;844.911284315138;894.9284057275403;929.2473096791621;936.8641546975787;943.8253923024263;4999.950000500021;5954.345022047572;6013.51891848651;6044.818655440344;6122.2959359674205;460.2474953451131;468.8265341823547;474.9026449577828;475.38200339559125;484.3340406940457;3903.4730311407598;3971.900702482461;3998.660113890294;4054.412110243998;4056.6146216109423;9367.718968430958;10454.68635940923;10922.344659320466;10977;10983.835242471368;8748.562571871382;8968.775780605407;10713.946430267799;10726.249162558546;10867.891321086847;6526.641034743135;8139.755807325908;8254.917450825535;8324.458910170819;8397.244248017707;4665.393498845128;6003.5797494174985;6003.958654057641;6111.113888486234;6117.541184411276;9892.307538472238;9905.306628536222;9953.552090156105;10278.383297002203;10462.738431539272;9983.550740216853;10076.798464030824;10425;10472.424016679155;10508.947455262674;7325.743598974011;7518.210587888193;7569.091708994735;7676.424268179797;7723.652435640297;8282.047564530156;8336.499810011419;8382.874256886029;8460.111688272642;8471.941007374078;7231.168415632059;7480.4015678746655;7484.288992545918;7490.850182996419;7716.498427602188;7306.853862922818;7445.292697193758;7449.5902725350625;7465.216152303929;7468.029156209658;6904.206016307988;6917.792466226021;6953.756618518328;6995.055667485028;7014.894776578458;4824.758762061812;4894.437139728977;4993.4756850530175;5010.599152067753;5127.384873764752;4979.551840334388;5036.496350365081;5078.542931136216;5128.487151284841;5283.339582552181 05:27:46 INFO - PROCESS | 6173 | |4;prototype.html;244.7479096530573;317.66327692645797;324.531052628951;325.1464904625358;327.29794590603154;5875.236219291486;5965.731542080606;6028.4574388305045;6092.634441933482;6138.386161383865;5311.442298558653;5487.957288115255;6034.24571928509;6059.969700151504;6092.969535152318;4511.819527218908;4539.9546004540025;4547.63618910488;4551.544845515455;4571.5428457154185;4158.792060396983;4346.543612920629;4386.311270160995;4523.403893904354;4556.863294101182;4192.014876504019;4452.265376212921;4492.707973981697;4503.909921801562;4511.72929624222;4507.391502147201;4524.502304746476;4529.705569137996;4535.977320113411;4547.24970379887;3268.5750852389274;3309.2791748290992;3551.3607550640872;3766.8681596144;3893.922121557553;5211.5049070338255;5602.887942241173;5693.77224911003;5729.942700573024;5757.309122905236;4745.95588970426;5049.2173713074535;5177.430482646906;5181.378234611833;5209.6874187548865;4866.51334866514;5235.55497782689;5559.722013899289;6407.16706828114;6415.65271293029;4134.4831896013;4143.937840932388;4163.937540936889;4175.749455032707;4202.432671589327;5577;6251.156093927352;6433.388828061326;6724.108633287684;6743.865122697519;3805.5052843130215;4018.9196216075516;4248.468941382327;4264.978675106605;4287.2711639021445;4341.869743907688;4356.542563030836;4369.737815731066;4386.956130438719;4403.251447253974;5133.9743301284;5136.768845401966;5142.794288228504;5158.968206358743;5180.922286165711;5342.759575819097;6177.1969643945995;6197.659128747962;6421.325760795143;6558.344165583403;1274.706817431996;1470.154661069889;1503.7894694742745;1510.23733014829;1511.8261399938929;847.2671139464319;960.2366118935323;972.5283237629744;989.6338354808623;1005.6379703306803;5303.443138470482;5954.493868021266;5967.37342579023;5978.671173085435;6095.963686173362;5380.300560927054;5881.705914704247;6082.178905847654;6556.704948277244;6703.765368212186;4854.490278520775;5287.867803304948;5430.864228394322;5610.7194640268635;6023.6385816851125;3096.383555895265;3409.215880347534;3477.4957631143343;3488.7906725596545;3499.685028347461;4817.735024573612;6943.27095654949;6956.269591692901;6960.965195173992;7113.7154513819905;5857.70711464425;6753;6964.512484126062;6977.267386924402;7028.92971070293;6565.96717016431;7037.8240543985785;7072.151341839012;7081.752138675121;7095.219525852152;6311.400416960381;6749.628770417477;6757.290484499057;6760.391564759196;6816.2842901496615;6524.804255872332;6696.799096027127;6715.932840671726;6749.730010799513;6754.358335958076;7001.824954376181;7055.223925368103;7059.505834591735;7093.1488221413765;7161.242921475374;3892.6691231245663;4337.240982828055;4357.346398040319;4368.170047690928;4469.374287599804;6367.936320636734;6411.294757576569;6741.528093033637;6750.561213521106;6785.89821152693;5893.5874488785375;6406.967965160145;6489.870202595827;6517.8696426072165;6556.967215163893;5107.897842043064;5551.861203469784;6034.758609655564;6478.902816457851;6553.4101930826455;5072.797088116434;6255.218097737783;6342.778002769881;6374.90437643445;6398.104265402754;5437.912417516433;6124.846878828065;6264.968675156777;6534.542582019213;6535.57518761279;4835.734034627989;5554.583406244628;5637.605367624227;6147.262328520606;6274.870523305849 05:27:46 INFO - PROCESS | 6173 | |5;yui.html;610.8045425463852;725.7822653204039;734.9485536012481;749.6251874062965;758.5031804168271;14705.191214483199;14838.406463741438;15018.924905375472;15019.924900375496;15264.771028434569;11695.824562631567;11924.7615047699;14043;14149.787753183711;14270.643233919158;711.7864640607797;890.3722875372879;899.0290486274807;923.3075193604797;926.6849271247775;883.0198479687574;904.8552231642939;912.2200518556638;924.3991405586355;926.9768255793591;825.529448214518;940.1538615246264;973.3964941736134;975.4050029482011;982.719924821426;930.2093220762332;972.4068318325816;972.9416235025922;973.2749101919115;974.6491263145333;716.2443621978811;718.48987219074;719.2843121094492;722.6170129831198;722.743426083738;12724.491020359175;15167.317470713844;15176.165310907896;15189.240537973168;15281.006734562217;12848.550300739429;12894.290814005226;12950.805737913844;12974.156679815782;13268.800967985488;8663.913360866374;10027.649032283907;10239.948800256025;10271;10287.177025837915;3067.5091985282247;3570.696490798259;3605.9098522536883;3643.5081264029545;3659.176685245825;84479;84859;87025.56487217586;87143.56428217882;87861.12138878657;8420.831583368421;9150.633974641072;9582.712518624452;9774.31579789408;9835.950820245853;22832.48293848943;22947;23003.88498057499;23007.88496057509;23044.96297666609;7610.885836712454;7620.809479762939;7655.655495502716;7714.228577142353;7735.265149810759;4047.352423612208;4099.057216840143;4099.938500922489;4103.076807718299;4111.773852438085;3662.6703596675893;3685.594584595692;3696.5564132303757;3704.018435114697;3718.4794128821986;651.4365074210774;654.2051407539861;656.5666660004374;666.2438132719399;674.1850307232949;496.13919849061847;500.7796569509404;518.4866981688101;552.6545908806995;562.6624025584698;7983.081945576333;8069.959650201711;8088;8198.467099638505;8230.960063238621;566.815784869919;566.9097461813038;586.865021045162;587.1075964533885;597.2951916738291;3878.3406820840523;3928.5285765707727;3934.5278566572197;3993.2412841560013;4097;75868.48263034818;78749.21250787418;78766.60616696879;78780;96836;65315.101367397634;67350.66324668346;67777;71407.92888106682;72542;39084.82745517582;41699;48758.75620621874;49474;64787;7999.560024198725;8050.597470126353;8060.476069055492;8268.214519620626;8272.875906861522;42467;42555.7233283002;43744.562554374046;44339;44480.33279500875;54818.725906370215;61895.76208475896;65137;65208.673956629915;65437.67281163564;10041.945595712345;10137.847932280874;10188.083072523508;10324.122449591869;10466.215033872339;11652.708682283012;11757.706057348634;11841.28952262867;11852.822207666719;12311.138220324492;9605.231581473325;11212.551497940318;11373.601923932954;11617;11639.243449175776;11080.778384432428;11126.165537584551;11155.274907131336;11237.71905702364;11535.711607209887;10957.780844383227;11038.337699738042;11172.273802202832;11181.664550063186;11411.714707132056;9269.814603708022;9756.85364719544;9914.603415863285;9920.305578609428;10146.289759717045;8989.730308090768;9530.35236018603;9611.951940240255;9673.22614190849;9835.114839664464 05:27:46 INFO - PROCESS | 6173 | __end_tp_report 05:27:46 INFO - PROCESS | 6173 | __start_cc_report 05:27:46 INFO - PROCESS | 6173 | _x_x_mozilla_cycle_collect,393 05:27:46 INFO - PROCESS | 6173 | __end_cc_report 05:27:46 INFO - PROCESS | 6173 | __startTimestamp1461587266071__endTimestamp 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | ------- Summary: start ------- 05:27:46 INFO - PROCESS | 6173 | Number of tests: 6 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | [#0] dojo.html Cycles:165 Average:5712.43 Median:5945.79 stddev:656.73 (11.0%) stddev-sans-first:615.05 05:27:46 INFO - PROCESS | 6173 | Values: 2709.6 3029.6 3426.1 3476.8 3477.8 5821.7 5826.2 5852.6 5855.0 5891.7 5699.9 5767.1 5819.4 5879.2 5910.9 5186.5 5231.8 5247.3 5278.2 5302.9 5301.5 5332.9 5352.0 5353.0 5394.6 4314.8 5005.8 5113.9 5200.1 5268.0 5161.2 5186.7 5195.4 5199.6 5228.3 5064.6 5180.5 5183.9 5194.9 5338.7 5285.9 5633.5 5692.9 5723.9 5782.5 6111.4 6147.7 6189.9 6193.5 6207.2 6160.0 6170.3 6183.7 6193.1 6261.5 5746.5 5830.9 5893.9 5910.4 5945.8 6168.2 6169.5 6170.7 6186.1 6187.1 6079.8 6089.5 6090.1 6102.2 6144.1 6062.3 6128.9 6139.6 6159.3 6193.8 6006.6 6121.0 6138.8 6170.6 6171.8 6131.2 6147.4 6178.6 6195.9 6197.6 4907.9 4941.8 4980.8 4993.7 5041.4 4406.4 4422.4 4449.6 4458.7 4467.4 5730.1 5822.2 5884.8 5894.3 5912.3 6114.2 6123.3 6159.6 6163.8 6211.8 5821.8 5822.9 5832.5 5851.2 5870.2 5365.6 5399.7 5403.6 5413.1 5417.7 5768.7 6017.7 6376.1 6386.9 6392.6 6151.4 6170.9 6193.3 6194.9 6240.2 6133.1 6260.4 6304.1 6309.7 6320.7 6133.6 6140.0 6183.5 6207.3 6208.3 4756.6 5132.6 5665.5 6150.4 6169.8 6082.5 6129.3 6144.5 6175.6 6189.8 4927.8 5850.6 6161.5 6167.8 6181.0 5940.8 6070.2 6081.2 6102.3 6176.6 5991.2 6117.2 6121.2 6125.8 6154.5 4981.5 6064.3 6084.5 6108.1 6112.6 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | [#1] ext.html Cycles:180 Average:66046.45 Median:36939.13 stddev:144430.99 (391.0%) stddev-sans-first:144752.31 05:27:46 INFO - PROCESS | 6173 | Values: 498.7 509.6 535.5 560.0 607.4 30073.9 38097.2 38247.6 38248.8 38447.0 39402.6 39787.6 39790.6 39882.0 39941.4 9388.3 9575.9 9615.9 9617.4 9650.8 8772.5 9230.9 9674.7 9675.8 9694.2 7936.7 8678.4 9704.2 9713.8 9750.2 9645.9 9695.6 9705.6 9733.2 9751.3 9537.5 9626.4 9658.3 9661.3 9664.6 37837.8 37887.4 37930.6 38389.8 38419.6 2737.8 3151.4 3233.5 3247.3 3452.7 26010.0 26047.7 26062.3 26452.5 26903.2 2633.5 2711.5 2734.7 2748.9 2767.6 362690.6 362860.0 363214.0 368064.0 368153.0 46680.1 52206.7 62204.8 62461.4 62656.0 66606.0 67478.6 67656.7 68478.7 68629.0 14393.6 17150.8 17185.7 17235.9 17242.6 11190.4 13054.7 13198.1 13212.7 13216.6 15883.0 19159.5 19236.8 19347.6 19439.8 7384.3 8130.8 8247.2 8261.3 8292.8 875.6 961.3 1050.4 1062.1 1114.9 26092.7 26951.0 29378.0 29727.9 30087.0 1071.8 1088.3 1139.5 1185.8 1214.7 14278.0 16081.5 16319.8 16494.9 16526.3 545381.0 625241.0 646968.0 647660.0 650422.7 50445.7 59063.7 59257.7 59778.7 59944.0 1458.8 1469.1 1471.9 1477.2 1483.0 29015.3 29317.6 29582.0 30109.5 30144.4 50840.2 51748.7 51840.0 51944.5 52005.0 576336.0 590241.0 596060.2 596979.0 599236.0 26077.5 26208.1 26270.6 26461.9 26463.3 43046.4 43688.6 43810.0 44063.8 44939.8 36286.6 36512.5 36661.3 37243.8 37559.4 35715.0 35752.6 36034.8 36925.6 36952.6 35502.6 35993.0 36236.6 36254.6 36562.8 31271.0 31987.4 32305.7 32380.0 32387.5 20083.0 23971.5 24334.3 24335.4 24603.9 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | [#2] jquery.html Cycles:180 Average:35137.22 Median:430.11 stddev:105939.72 (24630.9%) stddev-sans-first:106204.71 05:27:46 INFO - PROCESS | 6173 | Values: 355.5 384.9 398.4 401.8 408.8 18710.4 20169.0 20896.5 21010.7 21044.0 12073.7 12228.6 14797.8 19862.7 20433.3 5043.0 5314.8 5456.2 5475.0 5520.9 4157.3 4253.7 4964.1 5163.6 5403.3 5337.0 5342.5 5346.0 5416.1 5442.3 5458.5 5956.7 5988.6 6008.9 6025.6 5310.3 5311.0 5333.2 5346.6 5348.9 12979.4 13190.7 13204.3 13221.1 16635.6 1970.5 1986.2 2138.8 2258.8 2340.9 9193.9 9368.1 9723.7 9900.9 9935.8 1667.7 1679.9 1730.7 1748.8 1762.9 71492.6 108444.0 109071.0 116323.4 125391.0 11237.8 11618.7 11678.8 11784.2 11977.1 14861.9 15057.8 15110.4 15196.5 15209.2 7283.7 8693.5 8798.5 8877.6 8926.6 8740.3 8746.5 8751.9 8777.2 8863.6 4584.4 4688.4 4694.5 4696.6 4725.2 1970.9 1979.3 2013.8 2016.7 2048.8 388.0 398.6 426.8 809.1 911.3 11510.0 11881.2 12018.9 12043.0 12044.8 433.4 452.4 454.4 455.6 464.1 6036.6 6085.1 6111.4 6178.7 6211.2 590179.0 610235.0 653277.0 653619.7 655594.0 146625.3 147650.3 147768.0 151196.5 151211.2 461.0 467.3 990.3 1065.0 1075.2 18207.4 18223.6 18279.5 18285.2 18392.8 43768.0 43991.0 45309.8 46871.5 53670.0 78575.0 78602.8 80323.2 81866.2 82605.0 8010.3 8015.8 8103.7 8360.2 8546.7 7946.8 9992.8 11884.3 12239.4 12456.8 10618.3 10653.7 10958.7 11162.0 11288.9 8350.6 9525.6 10742.8 11245.0 11273.6 11288.4 11424.5 11497.8 11536.9 11592.4 8000.5 8080.5 8344.6 8351.3 8430.8 9315.0 10286.2 11112.2 11162.8 11326.9 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | [#3] mootools.html Cycles:180 Average:5710.47 Median:5019.47 stddev:3167.39 (63.1%) stddev-sans-first:3159.12 05:27:46 INFO - PROCESS | 6173 | Values: 1325.3 1601.7 1799.7 1938.4 1951.5 8053.5 8668.3 8740.8 8918.3 8925.2 8756.2 8802.6 8891.8 8942.8 8993.0 2468.9 2492.1 2495.8 2503.6 2505.9 2434.8 2482.8 2483.3 2485.6 2494.6 2471.3 2474.6 2491.2 2494.6 2499.6 2437.8 2442.6 2450.3 2453.7 2467.2 2422.9 2432.0 2434.6 2444.7 2450.4 8792.3 8914.7 8930.2 9029.0 9066.7 5213.9 5412.5 5420.4 5434.8 5448.4 2982.3 3417.7 3435.0 3542.5 3558.2 980.1 1004.0 1014.0 1017.2 1027.8 9782.5 11474.0 11556.2 11589.7 11592.0 4146.0 4727.7 4788.7 4808.6 4908.4 9802.0 9868.0 9894.7 9902.8 9973.0 5397.6 5417.3 5424.1 5429.9 5463.9 4415.4 4833.7 4965.3 5028.3 5034.6 4069.8 4081.1 4113.6 4151.9 4154.5 1252.7 1333.7 1357.5 1388.2 1396.1 844.9 894.9 929.2 936.9 943.8 5000.0 5954.3 6013.5 6044.8 6122.3 460.2 468.8 474.9 475.4 484.3 3903.5 3971.9 3998.7 4054.4 4056.6 9367.7 10454.7 10922.3 10977.0 10983.8 8748.6 8968.8 10713.9 10726.2 10867.9 6526.6 8139.8 8254.9 8324.5 8397.2 4665.4 6003.6 6004.0 6111.1 6117.5 9892.3 9905.3 9953.6 10278.4 10462.7 9983.6 10076.8 10425.0 10472.4 10508.9 7325.7 7518.2 7569.1 7676.4 7723.7 8282.0 8336.5 8382.9 8460.1 8471.9 7231.2 7480.4 7484.3 7490.9 7716.5 7306.9 7445.3 7449.6 7465.2 7468.0 6904.2 6917.8 6953.8 6995.1 7014.9 4824.8 4894.4 4993.5 5010.6 5127.4 4979.6 5036.5 5078.5 5128.5 5283.3 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | [#4] prototype.html Cycles:180 Average:5148.14 Median:5589.94 stddev:1650.60 (29.5%) stddev-sans-first:1613.68 05:27:46 INFO - PROCESS | 6173 | Values: 244.7 317.7 324.5 325.1 327.3 5875.2 5965.7 6028.5 6092.6 6138.4 5311.4 5488.0 6034.2 6060.0 6093.0 4511.8 4540.0 4547.6 4551.5 4571.5 4158.8 4346.5 4386.3 4523.4 4556.9 4192.0 4452.3 4492.7 4503.9 4511.7 4507.4 4524.5 4529.7 4536.0 4547.2 3268.6 3309.3 3551.4 3766.9 3893.9 5211.5 5602.9 5693.8 5729.9 5757.3 4746.0 5049.2 5177.4 5181.4 5209.7 4866.5 5235.6 5559.7 6407.2 6415.7 4134.5 4143.9 4163.9 4175.7 4202.4 5577.0 6251.2 6433.4 6724.1 6743.9 3805.5 4018.9 4248.5 4265.0 4287.3 4341.9 4356.5 4369.7 4387.0 4403.3 5134.0 5136.8 5142.8 5159.0 5180.9 5342.8 6177.2 6197.7 6421.3 6558.3 1274.7 1470.2 1503.8 1510.2 1511.8 847.3 960.2 972.5 989.6 1005.6 5303.4 5954.5 5967.4 5978.7 6096.0 5380.3 5881.7 6082.2 6556.7 6703.8 4854.5 5287.9 5430.9 5610.7 6023.6 3096.4 3409.2 3477.5 3488.8 3499.7 4817.7 6943.3 6956.3 6961.0 7113.7 5857.7 6753.0 6964.5 6977.3 7028.9 6566.0 7037.8 7072.2 7081.8 7095.2 6311.4 6749.6 6757.3 6760.4 6816.3 6524.8 6696.8 6715.9 6749.7 6754.4 7001.8 7055.2 7059.5 7093.1 7161.2 3892.7 4337.2 4357.3 4368.2 4469.4 6367.9 6411.3 6741.5 6750.6 6785.9 5893.6 6407.0 6489.9 6517.9 6557.0 5107.9 5551.9 6034.8 6478.9 6553.4 5072.8 6255.2 6342.8 6374.9 6398.1 5437.9 6124.8 6265.0 6534.5 6535.6 4835.7 5554.6 5637.6 6147.3 6274.9 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - PROCESS | 6173 | [#5] yui.html Cycles:180 Average:16966.78 Median:576.89 stddev:23289.83 (4037.2%) stddev-sans-first:23322.78 05:27:46 INFO - PROCESS | 6173 | Values: 610.8 725.8 734.9 749.6 758.5 14705.2 14838.4 15018.9 15019.9 15264.8 11695.8 11924.8 14043.0 14149.8 14270.6 711.8 890.4 899.0 923.3 926.7 883.0 904.9 912.2 924.4 927.0 825.5 940.2 973.4 975.4 982.7 930.2 972.4 972.9 973.3 974.6 716.2 718.5 719.3 722.6 722.7 12724.5 15167.3 15176.2 15189.2 15281.0 12848.6 12894.3 12950.8 12974.2 13268.8 8663.9 10027.6 10239.9 10271.0 10287.2 3067.5 3570.7 3605.9 3643.5 3659.2 84479.0 84859.0 87025.6 87143.6 87861.1 8420.8 9150.6 9582.7 9774.3 9836.0 22832.5 22947.0 23003.9 23007.9 23045.0 7610.9 7620.8 7655.7 7714.2 7735.3 4047.4 4099.1 4099.9 4103.1 4111.8 3662.7 3685.6 3696.6 3704.0 3718.5 651.4 654.2 656.6 666.2 674.2 496.1 500.8 518.5 552.7 562.7 7983.1 8070.0 8088.0 8198.5 8231.0 566.8 566.9 586.9 587.1 597.3 3878.3 3928.5 3934.5 3993.2 4097.0 75868.5 78749.2 78766.6 78780.0 96836.0 65315.1 67350.7 67777.0 71407.9 72542.0 39084.8 41699.0 48758.8 49474.0 64787.0 7999.6 8050.6 8060.5 8268.2 8272.9 42467.0 42555.7 43744.6 44339.0 44480.3 54818.7 61895.8 65137.0 65208.7 65437.7 10041.9 10137.8 10188.1 10324.1 10466.2 11652.7 11757.7 11841.3 11852.8 12311.1 9605.2 11212.6 11373.6 11617.0 11639.2 11080.8 11126.2 11155.3 11237.7 11535.7 10957.8 11038.3 11172.3 11181.7 11411.7 9269.8 9756.9 9914.6 9920.3 10146.3 8989.7 9530.4 9612.0 9673.2 9835.1 05:27:46 INFO - PROCESS | 6173 | -------- Summary: end -------- 05:27:46 INFO - PROCESS | 6173 | 05:27:46 INFO - TEST-INFO | 6173: exit 0 05:27:46 INFO - TEST-OK | dromaeo_css | took 1111982ms 05:27:46 INFO - TEST-START | kraken 05:27:46 INFO - operating with platform_type : mac_ 05:27:46 INFO - Initialising browser for kraken test... 05:27:46 INFO - TEST-INFO | started process 6179 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpjCcq3q/profile http://localhost:56615/getInfo.html) 05:27:49 INFO - PROCESS | 6179 | __metrics Screen width/height:1600/1200 05:27:49 INFO - PROCESS | 6179 | colorDepth:24 05:27:49 INFO - PROCESS | 6179 | Browser inner width/height: 1024/689 05:27:49 INFO - PROCESS | 6179 | __metrics 05:27:49 ERROR - PROCESS | 6179 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:27:50 INFO - TEST-INFO | 6179: exit 0 05:27:50 INFO - Browser initialized. 05:27:50 INFO - Running cycle 1/1 for kraken test... 05:27:50 INFO - TEST-INFO | started process 6182 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpjCcq3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:02 INFO - PROCESS | 6182 | RSS: Main: 248008704 05:28:02 INFO - PROCESS | 6182 | 05:28:05 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56615/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:06 INFO - PROCESS | 6182 | RSS: Main: 260333568 05:28:06 INFO - PROCESS | 6182 | 05:28:08 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56615/tests/kraken/driver.html?testName=audio-dft) 05:28:09 INFO - PROCESS | 6182 | RSS: Main: 269312000 05:28:09 INFO - PROCESS | 6182 | 05:28:12 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56615/tests/kraken/driver.html?testName=audio-fft) 05:28:13 INFO - PROCESS | 6182 | RSS: Main: 272355328 05:28:13 INFO - PROCESS | 6182 | 05:28:15 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56615/tests/kraken/driver.html?testName=audio-oscillator) 05:28:16 INFO - PROCESS | 6182 | RSS: Main: 273199104 05:28:16 INFO - PROCESS | 6182 | 05:28:18 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:19 INFO - PROCESS | 6182 | RSS: Main: 273711104 05:28:19 INFO - PROCESS | 6182 | 05:28:22 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56615/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:22 INFO - PROCESS | 6182 | RSS: Main: 275640320 05:28:22 INFO - PROCESS | 6182 | 05:28:25 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56615/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:26 INFO - PROCESS | 6182 | RSS: Main: 275791872 05:28:26 INFO - PROCESS | 6182 | 05:28:29 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56615/tests/kraken/driver.html?testName=json-parse-financial) 05:28:30 INFO - PROCESS | 6182 | RSS: Main: 275922944 05:28:30 INFO - PROCESS | 6182 | 05:28:31 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:32 INFO - PROCESS | 6182 | RSS: Main: 276385792 05:28:32 INFO - PROCESS | 6182 | 05:28:34 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:34 INFO - PROCESS | 6182 | RSS: Main: 275247104 05:28:34 INFO - PROCESS | 6182 | 05:28:37 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:37 INFO - PROCESS | 6182 | RSS: Main: 275562496 05:28:37 INFO - PROCESS | 6182 | 05:28:40 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:41 INFO - PROCESS | 6182 | RSS: Main: 275513344 05:28:41 INFO - PROCESS | 6182 | 05:28:44 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:44 INFO - PROCESS | 6182 | RSS: Main: 275529728 05:28:44 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | Cycle 1(1): loaded http://localhost:56615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56615/tests/kraken/driver.html?testName=ai-astar) 05:28:46 INFO - PROCESS | 6182 | RSS: Main: 277254144 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | __start_tp_report 05:28:46 INFO - PROCESS | 6182 | _x_x_mozilla_page_load 05:28:46 INFO - PROCESS | 6182 | _x_x_mozilla_page_load_details 05:28:46 INFO - PROCESS | 6182 | |i|pagename|runs| 05:28:46 INFO - PROCESS | 6182 | |0;ai-astar;134;152;167;123;121;182;166;116;120;119 05:28:46 INFO - PROCESS | 6182 | |1;audio-beat-detection;152;125;147;168;120;144;121;155;162;123 05:28:46 INFO - PROCESS | 6182 | |2;audio-dft;196;200;205;257;234;246;273;204;196;200 05:28:46 INFO - PROCESS | 6182 | |3;audio-fft;65;75;77;147;75;81;85;56;160;47 05:28:46 INFO - PROCESS | 6182 | |4;audio-oscillator;90;105;125;112;69;101;159;114;115;151 05:28:46 INFO - PROCESS | 6182 | |5;imaging-gaussian-blur;134;127;90;96;130;113;92;88;91;109 05:28:46 INFO - PROCESS | 6182 | |6;imaging-darkroom;95;121;148;95;98;98;96;95;115;150 05:28:46 INFO - PROCESS | 6182 | |7;imaging-desaturate;91;91;89;91;92;90;78;154;144;118 05:28:46 INFO - PROCESS | 6182 | |8;json-parse-financial;62;61;62;61;61;63;62;76;62;62 05:28:46 INFO - PROCESS | 6182 | |9;json-stringify-tinderbox;65;68;69;74;103;111;104;101;99;69 05:28:46 INFO - PROCESS | 6182 | |10;stanford-crypto-aes;84;82;86;82;84;86;84;86;87;88 05:28:46 INFO - PROCESS | 6182 | |11;stanford-crypto-ccm;143;140;138;143;149;142;131;164;199;226 05:28:46 INFO - PROCESS | 6182 | |12;stanford-crypto-pbkdf2;174;175;177;172;175;173;172;173;170;171 05:28:46 INFO - PROCESS | 6182 | |13;stanford-crypto-sha256-iterative;69;72;72;69;75;96;72;60;95;77 05:28:46 INFO - PROCESS | 6182 | __end_tp_report 05:28:46 INFO - PROCESS | 6182 | __start_cc_report 05:28:46 INFO - PROCESS | 6182 | _x_x_mozilla_cycle_collect,1011 05:28:46 INFO - PROCESS | 6182 | __end_cc_report 05:28:46 INFO - PROCESS | 6182 | __startTimestamp1461587326881__endTimestamp 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | ------- Summary: start ------- 05:28:46 INFO - PROCESS | 6182 | Number of tests: 14 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#0] ai-astar Cycles:10 Average:140.00 Median:143.00 stddev:24.53 (17.2%) stddev-sans-first:25.92 05:28:46 INFO - PROCESS | 6182 | Values: 134.0 152.0 167.0 123.0 121.0 182.0 166.0 116.0 120.0 119.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:149.50 stddev:18.10 (12.1%) stddev-sans-first:18.81 05:28:46 INFO - PROCESS | 6182 | Values: 152.0 125.0 147.0 168.0 120.0 144.0 121.0 155.0 162.0 123.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#2] audio-dft Cycles:10 Average:221.10 Median:219.50 stddev:28.81 (13.1%) stddev-sans-first:29.09 05:28:46 INFO - PROCESS | 6182 | Values: 196.0 200.0 205.0 257.0 234.0 246.0 273.0 204.0 196.0 200.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#3] audio-fft Cycles:10 Average:86.80 Median:75.00 stddev:37.12 (49.5%) stddev-sans-first:38.53 05:28:46 INFO - PROCESS | 6182 | Values: 65.0 75.0 77.0 147.0 75.0 81.0 85.0 56.0 160.0 47.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#4] audio-oscillator Cycles:10 Average:114.10 Median:138.00 stddev:26.61 (19.3%) stddev-sans-first:26.75 05:28:46 INFO - PROCESS | 6182 | Values: 90.0 105.0 125.0 112.0 69.0 101.0 159.0 114.0 115.0 151.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#5] imaging-gaussian-blur Cycles:10 Average:107.00 Median:89.00 stddev:18.10 (20.3%) stddev-sans-first:16.36 05:28:46 INFO - PROCESS | 6182 | Values: 134.0 127.0 90.0 96.0 130.0 113.0 92.0 88.0 91.0 109.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#6] imaging-darkroom Cycles:10 Average:111.10 Median:95.00 stddev:21.95 (23.1%) stddev-sans-first:22.50 05:28:46 INFO - PROCESS | 6182 | Values: 95.0 121.0 148.0 95.0 98.0 98.0 96.0 95.0 115.0 150.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:90.50 stddev:25.91 (28.6%) stddev-sans-first:27.07 05:28:46 INFO - PROCESS | 6182 | Values: 91.0 91.0 89.0 91.0 92.0 90.0 78.0 154.0 144.0 118.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:62.00 stddev:4.54 (7.3%) stddev-sans-first:4.80 05:28:46 INFO - PROCESS | 6182 | Values: 62.0 61.0 62.0 61.0 61.0 63.0 62.0 76.0 62.0 62.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#9] json-stringify-tinderbox Cycles:10 Average:86.30 Median:68.50 stddev:18.61 (27.2%) stddev-sans-first:18.08 05:28:46 INFO - PROCESS | 6182 | Values: 65.0 68.0 69.0 74.0 103.0 111.0 104.0 101.0 99.0 69.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:86.00 stddev:2.02 (2.4%) stddev-sans-first:2.12 05:28:46 INFO - PROCESS | 6182 | Values: 84.0 82.0 86.0 82.0 84.0 86.0 84.0 86.0 87.0 88.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:146.00 stddev:30.87 (21.1%) stddev-sans-first:32.30 05:28:46 INFO - PROCESS | 6182 | Values: 143.0 140.0 138.0 143.0 149.0 142.0 131.0 164.0 199.0 226.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:173.50 stddev:2.10 (1.2%) stddev-sans-first:2.20 05:28:46 INFO - PROCESS | 6182 | Values: 174.0 175.0 177.0 172.0 175.0 173.0 172.0 173.0 170.0 171.0 05:28:46 INFO - PROCESS | 6182 | 05:28:46 INFO - PROCESS | 6182 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:73.50 stddev:11.37 (15.5%) stddev-sans-first:11.80 05:28:46 INFO - PROCESS | 6182 | Values: 69.0 72.0 72.0 69.0 75.0 96.0 72.0 60.0 95.0 77.0 05:28:46 INFO - PROCESS | 6182 | -------- Summary: end -------- 05:28:46 INFO - PROCESS | 6182 | 05:28:47 INFO - TEST-INFO | 6182: exit 0 05:28:47 INFO - TEST-OK | kraken | took 61006ms 05:28:47 INFO - SUITE-END | took 1172s 05:28:48 INFO - Completed test suite (00:19:33) 05:28:48 INFO - javascript benchmark 05:28:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2709.5800150976597, 3029.575859379686, 3426.0749597608647, 3476.7566270361067, 3477.7565570410084, 5821.708914554271, 5826.213461182739, 5852.619579727315, 5855.0, 5891.675957822318, 5699.886002279952, 5767.10609855472, 5819.359870414251, 5879.17691523186, 5910.9113363299475, 5186.533212010918, 5231.764570594313, 5247.291615631879, 5278.181881808307, 5302.946970530284, 5301.496357845998, 5332.946670533283, 5352.036633405985, 5352.973235133819, 5394.568434525248, 4314.813426307759, 5005.799768009275, 5113.897722045538, 5200.089984252779, 5268.0, 5161.225816127573, 5186.688798672092, 5195.376554813409, 5199.6360254782185, 5228.320318358627, 5064.620153488466, 5180.456052114511, 5183.896322073538, 5194.896102077975, 5338.706371149585, 5285.947140528622, 5633.492985631272, 5692.857678558028, 5723.885522289531, 5782.479576838105, 6111.419415155598, 6147.661878596676, 6189.876202475925, 6193.535484838655, 6207.193064901579, 6160.0, 6170.259568851721, 6183.690815459209, 6193.071039344134, 6261.530385221081, 5746.454086861741, 5830.854228644275, 5893.882122357529, 5910.379410161957, 5945.791897283661, 6168.19813424252, 6169.475594574512, 6170.660613666291, 6186.10301506279, 6187.133801267826, 6079.756809727562, 6089.543284253698, 6090.086487026982, 6102.176206212193, 6144.109104179869, 6062.333143354227, 6128.900367973393, 6139.614800607318, 6159.260888693386, 6193.84515387119, 6006.63960162383, 6121.0, 6138.754449821957, 6170.598911070766, 6171.814845554641, 6131.202943617302, 6147.354527774609, 6178.62928224308, 6195.876082478325, 6197.628142311386, 4907.9263811042865, 4941.802327906916, 4980.750962451935, 4993.675411098267, 5041.395032596039, 4406.361077643788, 4422.380866678667, 4449.555044495589, 4458.687891847604, 4467.374567560544, 5730.140478928194, 5822.155787410802, 5884.823455296348, 5894.32215295238, 5912.290525137011, 6114.206128133723, 6123.313546946588, 6159.630422174684, 6163.8150855474405, 6211.844703882349, 5821.79623713168, 5822.912656310159, 5832.533397328203, 5851.1515830205235, 5870.207521984563, 5365.570754339644, 5399.70301633414, 5403.594730395236, 5413.052715774724, 5417.674939503642, 5768.682722450221, 6017.729202185912, 6376.107344971615, 6386.904196437057, 6392.648404337806, 6151.446369826737, 6170.938290617037, 6193.287771906108, 6194.946859033885, 6240.157578726814, 6133.089845874549, 6260.436560709558, 6304.117423560797, 6309.684515774285, 6320.683965801783, 6133.610107582747, 6140.0, 6183.474404675653, 6207.317195108625, 6208.317085120543, 4756.571908528249, 5132.6150538709, 5665.546756259571, 6150.446459818638, 6169.784057557964, 6082.513398927987, 6129.297663865929, 6144.477719393902, 6175.5677102602385, 6189.7929903668355, 4927.841957140141, 5850.561207909339, 6161.537884658579, 6167.784127555514, 6181.041938499539, 5940.79207227745, 6070.150178974859, 6081.179040829431, 6102.298235702951, 6176.629402235881, 5991.191189189578, 6117.248930028793, 6121.178620692955, 6125.754969801158, 6154.476869465966, 4981.4769449207315, 6064.3026052002815, 6084.543659225487, 6108.053251745987, 6112.633242005494], "value": 5670.035748092306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.72071639881693, 509.60760214634723, 535.4859335038363, 560.011579562073, 607.3683369295933, 30073.947411840563, 38097.23805523888, 38247.61752382475, 38248.80875595622, 38447.0, 39402.605973940255, 39787.60212397875, 39790.602093979054, 39882.00294992627, 39941.400878986766, 9388.295877809174, 9575.90424095757, 9615.855762163574, 9617.374870633386, 9650.758731031745, 8772.517511536864, 9230.861537076915, 9674.661386851461, 9675.806483870318, 9694.17599504043, 7936.6825326986855, 8678.435901666404, 9704.22366210705, 9713.805723885518, 9750.171235444996, 9645.903540964606, 9695.563699633534, 9705.563249653747, 9733.17268032218, 9751.317407781458, 9537.47543885086, 9626.37428567148, 9658.275629327829, 9661.323707340489, 9664.613415463373, 37837.810810946045, 37887.431688524695, 37930.62069379298, 38389.808050959844, 38419.61580384188, 2737.7536021758137, 3151.43274210642, 3233.4503134467195, 3247.301830106515, 3452.654734526552, 26010.0, 26047.739522604912, 26062.34844128912, 26452.47095058107, 26903.192904212905, 2633.499635069331, 2711.457708458316, 2734.740199681027, 2748.8900443982216, 2767.5848622706553, 362690.6116571841, 362860.0, 363214.0, 368064.0, 368153.0, 46680.066398671835, 52206.738966304925, 62204.75590488256, 62461.375386246465, 62656.0, 66606.00090998638, 67478.61389009698, 67656.66171669209, 68478.65760671165, 68629.0, 14393.640158995899, 17150.828491715172, 17185.656286874193, 17235.91382043082, 17242.568935776704, 11190.440477976068, 13054.738905222031, 13198.14212076212, 13212.669683257804, 13216.603501894959, 15883.0, 19159.52101197481, 19236.84578925269, 19347.613047738967, 19439.80560194408, 7384.2984916433925, 8130.83738325242, 8247.21651443112, 8261.297789687824, 8292.834143317099, 875.5578432891476, 961.3030552849128, 1050.4327663062013, 1062.1396668698378, 1114.9498272577591, 26092.73907260941, 26951.0, 29378.0, 29727.851360743058, 30087.0, 1071.8338657508098, 1088.298047759191, 1139.5498777982816, 1185.8458400407892, 1214.6881368122406, 14278.0, 16081.52662603666, 16319.755203671955, 16494.917525412297, 16526.338946442007, 545381.0, 625241.0, 646968.0, 647660.0, 650422.747886267, 50445.74777126091, 59063.704681477175, 59257.70371148117, 59778.70110649419, 59944.0, 1458.795768592398, 1469.1111877314286, 1471.933762980647, 1477.224457159978, 1482.9925850370894, 29015.274618134714, 29317.560236596895, 29582.0, 30109.548356775103, 30144.3971120572, 50840.23739643982, 51748.74125629348, 51840.0, 51944.480555193964, 52004.95990080101, 576336.0, 590241.0, 596060.2166880863, 596979.0, 599236.0, 26077.478450431263, 26208.08271710481, 26270.60594091052, 26461.867690661424, 26463.33841653974, 43046.35430468608, 43688.56311436845, 43810.0, 44063.77968110139, 44939.775301123285, 36286.63713362938, 36512.452313214795, 36661.266774663825, 37243.81378093092, 37559.43660845144, 35715.0, 35752.64247357493, 36034.819825900704, 36925.63074369222, 36952.63047369492, 35502.644973549934, 35993.0, 36236.63763362438, 36254.63745362618, 36562.8171859139, 31271.0, 31987.360252794348, 32305.676943231207, 32380.028599142064, 32387.51418728768, 20083.0, 23971.520569588858, 24334.26997190087, 24335.391615209053, 24603.876980614983], "value": 19447.630939716477, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.48277256591655, 384.90185002824273, 398.4382021349897, 401.78303715993366, 408.83033541080454, 18710.43868683938, 20168.991550422455, 20896.47758806027, 21010.684839727397, 21044.0, 12073.698157546065, 12228.633141005785, 14797.778033329509, 19862.70205946912, 20433.284835030776, 5043.016611760708, 5314.813981510648, 5456.208849716789, 5474.972625136868, 5520.91718624221, 4157.293260145782, 4253.723507971988, 4964.056829202458, 5163.561097306715, 5403.2705584745945, 5337.0, 5342.465753424646, 5345.973270133663, 5416.1063424534905, 5442.346918369782, 5458.536024437927, 5956.7319470623925, 5988.550858685594, 6008.939910600903, 6025.6083354581815, 5310.336207974004, 5310.9734451327495, 5333.226682131108, 5346.572274218053, 5348.893022139536, 12979.41592628334, 13190.73618527624, 13204.273764942924, 13221.140625859289, 16635.584110397216, 1970.5369238229005, 1986.1558837494151, 2138.786121387864, 2258.830587705929, 2340.941476463085, 9193.908060919372, 9368.110029547182, 9723.708288751348, 9900.90099099007, 9935.80128397428, 1667.749837524369, 1679.9496015119566, 1730.7403889416562, 1748.8076311605714, 1762.903040332794, 71492.6425367875, 108444.0, 109071.0, 116323.41838290755, 125391.0, 11237.775244495064, 11618.6514404568, 11678.824817627572, 11784.234024788533, 11977.101717371232, 14861.92569037148, 15057.849421505864, 15110.39558417673, 15196.544103676908, 15209.239538023054, 7283.672234749449, 8693.521856297964, 8798.516081615573, 8877.556122193864, 8926.642934282685, 8740.257078148428, 8746.51894145828, 8751.868721969175, 8777.210051095431, 8863.601137948808, 4584.358189853423, 4688.437387513521, 4694.530546945278, 4696.553827386393, 4725.1730947084125, 1970.9014549272479, 1979.2874565156533, 2013.8288245499004, 2016.7277417548737, 2048.8258498027535, 387.98836034919, 398.62330098057635, 426.8015372851639, 809.114020147937, 911.293747345799, 11510.0, 11881.168318217642, 12018.879811201776, 12042.976347010426, 12044.759104817855, 433.41488989864064, 452.38475673084577, 454.3752340531769, 455.6332152617175, 464.0903828496118, 6036.63780173191, 6085.148079268906, 6111.449969502677, 6178.7219575119225, 6211.192544969125, 590179.0, 610235.0, 653277.0, 653619.7319013374, 655594.0, 146625.26687366495, 147650.26174869057, 147768.0, 151196.48803512045, 151211.22481611778, 460.9746463944515, 467.2547287077107, 990.2869933647762, 1064.973375665599, 1075.1506310015156, 18207.362742303954, 18223.635527289644, 18279.451616451526, 18285.17716702725, 18392.804467709557, 43768.0, 43991.0, 45309.77345113253, 46871.53128468672, 53670.0, 78575.0, 78602.82095768682, 80323.19676803157, 81866.18133818585, 82605.0, 8010.279074883289, 8015.799605009922, 8103.6758529658155, 8360.163983601591, 8546.658133674584, 7946.801329966797, 9992.750906136733, 11884.34636095023, 12239.449224784728, 12456.75086498283, 10618.256722029384, 10653.733656658645, 10958.726031849268, 11162.034520419498, 11288.887111128784, 8350.624221909908, 9525.618975240914, 10742.785144297226, 11245.0, 11273.605423810128, 11288.379139147426, 11424.543018279508, 11497.827532587185, 11536.903994120881, 11592.362420066976, 8000.51996880189, 8080.515169089874, 8344.624491897757, 8351.33189344863, 8430.831383372175, 9314.95342523283, 10286.228532859916, 11112.222144450134, 11162.832557511481, 11326.94336528345], "value": 8553.400716059614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1325.2777236406157, 1601.7437210046387, 1799.6670615936052, 1938.4087853204767, 1951.541387773872, 8053.516788992664, 8668.34987375947, 8740.825183496327, 8918.286537077034, 8925.152110549496, 8756.211940925316, 8802.559872006406, 8891.777705557364, 8942.776430589238, 8992.955035224815, 2468.8642124683092, 2492.0903870087377, 2495.8128140389454, 2503.5618766715843, 2505.949881002379, 2434.8417352872093, 2482.7517248275117, 2483.341914392687, 2485.6023036314195, 2494.5634513960076, 2471.258622413278, 2474.6411770293385, 2491.215267190838, 2494.638277449769, 2499.6250562415603, 2437.8171637127107, 2442.6091825307954, 2450.2894160693377, 2453.681021467207, 2467.1858286765323, 2422.854628722265, 2431.978569001024, 2434.5982912819363, 2444.669969554105, 2450.362905644545, 8792.252658524034, 8914.687985920462, 8930.151635594673, 9028.954855225682, 9066.727998160066, 5213.895722085575, 5412.4587541245955, 5420.376656684492, 5434.75543600535, 5448.400675925645, 2982.3438843454405, 3417.726581873444, 3434.9656503434894, 3542.5394698689265, 3558.1994051338243, 980.1423754215061, 1004.0411407106196, 1014.0, 1017.1862509992051, 1027.7790275090892, 9782.51087445625, 11473.967342939175, 11556.191066625339, 11589.710257243552, 11592.0, 4145.97927010363, 4727.739974301447, 4788.715757975416, 4808.63935204861, 4908.386451693538, 9802.0, 9868.013198680219, 9894.653687120915, 9902.80194396108, 9973.0, 5397.569644044332, 5417.26866872975, 5424.077906755861, 5429.945700543023, 5463.890722185613, 4415.403920470695, 4833.685810422382, 4965.329680493087, 5028.346314979102, 5034.572061374751, 4069.7761623110423, 4081.1098411697544, 4113.629773320416, 4151.937720934188, 4154.543000269968, 1252.7181384188666, 1333.7063048842608, 1357.511295933463, 1388.208721029024, 1396.1343966740685, 844.911284315138, 894.9284057275403, 929.2473096791621, 936.8641546975787, 943.8253923024263, 4999.950000500021, 5954.345022047572, 6013.51891848651, 6044.818655440344, 6122.2959359674205, 460.2474953451131, 468.8265341823547, 474.9026449577828, 475.38200339559125, 484.3340406940457, 3903.4730311407598, 3971.900702482461, 3998.660113890294, 4054.412110243998, 4056.6146216109423, 9367.718968430958, 10454.68635940923, 10922.344659320466, 10977.0, 10983.835242471368, 8748.562571871382, 8968.775780605407, 10713.946430267799, 10726.249162558546, 10867.891321086847, 6526.641034743135, 8139.755807325908, 8254.917450825535, 8324.458910170819, 8397.244248017707, 4665.393498845128, 6003.5797494174985, 6003.958654057641, 6111.113888486234, 6117.541184411276, 9892.307538472238, 9905.306628536222, 9953.552090156105, 10278.383297002203, 10462.738431539272, 9983.550740216853, 10076.798464030824, 10425.0, 10472.424016679155, 10508.947455262674, 7325.743598974011, 7518.210587888193, 7569.091708994735, 7676.424268179797, 7723.652435640297, 8282.047564530156, 8336.499810011419, 8382.874256886029, 8460.111688272642, 8471.941007374078, 7231.168415632059, 7480.4015678746655, 7484.288992545918, 7490.850182996419, 7716.498427602188, 7306.853862922818, 7445.292697193758, 7449.5902725350625, 7465.216152303929, 7468.029156209658, 6904.206016307988, 6917.792466226021, 6953.756618518328, 6995.055667485028, 7014.894776578458, 4824.758762061812, 4894.437139728977, 4993.4756850530175, 5010.599152067753, 5127.384873764752, 4979.551840334388, 5036.496350365081, 5078.542931136216, 5128.487151284841, 5283.339582552181], "value": 4546.382651470547, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [244.7479096530573, 317.66327692645797, 324.531052628951, 325.1464904625358, 327.29794590603154, 5875.236219291486, 5965.731542080606, 6028.4574388305045, 6092.634441933482, 6138.386161383865, 5311.442298558653, 5487.957288115255, 6034.24571928509, 6059.969700151504, 6092.969535152318, 4511.819527218908, 4539.9546004540025, 4547.63618910488, 4551.544845515455, 4571.5428457154185, 4158.792060396983, 4346.543612920629, 4386.311270160995, 4523.403893904354, 4556.863294101182, 4192.014876504019, 4452.265376212921, 4492.707973981697, 4503.909921801562, 4511.72929624222, 4507.391502147201, 4524.502304746476, 4529.705569137996, 4535.977320113411, 4547.24970379887, 3268.5750852389274, 3309.2791748290992, 3551.3607550640872, 3766.8681596144, 3893.922121557553, 5211.5049070338255, 5602.887942241173, 5693.77224911003, 5729.942700573024, 5757.309122905236, 4745.95588970426, 5049.2173713074535, 5177.430482646906, 5181.378234611833, 5209.6874187548865, 4866.51334866514, 5235.55497782689, 5559.722013899289, 6407.16706828114, 6415.65271293029, 4134.4831896013, 4143.937840932388, 4163.937540936889, 4175.749455032707, 4202.432671589327, 5577.0, 6251.156093927352, 6433.388828061326, 6724.108633287684, 6743.865122697519, 3805.5052843130215, 4018.9196216075516, 4248.468941382327, 4264.978675106605, 4287.2711639021445, 4341.869743907688, 4356.542563030836, 4369.737815731066, 4386.956130438719, 4403.251447253974, 5133.9743301284, 5136.768845401966, 5142.794288228504, 5158.968206358743, 5180.922286165711, 5342.759575819097, 6177.1969643945995, 6197.659128747962, 6421.325760795143, 6558.344165583403, 1274.706817431996, 1470.154661069889, 1503.7894694742745, 1510.23733014829, 1511.8261399938929, 847.2671139464319, 960.2366118935323, 972.5283237629744, 989.6338354808623, 1005.6379703306803, 5303.443138470482, 5954.493868021266, 5967.37342579023, 5978.671173085435, 6095.963686173362, 5380.300560927054, 5881.705914704247, 6082.178905847654, 6556.704948277244, 6703.765368212186, 4854.490278520775, 5287.867803304948, 5430.864228394322, 5610.7194640268635, 6023.6385816851125, 3096.383555895265, 3409.215880347534, 3477.4957631143343, 3488.7906725596545, 3499.685028347461, 4817.735024573612, 6943.27095654949, 6956.269591692901, 6960.965195173992, 7113.7154513819905, 5857.70711464425, 6753.0, 6964.512484126062, 6977.267386924402, 7028.92971070293, 6565.96717016431, 7037.8240543985785, 7072.151341839012, 7081.752138675121, 7095.219525852152, 6311.400416960381, 6749.628770417477, 6757.290484499057, 6760.391564759196, 6816.2842901496615, 6524.804255872332, 6696.799096027127, 6715.932840671726, 6749.730010799513, 6754.358335958076, 7001.824954376181, 7055.223925368103, 7059.505834591735, 7093.1488221413765, 7161.242921475374, 3892.6691231245663, 4337.240982828055, 4357.346398040319, 4368.170047690928, 4469.374287599804, 6367.936320636734, 6411.294757576569, 6741.528093033637, 6750.561213521106, 6785.89821152693, 5893.5874488785375, 6406.967965160145, 6489.870202595827, 6517.8696426072165, 6556.967215163893, 5107.897842043064, 5551.861203469784, 6034.758609655564, 6478.902816457851, 6553.4101930826455, 5072.797088116434, 6255.218097737783, 6342.778002769881, 6374.90437643445, 6398.104265402754, 5437.912417516433, 6124.846878828065, 6264.968675156777, 6534.542582019213, 6535.57518761279, 4835.734034627989, 5554.583406244628, 5637.605367624227, 6147.262328520606, 6274.870523305849], "value": 4607.835860978008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8045425463852, 725.7822653204039, 734.9485536012481, 749.6251874062965, 758.5031804168271, 14705.191214483199, 14838.406463741438, 15018.924905375472, 15019.924900375496, 15264.771028434569, 11695.824562631567, 11924.7615047699, 14043.0, 14149.787753183711, 14270.643233919158, 711.7864640607797, 890.3722875372879, 899.0290486274807, 923.3075193604797, 926.6849271247775, 883.0198479687574, 904.8552231642939, 912.2200518556638, 924.3991405586355, 926.9768255793591, 825.529448214518, 940.1538615246264, 973.3964941736134, 975.4050029482011, 982.719924821426, 930.2093220762332, 972.4068318325816, 972.9416235025922, 973.2749101919115, 974.6491263145333, 716.2443621978811, 718.48987219074, 719.2843121094492, 722.6170129831198, 722.743426083738, 12724.491020359175, 15167.317470713844, 15176.165310907896, 15189.240537973168, 15281.006734562217, 12848.550300739429, 12894.290814005226, 12950.805737913844, 12974.156679815782, 13268.800967985488, 8663.913360866374, 10027.649032283907, 10239.948800256025, 10271.0, 10287.177025837915, 3067.5091985282247, 3570.696490798259, 3605.9098522536883, 3643.5081264029545, 3659.176685245825, 84479.0, 84859.0, 87025.56487217586, 87143.56428217882, 87861.12138878657, 8420.831583368421, 9150.633974641072, 9582.712518624452, 9774.31579789408, 9835.950820245853, 22832.48293848943, 22947.0, 23003.88498057499, 23007.88496057509, 23044.96297666609, 7610.885836712454, 7620.809479762939, 7655.655495502716, 7714.228577142353, 7735.265149810759, 4047.352423612208, 4099.057216840143, 4099.938500922489, 4103.076807718299, 4111.773852438085, 3662.6703596675893, 3685.594584595692, 3696.5564132303757, 3704.018435114697, 3718.4794128821986, 651.4365074210774, 654.2051407539861, 656.5666660004374, 666.2438132719399, 674.1850307232949, 496.13919849061847, 500.7796569509404, 518.4866981688101, 552.6545908806995, 562.6624025584698, 7983.081945576333, 8069.959650201711, 8088.0, 8198.467099638505, 8230.960063238621, 566.815784869919, 566.9097461813038, 586.865021045162, 587.1075964533885, 597.2951916738291, 3878.3406820840523, 3928.5285765707727, 3934.5278566572197, 3993.2412841560013, 4097.0, 75868.48263034818, 78749.21250787418, 78766.60616696879, 78780.0, 96836.0, 65315.101367397634, 67350.66324668346, 67777.0, 71407.92888106682, 72542.0, 39084.82745517582, 41699.0, 48758.75620621874, 49474.0, 64787.0, 7999.560024198725, 8050.597470126353, 8060.476069055492, 8268.214519620626, 8272.875906861522, 42467.0, 42555.7233283002, 43744.562554374046, 44339.0, 44480.33279500875, 54818.725906370215, 61895.76208475896, 65137.0, 65208.673956629915, 65437.67281163564, 10041.945595712345, 10137.847932280874, 10188.083072523508, 10324.122449591869, 10466.215033872339, 11652.708682283012, 11757.706057348634, 11841.28952262867, 11852.822207666719, 12311.138220324492, 9605.231581473325, 11212.551497940318, 11373.601923932954, 11617.0, 11639.243449175776, 11080.778384432428, 11126.165537584551, 11155.274907131336, 11237.71905702364, 11535.711607209887, 10957.780844383227, 11038.337699738042, 11172.273802202832, 11181.664550063186, 11411.714707132056, 9269.814603708022, 9756.85364719544, 9914.603415863285, 9920.305578609428, 10146.289759717045, 8989.730308090768, 9530.35236018603, 9611.951940240255, 9673.22614190849, 9835.114839664464], "value": 6733.47685322173, "unit": "score"}], "name": "dromaeo_css", "value": 7145.053601782218, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 152.0, 167.0, 123.0, 121.0, 182.0, 166.0, 116.0, 120.0, 119.0], "value": 140.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 147.0, 168.0, 120.0, 144.0, 121.0, 155.0, 162.0, 123.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 200.0, 205.0, 257.0, 234.0, 246.0, 273.0, 204.0, 196.0, 200.0], "value": 221.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 77.0, 147.0, 75.0, 81.0, 85.0, 56.0, 160.0, 47.0], "value": 86.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 105.0, 125.0, 112.0, 69.0, 101.0, 159.0, 114.0, 115.0, 151.0], "value": 114.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 90.0, 96.0, 130.0, 113.0, 92.0, 88.0, 91.0, 109.0], "value": 107.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 121.0, 148.0, 95.0, 98.0, 98.0, 96.0, 95.0, 115.0, 150.0], "value": 111.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 89.0, 91.0, 92.0, 90.0, 78.0, 154.0, 144.0, 118.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 76.0, 62.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 69.0, 74.0, 103.0, 111.0, 104.0, 101.0, 99.0, 69.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 86.0, 82.0, 84.0, 86.0, 84.0, 86.0, 87.0, 88.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 138.0, 143.0, 149.0, 142.0, 131.0, 164.0, 199.0, 226.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 175.0, 177.0, 172.0, 175.0, 173.0, 172.0, 173.0, 170.0, 171.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 72.0, 69.0, 75.0, 96.0, 72.0, 60.0, 95.0, 77.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1666.4, "alertThreshold": 2.0}]} 05:28:48 INFO - Return code: 0 05:28:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:48 ERROR - # TBPL SUCCESS # 05:28:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:48 INFO - 2016-04-25 05:28:48.201 screenresolution[6187:106086] starting screenresolution argv=screenresolution get 05:28:48 INFO - 2016-04-25 05:28:48.204 screenresolution[6187:106086] Display 0: 1600x1200x32@60 05:28:48 INFO - 2016-04-25 05:28:48.210 screenresolution[6188:106089] starting screenresolution argv=screenresolution list 05:28:48 INFO - Available Modes on Display 0 05:28:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:48 INFO - Intel Iris: 05:28:48 INFO - Chipset Model: Intel Iris 05:28:48 INFO - Type: GPU 05:28:48 INFO - Bus: Built-In 05:28:48 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:48 INFO - Vendor: Intel (0x8086) 05:28:48 INFO - Device ID: 0x0a2e 05:28:48 INFO - Revision ID: 0x0009 05:28:48 INFO - Displays: 05:28:48 INFO - Display: 05:28:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:48 INFO - Display Serial Number: 1600x1200 60 05:28:48 INFO - Main Display: Yes 05:28:48 INFO - Mirror: Off 05:28:48 INFO - Online: Yes 05:28:48 INFO - Rotation: Supported 05:28:48 INFO - Return code: 0 05:28:48 INFO - Running post-action listener: _resource_record_post_action 05:28:48 INFO - Running post-run listener: _resource_record_post_run 05:28:49 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 1695232; Write bytes: 696484352; Read time: 27; Write time: 1891 05:28:49 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 373524992; Write bytes: 368039424; Read time: 27934; Write time: 717 05:28:49 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1695232; Write bytes: 299015168; Read time: 27; Write time: 1118 05:28:49 INFO - Running post-run listener: _upload_blobber_files 05:28:49 INFO - Blob upload gear active. 05:28:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:28:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:28:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:28:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:50 INFO - (blobuploader) - INFO - Done attempting. 05:28:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:51 INFO - (blobuploader) - INFO - Done attempting. 05:28:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:51 INFO - Return code: 0 05:28:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4fc68cfc8ebd8e427b3f7dfd9755c03aad33a4e23858d0812f4c7a15a801b39f3a4c270f8b42bff235da699905f333d4e2e4077f06ad9edcf0ed1b3af9c0685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1193395a6da8a6d1a820590de77e75e9e9b40a6ba711d55ba7f1f7b4daa2c006ca47fa6a6a694eac559af6e42d9cc464066634b3976010483669c29c899bb2d3"} 05:28:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:51 INFO - Contents: 05:28:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4fc68cfc8ebd8e427b3f7dfd9755c03aad33a4e23858d0812f4c7a15a801b39f3a4c270f8b42bff235da699905f333d4e2e4077f06ad9edcf0ed1b3af9c0685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1193395a6da8a6d1a820590de77e75e9e9b40a6ba711d55ba7f1f7b4daa2c006ca47fa6a6a694eac559af6e42d9cc464066634b3976010483669c29c899bb2d3"} 05:28:51 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:51 INFO - Copying logs to upload dir... 05:28:51 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.867247 ========= master_lag: 2.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-25 05:28:53.706927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-25 05:28:53.712189) ========= 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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4fc68cfc8ebd8e427b3f7dfd9755c03aad33a4e23858d0812f4c7a15a801b39f3a4c270f8b42bff235da699905f333d4e2e4077f06ad9edcf0ed1b3af9c0685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1193395a6da8a6d1a820590de77e75e9e9b40a6ba711d55ba7f1f7b4daa2c006ca47fa6a6a694eac559af6e42d9cc464066634b3976010483669c29c899bb2d3"} build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011232 build_url: 'https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f4fc68cfc8ebd8e427b3f7dfd9755c03aad33a4e23858d0812f4c7a15a801b39f3a4c270f8b42bff235da699905f333d4e2e4077f06ad9edcf0ed1b3af9c0685", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1193395a6da8a6d1a820590de77e75e9e9b40a6ba711d55ba7f1f7b4daa2c006ca47fa6a6a694eac559af6e42d9cc464066634b3976010483669c29c899bb2d3"}' ========= master_lag: 3.51 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-04-25 05:28:57.236462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:57.236797) ========= 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.bHrfvAa0s4/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.oC1HMfDhtN/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/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.005258 ========= master_lag: 0.49 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:57.727295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:57.727662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:57.728508) ========= ========= Total master_lag: 6.24 =========