builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1461586056.7 results: success (0) buildid: 20160422035423 builduid: e1d26a5cd477466bafcab7d720b7b498 revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.696478) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.696982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.697317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.715946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.716259) ========= 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.MvEvV13TvD/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.vc7hub9ubi/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:36-- 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% 14.1M=0.001s 2016-04-25 05:07:36 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098452 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.834118) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.836865) ========= 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.MvEvV13TvD/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.vc7hub9ubi/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.020869 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.891333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:36.891705) ========= 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.MvEvV13TvD/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.vc7hub9ubi/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:36,972 truncating revision to first 12 chars 2016-04-25 05:07:36,972 Setting DEBUG logging. 2016-04-25 05:07:36,972 attempt 1/10 2016-04-25 05:07:36,972 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:37,689 unpacking tar archive at: fx-team-0361b7030d36/testing/mozharness/ program finished with exit code 0 elapsedTime=0.957481 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:37.870597) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:37.871380) ========= script_repo_revision: 0361b7030d363459416d46e651a8c50c9536788f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:37.872309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:37.872959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-25 05:07:37.888823) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-25 05:07:37.889336) ========= /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.MvEvV13TvD/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.vc7hub9ubi/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:38 INFO - MultiFileLogger online at 20160425 05:07:38 in /builds/slave/test 05:07:38 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:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:38 INFO - {'append_to_log': False, 05:07:38 INFO - 'base_work_dir': '/builds/slave/test', 05:07:38 INFO - 'blob_upload_branch': 'Fx-Team', 05:07:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:38 INFO - 'branch': 'Fx-Team', 05:07:38 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:38 INFO - 'config_files': ('talos/mac_config.py',), 05:07:38 INFO - 'default_actions': ('clobber', 05:07:38 INFO - 'read-buildbot-config', 05:07:38 INFO - 'download-and-extract', 05:07:38 INFO - 'populate-webroot', 05:07:38 INFO - 'create-virtualenv', 05:07:38 INFO - 'install', 05:07:38 INFO - 'run-tests'), 05:07:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:38 INFO - 'download_minidump_stackwalk': True, 05:07:38 INFO - 'download_symbols': 'ondemand', 05:07:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:38 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:38 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:38 INFO - 'installer_path': 'installer.exe', 05:07:38 INFO - 'log_level': 'info', 05:07:38 INFO - 'log_name': 'talos', 05:07:38 INFO - 'log_to_console': True, 05:07:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:07:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:07:38 INFO - 'opt_config_files': (), 05:07:38 INFO - 'pip_index': False, 05:07:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:38 INFO - 'cmd': ('bash', 05:07:38 INFO - '-c', 05:07:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:38 INFO - 'enabled': True, 05:07:38 INFO - 'halt_on_failure': False, 05:07:38 INFO - 'name': 'check_screen_resolution'},), 05:07:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:07:38 INFO - 'cmd': ('bash', 05:07:38 INFO - '-c', 05:07:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:07:38 INFO - 'enabled': True, 05:07:38 INFO - 'halt_on_failure': False, 05:07:38 INFO - 'name': 'check_screen_resolution'},), 05:07:38 INFO - 'run_cmd_checks_enabled': True, 05:07:38 INFO - 'sps_profile': False, 05:07:38 INFO - 'sps_profile_interval': 0, 05:07:38 INFO - 'suite': 'dromaeojs-e10s', 05:07:38 INFO - 'system_bits': '32', 05:07:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:38 INFO - 'title': 't-yosemite-r7-0139', 05:07:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:38 INFO - 'use_talos_json': True, 05:07:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:38 INFO - 'work_dir': 'build'} 05:07:38 INFO - ##### 05:07:38 INFO - ##### Running clobber step. 05:07:38 INFO - ##### 05:07:38 INFO - Running pre-action listener: _resource_record_pre_action 05:07:38 INFO - Running main action method: clobber 05:07:38 INFO - rmtree: /builds/slave/test/build 05:07:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:39 INFO - Running post-action listener: _resource_record_post_action 05:07:39 INFO - ##### 05:07:39 INFO - ##### Running read-buildbot-config step. 05:07:39 INFO - ##### 05:07:39 INFO - Running pre-action listener: _resource_record_pre_action 05:07:39 INFO - Running main action method: read_buildbot_config 05:07:39 INFO - Using buildbot properties: 05:07:39 INFO - { 05:07:39 INFO - "project": "", 05:07:39 INFO - "product": "firefox", 05:07:39 INFO - "script_repo_revision": "production", 05:07:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:07:39 INFO - "repository": "", 05:07:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:07:39 INFO - "buildid": "20160422035423", 05:07:39 INFO - "pgo_build": "False", 05:07:39 INFO - "basedir": "/builds/slave/test", 05:07:39 INFO - "buildnumber": 641, 05:07:39 INFO - "slavename": "t-yosemite-r7-0139", 05:07:39 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:07:39 INFO - "platform": "yosemite_r7", 05:07:39 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:07:39 INFO - "branch": "fx-team", 05:07:39 INFO - "repo_path": "integration/fx-team", 05:07:39 INFO - "revision": "0361b7030d363459416d46e651a8c50c9536788f", 05:07:39 INFO - "stage_platform": "macosx64", 05:07:39 INFO - "builduid": "e1d26a5cd477466bafcab7d720b7b498", 05:07:39 INFO - "slavebuilddir": "test" 05:07:39 INFO - } 05:07:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:07:39 INFO - Running post-action listener: _resource_record_post_action 05:07:39 INFO - ##### 05:07:39 INFO - ##### Running download-and-extract step. 05:07:39 INFO - ##### 05:07:39 INFO - Running pre-action listener: _resource_record_pre_action 05:07:39 INFO - Running main action method: download_and_extract 05:07:39 INFO - mkdir: /builds/slave/test/build/tests 05:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:39 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:39 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:39 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:39 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:39 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:40 INFO - Downloaded 1199 bytes. 05:07:40 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:07:40 INFO - Using the following test package requirements: 05:07:40 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:40 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:07:40 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:07:40 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'jsshell-mac.zip'], 05:07:40 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:07:40 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:07:40 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:07:40 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:07:40 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:07:40 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:07:40 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:07:40 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:40 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:40 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:40 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:40 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:40 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:41 INFO - Downloaded 18105795 bytes. 05:07:41 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:41 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:44 INFO - Return code: 0 05:07:44 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:44 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:44 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:44 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:44 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:44 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:44 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:46 INFO - Downloaded 18105795 bytes. 05:07:46 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:46 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:49 INFO - Return code: 0 05:07:49 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:49 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:49 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:49 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:49 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:49 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:50 INFO - Downloaded 10845952 bytes. 05:07:50 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:50 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:50 INFO - Return code: 0 05:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:07:50 INFO - https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:07:50 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:50 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:50 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:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:07:55 INFO - Downloaded 110035353 bytes. 05:07:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:55 INFO - mkdir: /builds/slave/test/properties 05:07:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:07:55 INFO - Writing to file /builds/slave/test/properties/build_url 05:07:55 INFO - Contents: 05:07:55 INFO - build_url:https://queue.taskcluster.net/v1/task/IzOfUWE2STi8OIApe7NbRw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:07:56 INFO - Running post-action listener: _resource_record_post_action 05:07:56 INFO - Running post-action listener: set_extra_try_arguments 05:07:56 INFO - ##### 05:07:56 INFO - ##### Running populate-webroot step. 05:07:56 INFO - ##### 05:07:56 INFO - Running pre-action listener: _resource_record_pre_action 05:07:56 INFO - Running main action method: populate_webroot 05:07:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:07:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:07:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:07:56 INFO - '--tppagecycles', 05:07:56 INFO - '7'], 05:07:56 INFO - 'tests': ['tsvgm']}}, 05:07:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:07:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:07:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:07:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:07:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:07:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['damp', 'tps']}, 05:07:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'tests': ['damp', 'tps']}, 05:07:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['dromaeo_dom']}, 05:07:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:07:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['a11yr', 05:07:56 INFO - 'ts_paint', 05:07:56 INFO - 'tpaint', 05:07:56 INFO - 'sessionrestore', 05:07:56 INFO - 'sessionrestore_no_auto_restore', 05:07:56 INFO - 'tabpaint']}, 05:07:56 INFO - 'other-e10s': {'tests': ['a11yr', 05:07:56 INFO - 'ts_paint', 05:07:56 INFO - 'tpaint', 05:07:56 INFO - 'sessionrestore', 05:07:56 INFO - 'sessionrestore_no_auto_restore', 05:07:56 INFO - 'tabpaint']}, 05:07:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:07:56 INFO - 'ts_paint', 05:07:56 INFO - 'tpaint', 05:07:56 INFO - 'sessionrestore', 05:07:56 INFO - 'sessionrestore_no_auto_restore', 05:07:56 INFO - 'tabpaint']}, 05:07:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:07:56 INFO - 'ts_paint', 05:07:56 INFO - 'tpaint', 05:07:56 INFO - 'sessionrestore', 05:07:56 INFO - 'sessionrestore_no_auto_restore', 05:07:56 INFO - 'tabpaint']}, 05:07:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['a11yr', 05:07:56 INFO - 'ts_paint', 05:07:56 INFO - 'tpaint', 05:07:56 INFO - 'sessionrestore', 05:07:56 INFO - 'sessionrestore_no_auto_restore', 05:07:56 INFO - 'tabpaint']}, 05:07:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['a11yr', 05:07:56 INFO - 'ts_paint', 05:07:56 INFO - 'tpaint', 05:07:56 INFO - 'sessionrestore', 05:07:56 INFO - 'sessionrestore_no_auto_restore', 05:07:56 INFO - 'tabpaint']}, 05:07:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['tsvgx', 05:07:56 INFO - 'tsvgr_opacity', 05:07:56 INFO - 'tart', 05:07:56 INFO - 'tscrollx', 05:07:56 INFO - 'cart']}, 05:07:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:07:56 INFO - 'tsvgr_opacity', 05:07:56 INFO - 'tart', 05:07:56 INFO - 'tscrollx', 05:07:56 INFO - 'cart']}, 05:07:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'talos_options': ['--disable-e10s'], 05:07:56 INFO - 'tests': ['tp5o']}, 05:07:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'tests': ['tp5o']}, 05:07:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'talos_options': ['--disable-e10s', 05:07:56 INFO - '--xperf_path', 05:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:56 INFO - 'tests': ['tp5n']}, 05:07:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:07:56 INFO - 'talos_options': ['--xperf_path', 05:07:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:07:56 INFO - 'tests': ['tp5n']}}, 05:07:56 INFO - 'talos.zip': {'path': '', 05:07:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:07:56 INFO - Running post-action listener: _resource_record_post_action 05:07:56 INFO - ##### 05:07:56 INFO - ##### Running create-virtualenv step. 05:07:56 INFO - ##### 05:07:56 INFO - Running pre-action listener: _resource_record_pre_action 05:07:56 INFO - Running main action method: create_virtualenv 05:07:56 INFO - Creating virtualenv /builds/slave/test/build/venv 05:07:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:07:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:07:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:07:56 INFO - Using real prefix '/tools/python27' 05:07:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:07:57 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:00 INFO - Installing pip.................done. 05:08:00 INFO - Return code: 0 05:08:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:00 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:00 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:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:00 INFO - 'HOME': '/Users/cltbld', 05:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:00 INFO - 'LOGNAME': 'cltbld', 05:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:00 INFO - 'MOZ_NO_REMOTE': '1', 05:08:00 INFO - 'NO_EM_RESTART': '1', 05:08:00 INFO - 'PAGER': '/bin/cat', 05:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:00 INFO - 'PWD': '/builds/slave/test', 05:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:00 INFO - 'SHELL': '/bin/bash', 05:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:00 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:00 INFO - 'USER': 'cltbld', 05:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:00 INFO - 'XPC_FLAGS': '0x0', 05:08:00 INFO - 'XPC_SERVICE_NAME': '0', 05:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 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:00 INFO - Cleaning up... 05:08:00 INFO - Return code: 0 05:08:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:00 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:00 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:00 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:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:00 INFO - 'HOME': '/Users/cltbld', 05:08:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:00 INFO - 'LOGNAME': 'cltbld', 05:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:00 INFO - 'MOZ_NO_REMOTE': '1', 05:08:00 INFO - 'NO_EM_RESTART': '1', 05:08:00 INFO - 'PAGER': '/bin/cat', 05:08:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:00 INFO - 'PWD': '/builds/slave/test', 05:08:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:00 INFO - 'SHELL': '/bin/bash', 05:08:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:00 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:00 INFO - 'USER': 'cltbld', 05:08:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:00 INFO - 'XPC_FLAGS': '0x0', 05:08:00 INFO - 'XPC_SERVICE_NAME': '0', 05:08:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:00 INFO - Downloading/unpacking psutil>=0.7.1 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:03 INFO - Installing collected packages: psutil 05:08:03 INFO - Running setup.py install for psutil 05:08:03 INFO - building 'psutil._psutil_osx' extension 05:08:03 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:04 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:04 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:04 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:04 INFO - building 'psutil._psutil_posix' extension 05:08:04 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:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:04 INFO - ^ 05:08:04 INFO - 1 warning generated. 05:08:04 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:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:04 INFO - Successfully installed psutil 05:08:04 INFO - Cleaning up... 05:08:04 INFO - Return code: 0 05:08:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08:04 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:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 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:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:04 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:04 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:04 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:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:04 INFO - 'HOME': '/Users/cltbld', 05:08:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:04 INFO - 'LOGNAME': 'cltbld', 05:08:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:04 INFO - 'MOZ_NO_REMOTE': '1', 05:08:04 INFO - 'NO_EM_RESTART': '1', 05:08:04 INFO - 'PAGER': '/bin/cat', 05:08:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:04 INFO - 'PWD': '/builds/slave/test', 05:08:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:04 INFO - 'SHELL': '/bin/bash', 05:08:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:04 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:04 INFO - 'USER': 'cltbld', 05:08:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:04 INFO - 'XPC_FLAGS': '0x0', 05:08:04 INFO - 'XPC_SERVICE_NAME': '0', 05:08:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:07 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:07 INFO - Installing collected packages: mozsystemmonitor 05:08:07 INFO - Running setup.py install for mozsystemmonitor 05:08:07 INFO - Successfully installed mozsystemmonitor 05:08:07 INFO - Cleaning up... 05:08:07 INFO - Return code: 0 05:08:07 INFO - Installing blobuploader==1.2.4 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', '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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 05:08:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/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.vc7hub9ubi/Listeners', 05:08:07 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:07 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:11 INFO - Downloading docopt-0.6.1.tar.gz 05:08:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:11 INFO - Running setup.py install for blobuploader 05:08:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:11 INFO - Running setup.py install for requests 05:08:12 INFO - Running setup.py install for docopt 05:08:12 INFO - Successfully installed blobuploader requests docopt 05:08:12 INFO - Cleaning up... 05:08:12 INFO - Return code: 0 05:08:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:12 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:12 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:12 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:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:12 INFO - 'HOME': '/Users/cltbld', 05:08:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:12 INFO - 'LOGNAME': 'cltbld', 05:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:12 INFO - 'MOZ_NO_REMOTE': '1', 05:08:12 INFO - 'NO_EM_RESTART': '1', 05:08:12 INFO - 'PAGER': '/bin/cat', 05:08:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:12 INFO - 'PWD': '/builds/slave/test', 05:08:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:12 INFO - 'SHELL': '/bin/bash', 05:08:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:12 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:12 INFO - 'USER': 'cltbld', 05:08:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:12 INFO - 'XPC_FLAGS': '0x0', 05:08:12 INFO - 'XPC_SERVICE_NAME': '0', 05:08:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:12 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ZpJuCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:12 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-s2et3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:12 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-oRagcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:12 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-rU_ehJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3r6sx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-BtnhqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-LxklWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gxJyDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-SoWynu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Wh2TrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-kdmYBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-j7kSW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-luc_wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:13 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-jSVJO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:14 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-vqZ6kS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:14 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QEAwSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:14 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-481cMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:14 INFO - Running setup.py install for manifestparser 05:08:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Running setup.py install for mozcrash 05:08:14 INFO - Running setup.py install for mozdebug 05:08:14 INFO - Running setup.py install for mozdevice 05:08:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:14 INFO - Running setup.py install for mozfile 05:08:15 INFO - Running setup.py install for mozhttpd 05:08:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozinfo 05:08:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozInstall 05:08:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for mozleak 05:08:15 INFO - Running setup.py install for mozlog 05:08:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:15 INFO - Running setup.py install for moznetwork 05:08:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Running setup.py install for mozprocess 05:08:16 INFO - Running setup.py install for mozprofile 05:08:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Running setup.py install for mozrunner 05:08:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Running setup.py install for mozscreenshot 05:08:16 INFO - Running setup.py install for moztest 05:08:16 INFO - Running setup.py install for mozversion 05:08:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:16 INFO - Cleaning up... 05:08:16 INFO - Return code: 0 05:08:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:16 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:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:16 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:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:16 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:16 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:16 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:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:16 INFO - 'HOME': '/Users/cltbld', 05:08:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:16 INFO - 'LOGNAME': 'cltbld', 05:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:16 INFO - 'MOZ_NO_REMOTE': '1', 05:08:16 INFO - 'NO_EM_RESTART': '1', 05:08:16 INFO - 'PAGER': '/bin/cat', 05:08:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:16 INFO - 'PWD': '/builds/slave/test', 05:08:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:16 INFO - 'SHELL': '/bin/bash', 05:08:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:16 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:16 INFO - 'USER': 'cltbld', 05:08:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:16 INFO - 'XPC_FLAGS': '0x0', 05:08:16 INFO - 'XPC_SERVICE_NAME': '0', 05:08:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-LFYEo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-d7UQLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-EEGx_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-OPuVnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-kCnvpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-XUkzl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-hnA3Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:17 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:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:17 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-HTr2Dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-gMoNjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Ye82rR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-dRcfIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-eF8HyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-lpzbZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-_x1tO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-HbCSCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-nD9nHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:18 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-vRKCBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:19 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:19 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:19 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:19 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:19 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:19 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:21 INFO - Downloading blessings-1.6.tar.gz 05:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:21 INFO - Installing collected packages: blessings 05:08:21 INFO - Running setup.py install for blessings 05:08:21 INFO - Successfully installed blessings 05:08:21 INFO - Cleaning up... 05:08:21 INFO - Return code: 0 05:08:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:22 INFO - Reading from file tmpfile_stdout 05:08:22 INFO - Current package versions: 05:08:22 INFO - blessings == 1.6 05:08:22 INFO - blobuploader == 1.2.4 05:08:22 INFO - docopt == 0.6.1 05:08:22 INFO - manifestparser == 1.1 05:08:22 INFO - mozInstall == 1.12 05:08:22 INFO - mozcrash == 0.17 05:08:22 INFO - mozdebug == 0.1 05:08:22 INFO - mozdevice == 0.48 05:08:22 INFO - mozfile == 1.2 05:08:22 INFO - mozhttpd == 0.7 05:08:22 INFO - mozinfo == 0.9 05:08:22 INFO - mozleak == 0.1 05:08:22 INFO - mozlog == 3.1 05:08:22 INFO - moznetwork == 0.27 05:08:22 INFO - mozprocess == 0.22 05:08:22 INFO - mozprofile == 0.28 05:08:22 INFO - mozrunner == 6.11 05:08:22 INFO - mozscreenshot == 0.1 05:08:22 INFO - mozsystemmonitor == 0.0 05:08:22 INFO - moztest == 0.7 05:08:22 INFO - mozversion == 1.4 05:08:22 INFO - psutil == 3.1.1 05:08:22 INFO - requests == 1.2.3 05:08:22 INFO - wsgiref == 0.1.2 05:08:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:22 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:22 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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:22 INFO - 'HOME': '/Users/cltbld', 05:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:22 INFO - 'LOGNAME': 'cltbld', 05:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:22 INFO - 'MOZ_NO_REMOTE': '1', 05:08:22 INFO - 'NO_EM_RESTART': '1', 05:08:22 INFO - 'PAGER': '/bin/cat', 05:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:22 INFO - 'PWD': '/builds/slave/test', 05:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:22 INFO - 'SHELL': '/bin/bash', 05:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:22 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:22 INFO - 'USER': 'cltbld', 05:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:22 INFO - 'XPC_FLAGS': '0x0', 05:08:22 INFO - 'XPC_SERVICE_NAME': '0', 05:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Cleaning up... 05:08:22 INFO - Return code: 0 05:08:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:22 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:22 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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:22 INFO - 'HOME': '/Users/cltbld', 05:08:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:22 INFO - 'LOGNAME': 'cltbld', 05:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:22 INFO - 'MOZ_NO_REMOTE': '1', 05:08:22 INFO - 'NO_EM_RESTART': '1', 05:08:22 INFO - 'PAGER': '/bin/cat', 05:08:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:22 INFO - 'PWD': '/builds/slave/test', 05:08:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:22 INFO - 'SHELL': '/bin/bash', 05:08:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:22 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:22 INFO - 'USER': 'cltbld', 05:08:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:22 INFO - 'XPC_FLAGS': '0x0', 05:08:22 INFO - 'XPC_SERVICE_NAME': '0', 05:08:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:22 INFO - Downloading/unpacking jsonschema 05:08:22 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:22 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:22 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:22 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:22 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:22 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:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:25 INFO - Downloading/unpacking functools32 (from jsonschema) 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:25 INFO - warning: no files found matching '*.txt' 05:08:25 INFO - no previously-included directories found matching 'build' 05:08:25 INFO - no previously-included directories found matching 'dist' 05:08:25 INFO - no previously-included directories found matching '.git*' 05:08:25 INFO - Installing collected packages: jsonschema, functools32 05:08:25 INFO - Running setup.py install for functools32 05:08:25 INFO - warning: no files found matching '*.txt' 05:08:25 INFO - no previously-included directories found matching 'build' 05:08:25 INFO - no previously-included directories found matching 'dist' 05:08:25 INFO - no previously-included directories found matching '.git*' 05:08:25 INFO - Successfully installed jsonschema functools32 05:08:25 INFO - Cleaning up... 05:08:25 INFO - Return code: 0 05:08:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:25 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 0x10315ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10316b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9ab58f660>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, '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.MvEvV13TvD/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.vc7hub9ubi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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:25 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:25 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:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:08:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:25 INFO - 'HOME': '/Users/cltbld', 05:08:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:25 INFO - 'LOGNAME': 'cltbld', 05:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:25 INFO - 'MOZ_NO_REMOTE': '1', 05:08:25 INFO - 'NO_EM_RESTART': '1', 05:08:25 INFO - 'PAGER': '/bin/cat', 05:08:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:25 INFO - 'PWD': '/builds/slave/test', 05:08:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:25 INFO - 'SHELL': '/bin/bash', 05:08:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:08:25 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:08:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:25 INFO - 'USER': 'cltbld', 05:08:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:25 INFO - 'XPC_FLAGS': '0x0', 05:08:25 INFO - 'XPC_SERVICE_NAME': '0', 05:08:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:26 INFO - Downloading/unpacking flake8 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:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:08:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:08:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:08:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:29 INFO - no previously-included directories found matching 'docs/_build' 05:08:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:08:29 INFO - Running setup.py install for pep8 05:08:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:08:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:08:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:08:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:08:29 INFO - no previously-included directories found matching 'docs/_build' 05:08:30 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:08:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:08:30 INFO - Cleaning up... 05:08:30 INFO - Return code: 0 05:08:30 INFO - Running post-action listener: _resource_record_post_action 05:08:30 INFO - Running post-action listener: _start_resource_monitoring 05:08:30 INFO - Starting resource monitoring. 05:08:30 INFO - ##### 05:08:30 INFO - ##### Running install step. 05:08:30 INFO - ##### 05:08:30 INFO - Running pre-action listener: _resource_record_pre_action 05:08:30 INFO - Running main action method: install 05:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:30 INFO - Reading from file tmpfile_stdout 05:08:30 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:30 INFO - Reading from file tmpfile_stdout 05:08:30 INFO - Output received: 05:08:30 INFO - Usage: mozinstall [options] installer 05:08:30 INFO - Options: 05:08:30 INFO - -h, --help show this help message and exit 05:08:30 INFO - -d DEST, --destination=DEST 05:08:30 INFO - Directory to install application into. [default: 05:08:30 INFO - "/builds/slave/test"] 05:08:30 INFO - --app=APP Application being installed. [default: firefox] 05:08:30 INFO - mkdir: /builds/slave/test/build/application 05:08:30 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:30 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:03 INFO - Reading from file tmpfile_stdout 05:09:03 INFO - Output received: 05:09:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:09:03 INFO - Running post-action listener: _resource_record_post_action 05:09:03 INFO - ##### 05:09:03 INFO - ##### Running run-tests step. 05:09:03 INFO - ##### 05:09:03 INFO - Running pre-action listener: _resource_record_pre_action 05:09:03 INFO - Running main action method: run_tests 05:09:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:03 INFO - 2016-04-25 05:09:03.915 screenresolution[2729:28699] starting screenresolution argv=screenresolution get 05:09:03 INFO - 2016-04-25 05:09:03.917 screenresolution[2729:28699] Display 0: 1600x1200x32@60 05:09:03 INFO - 2016-04-25 05:09:03.923 screenresolution[2730:28701] starting screenresolution argv=screenresolution list 05:09:03 INFO - Available Modes on Display 0 05:09:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:04 INFO - Intel Iris: 05:09:04 INFO - Chipset Model: Intel Iris 05:09:04 INFO - Type: GPU 05:09:04 INFO - Bus: Built-In 05:09:04 INFO - VRAM (Dynamic, Max): 1536 MB 05:09:04 INFO - Vendor: Intel (0x8086) 05:09:04 INFO - Device ID: 0x0a2e 05:09:04 INFO - Revision ID: 0x0009 05:09:04 INFO - Displays: 05:09:04 INFO - Display: 05:09:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:04 INFO - Display Serial Number: 1600x1200 60 05:09:04 INFO - Main Display: Yes 05:09:04 INFO - Mirror: Off 05:09:04 INFO - Online: Yes 05:09:04 INFO - Rotation: Supported 05:09:04 INFO - Return code: 0 05:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:04 INFO - Python 2.7.3 05:09:04 INFO - Return code: 0 05:09:04 INFO - grabbing minidump binary from tooltool 05:09:04 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:04 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 0x102ffae00>, '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 0x102e63db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ff5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:04 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:04 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:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:04 INFO - Return code: 0 05:09:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:09:05 INFO - Return code: 0 05:09:05 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-0139', '--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:05 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-0139 --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:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MvEvV13TvD/Render', 05:09:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:05 INFO - 'HOME': '/Users/cltbld', 05:09:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:05 INFO - 'LOGNAME': 'cltbld', 05:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:05 INFO - 'MOZ_NO_REMOTE': '1', 05:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:05 INFO - 'NO_EM_RESTART': '1', 05:09:05 INFO - 'PAGER': '/bin/cat', 05:09:05 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:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:05 INFO - 'PWD': '/builds/slave/test', 05:09:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:05 INFO - 'SHELL': '/bin/bash', 05:09:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vc7hub9ubi/Listeners', 05:09:05 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 05:09:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:05 INFO - 'USER': 'cltbld', 05:09:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:05 INFO - 'XPC_FLAGS': '0x0', 05:09:05 INFO - 'XPC_SERVICE_NAME': '0', 05:09:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:05 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-0139', '--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:05 INFO - mozversion application_buildid: 20160422035423 05:09:05 INFO - mozversion application_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:09:05 INFO - mozversion application_display_name: Nightly 05:09:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:05 INFO - mozversion application_name: Firefox 05:09:05 INFO - mozversion application_remotingname: firefox 05:09:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:09:05 INFO - mozversion application_vendor: Mozilla 05:09:05 INFO - mozversion application_version: 48.0a1 05:09:05 INFO - mozversion platform_buildid: 20160422035423 05:09:05 INFO - mozversion platform_changeset: 0361b7030d363459416d46e651a8c50c9536788f 05:09:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:09:05 INFO - mozversion platform_version: 48.0a1 05:09:05 INFO - using testdate: 1461586145 05:09:05 INFO - actual date: 1461586145 05:09:05 INFO - starting webserver on 'localhost:55587' 05:09:05 INFO - SUITE-START | Running 2 tests 05:09:05 INFO - TEST-START | dromaeo_css 05:09:05 INFO - operating with platform_type : mac_ 05:09:05 INFO - Initialising browser for dromaeo_css test... 05:09:05 INFO - TEST-INFO | started process 2748 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpJdUHI_/profile http://localhost:55587/getInfo.html) 05:09:08 INFO - PROCESS | 2748 | __metrics Screen width/height:1600/1200 05:09:08 INFO - PROCESS | 2748 | colorDepth:24 05:09:08 INFO - PROCESS | 2748 | Browser inner width/height: 1024/689 05:09:08 INFO - PROCESS | 2748 | __metrics 05:09:08 ERROR - PROCESS | 2748 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:09:09 INFO - TEST-INFO | 2748: exit 0 05:09:09 INFO - Browser initialized. 05:09:09 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:09 INFO - TEST-INFO | started process 2751 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpJdUHI_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:21 INFO - PROCESS | 2751 | RSS: Main: 248102912 05:09:21 INFO - PROCESS | 2751 | 05:10:10 INFO - PROCESS | 2751 | 1461586210978 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:22 INFO - PROCESS | 2751 | Cycle 1(1): loaded http://localhost:55587/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55587/tests/dromaeo/cssquery-ext.html) 05:12:23 INFO - PROCESS | 2751 | RSS: Main: 260300800 05:12:23 INFO - PROCESS | 2751 | 05:15:25 INFO - PROCESS | 2751 | Cycle 1(1): loaded http://localhost:55587/tests/dromaeo/cssquery-ext.html (next: http://localhost:55587/tests/dromaeo/cssquery-jquery.html) 05:15:26 INFO - PROCESS | 2751 | RSS: Main: 272052224 05:15:26 INFO - PROCESS | 2751 | 05:18:28 INFO - PROCESS | 2751 | Cycle 1(1): loaded http://localhost:55587/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55587/tests/dromaeo/cssquery-mootools.html) 05:18:28 INFO - PROCESS | 2751 | RSS: Main: 274006016 05:18:28 INFO - PROCESS | 2751 | 05:21:30 INFO - PROCESS | 2751 | Cycle 1(1): loaded http://localhost:55587/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55587/tests/dromaeo/cssquery-prototype.html) 05:21:31 INFO - PROCESS | 2751 | RSS: Main: 275562496 05:21:31 INFO - PROCESS | 2751 | 05:24:34 INFO - PROCESS | 2751 | Cycle 1(1): loaded http://localhost:55587/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55587/tests/dromaeo/cssquery-yui.html) 05:24:34 INFO - PROCESS | 2751 | RSS: Main: 278413312 05:24:34 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | Cycle 1(1): loaded http://localhost:55587/tests/dromaeo/cssquery-yui.html (next: http://localhost:55587/tests/dromaeo/cssquery-dojo.html) 05:27:37 INFO - PROCESS | 2751 | RSS: Main: 279613440 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | __start_tp_report 05:27:37 INFO - PROCESS | 2751 | _x_x_mozilla_page_load 05:27:37 INFO - PROCESS | 2751 | _x_x_mozilla_page_load_details 05:27:37 INFO - PROCESS | 2751 | |i|pagename|runs| 05:27:37 INFO - PROCESS | 2751 | |0;dojo.html;3462.359463499253;3480.1125712943194;3525.5064290999267;3548.3435564420583;3569.678728914397;5891;5922.496587790043;5923.5853490255695;5964.254468191476;5975.1933488978975;5775.56683248756;5870.677112758796;5942.405759424056;5963.910541341883;6086.452219300262;4160.9375859362135;4510.939929116671;5187.740612969336;5240.292560504331;5269.262303277545;740.9130273413336;5293.576513878899;5307.628466007381;5341.786328546854;5386.218998245272;5236.895262094775;5266.3153790007245;5281.8415447536445;5296.09966305729;5309.41596424393;4231.682623803227;4640.489546149921;5231.947680523184;5373.462653734595;5413.837584872421;5196.662216955923;5203.635745497817;5230.686158830445;5288.338957630296;5328.706921119337;5744.138379243105;5854.356020837705;5869.090291004858;5885.293764748215;5953.047512398039;5815.41845815415;6145.907811382833;6155.984262596666;6219.595726277777;6292.307846136921;6196.752129914798;6277.372262773732;6289.811305660837;6300.4329610334835;6304.148939893102;4604.907901841978;5881.764729410818;6021.488173505301;6026.126211699279;6066.363031881677;6221.751129954751;6279.215098112736;6362.522810789209;6376.043593461018;6385.808425747235;6165.290991535941;6194.969025154845;6196.194494715658;6211;6231;6215.12988181655;6279.340669229757;6306.306306306303;6309.558330916883;6323.20959880015;6097.403692570297;6192.164057852222;6214.906776398358;6257.5932564383165;6295.905561416583;6101.641069425254;6172.938270617326;6183.5671502994355;6184.412480814315;6267.905981410283;4996.950030499721;5015.573676237561;5030.220315851049;5037.899242015139;5049.899002019939;4445.644348452116;4528.705634133771;4530.728156310632;4568.040711450566;4594.1730488512385;5632.831015069554;5992.550558708114;6003.729832157564;6060.090986352083;6070.908936365958;5210.869728256748;6288.276848162428;6290.528210384239;6294.402031806971;6304.873902521924;5020.623453241022;5842.678652674059;5864.296284445809;6026.728797204137;6059.969805133138;5478.260434841245;5479.369872464637;5493.560515158778;5513.7794488220825;5545.306836645419;6409.230892292861;6417;6426.518011149089;6468.15913931186;6473.320301368477;6115.666295175977;6237.345078766664;6241.906371404341;6259.436650701458;6283.403076707706;6401.199850018747;6414.166158399378;6454.354564543508;6457.709403076967;6459.321771213955;5148.407933087593;6210.472109870711;6225.875482490234;6235.3452887446165;6244.906326405016;6149.754009839735;6182.752689892533;6223.471004964447;6250.812475625738;6276.152719383008;4973.378327709036;6061.454469097803;6176.752929882754;6209.5963762357105;6236.968815156077;6137.140800287874;6158.630482171084;6174.351693072343;6189.319174890848;6205.193324867739;5853.326867410302;5903.645781253139;5914.763409463573;6072.666003369857;6124.724387402489;6192.81421557354;6194.442500175006;6204.627722336674;6210.099535567408;6243.282022567463;6142.262928448615;6165.106059621419;6179.320274769681;6184.876302474016;6195.938040619536 05:27:37 INFO - PROCESS | 2751 | |1;ext.html;516.1174391790041;534.5456362092222;540.7999040355069;586.6128355285512;613.1875265273511;38623.42064869029;39447;39480.21039579207;39483;39519.802400988025;40967;41605.58394416055;41663.58336416635;41734.58265417345;41851.79074104633;9402.905970940272;9572.234221262317;9609.951950240238;9703.029697030275;9756.170725488342;9567.282453815957;9575.569099390545;9608.135267825894;9729.610815567405;9751.073648003463;8389.706360277392;9587.376820506679;9701.854472182922;9717.271204659679;9750.853737193913;9615.13463788259;9632.807343853083;9675.70972870815;9680.27397945157;9691.418514889094;9510.714678559654;9527.428354298765;9668.323217374787;9673;9681.51592420376;39559.40660890089;39957.60042399568;40017.39973900394;40034.799826000686;40150;2851.871665775045;3081.014075495842;3182.7772055956093;3213.2770126721534;3438.381091403546;26211;26255.868720656465;26357.868210659017;26492.60261096085;26513.73486265132;2612.1902210314674;2631.8815653295455;2664.120840122755;2675.0637276953107;2708.1198610451484;390671;390684;391314;392712;392800;34299.485507716905;34329.48505772415;34656;34674;34737.478937815955;35718;36028;60802.695986519786;66457.68025078354;71053;15380.30788614515;16756.575691066395;17191.31234750621;17325.2203650836;17416.738748918775;11495.022923051467;13163.868361316265;13189.736205276033;13261;13262.93368533151;19908.800911990696;20074.799252007586;20239.898800505904;20249.49376265576;20356.592868142852;8122.3502119831455;8138.9186108138165;8235.95882020586;8249;8278.917210827934;830.4892491117919;955.7132860141929;1080.2978064258295;1121.2879821313525;1180.9763804723857;29117.8352865883;29823;29880.55179172314;30111.849440753092;30696.84651576728;1100.2573263047411;1121.2935850414349;1163.6043745126528;1210.1166148711313;1210.195220178589;13967.79048314276;14015.719685606435;15322.846771532364;15886.364545418053;15929.362825487082;552465;654550;655230;658505;658635;61568.38431615626;62246.688766556785;63385.36614633795;63488.36511634917;63516.36483635197;1433.906796058253;1445.436279850859;1496.244396579742;1504.0674781635237;1504.465914600323;24403.633945491187;30903.845480772452;30907;30999.535006974464;31231;48817;54109.45890541044;54322.45677543332;55148.89702206013;55275.44724552703;573317;588848;592875;594406;595667;26659.86670066637;26927;27141;27306.863465682545;27321.86339068292;46542.83642908954;46607;46818;47144.52855471538;48213;37105.81447092747;38616.8414947552;38631.80684096562;39325.41011884767;39466;33338;37715.245695085396;37745.62254377421;37983.24033519259;38880.72312045616;37096.07259818526;37309.25381492301;37774.055648609006;37799.24401512009;37997.430038549996;32610.51084233786;33558.49662255019;33628.49557256594;33714.662853371156;33742.819001334836;24855.62716559217;25702.485950281265;25851.691404728925;26250.081247156257;26779.866100669373 05:27:37 INFO - PROCESS | 2751 | |2;jquery.html;396.18781497929245;398.78864201972965;401.55828588552595;404.18556608433994;409.05100167611135;20223.797762022376;20702.48243793906;20966.89516552417;21074.6838797418;21695.783042169613;20199.49501262469;20353.694694579557;20960;20986.160553577876;21591.56816863662;5737.2541569596;5835.299764028323;5851.502622277111;5861.941380586203;5948.256467941507;5297.364316282033;5566.777328906839;5850.64896106235;5934.64392136471;5960.850978725523;5839.240898683165;5902.586818922677;5909.320428150753;5932.9406705932815;5935.851603709899;5536.778528858861;5747.2241247431475;5811;5898.292204935392;5929.318128415244;5135.075686376451;5137.357830271216;5153.098207813618;5160.948390516084;5172.2241663750365;25921.481570368676;26792.660366981767;27229.591556126674;27301.86349068262;27327.180184594494;1822.7265910113456;1846.0861873372767;2134.6050980568643;2327.1622216002224;2442.7312995570474;12536.435860386213;14658.41366345345;15161.317740701696;15180.240987950558;15436.768448473169;1563.992180039104;1715.8970461772333;1803.7564928734585;1816.1282584359449;1831.7527133837027;91129;115733;124399.37800311031;129403;138151.30924345413;11350.318980861175;11630.53477860893;11826.704332391588;11842.467088981017;11941.582044628396;14774.556763297118;14834.777478337834;14865.925670371578;15026.323815428332;15287;6825.249222585511;6850.246472887979;8558.443701159405;8909.688160914337;8963.820723585492;8848.026717061119;8882.289416846637;8904;8978.1021897811;8995.77510562228;4566.452025756864;4633.119707255611;4698.765061746899;4700.741459219776;4735.857924262277;1986.5927484865567;2002.7596688397193;2015.7121666907872;2016.7680716717766;2019.2629690163278;902.801383695586;927.730958022166;953.9475328856979;961.1925982175006;1077.6820837852852;16846.747298790528;19474;20541.178352866016;20620.484487887923;20675.8966205168;961.8941916389192;980.8773903262093;997.436448406648;1001.8860204967513;1024.8718910136233;8995.55022248885;10603.098736607475;10640.201984851012;10872.565097396173;10885.510152043176;541129;543614;549746;598891;623059;130332;136161;136398;137173.3141334287;137319.31340343435;983.9212862970945;988.1501908358806;994.2145704893054;995.6415690351467;1036.3937096798306;17718.73421898647;17991.910040449715;18123.637527249644;18161.636767264845;18292.542686432946;51939.44181674556;52833.735831322134;53077.7346113267;53808.73095634653;53849;77667.44665106553;78019.60990195013;79897;81280;81505;7819.100803407681;8321.875171872305;11561.248518846249;12104.910558049818;12251.632451026484;12381.257124572554;13259.734805303648;13482.32588370558;13530.661733456742;13728.313584320944;11646.301221926711;11700.47347869331;11727.296362218294;11808.409579520818;11929.701757456132;11405.315681059163;11553.884461155618;11607.593734219261;11661.475233614678;11822.527098915947;11698.532058717556;11889;11969.16215864881;11988.220765650205;12142.817857732318;12358.62924112278;12364.62906112818;12399.070069744625;12481.500739970299;12542.749145017231;11802.291862488279;11993.82009269879;12030.939845300718;12038.458269378074;12065.939670301943 05:27:37 INFO - PROCESS | 2751 | |3;mootools.html;1565.8825588080892;1592.6894255620152;1827.2599597163146;1916.1856211110276;1924.7594050743658;6930.925706515492;7495.887561686579;7887.645055972481;8030.237127472896;8058.7179448719235;8548;8568.443051201668;8711.520866352348;8732.781680457992;8743.344249181306;2249.988750056247;2367.8342516023886;2422.624493203556;2455.72986971433;2469.0247352295833;2066.7519897612233;2410.650455683925;2455.165243817102;2465.815063870217;2471.88876500557;2405.9037638494437;2420.5037967216767;2443.0838435586656;2447.6206188040883;2448.069733501267;2404.4349577849193;2413.2518919135123;2417.190241269177;2422.0917156066475;2430.2830664953967;2385.2367242482414;2398.8920498577604;2420.310211589706;2420.346506443268;2423.5274121546304;8811.603477843513;8917.375783695144;8924.776880578038;8938.910610893872;8958.507282099481;5261;5442.836714898559;5465.398806131322;5481.479259470344;5511.476409741068;3473.583170019614;3491.423915054013;3496.7202623790035;3570.8750193743094;3604.098975256186;979.686500319898;1012.1447376966452;1012.9746756331077;1023.5598692562195;1025.2105878473533;11418.972292493632;11602.76794464106;11605.4197290136;11626.128040397005;11683.824742628867;3890.5720370759195;4312.05134870328;4700.318453824177;4896.167651499253;4943.505649435027;9667.661631842851;10003.399796012263;10005.699829005142;10037.598496060076;10057.195424366033;5330.040592693353;5416.9729151353995;5463.754131064112;5484.643498172606;5488.094464413327;4480.820767169277;4813.566778989908;4949.158643030693;4955.5044495550155;4972.950270497321;3984.980075099606;4033.596640335943;4085.2442298174337;4121.5878412158545;4179.728317659343;1354.2416246901766;1359.2252416122715;1366.4465891314035;1367.2275164532007;1371.5473893615083;858.6307887608264;895.8163576466809;920.9493477858648;942.6747772018642;956.6316967967383;5943.910841337383;6063.090536419484;6095.146679464879;6201.472874805602;6332.303446620868;1008.8890222075565;1027.773889744255;1040.1730624153815;1040.6149724601794;1072.6299426697776;3395.7283417326553;3941.3693808990997;4086.366613174963;4088.7546747195265;4101.938470922939;10148.797024059477;10489.790204195873;10500.422476763699;10603.575856965635;10635.989580989793;10343.94828025855;10350.171986241083;10374.325668831501;10454.895451045544;10539.525721342558;8044.2760151586635;8143.470674406263;8205;8209.014918209734;8229.012518497819;5762.7694892203845;5961.314448838439;6076.66578338178;6130.662813545119;6212.502999759918;9803.754906127118;9947.701568952943;10014.3490673106;10049.54281629145;10112.988701130122;9883.11052005323;10131.13885319756;10199.84700229512;10237.692869213935;10312.968703129927;6590.406863382319;6911.827204319932;7523.88714169277;7677.001989741298;8271.54506502148;8257.917420825715;8267.62795674208;8387.916120838714;8389.706360277361;8437.578121094044;7180.425565954607;7363.705451781869;7387.926120738939;7394.186639469546;7485.663145158372;7194.352508274281;7252.963735181291;7334.046573945353;7365.337119659256;7368.1526624438875;6866.588004719732;6909.2399836019;7028.929710702828;7041.5775053496955;7057.788266352018;4281.78591070439;4831.202851529459;4832.637552183671;5049.974750126225;5150.742462876916;4876.707397556158;5009.073321435546;5016.673916195436;5090.312807770903;5264.341957255343 05:27:37 INFO - PROCESS | 2751 | |4;prototype.html;282.7751937209918;320.94062598419293;325.096232473723;325.7361537154904;331.2976489841536;5233.319668443107;5255.553277971372;5776.39347868474;6331.651759153245;6342.270638876536;5397.4602539746;5626.818368142695;5735.655860648353;6081.42226488484;6206.689665516728;3816.3512202925567;4390.40729501518;4459.397981272536;4499.595036446719;4607.10161518504;4282.678799090065;4582.175208462475;4606.97696511517;4611.216093264153;4614.446266448031;4550.180967425862;4572.748498832563;4575.656825738066;4599.149157405891;4599.195140850355;3627.4740162676526;3792.7534710243744;4426.22541055314;4554.590086892195;4654.557817007379;3330.900072997814;3802.315583195024;3950.9012274693077;4012.177503611782;4012.3580227163807;5898.64608123514;5911.881762364728;5961.195238642815;5979.730912108966;5986.610870293461;5253.187650260654;5342.439043900412;5409.43200963897;5409.6213265071465;5422.40353561108;5846;6207.844803879894;6400.647964361959;6559.868802623969;6597.208334999831;4272.957270427287;4442.733435993819;4450.755208463534;4462.843800466968;4463.843765468226;5734.397888221718;6135.447809697149;6603.306652801435;6920.57779777079;6944.166699996033;4341.5021817472925;4355.412019377343;4489.910201795946;4527.796249168795;4532.9320060199125;3664.853405863789;3928.1307911706945;4325.940144664577;4601.378813860153;4625.676202665781;4666.4633567139535;5272.604554658416;5328.626996110235;5343.65266257692;5355.357357117093;5543.52880005196;6359.300476947532;6490.935090649127;6668.898292806008;6694.09629699994;1263.4440846027903;1524.8932574719663;1536.8539988701054;1547;1547.4911960838092;872.6116877989234;926.7312479380904;981.3572110267786;993.344392700814;995.4823491784232;6135.987562052301;6164.753409863555;6198;6228.906566401508;6238.500919926395;6641.535092543476;6827.863442731117;6881.277465866012;6917.481188910851;6955.513114081966;4880.804767809248;4950.6782059166035;5857.531397488191;5870.295564532284;6164.537659675542;3031.6968303169506;3198.552202691625;3429.742769292313;3652.4521321801412;3664.2854643344826;6843.520953533205;7096.92903070973;7149.463790215651;7155.141383034069;7160.928390716026;6598.845202089711;6938.8489568233;7049.612271325023;7060.6469676517;7094;6211.2857021442205;6802.4217941474535;7162.498625096193;7314.780556583205;7316.231795661592;6192;6969.616671083139;7000.47496437759;7013.509054366145;7036.401905838061;6076.361981991828;6309.7160627770945;6610;6853.862922741617;6901.24086350491;5693.896826229632;6697.497687673542;6886.552374095668;7243.311885370881;7296.671649775667;4389.495208051115;4403.4495688039;4421.2483877740215;4432.401625780607;4438.912466445741;5340.305760251143;5576.609637325349;5825.359210486928;6930.653467326714;6962.164540255202;5473.850491396851;6528.249251336157;6688.632125233159;6709.261981182163;6712.328767123248;5835.854103647443;6439.130717353098;6678.065070890177;6690.829104906525;6705.564138330993;5279.630425870306;6238.781642642486;6301.4328710416285;6523.412892839668;6561.40947314744;6256.562040657111;6390.808275751735;6687.297833727389;6694.397504224643;6793.93206067933;6279.152314437492;6511.511636627177;6557.311482294481;6580;6586.8353291168105 05:27:37 INFO - PROCESS | 2751 | |5;yui.html;652.9617907527035;663.6449499517756;728.118976038993;728.2971932085538;728.4791374167469;14520.709585808278;14574.417023319054;14952.327145278461;14954.77567836482;14983.92508037461;14805.3337599808;15535.533933981971;15568.68862622747;15588.064716117042;15599.610009749762;725.1696807155804;913.1370854542444;914.3142643017736;921.3274309753883;922.4188761080543;895.3463971300954;944.0465130218461;944.1361154543584;946.1768261612407;948.9145976862081;934.7522906429801;978.3445091788483;984.4191926763208;995.2635050062937;1027.5889644142328;944.1738478831023;948.6015873333216;986.1420564109235;988.0761488008699;989.3816364772017;699.0318409003515;721.0770214125927;721.9386352160072;729.6096588325221;736.7089999450187;14708.338124784303;14819.629509262248;14923.40306387754;15083.170425626586;15119.622009449742;12915.225086494747;12939.547115850994;12973.675658108623;13003.414846331938;13148.539801106916;9865.11213990737;10023.398596084258;10486.79026419475;10544.630937917136;10953.397563134024;3484.790912545255;3514.2268700885766;3517.4723791431234;3519.3313270478784;3565.964340356589;60274.69862650702;76645.85031224535;78456.99999999943;78596;78955;7960.721374751856;9200.355975081813;9461.337706360626;9486.478243696525;9576.664816731382;17088.743668844727;20656.17375305001;20712.48218794512;20750;20764;6798.694058767367;7566.848663026819;7594.6202689866395;7611.961940190264;7775.57234352116;4075.97962010194;4088.6729061674996;4101.85643502476;4120.402541631447;4144.254034273859;3099.4730895747775;3548.432250839853;3588.551431071116;3643.9979005773625;3666.3217304798163;628.1990462160691;649.8667773106501;652.5921299188008;661.8246164766341;667.976620818269;499.5878400319751;508.9083964886356;584.9824505264849;588.9646621202742;612.3080918561997;7878.921210787818;8033.277005069455;8349.123342048997;8570.700025499078;8668.003179634297;603.7916918663054;605.1346574398652;605.9396056900424;607.5534482155612;627.3475585391234;3365.5793025871767;3488.267463832573;3848.4034974578985;3903.6877049835944;3915.530136383652;86448;87178.84622114713;87726.56136719276;88027;88770.11229887747;71590.64204678943;71680;72013.27986720171;72229;73088.2691173092;60510;63271.30558249779;63825.680871595345;66874;67413.66293168503;7553.282438168365;7561.168271490022;7732.8840067397905;7872.294115319093;7981.082175549654;36630.63369366272;38363.040923976005;42263.7886810564;43218.919527012076;43507.347389789815;58179.709101454224;58611.70694146502;62163.75672486615;62439.37560624335;62816;8752.562371881508;10352.741181470523;10388.636397726043;10446.582136714447;10447.529861156114;10934.671959841218;10967.232293739362;10972.915146122212;11117.610883619034;11160.051395631463;10246.282760206714;10272.075513203548;10284.845727314247;10442.373457592264;10800.783984320113;10357.482125893826;10377.193726578162;10380.791409823147;10462.843057354297;10848.945755271174;10278.434686092336;10321;10410.479476026017;10537.789244215226;10609.310394824312;8378.958105209435;8674.609642566225;8741.213290803858;9125.087491250822;9230.676926307548;8570.828583428422;8681.479111253346;8706.782330441789;8811.427257228259;8908.688195913111 05:27:37 INFO - PROCESS | 2751 | __end_tp_report 05:27:37 INFO - PROCESS | 2751 | __start_cc_report 05:27:37 INFO - PROCESS | 2751 | _x_x_mozilla_cycle_collect,399 05:27:37 INFO - PROCESS | 2751 | __end_cc_report 05:27:37 INFO - PROCESS | 2751 | __startTimestamp1461587257360__endTimestamp 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | ------- Summary: start ------- 05:27:37 INFO - PROCESS | 2751 | Number of tests: 6 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | [#0] dojo.html Cycles:165 Average:5757.84 Median:6086.45 stddev:773.49 (12.7%) stddev-sans-first:754.61 05:27:37 INFO - PROCESS | 2751 | Values: 3462.4 3480.1 3525.5 3548.3 3569.7 5891.0 5922.5 5923.6 5964.3 5975.2 5775.6 5870.7 5942.4 5963.9 6086.5 4160.9 4510.9 5187.7 5240.3 5269.3 740.9 5293.6 5307.6 5341.8 5386.2 5236.9 5266.3 5281.8 5296.1 5309.4 4231.7 4640.5 5231.9 5373.5 5413.8 5196.7 5203.6 5230.7 5288.3 5328.7 5744.1 5854.4 5869.1 5885.3 5953.0 5815.4 6145.9 6156.0 6219.6 6292.3 6196.8 6277.4 6289.8 6300.4 6304.1 4604.9 5881.8 6021.5 6026.1 6066.4 6221.8 6279.2 6362.5 6376.0 6385.8 6165.3 6195.0 6196.2 6211.0 6231.0 6215.1 6279.3 6306.3 6309.6 6323.2 6097.4 6192.2 6214.9 6257.6 6295.9 6101.6 6172.9 6183.6 6184.4 6267.9 4997.0 5015.6 5030.2 5037.9 5049.9 4445.6 4528.7 4530.7 4568.0 4594.2 5632.8 5992.6 6003.7 6060.1 6070.9 5210.9 6288.3 6290.5 6294.4 6304.9 5020.6 5842.7 5864.3 6026.7 6060.0 5478.3 5479.4 5493.6 5513.8 5545.3 6409.2 6417.0 6426.5 6468.2 6473.3 6115.7 6237.3 6241.9 6259.4 6283.4 6401.2 6414.2 6454.4 6457.7 6459.3 5148.4 6210.5 6225.9 6235.3 6244.9 6149.8 6182.8 6223.5 6250.8 6276.2 4973.4 6061.5 6176.8 6209.6 6237.0 6137.1 6158.6 6174.4 6189.3 6205.2 5853.3 5903.6 5914.8 6072.7 6124.7 6192.8 6194.4 6204.6 6210.1 6243.3 6142.3 6165.1 6179.3 6184.9 6195.9 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | [#1] ext.html Cycles:180 Average:66838.24 Median:38620.13 stddev:147115.72 (380.9%) stddev-sans-first:147444.14 05:27:37 INFO - PROCESS | 2751 | Values: 516.1 534.5 540.8 586.6 613.2 38623.4 39447.0 39480.2 39483.0 39519.8 40967.0 41605.6 41663.6 41734.6 41851.8 9402.9 9572.2 9610.0 9703.0 9756.2 9567.3 9575.6 9608.1 9729.6 9751.1 8389.7 9587.4 9701.9 9717.3 9750.9 9615.1 9632.8 9675.7 9680.3 9691.4 9510.7 9527.4 9668.3 9673.0 9681.5 39559.4 39957.6 40017.4 40034.8 40150.0 2851.9 3081.0 3182.8 3213.3 3438.4 26211.0 26255.9 26357.9 26492.6 26513.7 2612.2 2631.9 2664.1 2675.1 2708.1 390671.0 390684.0 391314.0 392712.0 392800.0 34299.5 34329.5 34656.0 34674.0 34737.5 35718.0 36028.0 60802.7 66457.7 71053.0 15380.3 16756.6 17191.3 17325.2 17416.7 11495.0 13163.9 13189.7 13261.0 13262.9 19908.8 20074.8 20239.9 20249.5 20356.6 8122.4 8138.9 8236.0 8249.0 8278.9 830.5 955.7 1080.3 1121.3 1181.0 29117.8 29823.0 29880.6 30111.8 30696.8 1100.3 1121.3 1163.6 1210.1 1210.2 13967.8 14015.7 15322.8 15886.4 15929.4 552465.0 654550.0 655230.0 658505.0 658635.0 61568.4 62246.7 63385.4 63488.4 63516.4 1433.9 1445.4 1496.2 1504.1 1504.5 24403.6 30903.8 30907.0 30999.5 31231.0 48817.0 54109.5 54322.5 55148.9 55275.4 573317.0 588848.0 592875.0 594406.0 595667.0 26659.9 26927.0 27141.0 27306.9 27321.9 46542.8 46607.0 46818.0 47144.5 48213.0 37105.8 38616.8 38631.8 39325.4 39466.0 33338.0 37715.2 37745.6 37983.2 38880.7 37096.1 37309.3 37774.1 37799.2 37997.4 32610.5 33558.5 33628.5 33714.7 33742.8 24855.6 25702.5 25851.7 26250.1 26779.9 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | [#2] jquery.html Cycles:180 Average:34999.73 Median:20831.24 stddev:95989.31 (460.8%) stddev-sans-first:96223.42 05:27:37 INFO - PROCESS | 2751 | Values: 396.2 398.8 401.6 404.2 409.1 20223.8 20702.5 20966.9 21074.7 21695.8 20199.5 20353.7 20960.0 20986.2 21591.6 5737.3 5835.3 5851.5 5861.9 5948.3 5297.4 5566.8 5850.6 5934.6 5960.9 5839.2 5902.6 5909.3 5932.9 5935.9 5536.8 5747.2 5811.0 5898.3 5929.3 5135.1 5137.4 5153.1 5160.9 5172.2 25921.5 26792.7 27229.6 27301.9 27327.2 1822.7 1846.1 2134.6 2327.2 2442.7 12536.4 14658.4 15161.3 15180.2 15436.8 1564.0 1715.9 1803.8 1816.1 1831.8 91129.0 115733.0 124399.4 129403.0 138151.3 11350.3 11630.5 11826.7 11842.5 11941.6 14774.6 14834.8 14865.9 15026.3 15287.0 6825.2 6850.2 8558.4 8909.7 8963.8 8848.0 8882.3 8904.0 8978.1 8995.8 4566.5 4633.1 4698.8 4700.7 4735.9 1986.6 2002.8 2015.7 2016.8 2019.3 902.8 927.7 953.9 961.2 1077.7 16846.7 19474.0 20541.2 20620.5 20675.9 961.9 980.9 997.4 1001.9 1024.9 8995.6 10603.1 10640.2 10872.6 10885.5 541129.0 543614.0 549746.0 598891.0 623059.0 130332.0 136161.0 136398.0 137173.3 137319.3 983.9 988.2 994.2 995.6 1036.4 17718.7 17991.9 18123.6 18161.6 18292.5 51939.4 52833.7 53077.7 53808.7 53849.0 77667.4 78019.6 79897.0 81280.0 81505.0 7819.1 8321.9 11561.2 12104.9 12251.6 12381.3 13259.7 13482.3 13530.7 13728.3 11646.3 11700.5 11727.3 11808.4 11929.7 11405.3 11553.9 11607.6 11661.5 11822.5 11698.5 11889.0 11969.2 11988.2 12142.8 12358.6 12364.6 12399.1 12481.5 12542.7 11802.3 11993.8 12030.9 12038.5 12065.9 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | [#3] mootools.html Cycles:180 Average:5703.21 Median:4822.38 stddev:3137.57 (65.1%) stddev-sans-first:3130.96 05:27:37 INFO - PROCESS | 2751 | Values: 1565.9 1592.7 1827.3 1916.2 1924.8 6930.9 7495.9 7887.6 8030.2 8058.7 8548.0 8568.4 8711.5 8732.8 8743.3 2250.0 2367.8 2422.6 2455.7 2469.0 2066.8 2410.7 2455.2 2465.8 2471.9 2405.9 2420.5 2443.1 2447.6 2448.1 2404.4 2413.3 2417.2 2422.1 2430.3 2385.2 2398.9 2420.3 2420.3 2423.5 8811.6 8917.4 8924.8 8938.9 8958.5 5261.0 5442.8 5465.4 5481.5 5511.5 3473.6 3491.4 3496.7 3570.9 3604.1 979.7 1012.1 1013.0 1023.6 1025.2 11419.0 11602.8 11605.4 11626.1 11683.8 3890.6 4312.1 4700.3 4896.2 4943.5 9667.7 10003.4 10005.7 10037.6 10057.2 5330.0 5417.0 5463.8 5484.6 5488.1 4480.8 4813.6 4949.2 4955.5 4973.0 3985.0 4033.6 4085.2 4121.6 4179.7 1354.2 1359.2 1366.4 1367.2 1371.5 858.6 895.8 920.9 942.7 956.6 5943.9 6063.1 6095.1 6201.5 6332.3 1008.9 1027.8 1040.2 1040.6 1072.6 3395.7 3941.4 4086.4 4088.8 4101.9 10148.8 10489.8 10500.4 10603.6 10636.0 10343.9 10350.2 10374.3 10454.9 10539.5 8044.3 8143.5 8205.0 8209.0 8229.0 5762.8 5961.3 6076.7 6130.7 6212.5 9803.8 9947.7 10014.3 10049.5 10113.0 9883.1 10131.1 10199.8 10237.7 10313.0 6590.4 6911.8 7523.9 7677.0 8271.5 8257.9 8267.6 8387.9 8389.7 8437.6 7180.4 7363.7 7387.9 7394.2 7485.7 7194.4 7253.0 7334.0 7365.3 7368.2 6866.6 6909.2 7028.9 7041.6 7057.8 4281.8 4831.2 4832.6 5050.0 5150.7 4876.7 5009.1 5016.7 5090.3 5264.3 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | [#4] prototype.html Cycles:180 Average:5289.33 Median:5905.26 stddev:1703.07 (28.8%) stddev-sans-first:1665.88 05:27:37 INFO - PROCESS | 2751 | Values: 282.8 320.9 325.1 325.7 331.3 5233.3 5255.6 5776.4 6331.7 6342.3 5397.5 5626.8 5735.7 6081.4 6206.7 3816.4 4390.4 4459.4 4499.6 4607.1 4282.7 4582.2 4607.0 4611.2 4614.4 4550.2 4572.7 4575.7 4599.1 4599.2 3627.5 3792.8 4426.2 4554.6 4654.6 3330.9 3802.3 3950.9 4012.2 4012.4 5898.6 5911.9 5961.2 5979.7 5986.6 5253.2 5342.4 5409.4 5409.6 5422.4 5846.0 6207.8 6400.6 6559.9 6597.2 4273.0 4442.7 4450.8 4462.8 4463.8 5734.4 6135.4 6603.3 6920.6 6944.2 4341.5 4355.4 4489.9 4527.8 4532.9 3664.9 3928.1 4325.9 4601.4 4625.7 4666.5 5272.6 5328.6 5343.7 5355.4 5543.5 6359.3 6490.9 6668.9 6694.1 1263.4 1524.9 1536.9 1547.0 1547.5 872.6 926.7 981.4 993.3 995.5 6136.0 6164.8 6198.0 6228.9 6238.5 6641.5 6827.9 6881.3 6917.5 6955.5 4880.8 4950.7 5857.5 5870.3 6164.5 3031.7 3198.6 3429.7 3652.5 3664.3 6843.5 7096.9 7149.5 7155.1 7160.9 6598.8 6938.8 7049.6 7060.6 7094.0 6211.3 6802.4 7162.5 7314.8 7316.2 6192.0 6969.6 7000.5 7013.5 7036.4 6076.4 6309.7 6610.0 6853.9 6901.2 5693.9 6697.5 6886.6 7243.3 7296.7 4389.5 4403.4 4421.2 4432.4 4438.9 5340.3 5576.6 5825.4 6930.7 6962.2 5473.9 6528.2 6688.6 6709.3 6712.3 5835.9 6439.1 6678.1 6690.8 6705.6 5279.6 6238.8 6301.4 6523.4 6561.4 6256.6 6390.8 6687.3 6694.4 6793.9 6279.2 6511.5 6557.3 6580.0 6586.8 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - PROCESS | 2751 | [#5] yui.html Cycles:180 Average:17037.97 Median:609.93 stddev:23617.05 (3872.1%) stddev-sans-first:23651.25 05:27:37 INFO - PROCESS | 2751 | Values: 653.0 663.6 728.1 728.3 728.5 14520.7 14574.4 14952.3 14954.8 14983.9 14805.3 15535.5 15568.7 15588.1 15599.6 725.2 913.1 914.3 921.3 922.4 895.3 944.0 944.1 946.2 948.9 934.8 978.3 984.4 995.3 1027.6 944.2 948.6 986.1 988.1 989.4 699.0 721.1 721.9 729.6 736.7 14708.3 14819.6 14923.4 15083.2 15119.6 12915.2 12939.5 12973.7 13003.4 13148.5 9865.1 10023.4 10486.8 10544.6 10953.4 3484.8 3514.2 3517.5 3519.3 3566.0 60274.7 76645.9 78457.0 78596.0 78955.0 7960.7 9200.4 9461.3 9486.5 9576.7 17088.7 20656.2 20712.5 20750.0 20764.0 6798.7 7566.8 7594.6 7612.0 7775.6 4076.0 4088.7 4101.9 4120.4 4144.3 3099.5 3548.4 3588.6 3644.0 3666.3 628.2 649.9 652.6 661.8 668.0 499.6 508.9 585.0 589.0 612.3 7878.9 8033.3 8349.1 8570.7 8668.0 603.8 605.1 605.9 607.6 627.3 3365.6 3488.3 3848.4 3903.7 3915.5 86448.0 87178.8 87726.6 88027.0 88770.1 71590.6 71680.0 72013.3 72229.0 73088.3 60510.0 63271.3 63825.7 66874.0 67413.7 7553.3 7561.2 7732.9 7872.3 7981.1 36630.6 38363.0 42263.8 43218.9 43507.3 58179.7 58611.7 62163.8 62439.4 62816.0 8752.6 10352.7 10388.6 10446.6 10447.5 10934.7 10967.2 10972.9 11117.6 11160.1 10246.3 10272.1 10284.8 10442.4 10800.8 10357.5 10377.2 10380.8 10462.8 10848.9 10278.4 10321.0 10410.5 10537.8 10609.3 8379.0 8674.6 8741.2 9125.1 9230.7 8570.8 8681.5 8706.8 8811.4 8908.7 05:27:37 INFO - PROCESS | 2751 | -------- Summary: end -------- 05:27:37 INFO - PROCESS | 2751 | 05:27:37 INFO - TEST-INFO | 2751: exit 0 05:27:38 INFO - TEST-OK | dromaeo_css | took 1112339ms 05:27:38 INFO - TEST-START | kraken 05:27:38 INFO - operating with platform_type : mac_ 05:27:38 INFO - Initialising browser for kraken test... 05:27:38 INFO - TEST-INFO | started process 2755 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpVLCGCh/profile http://localhost:55587/getInfo.html) 05:27:40 INFO - PROCESS | 2755 | __metrics Screen width/height:1600/1200 05:27:40 INFO - PROCESS | 2755 | colorDepth:24 05:27:40 INFO - PROCESS | 2755 | Browser inner width/height: 1024/689 05:27:40 INFO - PROCESS | 2755 | __metrics 05:27:40 ERROR - PROCESS | 2755 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:27:41 INFO - TEST-INFO | 2755: exit 0 05:27:41 INFO - Browser initialized. 05:27:41 INFO - Running cycle 1/1 for kraken test... 05:27:41 INFO - TEST-INFO | started process 2758 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpVLCGCh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:53 INFO - PROCESS | 2758 | RSS: Main: 247967744 05:27:53 INFO - PROCESS | 2758 | 05:27:56 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55587/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:57 INFO - PROCESS | 2758 | RSS: Main: 259960832 05:27:57 INFO - PROCESS | 2758 | 05:27:59 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55587/tests/kraken/driver.html?testName=audio-dft) 05:28:00 INFO - PROCESS | 2758 | RSS: Main: 269180928 05:28:00 INFO - PROCESS | 2758 | 05:28:03 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55587/tests/kraken/driver.html?testName=audio-fft) 05:28:04 INFO - PROCESS | 2758 | RSS: Main: 272236544 05:28:04 INFO - PROCESS | 2758 | 05:28:06 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55587/tests/kraken/driver.html?testName=audio-oscillator) 05:28:07 INFO - PROCESS | 2758 | RSS: Main: 274190336 05:28:07 INFO - PROCESS | 2758 | 05:28:09 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55587/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:09 INFO - PROCESS | 2758 | RSS: Main: 274677760 05:28:09 INFO - PROCESS | 2758 | 05:28:12 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55587/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:13 INFO - PROCESS | 2758 | RSS: Main: 274903040 05:28:13 INFO - PROCESS | 2758 | 05:28:16 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55587/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:16 INFO - PROCESS | 2758 | RSS: Main: 274886656 05:28:16 INFO - PROCESS | 2758 | 05:28:19 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55587/tests/kraken/driver.html?testName=json-parse-financial) 05:28:20 INFO - PROCESS | 2758 | RSS: Main: 275087360 05:28:20 INFO - PROCESS | 2758 | 05:28:22 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55587/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:22 INFO - PROCESS | 2758 | RSS: Main: 275005440 05:28:22 INFO - PROCESS | 2758 | 05:28:24 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:25 INFO - PROCESS | 2758 | RSS: Main: 275169280 05:28:25 INFO - PROCESS | 2758 | 05:28:27 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:28 INFO - PROCESS | 2758 | RSS: Main: 275312640 05:28:28 INFO - PROCESS | 2758 | 05:28:30 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:31 INFO - PROCESS | 2758 | RSS: Main: 275525632 05:28:31 INFO - PROCESS | 2758 | 05:28:34 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:35 INFO - PROCESS | 2758 | RSS: Main: 275406848 05:28:35 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | Cycle 1(1): loaded http://localhost:55587/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55587/tests/kraken/driver.html?testName=ai-astar) 05:28:37 INFO - PROCESS | 2758 | RSS: Main: 277131264 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | __start_tp_report 05:28:37 INFO - PROCESS | 2758 | _x_x_mozilla_page_load 05:28:37 INFO - PROCESS | 2758 | _x_x_mozilla_page_load_details 05:28:37 INFO - PROCESS | 2758 | |i|pagename|runs| 05:28:37 INFO - PROCESS | 2758 | |0;ai-astar;116;109;118;116;117;131;116;117;115;114 05:28:37 INFO - PROCESS | 2758 | |1;audio-beat-detection;152;121;144;167;119;140;141;125;164;149 05:28:37 INFO - PROCESS | 2758 | |2;audio-dft;194;195;218;249;230;202;198;197;202;197 05:28:37 INFO - PROCESS | 2758 | |3;audio-fft;58;108;66;111;80;78;84;81;120;55 05:28:37 INFO - PROCESS | 2758 | |4;audio-oscillator;81;82;126;77;82;88;121;79;80;122 05:28:37 INFO - PROCESS | 2758 | |5;imaging-gaussian-blur;135;129;89;99;133;86;90;87;91;76 05:28:37 INFO - PROCESS | 2758 | |6;imaging-darkroom;94;96;95;115;95;95;95;96;95;94 05:28:37 INFO - PROCESS | 2758 | |7;imaging-desaturate;77;146;143;91;116;90;150;129;90;117 05:28:37 INFO - PROCESS | 2758 | |8;json-parse-financial;63;62;61;61;61;62;63;77;61;60 05:28:37 INFO - PROCESS | 2758 | |9;json-stringify-tinderbox;60;68;69;69;69;82;71;68;65;68 05:28:37 INFO - PROCESS | 2758 | |10;stanford-crypto-aes;85;82;85;82;86;85;83;83;83;84 05:28:37 INFO - PROCESS | 2758 | |11;stanford-crypto-ccm;140;138;153;127;153;158;163;152;254;195 05:28:37 INFO - PROCESS | 2758 | |12;stanford-crypto-pbkdf2;176;182;169;170;177;175;174;237;224;185 05:28:37 INFO - PROCESS | 2758 | |13;stanford-crypto-sha256-iterative;72;97;61;76;81;64;84;95;99;82 05:28:37 INFO - PROCESS | 2758 | __end_tp_report 05:28:37 INFO - PROCESS | 2758 | __start_cc_report 05:28:37 INFO - PROCESS | 2758 | _x_x_mozilla_cycle_collect,1029 05:28:37 INFO - PROCESS | 2758 | __end_cc_report 05:28:37 INFO - PROCESS | 2758 | __startTimestamp1461587317401__endTimestamp 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | ------- Summary: start ------- 05:28:37 INFO - PROCESS | 2758 | Number of tests: 14 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.50 stddev:5.55 (4.8%) stddev-sans-first:5.87 05:28:37 INFO - PROCESS | 2758 | Values: 116.0 109.0 118.0 116.0 117.0 131.0 116.0 117.0 115.0 114.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:146.50 stddev:16.75 (11.4%) stddev-sans-first:17.39 05:28:37 INFO - PROCESS | 2758 | Values: 152.0 121.0 144.0 167.0 119.0 140.0 141.0 125.0 164.0 149.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#2] audio-dft Cycles:10 Average:208.20 Median:202.00 stddev:18.39 (9.1%) stddev-sans-first:18.77 05:28:37 INFO - PROCESS | 2758 | Values: 194.0 195.0 218.0 249.0 230.0 202.0 198.0 197.0 202.0 197.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#3] audio-fft Cycles:10 Average:84.10 Median:72.00 stddev:22.37 (31.1%) stddev-sans-first:21.64 05:28:37 INFO - PROCESS | 2758 | Values: 58.0 108.0 66.0 111.0 80.0 78.0 84.0 81.0 120.0 55.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:80.50 stddev:20.38 (25.3%) stddev-sans-first:21.09 05:28:37 INFO - PROCESS | 2758 | Values: 81.0 82.0 126.0 77.0 82.0 88.0 121.0 79.0 80.0 122.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:88.00 stddev:22.05 (25.1%) stddev-sans-first:19.78 05:28:37 INFO - PROCESS | 2758 | Values: 135.0 129.0 89.0 99.0 133.0 86.0 90.0 87.0 91.0 76.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#6] imaging-darkroom Cycles:10 Average:97.00 Median:95.00 stddev:6.36 (6.7%) stddev-sans-first:6.65 05:28:37 INFO - PROCESS | 2758 | Values: 94.0 96.0 95.0 115.0 95.0 95.0 95.0 96.0 95.0 94.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#7] imaging-desaturate Cycles:10 Average:114.90 Median:113.50 stddev:26.75 (23.6%) stddev-sans-first:24.61 05:28:37 INFO - PROCESS | 2758 | Values: 77.0 146.0 143.0 91.0 116.0 90.0 150.0 129.0 90.0 117.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:62.00 stddev:4.98 (8.0%) stddev-sans-first:5.28 05:28:37 INFO - PROCESS | 2758 | Values: 63.0 62.0 61.0 61.0 61.0 62.0 63.0 77.0 61.0 60.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:5.51 (8.0%) stddev-sans-first:4.81 05:28:37 INFO - PROCESS | 2758 | Values: 60.0 68.0 69.0 69.0 69.0 82.0 71.0 68.0 65.0 68.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.50 stddev:1.40 (1.7%) stddev-sans-first:1.41 05:28:37 INFO - PROCESS | 2758 | Values: 85.0 82.0 85.0 82.0 86.0 85.0 83.0 83.0 83.0 84.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#11] stanford-crypto-ccm Cycles:10 Average:163.30 Median:155.50 stddev:36.67 (23.6%) stddev-sans-first:37.91 05:28:37 INFO - PROCESS | 2758 | Values: 140.0 138.0 153.0 127.0 153.0 158.0 163.0 152.0 254.0 195.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.90 Median:179.50 stddev:23.68 (13.2%) stddev-sans-first:24.78 05:28:37 INFO - PROCESS | 2758 | Values: 176.0 182.0 169.0 170.0 177.0 175.0 174.0 237.0 224.0 185.0 05:28:37 INFO - PROCESS | 2758 | 05:28:37 INFO - PROCESS | 2758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.10 Median:83.00 stddev:13.25 (16.0%) stddev-sans-first:13.64 05:28:37 INFO - PROCESS | 2758 | Values: 72.0 97.0 61.0 76.0 81.0 64.0 84.0 95.0 99.0 82.0 05:28:37 INFO - PROCESS | 2758 | -------- Summary: end -------- 05:28:37 INFO - PROCESS | 2758 | 05:28:38 INFO - TEST-INFO | 2758: exit 0 05:28:38 INFO - TEST-OK | kraken | took 60149ms 05:28:38 INFO - SUITE-END | took 1172s 05:28:38 INFO - Completed test suite (00:19:32) 05:28:38 INFO - javascript benchmark 05:28:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3462.359463499253, 3480.1125712943194, 3525.5064290999267, 3548.3435564420583, 3569.678728914397, 5891.0, 5922.496587790043, 5923.5853490255695, 5964.254468191476, 5975.1933488978975, 5775.56683248756, 5870.677112758796, 5942.405759424056, 5963.910541341883, 6086.452219300262, 4160.9375859362135, 4510.939929116671, 5187.740612969336, 5240.292560504331, 5269.262303277545, 740.9130273413336, 5293.576513878899, 5307.628466007381, 5341.786328546854, 5386.218998245272, 5236.895262094775, 5266.3153790007245, 5281.8415447536445, 5296.09966305729, 5309.41596424393, 4231.682623803227, 4640.489546149921, 5231.947680523184, 5373.462653734595, 5413.837584872421, 5196.662216955923, 5203.635745497817, 5230.686158830445, 5288.338957630296, 5328.706921119337, 5744.138379243105, 5854.356020837705, 5869.090291004858, 5885.293764748215, 5953.047512398039, 5815.41845815415, 6145.907811382833, 6155.984262596666, 6219.595726277777, 6292.307846136921, 6196.752129914798, 6277.372262773732, 6289.811305660837, 6300.4329610334835, 6304.148939893102, 4604.907901841978, 5881.764729410818, 6021.488173505301, 6026.126211699279, 6066.363031881677, 6221.751129954751, 6279.215098112736, 6362.522810789209, 6376.043593461018, 6385.808425747235, 6165.290991535941, 6194.969025154845, 6196.194494715658, 6211.0, 6231.0, 6215.12988181655, 6279.340669229757, 6306.306306306303, 6309.558330916883, 6323.20959880015, 6097.403692570297, 6192.164057852222, 6214.906776398358, 6257.5932564383165, 6295.905561416583, 6101.641069425254, 6172.938270617326, 6183.5671502994355, 6184.412480814315, 6267.905981410283, 4996.950030499721, 5015.573676237561, 5030.220315851049, 5037.899242015139, 5049.899002019939, 4445.644348452116, 4528.705634133771, 4530.728156310632, 4568.040711450566, 4594.1730488512385, 5632.831015069554, 5992.550558708114, 6003.729832157564, 6060.090986352083, 6070.908936365958, 5210.869728256748, 6288.276848162428, 6290.528210384239, 6294.402031806971, 6304.873902521924, 5020.623453241022, 5842.678652674059, 5864.296284445809, 6026.728797204137, 6059.969805133138, 5478.260434841245, 5479.369872464637, 5493.560515158778, 5513.7794488220825, 5545.306836645419, 6409.230892292861, 6417.0, 6426.518011149089, 6468.15913931186, 6473.320301368477, 6115.666295175977, 6237.345078766664, 6241.906371404341, 6259.436650701458, 6283.403076707706, 6401.199850018747, 6414.166158399378, 6454.354564543508, 6457.709403076967, 6459.321771213955, 5148.407933087593, 6210.472109870711, 6225.875482490234, 6235.3452887446165, 6244.906326405016, 6149.754009839735, 6182.752689892533, 6223.471004964447, 6250.812475625738, 6276.152719383008, 4973.378327709036, 6061.454469097803, 6176.752929882754, 6209.5963762357105, 6236.968815156077, 6137.140800287874, 6158.630482171084, 6174.351693072343, 6189.319174890848, 6205.193324867739, 5853.326867410302, 5903.645781253139, 5914.763409463573, 6072.666003369857, 6124.724387402489, 6192.81421557354, 6194.442500175006, 6204.627722336674, 6210.099535567408, 6243.282022567463, 6142.262928448615, 6165.106059621419, 6179.320274769681, 6184.876302474016, 6195.938040619536], "value": 5712.957031980134, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.1174391790041, 534.5456362092222, 540.7999040355069, 586.6128355285512, 613.1875265273511, 38623.42064869029, 39447.0, 39480.21039579207, 39483.0, 39519.802400988025, 40967.0, 41605.58394416055, 41663.58336416635, 41734.58265417345, 41851.79074104633, 9402.905970940272, 9572.234221262317, 9609.951950240238, 9703.029697030275, 9756.170725488342, 9567.282453815957, 9575.569099390545, 9608.135267825894, 9729.610815567405, 9751.073648003463, 8389.706360277392, 9587.376820506679, 9701.854472182922, 9717.271204659679, 9750.853737193913, 9615.13463788259, 9632.807343853083, 9675.70972870815, 9680.27397945157, 9691.418514889094, 9510.714678559654, 9527.428354298765, 9668.323217374787, 9673.0, 9681.51592420376, 39559.40660890089, 39957.60042399568, 40017.39973900394, 40034.799826000686, 40150.0, 2851.871665775045, 3081.014075495842, 3182.7772055956093, 3213.2770126721534, 3438.381091403546, 26211.0, 26255.868720656465, 26357.868210659017, 26492.60261096085, 26513.73486265132, 2612.1902210314674, 2631.8815653295455, 2664.120840122755, 2675.0637276953107, 2708.1198610451484, 390671.0, 390684.0, 391314.0, 392712.0, 392800.0, 34299.485507716905, 34329.48505772415, 34656.0, 34674.0, 34737.478937815955, 35718.0, 36028.0, 60802.695986519786, 66457.68025078354, 71053.0, 15380.30788614515, 16756.575691066395, 17191.31234750621, 17325.2203650836, 17416.738748918775, 11495.022923051467, 13163.868361316265, 13189.736205276033, 13261.0, 13262.93368533151, 19908.800911990696, 20074.799252007586, 20239.898800505904, 20249.49376265576, 20356.592868142852, 8122.3502119831455, 8138.9186108138165, 8235.95882020586, 8249.0, 8278.917210827934, 830.4892491117919, 955.7132860141929, 1080.2978064258295, 1121.2879821313525, 1180.9763804723857, 29117.8352865883, 29823.0, 29880.55179172314, 30111.849440753092, 30696.84651576728, 1100.2573263047411, 1121.2935850414349, 1163.6043745126528, 1210.1166148711313, 1210.195220178589, 13967.79048314276, 14015.719685606435, 15322.846771532364, 15886.364545418053, 15929.362825487082, 552465.0, 654550.0, 655230.0, 658505.0, 658635.0, 61568.38431615626, 62246.688766556785, 63385.36614633795, 63488.36511634917, 63516.36483635197, 1433.906796058253, 1445.436279850859, 1496.244396579742, 1504.0674781635237, 1504.465914600323, 24403.633945491187, 30903.845480772452, 30907.0, 30999.535006974464, 31231.0, 48817.0, 54109.45890541044, 54322.45677543332, 55148.89702206013, 55275.44724552703, 573317.0, 588848.0, 592875.0, 594406.0, 595667.0, 26659.86670066637, 26927.0, 27141.0, 27306.863465682545, 27321.86339068292, 46542.83642908954, 46607.0, 46818.0, 47144.52855471538, 48213.0, 37105.81447092747, 38616.8414947552, 38631.80684096562, 39325.41011884767, 39466.0, 33338.0, 37715.245695085396, 37745.62254377421, 37983.24033519259, 38880.72312045616, 37096.07259818526, 37309.25381492301, 37774.055648609006, 37799.24401512009, 37997.430038549996, 32610.51084233786, 33558.49662255019, 33628.49557256594, 33714.662853371156, 33742.819001334836, 24855.62716559217, 25702.485950281265, 25851.691404728925, 26250.081247156257, 26779.866100669373], "value": 19553.309582703518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.18781497929245, 398.78864201972965, 401.55828588552595, 404.18556608433994, 409.05100167611135, 20223.797762022376, 20702.48243793906, 20966.89516552417, 21074.6838797418, 21695.783042169613, 20199.49501262469, 20353.694694579557, 20960.0, 20986.160553577876, 21591.56816863662, 5737.2541569596, 5835.299764028323, 5851.502622277111, 5861.941380586203, 5948.256467941507, 5297.364316282033, 5566.777328906839, 5850.64896106235, 5934.64392136471, 5960.850978725523, 5839.240898683165, 5902.586818922677, 5909.320428150753, 5932.9406705932815, 5935.851603709899, 5536.778528858861, 5747.2241247431475, 5811.0, 5898.292204935392, 5929.318128415244, 5135.075686376451, 5137.357830271216, 5153.098207813618, 5160.948390516084, 5172.2241663750365, 25921.481570368676, 26792.660366981767, 27229.591556126674, 27301.86349068262, 27327.180184594494, 1822.7265910113456, 1846.0861873372767, 2134.6050980568643, 2327.1622216002224, 2442.7312995570474, 12536.435860386213, 14658.41366345345, 15161.317740701696, 15180.240987950558, 15436.768448473169, 1563.992180039104, 1715.8970461772333, 1803.7564928734585, 1816.1282584359449, 1831.7527133837027, 91129.0, 115733.0, 124399.37800311031, 129403.0, 138151.30924345413, 11350.318980861175, 11630.53477860893, 11826.704332391588, 11842.467088981017, 11941.582044628396, 14774.556763297118, 14834.777478337834, 14865.925670371578, 15026.323815428332, 15287.0, 6825.249222585511, 6850.246472887979, 8558.443701159405, 8909.688160914337, 8963.820723585492, 8848.026717061119, 8882.289416846637, 8904.0, 8978.1021897811, 8995.77510562228, 4566.452025756864, 4633.119707255611, 4698.765061746899, 4700.741459219776, 4735.857924262277, 1986.5927484865567, 2002.7596688397193, 2015.7121666907872, 2016.7680716717766, 2019.2629690163278, 902.801383695586, 927.730958022166, 953.9475328856979, 961.1925982175006, 1077.6820837852852, 16846.747298790528, 19474.0, 20541.178352866016, 20620.484487887923, 20675.8966205168, 961.8941916389192, 980.8773903262093, 997.436448406648, 1001.8860204967513, 1024.8718910136233, 8995.55022248885, 10603.098736607475, 10640.201984851012, 10872.565097396173, 10885.510152043176, 541129.0, 543614.0, 549746.0, 598891.0, 623059.0, 130332.0, 136161.0, 136398.0, 137173.3141334287, 137319.31340343435, 983.9212862970945, 988.1501908358806, 994.2145704893054, 995.6415690351467, 1036.3937096798306, 17718.73421898647, 17991.910040449715, 18123.637527249644, 18161.636767264845, 18292.542686432946, 51939.44181674556, 52833.735831322134, 53077.7346113267, 53808.73095634653, 53849.0, 77667.44665106553, 78019.60990195013, 79897.0, 81280.0, 81505.0, 7819.100803407681, 8321.875171872305, 11561.248518846249, 12104.910558049818, 12251.632451026484, 12381.257124572554, 13259.734805303648, 13482.32588370558, 13530.661733456742, 13728.313584320944, 11646.301221926711, 11700.47347869331, 11727.296362218294, 11808.409579520818, 11929.701757456132, 11405.315681059163, 11553.884461155618, 11607.593734219261, 11661.475233614678, 11822.527098915947, 11698.532058717556, 11889.0, 11969.16215864881, 11988.220765650205, 12142.817857732318, 12358.62924112278, 12364.62906112818, 12399.070069744625, 12481.500739970299, 12542.749145017231, 11802.291862488279, 11993.82009269879, 12030.939845300718, 12038.458269378074, 12065.939670301943], "value": 9945.86998374045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1565.8825588080892, 1592.6894255620152, 1827.2599597163146, 1916.1856211110276, 1924.7594050743658, 6930.925706515492, 7495.887561686579, 7887.645055972481, 8030.237127472896, 8058.7179448719235, 8548.0, 8568.443051201668, 8711.520866352348, 8732.781680457992, 8743.344249181306, 2249.988750056247, 2367.8342516023886, 2422.624493203556, 2455.72986971433, 2469.0247352295833, 2066.7519897612233, 2410.650455683925, 2455.165243817102, 2465.815063870217, 2471.88876500557, 2405.9037638494437, 2420.5037967216767, 2443.0838435586656, 2447.6206188040883, 2448.069733501267, 2404.4349577849193, 2413.2518919135123, 2417.190241269177, 2422.0917156066475, 2430.2830664953967, 2385.2367242482414, 2398.8920498577604, 2420.310211589706, 2420.346506443268, 2423.5274121546304, 8811.603477843513, 8917.375783695144, 8924.776880578038, 8938.910610893872, 8958.507282099481, 5261.0, 5442.836714898559, 5465.398806131322, 5481.479259470344, 5511.476409741068, 3473.583170019614, 3491.423915054013, 3496.7202623790035, 3570.8750193743094, 3604.098975256186, 979.686500319898, 1012.1447376966452, 1012.9746756331077, 1023.5598692562195, 1025.2105878473533, 11418.972292493632, 11602.76794464106, 11605.4197290136, 11626.128040397005, 11683.824742628867, 3890.5720370759195, 4312.05134870328, 4700.318453824177, 4896.167651499253, 4943.505649435027, 9667.661631842851, 10003.399796012263, 10005.699829005142, 10037.598496060076, 10057.195424366033, 5330.040592693353, 5416.9729151353995, 5463.754131064112, 5484.643498172606, 5488.094464413327, 4480.820767169277, 4813.566778989908, 4949.158643030693, 4955.5044495550155, 4972.950270497321, 3984.980075099606, 4033.596640335943, 4085.2442298174337, 4121.5878412158545, 4179.728317659343, 1354.2416246901766, 1359.2252416122715, 1366.4465891314035, 1367.2275164532007, 1371.5473893615083, 858.6307887608264, 895.8163576466809, 920.9493477858648, 942.6747772018642, 956.6316967967383, 5943.910841337383, 6063.090536419484, 6095.146679464879, 6201.472874805602, 6332.303446620868, 1008.8890222075565, 1027.773889744255, 1040.1730624153815, 1040.6149724601794, 1072.6299426697776, 3395.7283417326553, 3941.3693808990997, 4086.366613174963, 4088.7546747195265, 4101.938470922939, 10148.797024059477, 10489.790204195873, 10500.422476763699, 10603.575856965635, 10635.989580989793, 10343.94828025855, 10350.171986241083, 10374.325668831501, 10454.895451045544, 10539.525721342558, 8044.2760151586635, 8143.470674406263, 8205.0, 8209.014918209734, 8229.012518497819, 5762.7694892203845, 5961.314448838439, 6076.66578338178, 6130.662813545119, 6212.502999759918, 9803.754906127118, 9947.701568952943, 10014.3490673106, 10049.54281629145, 10112.988701130122, 9883.11052005323, 10131.13885319756, 10199.84700229512, 10237.692869213935, 10312.968703129927, 6590.406863382319, 6911.827204319932, 7523.88714169277, 7677.001989741298, 8271.54506502148, 8257.917420825715, 8267.62795674208, 8387.916120838714, 8389.706360277361, 8437.578121094044, 7180.425565954607, 7363.705451781869, 7387.926120738939, 7394.186639469546, 7485.663145158372, 7194.352508274281, 7252.963735181291, 7334.046573945353, 7365.337119659256, 7368.1526624438875, 6866.588004719732, 6909.2399836019, 7028.929710702828, 7041.5775053496955, 7057.788266352018, 4281.78591070439, 4831.202851529459, 4832.637552183671, 5049.974750126225, 5150.742462876916, 4876.707397556158, 5009.073321435546, 5016.673916195436, 5090.312807770903, 5264.341957255343], "value": 4625.444467167242, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7751937209918, 320.94062598419293, 325.096232473723, 325.7361537154904, 331.2976489841536, 5233.319668443107, 5255.553277971372, 5776.39347868474, 6331.651759153245, 6342.270638876536, 5397.4602539746, 5626.818368142695, 5735.655860648353, 6081.42226488484, 6206.689665516728, 3816.3512202925567, 4390.40729501518, 4459.397981272536, 4499.595036446719, 4607.10161518504, 4282.678799090065, 4582.175208462475, 4606.97696511517, 4611.216093264153, 4614.446266448031, 4550.180967425862, 4572.748498832563, 4575.656825738066, 4599.149157405891, 4599.195140850355, 3627.4740162676526, 3792.7534710243744, 4426.22541055314, 4554.590086892195, 4654.557817007379, 3330.900072997814, 3802.315583195024, 3950.9012274693077, 4012.177503611782, 4012.3580227163807, 5898.64608123514, 5911.881762364728, 5961.195238642815, 5979.730912108966, 5986.610870293461, 5253.187650260654, 5342.439043900412, 5409.43200963897, 5409.6213265071465, 5422.40353561108, 5846.0, 6207.844803879894, 6400.647964361959, 6559.868802623969, 6597.208334999831, 4272.957270427287, 4442.733435993819, 4450.755208463534, 4462.843800466968, 4463.843765468226, 5734.397888221718, 6135.447809697149, 6603.306652801435, 6920.57779777079, 6944.166699996033, 4341.5021817472925, 4355.412019377343, 4489.910201795946, 4527.796249168795, 4532.9320060199125, 3664.853405863789, 3928.1307911706945, 4325.940144664577, 4601.378813860153, 4625.676202665781, 4666.4633567139535, 5272.604554658416, 5328.626996110235, 5343.65266257692, 5355.357357117093, 5543.52880005196, 6359.300476947532, 6490.935090649127, 6668.898292806008, 6694.09629699994, 1263.4440846027903, 1524.8932574719663, 1536.8539988701054, 1547.0, 1547.4911960838092, 872.6116877989234, 926.7312479380904, 981.3572110267786, 993.344392700814, 995.4823491784232, 6135.987562052301, 6164.753409863555, 6198.0, 6228.906566401508, 6238.500919926395, 6641.535092543476, 6827.863442731117, 6881.277465866012, 6917.481188910851, 6955.513114081966, 4880.804767809248, 4950.6782059166035, 5857.531397488191, 5870.295564532284, 6164.537659675542, 3031.6968303169506, 3198.552202691625, 3429.742769292313, 3652.4521321801412, 3664.2854643344826, 6843.520953533205, 7096.92903070973, 7149.463790215651, 7155.141383034069, 7160.928390716026, 6598.845202089711, 6938.8489568233, 7049.612271325023, 7060.6469676517, 7094.0, 6211.2857021442205, 6802.4217941474535, 7162.498625096193, 7314.780556583205, 7316.231795661592, 6192.0, 6969.616671083139, 7000.47496437759, 7013.509054366145, 7036.401905838061, 6076.361981991828, 6309.7160627770945, 6610.0, 6853.862922741617, 6901.24086350491, 5693.896826229632, 6697.497687673542, 6886.552374095668, 7243.311885370881, 7296.671649775667, 4389.495208051115, 4403.4495688039, 4421.2483877740215, 4432.401625780607, 4438.912466445741, 5340.305760251143, 5576.609637325349, 5825.359210486928, 6930.653467326714, 6962.164540255202, 5473.850491396851, 6528.249251336157, 6688.632125233159, 6709.261981182163, 6712.328767123248, 5835.854103647443, 6439.130717353098, 6678.065070890177, 6690.829104906525, 6705.564138330993, 5279.630425870306, 6238.781642642486, 6301.4328710416285, 6523.412892839668, 6561.40947314744, 6256.562040657111, 6390.808275751735, 6687.297833727389, 6694.397504224643, 6793.93206067933, 6279.152314437492, 6511.511636627177, 6557.311482294481, 6580.0, 6586.8353291168105], "value": 4727.989516763306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.9617907527035, 663.6449499517756, 728.118976038993, 728.2971932085538, 728.4791374167469, 14520.709585808278, 14574.417023319054, 14952.327145278461, 14954.77567836482, 14983.92508037461, 14805.3337599808, 15535.533933981971, 15568.68862622747, 15588.064716117042, 15599.610009749762, 725.1696807155804, 913.1370854542444, 914.3142643017736, 921.3274309753883, 922.4188761080543, 895.3463971300954, 944.0465130218461, 944.1361154543584, 946.1768261612407, 948.9145976862081, 934.7522906429801, 978.3445091788483, 984.4191926763208, 995.2635050062937, 1027.5889644142328, 944.1738478831023, 948.6015873333216, 986.1420564109235, 988.0761488008699, 989.3816364772017, 699.0318409003515, 721.0770214125927, 721.9386352160072, 729.6096588325221, 736.7089999450187, 14708.338124784303, 14819.629509262248, 14923.40306387754, 15083.170425626586, 15119.622009449742, 12915.225086494747, 12939.547115850994, 12973.675658108623, 13003.414846331938, 13148.539801106916, 9865.11213990737, 10023.398596084258, 10486.79026419475, 10544.630937917136, 10953.397563134024, 3484.790912545255, 3514.2268700885766, 3517.4723791431234, 3519.3313270478784, 3565.964340356589, 60274.69862650702, 76645.85031224535, 78456.99999999943, 78596.0, 78955.0, 7960.721374751856, 9200.355975081813, 9461.337706360626, 9486.478243696525, 9576.664816731382, 17088.743668844727, 20656.17375305001, 20712.48218794512, 20750.0, 20764.0, 6798.694058767367, 7566.848663026819, 7594.6202689866395, 7611.961940190264, 7775.57234352116, 4075.97962010194, 4088.6729061674996, 4101.85643502476, 4120.402541631447, 4144.254034273859, 3099.4730895747775, 3548.432250839853, 3588.551431071116, 3643.9979005773625, 3666.3217304798163, 628.1990462160691, 649.8667773106501, 652.5921299188008, 661.8246164766341, 667.976620818269, 499.5878400319751, 508.9083964886356, 584.9824505264849, 588.9646621202742, 612.3080918561997, 7878.921210787818, 8033.277005069455, 8349.123342048997, 8570.700025499078, 8668.003179634297, 603.7916918663054, 605.1346574398652, 605.9396056900424, 607.5534482155612, 627.3475585391234, 3365.5793025871767, 3488.267463832573, 3848.4034974578985, 3903.6877049835944, 3915.530136383652, 86448.0, 87178.84622114713, 87726.56136719276, 88027.0, 88770.11229887747, 71590.64204678943, 71680.0, 72013.27986720171, 72229.0, 73088.2691173092, 60510.0, 63271.30558249779, 63825.680871595345, 66874.0, 67413.66293168503, 7553.282438168365, 7561.168271490022, 7732.8840067397905, 7872.294115319093, 7981.082175549654, 36630.63369366272, 38363.040923976005, 42263.7886810564, 43218.919527012076, 43507.347389789815, 58179.709101454224, 58611.70694146502, 62163.75672486615, 62439.37560624335, 62816.0, 8752.562371881508, 10352.741181470523, 10388.636397726043, 10446.582136714447, 10447.529861156114, 10934.671959841218, 10967.232293739362, 10972.915146122212, 11117.610883619034, 11160.051395631463, 10246.282760206714, 10272.075513203548, 10284.845727314247, 10442.373457592264, 10800.783984320113, 10357.482125893826, 10377.193726578162, 10380.791409823147, 10462.843057354297, 10848.945755271174, 10278.434686092336, 10321.0, 10410.479476026017, 10537.789244215226, 10609.310394824312, 8378.958105209435, 8674.609642566225, 8741.213290803858, 9125.087491250822, 9230.676926307548, 8570.828583428422, 8681.479111253346, 8706.782330441789, 8811.427257228259, 8908.688195913111], "value": 6681.632215499154, "unit": "score"}], "name": "dromaeo_css", "value": 7386.058310149763, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 109.0, 118.0, 116.0, 117.0, 131.0, 116.0, 117.0, 115.0, 114.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 144.0, 167.0, 119.0, 140.0, 141.0, 125.0, 164.0, 149.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 195.0, 218.0, 249.0, 230.0, 202.0, 198.0, 197.0, 202.0, 197.0], "value": 208.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 108.0, 66.0, 111.0, 80.0, 78.0, 84.0, 81.0, 120.0, 55.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 126.0, 77.0, 82.0, 88.0, 121.0, 79.0, 80.0, 122.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 129.0, 89.0, 99.0, 133.0, 86.0, 90.0, 87.0, 91.0, 76.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 115.0, 95.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 97.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 146.0, 143.0, 91.0, 116.0, 90.0, 150.0, 129.0, 90.0, 117.0], "value": 114.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 61.0, 61.0, 62.0, 63.0, 77.0, 61.0, 60.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 68.0, 69.0, 69.0, 69.0, 82.0, 71.0, 68.0, 65.0, 68.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 85.0, 82.0, 86.0, 85.0, 83.0, 83.0, 83.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 153.0, 127.0, 153.0, 158.0, 163.0, 152.0, 254.0, 195.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 182.0, 169.0, 170.0, 177.0, 175.0, 174.0, 237.0, 224.0, 185.0], "value": 186.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 97.0, 61.0, 76.0, 81.0, 64.0, 84.0, 95.0, 99.0, 82.0], "value": 81.1, "unit": "score"}], "name": "kraken", "value": 1605.6999999999998, "alertThreshold": 2.0}]} 05:28:38 INFO - Return code: 0 05:28:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:28:38 ERROR - # TBPL SUCCESS # 05:28:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:28:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:28:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:28:38 INFO - 2016-04-25 05:28:38.682 screenresolution[2763:31212] starting screenresolution argv=screenresolution get 05:28:38 INFO - 2016-04-25 05:28:38.685 screenresolution[2763:31212] Display 0: 1600x1200x32@60 05:28:38 INFO - 2016-04-25 05:28:38.691 screenresolution[2764:31215] starting screenresolution argv=screenresolution list 05:28:38 INFO - Available Modes on Display 0 05:28:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:28:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:28:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:28:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:28:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:28:38 INFO - Intel Iris: 05:28:38 INFO - Chipset Model: Intel Iris 05:28:38 INFO - Type: GPU 05:28:38 INFO - Bus: Built-In 05:28:38 INFO - VRAM (Dynamic, Max): 1536 MB 05:28:38 INFO - Vendor: Intel (0x8086) 05:28:38 INFO - Device ID: 0x0a2e 05:28:38 INFO - Revision ID: 0x0009 05:28:38 INFO - Displays: 05:28:38 INFO - Display: 05:28:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:28:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:28:38 INFO - Display Serial Number: 1600x1200 60 05:28:38 INFO - Main Display: Yes 05:28:38 INFO - Mirror: Off 05:28:38 INFO - Online: Yes 05:28:38 INFO - Rotation: Supported 05:28:38 INFO - Return code: 0 05:28:38 INFO - Running post-action listener: _resource_record_post_action 05:28:38 INFO - Running post-run listener: _resource_record_post_run 05:28:39 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 647680; Write bytes: 693873664; Read time: 6; Write time: 1910 05:28:39 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379816448; Write bytes: 374113792; Read time: 28178; Write time: 658 05:28:40 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 647680; Write bytes: 296621568; Read time: 6; Write time: 1204 05:28:40 INFO - Running post-run listener: _upload_blobber_files 05:28:40 INFO - Blob upload gear active. 05:28:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:40 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:40 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:40 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:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:41 INFO - (blobuploader) - INFO - Done attempting. 05:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:42 INFO - (blobuploader) - INFO - Done attempting. 05:28:42 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:42 INFO - Return code: 0 05:28:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8988d7a33e82bb4f2120033dd1a4f2399d4cbc407f2b48fa253127bc9045f2e413d92d2b9148b5f772933556f22d90fa99c2f8dcae1929ba5b8b5f1ac91bb1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dd2326be27e8e83ea1c5b0e7134db816c100191e36b4613b6f8e72a65565925c4d8cd62ae4a61130da177d562da06711ef316b09f9128ef6397b0eac900a66d"} 05:28:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:42 INFO - Contents: 05:28:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8988d7a33e82bb4f2120033dd1a4f2399d4cbc407f2b48fa253127bc9045f2e413d92d2b9148b5f772933556f22d90fa99c2f8dcae1929ba5b8b5f1ac91bb1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dd2326be27e8e83ea1c5b0e7134db816c100191e36b4613b6f8e72a65565925c4d8cd62ae4a61130da177d562da06711ef316b09f9128ef6397b0eac900a66d"} 05:28:42 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:42 INFO - Copying logs to upload dir... 05:28:42 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.605021 ========= master_lag: 2.91 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-25 05:28:45.403927) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:45.411671) ========= 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.MvEvV13TvD/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.vc7hub9ubi/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/8988d7a33e82bb4f2120033dd1a4f2399d4cbc407f2b48fa253127bc9045f2e413d92d2b9148b5f772933556f22d90fa99c2f8dcae1929ba5b8b5f1ac91bb1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dd2326be27e8e83ea1c5b0e7134db816c100191e36b4613b6f8e72a65565925c4d8cd62ae4a61130da177d562da06711ef316b09f9128ef6397b0eac900a66d"} 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.011375 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/8988d7a33e82bb4f2120033dd1a4f2399d4cbc407f2b48fa253127bc9045f2e413d92d2b9148b5f772933556f22d90fa99c2f8dcae1929ba5b8b5f1ac91bb1e4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7dd2326be27e8e83ea1c5b0e7134db816c100191e36b4613b6f8e72a65565925c4d8cd62ae4a61130da177d562da06711ef316b09f9128ef6397b0eac900a66d"}' ========= master_lag: 0.54 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:45.967798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:45.968134) ========= 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.MvEvV13TvD/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.vc7hub9ubi/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.005433 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-25 05:28:46.028842) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:46.029174) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-25 05:28:46.031596) ========= ========= Total master_lag: 3.58 =========