builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0212 starttime: 1464366208.94 results: success (0) buildid: 20160527062742 builduid: 035667decf304021b3c5862c967568e3 revision: dd3e899cfa818fcbb47b3d7432e0977e835702ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:28.938600) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:28.938970) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:28.939235) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:29.026354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:29.026654) ========= 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.rwd9yybnA4/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.HnFSoWbnRy/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-05-27 09:23:29-- 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% 40.3M=0s 2016-05-27 09:23:29 (40.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.492388 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:29.543509) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:29.543838) ========= 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.rwd9yybnA4/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.HnFSoWbnRy/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.025448 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:29.592037) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:29.592426) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd3e899cfa818fcbb47b3d7432e0977e835702ee --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 dd3e899cfa818fcbb47b3d7432e0977e835702ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rwd9yybnA4/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.HnFSoWbnRy/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-05-27 09:23:29,675 truncating revision to first 12 chars 2016-05-27 09:23:29,675 Setting DEBUG logging. 2016-05-27 09:23:29,675 attempt 1/10 2016-05-27 09:23:29,675 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd3e899cfa81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-27 09:23:30,250 unpacking tar archive at: fx-team-dd3e899cfa81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.860782 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:30.516725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:30.517204) ========= script_repo_revision: dd3e899cfa818fcbb47b3d7432e0977e835702ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:30.517752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:30.518018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-27 09:23:30.557320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-05-27 09:23:30.557666) ========= /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.rwd9yybnA4/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.HnFSoWbnRy/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:23:30 INFO - MultiFileLogger online at 20160527 09:23:30 in /builds/slave/test 09:23:30 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 09:23:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:30 INFO - {'append_to_log': False, 09:23:30 INFO - 'base_work_dir': '/builds/slave/test', 09:23:30 INFO - 'blob_upload_branch': 'Fx-Team', 09:23:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:30 INFO - 'branch': 'Fx-Team', 09:23:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:30 INFO - 'config_files': ('talos/mac_config.py',), 09:23:30 INFO - 'default_actions': ('clobber', 09:23:30 INFO - 'read-buildbot-config', 09:23:30 INFO - 'download-and-extract', 09:23:30 INFO - 'populate-webroot', 09:23:30 INFO - 'create-virtualenv', 09:23:30 INFO - 'install', 09:23:30 INFO - 'run-tests'), 09:23:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:30 INFO - 'download_minidump_stackwalk': True, 09:23:30 INFO - 'download_symbols': 'ondemand', 09:23:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:30 INFO - 'installer_path': 'installer.exe', 09:23:30 INFO - 'log_level': 'info', 09:23:30 INFO - 'log_name': 'talos', 09:23:30 INFO - 'log_to_console': True, 09:23:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:23:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:23:30 INFO - 'opt_config_files': (), 09:23:30 INFO - 'pip_index': False, 09:23:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:30 INFO - 'cmd': ('bash', 09:23:30 INFO - '-c', 09:23:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:30 INFO - 'enabled': True, 09:23:30 INFO - 'halt_on_failure': False, 09:23:30 INFO - 'name': 'check_screen_resolution'},), 09:23:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:23:30 INFO - 'cmd': ('bash', 09:23:30 INFO - '-c', 09:23:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:23:30 INFO - 'enabled': True, 09:23:30 INFO - 'halt_on_failure': False, 09:23:30 INFO - 'name': 'check_screen_resolution'},), 09:23:30 INFO - 'run_cmd_checks_enabled': True, 09:23:30 INFO - 'sps_profile': False, 09:23:30 INFO - 'sps_profile_interval': 0, 09:23:30 INFO - 'suite': 'dromaeojs-e10s', 09:23:30 INFO - 'system_bits': '32', 09:23:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:30 INFO - 'title': 't-yosemite-r7-0212', 09:23:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:30 INFO - 'use_talos_json': True, 09:23:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:30 INFO - 'work_dir': 'build'} 09:23:30 INFO - ##### 09:23:30 INFO - ##### Running clobber step. 09:23:30 INFO - ##### 09:23:30 INFO - Running pre-action listener: _resource_record_pre_action 09:23:30 INFO - Running main action method: clobber 09:23:30 INFO - rmtree: /builds/slave/test/build 09:23:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:32 INFO - Running post-action listener: _resource_record_post_action 09:23:32 INFO - ##### 09:23:32 INFO - ##### Finished clobber step (success) 09:23:32 INFO - ##### 09:23:32 INFO - ##### 09:23:32 INFO - ##### Running read-buildbot-config step. 09:23:32 INFO - ##### 09:23:32 INFO - Running pre-action listener: _resource_record_pre_action 09:23:32 INFO - Running main action method: read_buildbot_config 09:23:32 INFO - Using buildbot properties: 09:23:32 INFO - { 09:23:32 INFO - "project": "", 09:23:32 INFO - "product": "firefox", 09:23:32 INFO - "script_repo_revision": "production", 09:23:32 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:23:32 INFO - "repository": "", 09:23:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:23:32 INFO - "buildid": "20160527062742", 09:23:32 INFO - "pgo_build": "False", 09:23:32 INFO - "basedir": "/builds/slave/test", 09:23:32 INFO - "buildnumber": 6, 09:23:32 INFO - "slavename": "t-yosemite-r7-0212", 09:23:32 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 09:23:32 INFO - "platform": "yosemite_r7", 09:23:32 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 09:23:32 INFO - "branch": "fx-team", 09:23:32 INFO - "repo_path": "integration/fx-team", 09:23:32 INFO - "revision": "dd3e899cfa818fcbb47b3d7432e0977e835702ee", 09:23:32 INFO - "stage_platform": "macosx64", 09:23:32 INFO - "builduid": "035667decf304021b3c5862c967568e3", 09:23:32 INFO - "slavebuilddir": "test" 09:23:32 INFO - } 09:23:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 09:23:32 INFO - Running post-action listener: _resource_record_post_action 09:23:32 INFO - ##### 09:23:32 INFO - ##### Finished read-buildbot-config step (success) 09:23:32 INFO - ##### 09:23:32 INFO - ##### 09:23:32 INFO - ##### Running download-and-extract step. 09:23:32 INFO - ##### 09:23:32 INFO - Running pre-action listener: _resource_record_pre_action 09:23:32 INFO - Running main action method: download_and_extract 09:23:32 INFO - mkdir: /builds/slave/test/build/tests 09:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:32 INFO - https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:23:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 09:23:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 09:23:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 09:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 09:23:37 INFO - Downloaded 1199 bytes. 09:23:37 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 09:23:37 INFO - Using the following test package requirements: 09:23:37 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 09:23:37 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 09:23:37 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 09:23:37 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'jsshell-mac.zip'], 09:23:37 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 09:23:37 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 09:23:37 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 09:23:37 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 09:23:37 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 09:23:37 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 09:23:37 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 09:23:37 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:37 INFO - https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:23:38 INFO - Downloaded 18684824 bytes. 09:23:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:23:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:23:42 INFO - Return code: 0 09:23:42 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:42 INFO - https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 09:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:23:48 INFO - Downloaded 18684824 bytes. 09:23:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:23:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:23:52 INFO - Return code: 0 09:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:52 INFO - https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:23:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:23:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:23:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 09:23:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:23:53 INFO - Downloaded 10834034 bytes. 09:23:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:23:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:23:53 INFO - Return code: 0 09:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:53 INFO - https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:23:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:23:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:23:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 09:23:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 09:24:10 INFO - Downloaded 110487848 bytes. 09:24:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:24:10 INFO - mkdir: /builds/slave/test/properties 09:24:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:10 INFO - Contents: 09:24:10 INFO - build_url:https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 09:24:11 INFO - Running post-action listener: _resource_record_post_action 09:24:11 INFO - Running post-action listener: set_extra_try_arguments 09:24:11 INFO - ##### 09:24:11 INFO - ##### Finished download-and-extract step (success) 09:24:11 INFO - ##### 09:24:11 INFO - ##### 09:24:11 INFO - ##### Running populate-webroot step. 09:24:11 INFO - ##### 09:24:11 INFO - Running pre-action listener: _resource_record_pre_action 09:24:11 INFO - Running main action method: populate_webroot 09:24:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:11 INFO - '--tppagecycles', 09:24:11 INFO - '7'], 09:24:11 INFO - 'tests': ['tsvgm']}}, 09:24:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['damp', 'tps']}, 09:24:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'tests': ['damp', 'tps']}, 09:24:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['dromaeo_dom']}, 09:24:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['a11yr', 09:24:11 INFO - 'ts_paint', 09:24:11 INFO - 'tpaint', 09:24:11 INFO - 'sessionrestore', 09:24:11 INFO - 'sessionrestore_no_auto_restore', 09:24:11 INFO - 'tabpaint']}, 09:24:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:11 INFO - 'ts_paint', 09:24:11 INFO - 'tpaint', 09:24:11 INFO - 'sessionrestore', 09:24:11 INFO - 'sessionrestore_no_auto_restore', 09:24:11 INFO - 'tabpaint']}, 09:24:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:11 INFO - 'ts_paint', 09:24:11 INFO - 'tpaint', 09:24:11 INFO - 'sessionrestore', 09:24:11 INFO - 'sessionrestore_no_auto_restore', 09:24:11 INFO - 'tabpaint']}, 09:24:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:11 INFO - 'ts_paint', 09:24:11 INFO - 'tpaint', 09:24:11 INFO - 'sessionrestore', 09:24:11 INFO - 'sessionrestore_no_auto_restore', 09:24:11 INFO - 'tabpaint']}, 09:24:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['a11yr', 09:24:11 INFO - 'ts_paint', 09:24:11 INFO - 'tpaint', 09:24:11 INFO - 'sessionrestore', 09:24:11 INFO - 'sessionrestore_no_auto_restore', 09:24:11 INFO - 'tabpaint']}, 09:24:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['a11yr', 09:24:11 INFO - 'ts_paint', 09:24:11 INFO - 'tpaint', 09:24:11 INFO - 'sessionrestore', 09:24:11 INFO - 'sessionrestore_no_auto_restore', 09:24:11 INFO - 'tabpaint']}, 09:24:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['tsvgx', 09:24:11 INFO - 'tsvgr_opacity', 09:24:11 INFO - 'tart', 09:24:11 INFO - 'tscrollx', 09:24:11 INFO - 'cart']}, 09:24:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:11 INFO - 'tsvgr_opacity', 09:24:11 INFO - 'tart', 09:24:11 INFO - 'tscrollx', 09:24:11 INFO - 'cart']}, 09:24:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'talos_options': ['--disable-e10s'], 09:24:11 INFO - 'tests': ['tp5o']}, 09:24:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'tests': ['tp5o']}, 09:24:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'talos_options': ['--disable-e10s', 09:24:11 INFO - '--xperf_path', 09:24:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:11 INFO - 'tests': ['tp5n']}, 09:24:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:11 INFO - 'talos_options': ['--xperf_path', 09:24:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:11 INFO - 'tests': ['tp5n']}}, 09:24:11 INFO - 'talos.zip': {'path': '', 09:24:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:11 INFO - Running post-action listener: _resource_record_post_action 09:24:11 INFO - ##### 09:24:11 INFO - ##### Finished populate-webroot step (success) 09:24:11 INFO - ##### 09:24:11 INFO - ##### 09:24:11 INFO - ##### Running create-virtualenv step. 09:24:11 INFO - ##### 09:24:11 INFO - Running pre-action listener: _resource_record_pre_action 09:24:11 INFO - Running main action method: create_virtualenv 09:24:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:11 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 09:24:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:11 INFO - Using real prefix '/tools/python27' 09:24:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:12 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:15 INFO - Installing pip.................done. 09:24:15 INFO - Return code: 0 09:24:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:15 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')]} 09:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 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')]} 09:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:15 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 09:24:15 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 09:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:15 INFO - 'HOME': '/Users/cltbld', 09:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:15 INFO - 'LOGNAME': 'cltbld', 09:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:15 INFO - 'MOZ_NO_REMOTE': '1', 09:24:15 INFO - 'NO_EM_RESTART': '1', 09:24:15 INFO - 'PAGER': '/bin/cat', 09:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:15 INFO - 'PWD': '/builds/slave/test', 09:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:15 INFO - 'SHELL': '/bin/bash', 09:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:15 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:15 INFO - 'USER': 'cltbld', 09:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:15 INFO - 'XPC_FLAGS': '0x0', 09:24:15 INFO - 'XPC_SERVICE_NAME': '0', 09:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:15 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 09:24:15 INFO - Cleaning up... 09:24:15 INFO - Return code: 0 09:24:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:15 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')]} 09:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 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')]} 09:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:15 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:15 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>=3.1.1'] in /builds/slave/test/build 09:24:15 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>=3.1.1 09:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:15 INFO - 'HOME': '/Users/cltbld', 09:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:15 INFO - 'LOGNAME': 'cltbld', 09:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:15 INFO - 'MOZ_NO_REMOTE': '1', 09:24:15 INFO - 'NO_EM_RESTART': '1', 09:24:15 INFO - 'PAGER': '/bin/cat', 09:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:15 INFO - 'PWD': '/builds/slave/test', 09:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:15 INFO - 'SHELL': '/bin/bash', 09:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:15 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:15 INFO - 'USER': 'cltbld', 09:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:15 INFO - 'XPC_FLAGS': '0x0', 09:24:15 INFO - 'XPC_SERVICE_NAME': '0', 09:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:15 INFO - Downloading/unpacking psutil>=3.1.1 09:24:15 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 09:24:15 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 09:24:15 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 09:24:15 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 09:24:15 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 09:24:15 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 09:24:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:18 INFO - Installing collected packages: psutil 09:24:18 INFO - Running setup.py install for psutil 09:24:18 INFO - building 'psutil._psutil_osx' extension 09:24:18 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 09:24:18 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 09:24:18 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 09:24:18 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 09:24:19 INFO - building 'psutil._psutil_posix' extension 09:24:19 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 09:24:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:24:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:24:19 INFO - ^ 09:24:19 INFO - 1 warning generated. 09:24:19 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 09:24:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:19 INFO - Successfully installed psutil 09:24:19 INFO - Cleaning up... 09:24:19 INFO - Return code: 0 09:24:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:24:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:19 INFO - 'HOME': '/Users/cltbld', 09:24:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:19 INFO - 'LOGNAME': 'cltbld', 09:24:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:19 INFO - 'MOZ_NO_REMOTE': '1', 09:24:19 INFO - 'NO_EM_RESTART': '1', 09:24:19 INFO - 'PAGER': '/bin/cat', 09:24:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:19 INFO - 'PWD': '/builds/slave/test', 09:24:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:19 INFO - 'SHELL': '/bin/bash', 09:24:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:19 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:19 INFO - 'USER': 'cltbld', 09:24:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:19 INFO - 'XPC_FLAGS': '0x0', 09:24:19 INFO - 'XPC_SERVICE_NAME': '0', 09:24:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:22 INFO - Installing collected packages: mozsystemmonitor 09:24:22 INFO - Running setup.py install for mozsystemmonitor 09:24:22 INFO - Successfully installed mozsystemmonitor 09:24:22 INFO - Cleaning up... 09:24:22 INFO - Return code: 0 09:24:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24: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')]} 09:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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')]} 09:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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', '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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:24: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 blobuploader==1.2.4 09:24:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:22 INFO - 'HOME': '/Users/cltbld', 09:24:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:22 INFO - 'LOGNAME': 'cltbld', 09:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:22 INFO - 'MOZ_NO_REMOTE': '1', 09:24:22 INFO - 'NO_EM_RESTART': '1', 09:24:22 INFO - 'PAGER': '/bin/cat', 09:24:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:22 INFO - 'PWD': '/builds/slave/test', 09:24:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:22 INFO - 'SHELL': '/bin/bash', 09:24:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:22 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:22 INFO - 'USER': 'cltbld', 09:24:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:22 INFO - 'XPC_FLAGS': '0x0', 09:24:22 INFO - 'XPC_SERVICE_NAME': '0', 09:24:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:22 INFO - Downloading/unpacking blobuploader==1.2.4 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:25 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24: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 09:24:26 INFO - Downloading docopt-0.6.1.tar.gz 09:24:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:26 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:26 INFO - Running setup.py install for blobuploader 09:24:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:26 INFO - Running setup.py install for requests 09:24:26 INFO - Running setup.py install for docopt 09:24:27 INFO - Successfully installed blobuploader requests docopt 09:24:27 INFO - Cleaning up... 09:24:27 INFO - Return code: 0 09:24:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:27 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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:27 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 09:24:27 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 09:24:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:27 INFO - 'HOME': '/Users/cltbld', 09:24:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:27 INFO - 'LOGNAME': 'cltbld', 09:24:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:27 INFO - 'MOZ_NO_REMOTE': '1', 09:24:27 INFO - 'NO_EM_RESTART': '1', 09:24:27 INFO - 'PAGER': '/bin/cat', 09:24:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:27 INFO - 'PWD': '/builds/slave/test', 09:24:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:27 INFO - 'SHELL': '/bin/bash', 09:24:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:27 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:27 INFO - 'USER': 'cltbld', 09:24:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:27 INFO - 'XPC_FLAGS': '0x0', 09:24:27 INFO - 'XPC_SERVICE_NAME': '0', 09:24:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:27 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-mGJElR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:27 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-wp0ZtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:27 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-tCm89l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:27 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-J298eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:27 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-r2uyw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-h29lCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Ir4Y0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-VJWBRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ZQToH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-omQM24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-9guPMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-nZcndN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-4AlK9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Hg8VKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:28 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Iy9djk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:29 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Rr4anx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:29 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-8cNXlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:29 INFO - Running setup.py install for manifestparser 09:24:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Running setup.py install for mozcrash 09:24:29 INFO - Running setup.py install for mozdebug 09:24:29 INFO - Running setup.py install for mozdevice 09:24:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:29 INFO - Running setup.py install for mozfile 09:24:29 INFO - Running setup.py install for mozhttpd 09:24:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for mozinfo 09:24:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for mozInstall 09:24:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for mozleak 09:24:30 INFO - Running setup.py install for mozlog 09:24:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for moznetwork 09:24:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:30 INFO - Running setup.py install for mozprocess 09:24:30 INFO - Running setup.py install for mozprofile 09:24:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:31 INFO - Running setup.py install for mozrunner 09:24:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:31 INFO - Running setup.py install for mozscreenshot 09:24:31 INFO - Running setup.py install for moztest 09:24:31 INFO - Running setup.py install for mozversion 09:24:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:31 INFO - Cleaning up... 09:24:31 INFO - Return code: 0 09:24:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:31 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')]} 09:24:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:31 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')]} 09:24:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:31 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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:31 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 09:24:31 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 09:24:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:31 INFO - 'HOME': '/Users/cltbld', 09:24:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:31 INFO - 'LOGNAME': 'cltbld', 09:24:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:31 INFO - 'MOZ_NO_REMOTE': '1', 09:24:31 INFO - 'NO_EM_RESTART': '1', 09:24:31 INFO - 'PAGER': '/bin/cat', 09:24:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:31 INFO - 'PWD': '/builds/slave/test', 09:24:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:31 INFO - 'SHELL': '/bin/bash', 09:24:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:31 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:31 INFO - 'USER': 'cltbld', 09:24:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:31 INFO - 'XPC_FLAGS': '0x0', 09:24:31 INFO - 'XPC_SERVICE_NAME': '0', 09:24:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-iG5nMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-QZg3yH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-UOSFrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-gkrlS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-wQmMRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-_7W8pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-3Zi3OM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-N5YJzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-MCxUB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:32 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)) 09:24:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:32 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-y_pRfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HGnyA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:33 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-FYz9vZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:33 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HuM1wQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:33 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Z80TjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:33 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-lruORV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:33 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-speRja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:33 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)) 09:24:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:33 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-HCPMOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:33 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)) 09:24:33 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)) 09:24:33 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)) 09:24:33 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)) 09:24:33 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)) 09:24:33 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)) 09:24:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:33 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 09:24:33 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 09:24:33 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 09:24:33 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 09:24:33 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 09:24:33 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 09:24:36 INFO - Downloading blessings-1.6.tar.gz 09:24:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:36 INFO - Installing collected packages: blessings 09:24:36 INFO - Running setup.py install for blessings 09:24:36 INFO - Successfully installed blessings 09:24:36 INFO - Cleaning up... 09:24:36 INFO - Return code: 0 09:24:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:36 INFO - Reading from file tmpfile_stdout 09:24:36 INFO - Current package versions: 09:24:36 INFO - blessings == 1.6 09:24:36 INFO - blobuploader == 1.2.4 09:24:36 INFO - docopt == 0.6.1 09:24:36 INFO - manifestparser == 1.1 09:24:36 INFO - mozInstall == 1.12 09:24:36 INFO - mozcrash == 0.17 09:24:36 INFO - mozdebug == 0.1 09:24:36 INFO - mozdevice == 0.48 09:24:36 INFO - mozfile == 1.2 09:24:36 INFO - mozhttpd == 0.7 09:24:36 INFO - mozinfo == 0.9 09:24:36 INFO - mozleak == 0.1 09:24:36 INFO - mozlog == 3.2 09:24:36 INFO - moznetwork == 0.27 09:24:36 INFO - mozprocess == 0.22 09:24:36 INFO - mozprofile == 0.28 09:24:36 INFO - mozrunner == 6.11 09:24:36 INFO - mozscreenshot == 0.1 09:24:36 INFO - mozsystemmonitor == 0.3 09:24:36 INFO - moztest == 0.7 09:24:36 INFO - mozversion == 1.4 09:24:36 INFO - psutil == 3.1.1 09:24:36 INFO - requests == 1.2.3 09:24:36 INFO - wsgiref == 0.1.2 09:24:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:36 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')]} 09:24:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:37 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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:37 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 09:24:37 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 09:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:37 INFO - 'HOME': '/Users/cltbld', 09:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:37 INFO - 'LOGNAME': 'cltbld', 09:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:37 INFO - 'MOZ_NO_REMOTE': '1', 09:24:37 INFO - 'NO_EM_RESTART': '1', 09:24:37 INFO - 'PAGER': '/bin/cat', 09:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:37 INFO - 'PWD': '/builds/slave/test', 09:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:37 INFO - 'SHELL': '/bin/bash', 09:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:37 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:37 INFO - 'USER': 'cltbld', 09:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:37 INFO - 'XPC_FLAGS': '0x0', 09:24:37 INFO - 'XPC_SERVICE_NAME': '0', 09:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 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)) 09:24:37 INFO - Cleaning up... 09:24:37 INFO - Return code: 0 09:24:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:37 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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:37 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 09:24:37 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 09:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:37 INFO - 'HOME': '/Users/cltbld', 09:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:37 INFO - 'LOGNAME': 'cltbld', 09:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:37 INFO - 'MOZ_NO_REMOTE': '1', 09:24:37 INFO - 'NO_EM_RESTART': '1', 09:24:37 INFO - 'PAGER': '/bin/cat', 09:24:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:37 INFO - 'PWD': '/builds/slave/test', 09:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:37 INFO - 'SHELL': '/bin/bash', 09:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:37 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:37 INFO - 'USER': 'cltbld', 09:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:37 INFO - 'XPC_FLAGS': '0x0', 09:24:37 INFO - 'XPC_SERVICE_NAME': '0', 09:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:37 INFO - Downloading/unpacking jsonschema 09:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:40 INFO - Downloading/unpacking functools32 (from jsonschema) 09:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:40 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:40 INFO - warning: no files found matching '*.txt' 09:24:40 INFO - no previously-included directories found matching 'build' 09:24:40 INFO - no previously-included directories found matching 'dist' 09:24:40 INFO - no previously-included directories found matching '.git*' 09:24:40 INFO - Installing collected packages: jsonschema, functools32 09:24:40 INFO - Running setup.py install for functools32 09:24:41 INFO - warning: no files found matching '*.txt' 09:24:41 INFO - no previously-included directories found matching 'build' 09:24:41 INFO - no previously-included directories found matching 'dist' 09:24:41 INFO - no previously-included directories found matching '.git*' 09:24:41 INFO - Successfully installed jsonschema functools32 09:24:41 INFO - Cleaning up... 09:24:41 INFO - Return code: 0 09:24:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:24:41 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')]} 09:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:41 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')]} 09:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:41 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 0x10686ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106874570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd218c501e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, '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.rwd9yybnA4/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.HnFSoWbnRy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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 09:24:41 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 09:24:41 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 09:24:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:24:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:24:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:24:41 INFO - 'HOME': '/Users/cltbld', 09:24:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:24:41 INFO - 'LOGNAME': 'cltbld', 09:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:41 INFO - 'MOZ_NO_REMOTE': '1', 09:24:41 INFO - 'NO_EM_RESTART': '1', 09:24:41 INFO - 'PAGER': '/bin/cat', 09:24:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:41 INFO - 'PWD': '/builds/slave/test', 09:24:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:24:41 INFO - 'SHELL': '/bin/bash', 09:24:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:24:41 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:24:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:24:41 INFO - 'USER': 'cltbld', 09:24:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:24:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:41 INFO - 'XPC_FLAGS': '0x0', 09:24:41 INFO - 'XPC_SERVICE_NAME': '0', 09:24:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:41 INFO - Downloading/unpacking flake8 09:24:41 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 09:24:41 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 09:24:41 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 09:24:41 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 09:24:41 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 09:24:41 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 09:24:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:24:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:24:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 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 09:24:44 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 09:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:45 INFO - no previously-included directories found matching 'docs/_build' 09:24:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:24:45 INFO - Running setup.py install for pep8 09:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:24:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:24:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:24:45 INFO - no previously-included directories found matching 'docs/_build' 09:24:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:24:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:24:45 INFO - Cleaning up... 09:24:45 INFO - Return code: 0 09:24:45 INFO - Running post-action listener: _resource_record_post_action 09:24:45 INFO - Running post-action listener: _start_resource_monitoring 09:24:45 INFO - Starting resource monitoring. 09:24:45 INFO - ##### 09:24:45 INFO - ##### Finished create-virtualenv step (success) 09:24:45 INFO - ##### 09:24:45 INFO - ##### 09:24:45 INFO - ##### Running install step. 09:24:45 INFO - ##### 09:24:45 INFO - Running pre-action listener: _resource_record_pre_action 09:24:45 INFO - Running main action method: install 09:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:45 INFO - Reading from file tmpfile_stdout 09:24:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:45 INFO - Reading from file tmpfile_stdout 09:24:45 INFO - Output received: 09:24:45 INFO - Usage: mozinstall [options] installer 09:24:45 INFO - Options: 09:24:45 INFO - -h, --help show this help message and exit 09:24:45 INFO - -d DEST, --destination=DEST 09:24:45 INFO - Directory to install application into. [default: 09:24:45 INFO - "/builds/slave/test"] 09:24:45 INFO - --app=APP Application being installed. [default: firefox] 09:24:45 INFO - mkdir: /builds/slave/test/build/application 09:24:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:24:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:25:19 INFO - Reading from file tmpfile_stdout 09:25:19 INFO - Output received: 09:25:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:25:19 INFO - Running post-action listener: _resource_record_post_action 09:25:19 INFO - ##### 09:25:19 INFO - ##### Finished install step (success) 09:25:19 INFO - ##### 09:25:19 INFO - ##### 09:25:19 INFO - ##### Running run-tests step. 09:25:19 INFO - ##### 09:25:19 INFO - Running pre-action listener: _resource_record_pre_action 09:25:19 INFO - Running main action method: run_tests 09:25:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:19 INFO - 2016-05-27 09:25:19.483 screenresolution[1650:8258] starting screenresolution argv=screenresolution get 09:25:19 INFO - 2016-05-27 09:25:19.485 screenresolution[1650:8258] Display 0: 1600x1200x32@60 09:25:19 INFO - 2016-05-27 09:25:19.490 screenresolution[1651:8261] starting screenresolution argv=screenresolution list 09:25:19 INFO - Available Modes on Display 0 09:25:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:19 INFO - Intel Iris: 09:25:19 INFO - Chipset Model: Intel Iris 09:25:19 INFO - Type: GPU 09:25:19 INFO - Bus: Built-In 09:25:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:19 INFO - Vendor: Intel (0x8086) 09:25:19 INFO - Device ID: 0x0a2e 09:25:19 INFO - Revision ID: 0x0009 09:25:19 INFO - Displays: 09:25:19 INFO - Display: 09:25:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:19 INFO - Display Serial Number: 1600x1200 60 09:25:19 INFO - Main Display: Yes 09:25:19 INFO - Mirror: Off 09:25:19 INFO - Online: Yes 09:25:19 INFO - Rotation: Supported 09:25:19 INFO - Return code: 0 09:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:19 INFO - Python 2.7.3 09:25:19 INFO - Return code: 0 09:25:19 INFO - grabbing minidump binary from tooltool 09:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:25:19 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106712d30>, '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 0x106536db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106709b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:19 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 09:25:19 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 09:25:19 INFO - Calling ['/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'] with output_timeout 600 09:25:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:19 INFO - Return code: 0 09:25:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:25:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:25:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:25:20 INFO - Return code: 0 09:25:20 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/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--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 09:25:20 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/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --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 09:25:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rwd9yybnA4/Render', 09:25:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:25:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:25:20 INFO - 'HOME': '/Users/cltbld', 09:25:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:25:20 INFO - 'LOGNAME': 'cltbld', 09:25:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:20 INFO - 'MOZ_NO_REMOTE': '1', 09:25:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:20 INFO - 'NO_EM_RESTART': '1', 09:25:20 INFO - 'PAGER': '/bin/cat', 09:25:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:20 INFO - 'PWD': '/builds/slave/test', 09:25:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:25:20 INFO - 'SHELL': '/bin/bash', 09:25:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HnFSoWbnRy/Listeners', 09:25:20 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 09:25:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:25:20 INFO - 'USER': 'cltbld', 09:25:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:25:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:20 INFO - 'XPC_FLAGS': '0x0', 09:25:20 INFO - 'XPC_SERVICE_NAME': '0', 09:25:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:25:20 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/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--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 09:25:21 INFO - mozversion application_buildid: 20160527062742 09:25:21 INFO - mozversion application_changeset: dd3e899cfa818fcbb47b3d7432e0977e835702ee 09:25:21 INFO - mozversion application_display_name: Nightly 09:25:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:21 INFO - mozversion application_name: Firefox 09:25:21 INFO - mozversion application_remotingname: firefox 09:25:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:25:21 INFO - mozversion application_vendor: Mozilla 09:25:21 INFO - mozversion application_version: 49.0a1 09:25:21 INFO - mozversion platform_buildid: 20160527062742 09:25:21 INFO - mozversion platform_changeset: dd3e899cfa818fcbb47b3d7432e0977e835702ee 09:25:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:25:21 INFO - mozversion platform_version: 49.0a1 09:25:21 INFO - using testdate: 1464366321 09:25:21 INFO - actual date: 1464366321 09:25:21 INFO - starting webserver on 'localhost:49280' 09:25:21 INFO - SUITE-START | Running 2 tests 09:25:21 INFO - TEST-START | dromaeo_css 09:25:21 INFO - operating with platform_type : mac_ 09:25:21 INFO - Initialising browser for dromaeo_css test... 09:25:21 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp8knz2Q/profile http://localhost:49280/getInfo.html) 09:25:24 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 09:25:24 INFO - PROCESS | 1669 | colorDepth:24 09:25:24 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 09:25:24 INFO - PROCESS | 1669 | __metrics 09:25:24 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:25:24 INFO - TEST-INFO | 1669: exit 0 09:25:24 INFO - Browser initialized. 09:25:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:24 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp8knz2Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:36 INFO - PROCESS | 1673 | RSS: Main: 252608512 09:25:36 INFO - PROCESS | 1673 | 09:26:26 INFO - PROCESS | 1673 | 1464366386512 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] 09:28:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 09:28:38 INFO - PROCESS | 1673 | RSS: Main: 266530816 09:28:38 INFO - PROCESS | 1673 | 09:31:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 09:31:41 INFO - PROCESS | 1673 | RSS: Main: 277884928 09:31:41 INFO - PROCESS | 1673 | 09:34:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 09:34:43 INFO - PROCESS | 1673 | RSS: Main: 279998464 09:34:43 INFO - PROCESS | 1673 | 09:37:45 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 09:37:46 INFO - PROCESS | 1673 | RSS: Main: 281513984 09:37:46 INFO - PROCESS | 1673 | 09:40:49 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 09:40:49 INFO - PROCESS | 1673 | RSS: Main: 284983296 09:40:49 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 09:43:52 INFO - PROCESS | 1673 | RSS: Main: 285286400 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | __start_tp_report 09:43:52 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 09:43:52 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 09:43:52 INFO - PROCESS | 1673 | |i|pagename|runs| 09:43:52 INFO - PROCESS | 1673 | |0;dojo.html;3117.2206948262933;3439.29494453637;3498.1429549760305;3522.2251104756942;3528.717702583792;4374.868753937387;4537.773111344436;5730.025895597748;5812.360640329561;5858.945389829829;5617.859553511164;5770.884582308351;5796.3334216565;5820.330661973874;5861.824145275638;5175.171972484412;5226.895462090756;5241.633085684004;5332.840014799563;5383;5371.301730774994;5451.536619387357;5459.426760190182;5465.125579907216;5471.890562188753;5163.948360516403;5256.053910296145;5292.550133238679;5295.576353891679;5362.4637536246455;5332.706701131437;5337.11937530307;5349.197620356938;5362.1420572708175;5370.301860758115;4374.671899607542;5184.559312458446;5282.683039017671;5295.576353891679;5368.979893820162;5585.720713964285;5716.685582292972;5734.885302293931;5812.128180772876;5840.386759390288;4853.3690620219495;6151.569390142692;6238.4697300729495;6331.176946996861;6341.239051313872;5112.386513618352;6188.412100850412;6276;6282.748690052393;6283;5971.910421343683;6035.7283922223605;6047.304559975615;6050.122732203894;6084.056971169476;6308.635075252465;6324.557280990379;6342.873142537123;6370.649614271167;6417.262014868256;6103.519504250378;6117.3402608778015;6133.478654314434;6148.1392605035335;6160;6239.126522286883;6251.343608920998;6256.405641464054;6284.685765711696;6299.212598425197;6094.756209751649;6128.754849806047;6136.969315153396;6185.505159587222;6190.938090619036;6098.207233059763;6122.051082082285;6211.254649442006;6226.968865155736;6247.969085100907;4348.326009468537;5010.3737032870895;5059.291699162047;5067.493250674903;5068.23976403535;4530.728156310632;4542.1824071667415;4547.704399214041;4548.363229147922;4559.726416415026;5717.685527295956;5881.676507792113;5910.8817823643285;6019.60872543292;6023.69881505923;6293.653849038347;6295.527835412362;6301.495880329563;6312.400321969406;6328.019157030575;5945.16767652529;5949.315828679757;5952.7321270542925;5960.493358064527;6000;5411.107167317427;5435.592330575223;5453.7818487260065;5497.257870187474;5503.972480137573;6388.904166437507;6433.163688720437;6440.61356318613;6449.516286278642;6467.062275969958;6267.6866156692895;6282.905756413749;6298.149749783721;6298.874022519432;6300.9684951574945;6249.406306400884;6338.239411270677;6381.968090159519;6439.452646525097;6442.452391546771;6217.658028808278;6218.06728990655;6284.5600807943;6292.244930608356;6297.937020629735;6182.196314479269;6279.340669229848;6281.183446152154;6289.528285378524;6295.118683384421;6141.662208578571;6149.877002460015;6155.47678447337;6185.855616710923;6208.1308616792785;6179.16581261524;6185.567010309415;6245.375462453719;6246.281677607133;6270.905936410866;5801.680907549957;5973.193618861398;6058.3335833057445;6168.814935551941;6191.226096737908;6162.414570615784;6180;6253.96873015632;6287.74849006053;6297.653629050446;6184.969075154775;6185.072239164161;6199.5660303780105;6214.782482613087;6222.719977600928 09:43:52 INFO - PROCESS | 1673 | |1;ext.html;516.4396629656823;518.486698168813;533.1629341933167;554.1991821817475;563.4168635462297;36437.271254574924;37614;39698.60301396985;39802.203955920864;41711.331546738096;29400;33681.49477757836;39898.40152397716;41044.79477602615;41503.79248103763;8500.404971651988;9235.861462078074;9374.484403357812;9638;9667.178289845371;9418.952905235465;9434.622615095388;9528.333016688835;9557.665481708142;9564.473953932531;9564.18704410126;9637.518124093802;9642.807143857119;9669.806603867919;9670.081342272508;9552.61789528418;9627.422354658744;9633.903660963371;9635.421874687507;9645.614175432975;9303.162715355582;9350.625974960993;9421.811563768755;9490.572924218426;9497.857532137023;31189.688103119133;37426.625733742585;37795.811020944995;38203.61796382028;38253.617463825285;3273.29624130813;3306.3056758080834;3485.19840436701;3487.4943133245793;3608.1520842601967;30216.697833021608;30905.536416953764;31012.0696379109;31074.844625776954;31324.530132048036;3200.9839950800097;3219.983900080508;3247.171971147366;3285.9342813143844;3294.0941241158635;452148;453925;454418.72790636163;454963;455628;30093.49532523409;31782;33671.66328336734;33876.661233387844;33893.49159762605;31134.688653113633;34861.82569087138;35035.824820876245;35251.94244172628;36875.81562092173;17090.974541527547;17196.31214751421;17223;17243.930728312433;17244.396446124327;12631.873681263254;12820;12986.155899866479;13099.738005240033;13110.213387196607;19158.23367065302;19798;19805.900970495055;19874.304399345954;19947.900260498605;8424.536650484282;8450.690143027841;8501.107383724744;8556.443831150955;8567;959.6881013670445;1069.994650026745;1116.385987706758;1137.6928229378022;1166.416791604198;29990.55014174789;30477.08568742941;30572.54141187884;30882.69117308843;31208.531872021937;1016.2022812092472;1085.375908852413;1125.8874112588676;1173.1260211142753;1223.7124275795181;15534.456294029655;15537.446255374598;15880;16059.598510037342;16261.918690406472;603037;634335;640384.7980760066;641846;642416;60191;60342.69828650829;60582.091268631004;60634;61038.474038149405;1376.126159888478;1399.4122468563228;1420.6448387902817;1427.6216802547333;1437.094630382852;30237.848810755804;30809.383812324075;30917.381652367276;31101.844490777403;31119.844400777853;41417.58582414137;49608.75195623999;50035;50388.496115039845;50451.74774126106;541434;542848;543080;547257;548560;25907.48185036251;25943.351416214744;25979.350516237246;26036;26088.73911260863;34611.78858739932;39988.60011399849;44521.77739111284;45788;45961.77019114883;35549.82225088858;36560.81719591385;36716.81641591775;38271.6172838268;38816.2236755269;36961;37282.440763388026;37747;38033.619663804115;38246.80876595599;31124.68875311218;37039;37326.440103399014;39190.60809391984;39876.60123398729;27769.861150694116;32283.35433291368;33514.83242583772;33788.607481028295;34118.8294058538;24573.38566535851;24800.875995619906;24802.751972480044;25211.49577008413;25505.48989020246 09:43:52 INFO - PROCESS | 1673 | |2;jquery.html;383.9462475253465;390.22734984730243;390.34829173085797;390.36760448074114;407.6718241815339;14239.78640320396;15500.612484687888;15808.367665293403;21170.30637548994;21171.788282117173;19511.804881951175;19882.602347953034;20169.798302016974;21367.252146174887;21428.785712142875;5904.114382842587;5940.584159108864;6111.236095488064;6131.264248290211;6138.938610613904;6064.484518815906;6085.269767627891;6094.756209751627;6106.81679549612;6127.601705889125;5721.31344238692;6003.159557661931;6067.24159480065;6112.81661550152;6153.90769138461;5957.612755170921;6060.969635162033;6076.756929722828;6132.632042077467;6227.470664993481;5965.3736357682255;5974.133750606181;5993.250843644544;6019.969900150471;6080.756769729205;12826.871731282661;13254.40355184019;13440.798388024188;13456.865431345659;13485.258310792902;2086.613976414353;2177.945551361229;2194.5391467791783;2227.9108835646716;2291.32405940248;10107.989201079834;10212.846807297896;10440.634577789817;12933;12992.155509891827;1803.9909800450914;1811.7282407638827;1897.7722673279295;1918.2902326139417;1936.1674479973606;81844;94720;118314.40842795817;119367.20949185769;121278.39360803227;9466.574004169828;11238.494267757807;11418.086553075735;11555.711107222218;11559;14718.043327183914;14720.631984200267;14727.92636036813;14734.484293049692;14747.410103595736;7004.544704594185;8476.406651534457;8550.315974722007;8727.781805454915;8758;6926.861462770717;8654.134586541422;8662.436941598777;8747.650093996295;8758.86861697075;4261.296886013835;4337.501187363494;4530.637548996073;4552.359631413772;4668.6498512611015;1923.9995202494624;1984.6328429240637;1987.1058023889307;2008.9799102009085;2022.7572691277142;847.7965288330756;981.896900825403;1009.9444530550743;1011.549860312154;1015.2791518022287;19656.410307690792;20851.374458766262;20924.476888077614;21066.84132372734;21090.367288981353;970.3741086998988;975.3221511049894;1001.7746007148334;1055.0030221440666;1069.4759567811716;10727.731806704895;10987.230893837355;11106.278091924;11112.999830015337;11115.44422778874;598934;617612;627310;640221;642351;121449;132317.33841330733;135159.32420337835;147219;153842;438.6074463355279;456.5320546439926;457.9427571553556;459.26288307266356;459.85054857171554;10172.440515771408;10980.286281391684;11214.83177752318;11216.55133794639;11390.487428065922;53600.19599706086;55025.44974550203;56437;56782;57331.14003289871;78669;79142.6042869782;79560.60219699096;80732.19267807482;81198.59400702959;7819.530828150329;8145.185481451807;8262.462939908886;8517.063123056334;8531.018932822557;11680.007199388147;12946.029047821263;13029;13152.408141633457;13290.20258784476;10529.631147950717;10576.4711764413;11152.996230339308;11232.943835280772;11439.771204576029;10070.19438444908;10695.465226738477;10735.94632026835;10903.236773425784;10938.835917461403;11311.981921627093;11498.77002459963;11521.308721476738;11633.6509904703;11644.2431241969;6561.934380656132;8215.917840821516;8359.498430094214;8550;8677.826443470969;10501.002404771534;10636.41499717523;10898.12814974816;10922.56309747633;10924.563017479211 09:43:52 INFO - PROCESS | 1673 | |3;mootools.html;1387.7363300972816;1551.7051760165568;1769.6991511443052;1917.4822797844583;1947.1627200303863;7964.522128672269;8668.696595619147;8676.392652514327;9185.54072296385;9208.815823683532;8831.558422078902;8929.196372326489;9060.909390906088;9075.773105672362;9075.910890693109;1995.8902260375673;2388.199953015742;2433.07543133609;2435.8903849326734;2439.792617627495;1976.2391479280436;2380.6310021946624;2390.796782273509;2391.928242152738;2436.914707985221;2387.7254115776645;2404.843685160468;2410.8794560272004;2413.2036427978815;2432.2946345559853;1899.4396652987402;2399;2401.819863510235;2406.121765555577;2420.7337192908767;2376.726676432198;2385.8926348314367;2389.976100238993;2391.342380845264;2391.4141035446255;8898.37711360205;8952.015278319379;8997.910020899839;9032.909670903338;9059.365844390895;5248.134057880445;5273.472652734734;5403.864903377408;5415.10650742627;5415.214793854869;3473.6873681368547;3586.1751797086554;3631.237440137574;3658.2317713280245;3665.486831843544;1067.5622994572266;1071.9035286824146;1083.2363183955292;1086.5490821309147;1087.6954452753162;11543.191976561644;11697.005754510878;11950.641480755592;11970.58102966392;11987.94006029973;4016;4369.47566292047;4742.810287588527;4866.732329721899;4879.365682461328;8178.386621003448;9956.303058785816;9960.601575936882;9979.80040399188;9985;4570;5379.67721936685;5409.486098820606;5414.7021913795115;5429.239906413105;4462.509123996358;4819.807207711652;4849.927251091236;4961.578265847371;5003.974980125149;4003.01926028125;4018.2566225248424;4057.776822274803;4095.692823038284;4130.648894843912;1329.3486191765965;1331.5206525650758;1343.355189509041;1356.3828458051562;1357.7080927600416;879.1691851200554;962.3888830592624;966.7534778631403;980.1619615228876;1007.9748006299754;5060.291559181717;5135.589152867761;6021.849453763691;6171.444569988723;6189.84525386869;420.9031922657806;442.15106994570505;460.67062050633956;461.8822200338892;471.24365393543553;3451.7583769135917;4072.3280658690983;4083.244599749056;4124.546299907008;4124.6906482013965;8886.4668119913;10466;10861.239713219999;10863.45682715861;10896.673099807018;10691.679249622524;10762.892371076345;10816.621418250323;10820.837687434694;10825.83761243582;8158.469699469515;8161.918380816234;8284.295834853985;8305.543195124326;8339.12439193888;5902.350741418355;5908.468237858613;5953.583249172516;5970.104484327386;6045.909311360245;8349.415540912078;10063.194944404577;10188.388696678223;10189.643362482277;10190.592376304865;8184.468009579358;9768.316217864682;10406.531706073396;10409.635662751767;10428.791424171626;6958.234594194533;7481;7551.773446796605;7734.458587898793;7820.687172513036;8494.660213591635;8524.872126917977;8601.741947741577;8605.82788344217;8677.1756683115;7565.735199268;7730.613469326398;7744.922550774646;7791.727289544839;7799.610019499116;7460.515066520658;7528.360089392463;7575.393968482618;7655.655495502604;7706.653200606098;7163.7492687755675;7172.748953786592;7239.420846332386;7254.528455650366;7285.526440781332;5038.974805125951;5114.71869047206;5148.5584036469845;5201.141811601044;5211.296474975829;5066.670666406671;5074.3657042869645;5077.974610126926;5104.0812653721205;5117.641765076409 09:43:52 INFO - PROCESS | 1673 | |4;prototype.html;274.57989276407096;315.82945209586825;320.5448263465878;320.91495753625287;323.3807259098826;4865.370101016159;5308.256844041827;5437.85804980954;5813.970930145343;5827.698059266592;4628;5190.92213616796;5204.635675502707;5648.971755141229;5767.480926716595;3766.962330376702;4045.939310910331;4129.926219183019;4197.265478541259;4280.5291417944;3795.905102372449;3920.568992317812;4132.297509423405;4298.183345164424;4316.223079845627;4297.441332626754;4332.501762297345;4346.9136912791955;4382.641381171847;4432.3794668746405;3060.9540856887165;3903.512060992376;4232.555581663943;4282.978585107086;4321.58944900234;3340.4321265384942;3686.631336866292;3688.598332633609;3693.7045036397026;3711.5731690855628;4397.053973837536;5046.394432668067;5521.972390138064;5547.697705452232;5563.36021357541;4440.666949978765;4578.161539845284;4864.975675121602;4887.193613053842;5015.699058056528;4856.732879691615;5904.527637788967;5958.285005799332;5995.52035837132;6020.307664618581;3986.8405263789414;4020.015096301425;4115.773632450214;4166.270902592065;4212.978935105305;5636.71816409182;5885.264341957255;6257.968710156466;6330.366963303679;6334.018227174749;3473.8784142555396;4145;4156.189543039079;4158.08522125132;4166.58334166587;3487.093355727529;3579.319929213441;4148.875533733993;4242.363645453207;4252.340887162495;4217.957820421818;4623.514530974267;4696.1546921554445;4998.525140111684;5011.899762004739;4805.879853003703;5308.495692909168;5311.7344132793205;5896.587238893237;6068.6358818471035;1236.3879879459546;1410.2737090398452;1460.5545308680742;1460.7881857130656;1477.837437881832;813;875.65411662393;901.2204443156622;919.6689191890914;967.666155176463;4446.466424029072;4957.603391728653;5119.385673719177;5349.946500534945;5578.191162281528;5337.359516857924;5975.43233392827;6022.5483088768515;6168.686742471573;6200;4865.318855360252;4906.681065730788;5420.945790542044;5518.764900215419;5632.887342253132;2771.6973022679713;2914.3588410549646;2947.985260073686;2997.8608128910873;3094.628644562667;5673.687947162863;6111.54163437744;6358.904616430757;6360.554761166766;6404.815109204812;6023.379829774062;6164.167837341991;6342.746290148342;6348.936510634834;6377.034678874253;5557.638753481011;6323.494120470259;6367.904481432783;6404.445532729287;6410.076976906909;5323.463597858184;5769.624974376652;6129.498272922984;6177.876442471215;6206.262246570967;5154.433012368711;5420.403755586961;5497.972510137423;5726.942730572641;6095.847603809941;5026.949730502648;5613.242212301287;5634.352049514358;5646.774129034792;6002.709417475264;3984.3664097719798;4020.638142567183;4038.4548086008012;4059.2287465381482;4073.5926407359025;5506.449355064461;5520.806771762969;5562.888742225214;6314.6842657866;6371.585846919936;5280.313559237275;5819.566455791103;6099.176611157614;6112.755489780359;6161.661108639068;5294.523492885504;5313.495217954288;5964.97017514927;6015.278166619859;6043.7884674036195;4957.405111386656;5056.519630635084;5406.567474602101;5576.498115169654;5903.409659034062;5013.448520662651;5117.974410127926;5930;5984.401559844155;6070;5028.899422011613;5136.768845401891;5734.799282025109;5789.45000224978;6045.607035542852 09:43:52 INFO - PROCESS | 1673 | |5;yui.html;655.4559715436188;715.2454160860293;722.9277072292768;791.9802004949877;812.3176531713359;12646.747065058706;14384.352704128312;15287.541373758804;16112.46229214242;16567.337306507725;13594.320283985811;15538.533843984698;15812.9721568098;15829.050256984588;15851.920740396281;819.5615345790004;851.9105493923141;907.6278725722472;910.8223896340216;911.0297533127232;724.337231433238;892.0455113029061;913.8903331600218;915.8580420034905;916.4043371808344;934.8364036293656;954.7613096725819;957.5643082397493;962.9855552166723;963.9662611808589;928.109015345266;956.7225504603657;958.6932181701858;959.7504648791364;964.9903500965006;625.7966160997694;688.1535711075355;708.2669437132595;710.5097482736895;714.8927660850862;14888.553343399608;14896.255187240704;14913.956023078388;14946;14970.17664028478;13749.725005499835;13806;13830.86169138316;13857.514986975408;13969.231692256923;11697.473613687405;11823.94088029563;11829.290242585386;12018.69953251167;12131.636050918487;3738.2336620992633;3818.8090595470117;3818.866339678098;3824.5601755797884;3949.6840252779707;50170.7491462544;59979;78618;80203.5989820053;80486;10663.73340666474;10685.78628427427;10690.358578485315;10792.56829726802;10918.727031824268;17480.21339039721;20577.176912923616;20737.79262207389;21017.579648406947;21043.263485778232;7714.421418393531;7748.883766743504;7850.725224617111;8007.1592482788465;8094.635741391651;3843.5003449551377;3848.288066707668;4438.5561443856;4512.278035514302;4534.229181039232;3442.9483557746653;3447.1554469155217;3483.0943954571485;3520.718342532591;3538.15084379747;557.4731878374897;648.2739331948248;660.4815220052236;672.8385187554951;678.2573082474682;555.3668817547917;685.869684759894;701.7473709464589;712.6508011074536;719.4388377065897;9005.414648047987;9419.576119074658;9508.952455237679;9569.952150239344;9575;587.8530367408148;672.4452326830384;681.5501768832547;697.476892330752;706.0856191232366;3814.6566808987322;4302.161078589707;4353.791730489991;4362.8036738346855;4448.399466072104;88376;89768;90955;91222.08777912268;91499.54250228706;62397;75322.24677753262;76643.61678191573;78550.60724696454;79621.4075718494;71366.286337137;71497.64251178711;71508;71841.28158718556;71922;7687.769366919001;8458.492490450593;8800.17986060808;8848.911510885066;8944.731658050268;34811.65188348084;45198.77400612976;46507;46777.76611116923;46873;61609;63212;63349.68325158345;63997.360026401;64337.67831160814;11472.024877885473;11596.594119205787;11662.941685291858;11707.824382634097;12190.51237950472;12229.082818788449;12503.812442813547;12520.373981301082;13049.217046977212;13223.603291901258;11722;11845.466953987263;11887.465064071965;11932.343721095076;12165.330906799856;11727.488080602445;11968.521259149536;12084.154109212623;12111.333876636869;12401.317927514074;11576.47905844256;11747.471363788822;12259.264444133381;12615.432305546088;12647.304398258184;11010.559577616805;11086;11088.778224435628;11105.499772245492;11593.884061159617;9450.810983780148;10685.8931410688;11310.717232069264;11344.659660210207;11375.886241137483 09:43:52 INFO - PROCESS | 1673 | __end_tp_report 09:43:52 INFO - PROCESS | 1673 | __start_cc_report 09:43:52 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,419 09:43:52 INFO - PROCESS | 1673 | __end_cc_report 09:43:52 INFO - PROCESS | 1673 | __startTimestamp1464367432577__endTimestamp 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | ------- Summary: start ------- 09:43:52 INFO - PROCESS | 1673 | Number of tests: 6 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | [#0] dojo.html Cycles:165 Average:5798.64 Median:6103.52 stddev:666.29 (10.9%) stddev-sans-first:634.26 09:43:52 INFO - PROCESS | 1673 | Values: 3117.2 3439.3 3498.1 3522.2 3528.7 4374.9 4537.8 5730.0 5812.4 5858.9 5617.9 5770.9 5796.3 5820.3 5861.8 5175.2 5226.9 5241.6 5332.8 5383.0 5371.3 5451.5 5459.4 5465.1 5471.9 5163.9 5256.1 5292.6 5295.6 5362.5 5332.7 5337.1 5349.2 5362.1 5370.3 4374.7 5184.6 5282.7 5295.6 5369.0 5585.7 5716.7 5734.9 5812.1 5840.4 4853.4 6151.6 6238.5 6331.2 6341.2 5112.4 6188.4 6276.0 6282.7 6283.0 5971.9 6035.7 6047.3 6050.1 6084.1 6308.6 6324.6 6342.9 6370.6 6417.3 6103.5 6117.3 6133.5 6148.1 6160.0 6239.1 6251.3 6256.4 6284.7 6299.2 6094.8 6128.8 6137.0 6185.5 6190.9 6098.2 6122.1 6211.3 6227.0 6248.0 4348.3 5010.4 5059.3 5067.5 5068.2 4530.7 4542.2 4547.7 4548.4 4559.7 5717.7 5881.7 5910.9 6019.6 6023.7 6293.7 6295.5 6301.5 6312.4 6328.0 5945.2 5949.3 5952.7 5960.5 6000.0 5411.1 5435.6 5453.8 5497.3 5504.0 6388.9 6433.2 6440.6 6449.5 6467.1 6267.7 6282.9 6298.1 6298.9 6301.0 6249.4 6338.2 6382.0 6439.5 6442.5 6217.7 6218.1 6284.6 6292.2 6297.9 6182.2 6279.3 6281.2 6289.5 6295.1 6141.7 6149.9 6155.5 6185.9 6208.1 6179.2 6185.6 6245.4 6246.3 6270.9 5801.7 5973.2 6058.3 6168.8 6191.2 6162.4 6180.0 6254.0 6287.7 6297.7 6185.0 6185.1 6199.6 6214.8 6222.7 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | [#1] ext.html Cycles:180 Average:66174.43 Median:36638.82 stddev:146737.83 (400.5%) stddev-sans-first:147066.66 09:43:52 INFO - PROCESS | 1673 | Values: 516.4 518.5 533.2 554.2 563.4 36437.3 37614.0 39698.6 39802.2 41711.3 29400.0 33681.5 39898.4 41044.8 41503.8 8500.4 9235.9 9374.5 9638.0 9667.2 9419.0 9434.6 9528.3 9557.7 9564.5 9564.2 9637.5 9642.8 9669.8 9670.1 9552.6 9627.4 9633.9 9635.4 9645.6 9303.2 9350.6 9421.8 9490.6 9497.9 31189.7 37426.6 37795.8 38203.6 38253.6 3273.3 3306.3 3485.2 3487.5 3608.2 30216.7 30905.5 31012.1 31074.8 31324.5 3201.0 3220.0 3247.2 3285.9 3294.1 452148.0 453925.0 454418.7 454963.0 455628.0 30093.5 31782.0 33671.7 33876.7 33893.5 31134.7 34861.8 35035.8 35251.9 36875.8 17091.0 17196.3 17223.0 17243.9 17244.4 12631.9 12820.0 12986.2 13099.7 13110.2 19158.2 19798.0 19805.9 19874.3 19947.9 8424.5 8450.7 8501.1 8556.4 8567.0 959.7 1070.0 1116.4 1137.7 1166.4 29990.6 30477.1 30572.5 30882.7 31208.5 1016.2 1085.4 1125.9 1173.1 1223.7 15534.5 15537.4 15880.0 16059.6 16261.9 603037.0 634335.0 640384.8 641846.0 642416.0 60191.0 60342.7 60582.1 60634.0 61038.5 1376.1 1399.4 1420.6 1427.6 1437.1 30237.8 30809.4 30917.4 31101.8 31119.8 41417.6 49608.8 50035.0 50388.5 50451.7 541434.0 542848.0 543080.0 547257.0 548560.0 25907.5 25943.4 25979.4 26036.0 26088.7 34611.8 39988.6 44521.8 45788.0 45961.8 35549.8 36560.8 36716.8 38271.6 38816.2 36961.0 37282.4 37747.0 38033.6 38246.8 31124.7 37039.0 37326.4 39190.6 39876.6 27769.9 32283.4 33514.8 33788.6 34118.8 24573.4 24800.9 24802.8 25211.5 25505.5 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | [#2] jquery.html Cycles:180 Average:35295.24 Median:21171.05 stddev:104371.16 (493.0%) stddev-sans-first:104631.03 09:43:52 INFO - PROCESS | 1673 | Values: 383.9 390.2 390.3 390.4 407.7 14239.8 15500.6 15808.4 21170.3 21171.8 19511.8 19882.6 20169.8 21367.3 21428.8 5904.1 5940.6 6111.2 6131.3 6138.9 6064.5 6085.3 6094.8 6106.8 6127.6 5721.3 6003.2 6067.2 6112.8 6153.9 5957.6 6061.0 6076.8 6132.6 6227.5 5965.4 5974.1 5993.3 6020.0 6080.8 12826.9 13254.4 13440.8 13456.9 13485.3 2086.6 2177.9 2194.5 2227.9 2291.3 10108.0 10212.8 10440.6 12933.0 12992.2 1804.0 1811.7 1897.8 1918.3 1936.2 81844.0 94720.0 118314.4 119367.2 121278.4 9466.6 11238.5 11418.1 11555.7 11559.0 14718.0 14720.6 14727.9 14734.5 14747.4 7004.5 8476.4 8550.3 8727.8 8758.0 6926.9 8654.1 8662.4 8747.7 8758.9 4261.3 4337.5 4530.6 4552.4 4668.6 1924.0 1984.6 1987.1 2009.0 2022.8 847.8 981.9 1009.9 1011.5 1015.3 19656.4 20851.4 20924.5 21066.8 21090.4 970.4 975.3 1001.8 1055.0 1069.5 10727.7 10987.2 11106.3 11113.0 11115.4 598934.0 617612.0 627310.0 640221.0 642351.0 121449.0 132317.3 135159.3 147219.0 153842.0 438.6 456.5 457.9 459.3 459.9 10172.4 10980.3 11214.8 11216.6 11390.5 53600.2 55025.4 56437.0 56782.0 57331.1 78669.0 79142.6 79560.6 80732.2 81198.6 7819.5 8145.2 8262.5 8517.1 8531.0 11680.0 12946.0 13029.0 13152.4 13290.2 10529.6 10576.5 11153.0 11232.9 11439.8 10070.2 10695.5 10735.9 10903.2 10938.8 11312.0 11498.8 11521.3 11633.7 11644.2 6561.9 8215.9 8359.5 8550.0 8677.8 10501.0 10636.4 10898.1 10922.6 10924.6 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | [#3] mootools.html Cycles:180 Average:5741.22 Median:4920.47 stddev:3226.13 (65.6%) stddev-sans-first:3218.58 09:43:52 INFO - PROCESS | 1673 | Values: 1387.7 1551.7 1769.7 1917.5 1947.2 7964.5 8668.7 8676.4 9185.5 9208.8 8831.6 8929.2 9060.9 9075.8 9075.9 1995.9 2388.2 2433.1 2435.9 2439.8 1976.2 2380.6 2390.8 2391.9 2436.9 2387.7 2404.8 2410.9 2413.2 2432.3 1899.4 2399.0 2401.8 2406.1 2420.7 2376.7 2385.9 2390.0 2391.3 2391.4 8898.4 8952.0 8997.9 9032.9 9059.4 5248.1 5273.5 5403.9 5415.1 5415.2 3473.7 3586.2 3631.2 3658.2 3665.5 1067.6 1071.9 1083.2 1086.5 1087.7 11543.2 11697.0 11950.6 11970.6 11987.9 4016.0 4369.5 4742.8 4866.7 4879.4 8178.4 9956.3 9960.6 9979.8 9985.0 4570.0 5379.7 5409.5 5414.7 5429.2 4462.5 4819.8 4849.9 4961.6 5004.0 4003.0 4018.3 4057.8 4095.7 4130.6 1329.3 1331.5 1343.4 1356.4 1357.7 879.2 962.4 966.8 980.2 1008.0 5060.3 5135.6 6021.8 6171.4 6189.8 420.9 442.2 460.7 461.9 471.2 3451.8 4072.3 4083.2 4124.5 4124.7 8886.5 10466.0 10861.2 10863.5 10896.7 10691.7 10762.9 10816.6 10820.8 10825.8 8158.5 8161.9 8284.3 8305.5 8339.1 5902.4 5908.5 5953.6 5970.1 6045.9 8349.4 10063.2 10188.4 10189.6 10190.6 8184.5 9768.3 10406.5 10409.6 10428.8 6958.2 7481.0 7551.8 7734.5 7820.7 8494.7 8524.9 8601.7 8605.8 8677.2 7565.7 7730.6 7744.9 7791.7 7799.6 7460.5 7528.4 7575.4 7655.7 7706.7 7163.7 7172.7 7239.4 7254.5 7285.5 5039.0 5114.7 5148.6 5201.1 5211.3 5066.7 5074.4 5078.0 5104.1 5117.6 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | [#4] prototype.html Cycles:180 Average:4738.09 Median:5242.47 stddev:1476.04 (28.2%) stddev-sans-first:1441.66 09:43:52 INFO - PROCESS | 1673 | Values: 274.6 315.8 320.5 320.9 323.4 4865.4 5308.3 5437.9 5814.0 5827.7 4628.0 5190.9 5204.6 5649.0 5767.5 3767.0 4045.9 4129.9 4197.3 4280.5 3795.9 3920.6 4132.3 4298.2 4316.2 4297.4 4332.5 4346.9 4382.6 4432.4 3061.0 3903.5 4232.6 4283.0 4321.6 3340.4 3686.6 3688.6 3693.7 3711.6 4397.1 5046.4 5522.0 5547.7 5563.4 4440.7 4578.2 4865.0 4887.2 5015.7 4856.7 5904.5 5958.3 5995.5 6020.3 3986.8 4020.0 4115.8 4166.3 4213.0 5636.7 5885.3 6258.0 6330.4 6334.0 3473.9 4145.0 4156.2 4158.1 4166.6 3487.1 3579.3 4148.9 4242.4 4252.3 4218.0 4623.5 4696.2 4998.5 5011.9 4805.9 5308.5 5311.7 5896.6 6068.6 1236.4 1410.3 1460.6 1460.8 1477.8 813.0 875.7 901.2 919.7 967.7 4446.5 4957.6 5119.4 5349.9 5578.2 5337.4 5975.4 6022.5 6168.7 6200.0 4865.3 4906.7 5420.9 5518.8 5632.9 2771.7 2914.4 2948.0 2997.9 3094.6 5673.7 6111.5 6358.9 6360.6 6404.8 6023.4 6164.2 6342.7 6348.9 6377.0 5557.6 6323.5 6367.9 6404.4 6410.1 5323.5 5769.6 6129.5 6177.9 6206.3 5154.4 5420.4 5498.0 5726.9 6095.8 5026.9 5613.2 5634.4 5646.8 6002.7 3984.4 4020.6 4038.5 4059.2 4073.6 5506.4 5520.8 5562.9 6314.7 6371.6 5280.3 5819.6 6099.2 6112.8 6161.7 5294.5 5313.5 5965.0 6015.3 6043.8 4957.4 5056.5 5406.6 5576.5 5903.4 5013.4 5118.0 5930.0 5984.4 6070.0 5028.9 5136.8 5734.8 5789.5 6045.6 09:43:52 INFO - PROCESS | 1673 | 09:43:52 INFO - PROCESS | 1673 | [#5] yui.html Cycles:180 Average:17970.83 Median:25520.61 stddev:24268.33 (95.1%) stddev-sans-first:24301.58 09:43:52 INFO - PROCESS | 1673 | Values: 655.5 715.2 722.9 792.0 812.3 12646.7 14384.4 15287.5 16112.5 16567.3 13594.3 15538.5 15813.0 15829.1 15851.9 819.6 851.9 907.6 910.8 911.0 724.3 892.0 913.9 915.9 916.4 934.8 954.8 957.6 963.0 964.0 928.1 956.7 958.7 959.8 965.0 625.8 688.2 708.3 710.5 714.9 14888.6 14896.3 14914.0 14946.0 14970.2 13749.7 13806.0 13830.9 13857.5 13969.2 11697.5 11823.9 11829.3 12018.7 12131.6 3738.2 3818.8 3818.9 3824.6 3949.7 50170.7 59979.0 78618.0 80203.6 80486.0 10663.7 10685.8 10690.4 10792.6 10918.7 17480.2 20577.2 20737.8 21017.6 21043.3 7714.4 7748.9 7850.7 8007.2 8094.6 3843.5 3848.3 4438.6 4512.3 4534.2 3442.9 3447.2 3483.1 3520.7 3538.2 557.5 648.3 660.5 672.8 678.3 555.4 685.9 701.7 712.7 719.4 9005.4 9419.6 9509.0 9570.0 9575.0 587.9 672.4 681.6 697.5 706.1 3814.7 4302.2 4353.8 4362.8 4448.4 88376.0 89768.0 90955.0 91222.1 91499.5 62397.0 75322.2 76643.6 78550.6 79621.4 71366.3 71497.6 71508.0 71841.3 71922.0 7687.8 8458.5 8800.2 8848.9 8944.7 34811.7 45198.8 46507.0 46777.8 46873.0 61609.0 63212.0 63349.7 63997.4 64337.7 11472.0 11596.6 11662.9 11707.8 12190.5 12229.1 12503.8 12520.4 13049.2 13223.6 11722.0 11845.5 11887.5 11932.3 12165.3 11727.5 11968.5 12084.2 12111.3 12401.3 11576.5 11747.5 12259.3 12615.4 12647.3 11010.6 11086.0 11088.8 11105.5 11593.9 9450.8 10685.9 11310.7 11344.7 11375.9 09:43:52 INFO - PROCESS | 1673 | -------- Summary: end -------- 09:43:52 INFO - PROCESS | 1673 | 09:43:53 INFO - TEST-INFO | 1673: exit 0 09:43:53 INFO - TEST-OK | dromaeo_css | took 1111977ms 09:43:53 INFO - TEST-START | kraken 09:43:53 INFO - operating with platform_type : mac_ 09:43:53 INFO - Initialising browser for kraken test... 09:43:53 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp11yUhI/profile http://localhost:49280/getInfo.html) 09:43:56 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 09:43:56 INFO - PROCESS | 1682 | colorDepth:24 09:43:56 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 09:43:56 INFO - PROCESS | 1682 | __metrics 09:43:56 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:43:56 INFO - TEST-INFO | 1682: exit 0 09:43:56 INFO - Browser initialized. 09:43:56 INFO - Running cycle 1/1 for kraken test... 09:43:56 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmp11yUhI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:08 INFO - PROCESS | 1684 | RSS: Main: 252379136 09:44:08 INFO - PROCESS | 1684 | 09:44:11 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:12 INFO - PROCESS | 1684 | RSS: Main: 265240576 09:44:12 INFO - PROCESS | 1684 | 09:44:15 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 09:44:15 INFO - PROCESS | 1684 | RSS: Main: 269549568 09:44:15 INFO - PROCESS | 1684 | 09:44:19 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 09:44:19 INFO - PROCESS | 1684 | RSS: Main: 270086144 09:44:19 INFO - PROCESS | 1684 | 09:44:21 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 09:44:22 INFO - PROCESS | 1684 | RSS: Main: 270970880 09:44:22 INFO - PROCESS | 1684 | 09:44:24 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:24 INFO - PROCESS | 1684 | RSS: Main: 271585280 09:44:24 INFO - PROCESS | 1684 | 09:44:27 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:28 INFO - PROCESS | 1684 | RSS: Main: 271491072 09:44:28 INFO - PROCESS | 1684 | 09:44:31 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:32 INFO - PROCESS | 1684 | RSS: Main: 271638528 09:44:32 INFO - PROCESS | 1684 | 09:44:35 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 09:44:35 INFO - PROCESS | 1684 | RSS: Main: 271757312 09:44:35 INFO - PROCESS | 1684 | 09:44:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:37 INFO - PROCESS | 1684 | RSS: Main: 271269888 09:44:37 INFO - PROCESS | 1684 | 09:44:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:40 INFO - PROCESS | 1684 | RSS: Main: 271544320 09:44:40 INFO - PROCESS | 1684 | 09:44:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:43 INFO - PROCESS | 1684 | RSS: Main: 271884288 09:44:43 INFO - PROCESS | 1684 | 09:44:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:46 INFO - PROCESS | 1684 | RSS: Main: 271777792 09:44:46 INFO - PROCESS | 1684 | 09:44:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:50 INFO - PROCESS | 1684 | RSS: Main: 271695872 09:44:50 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 09:44:52 INFO - PROCESS | 1684 | RSS: Main: 272723968 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | __start_tp_report 09:44:52 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 09:44:52 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 09:44:52 INFO - PROCESS | 1684 | |i|pagename|runs| 09:44:52 INFO - PROCESS | 1684 | |0;ai-astar;116;110;113;123;168;168;115;118;115;116 09:44:52 INFO - PROCESS | 1684 | |1;audio-beat-detection;156;117;145;167;119;139;144;142;208;111 09:44:52 INFO - PROCESS | 1684 | |2;audio-dft;221;224;204;242;190;193;195;196;201;196 09:44:52 INFO - PROCESS | 1684 | |3;audio-fft;69;81;74;140;58;57;58;61;135;62 09:44:52 INFO - PROCESS | 1684 | |4;audio-oscillator;70;74;149;77;59;115;110;57;94;149 09:44:52 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;88;88;88;86;78;106;136;92;91;132 09:44:52 INFO - PROCESS | 1684 | |6;imaging-darkroom;154;95;95;94;95;110;92;94;152;155 09:44:52 INFO - PROCESS | 1684 | |7;imaging-desaturate;89;92;98;90;88;143;147;91;91;90 09:44:52 INFO - PROCESS | 1684 | |8;json-parse-financial;57;55;56;59;55;58;54;55;56;55 09:44:52 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;68;66;66;100;74;74;74;70;69;68 09:44:52 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;101;111;88;88;90;86;86;89;121;112 09:44:52 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;136;139;137;141;149;126;163;148;160;140 09:44:52 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;227;231;179;162;163;163;165;164;166;180 09:44:52 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;67;67;66;67;69;64;59;89;85;86 09:44:52 INFO - PROCESS | 1684 | __end_tp_report 09:44:52 INFO - PROCESS | 1684 | __start_cc_report 09:44:52 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1067 09:44:52 INFO - PROCESS | 1684 | __end_cc_report 09:44:52 INFO - PROCESS | 1684 | __startTimestamp1464367492342__endTimestamp 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | ------- Summary: start ------- 09:44:52 INFO - PROCESS | 1684 | Number of tests: 14 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:126.20 Median:117.00 stddev:22.28 (19.0%) stddev-sans-first:23.32 09:44:52 INFO - PROCESS | 1684 | Values: 116.0 110.0 113.0 123.0 168.0 168.0 115.0 118.0 115.0 116.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:144.50 stddev:28.35 (19.6%) stddev-sans-first:29.78 09:44:52 INFO - PROCESS | 1684 | Values: 156.0 117.0 145.0 167.0 119.0 139.0 144.0 142.0 208.0 111.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:206.20 Median:202.50 stddev:17.06 (8.4%) stddev-sans-first:17.23 09:44:52 INFO - PROCESS | 1684 | Values: 221.0 224.0 204.0 242.0 190.0 193.0 195.0 196.0 201.0 196.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:79.50 Median:61.50 stddev:31.56 (51.3%) stddev-sans-first:33.24 09:44:52 INFO - PROCESS | 1684 | Values: 69.0 81.0 74.0 140.0 58.0 57.0 58.0 61.0 135.0 62.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:64.50 stddev:34.30 (53.2%) stddev-sans-first:35.12 09:44:52 INFO - PROCESS | 1684 | Values: 70.0 74.0 149.0 77.0 59.0 115.0 110.0 57.0 94.0 149.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:98.50 Median:88.00 stddev:19.97 (22.7%) stddev-sans-first:20.82 09:44:52 INFO - PROCESS | 1684 | Values: 88.0 88.0 88.0 86.0 78.0 106.0 136.0 92.0 91.0 132.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:113.60 Median:94.00 stddev:28.10 (29.9%) stddev-sans-first:25.72 09:44:52 INFO - PROCESS | 1684 | Values: 154.0 95.0 95.0 94.0 95.0 110.0 92.0 94.0 152.0 155.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:90.50 stddev:22.89 (25.3%) stddev-sans-first:23.80 09:44:52 INFO - PROCESS | 1684 | Values: 89.0 92.0 98.0 90.0 88.0 143.0 147.0 91.0 91.0 90.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:1.56 (2.8%) stddev-sans-first:1.62 09:44:52 INFO - PROCESS | 1684 | Values: 57.0 55.0 56.0 59.0 55.0 58.0 54.0 55.0 56.0 55.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:69.50 stddev:10.03 (14.4%) stddev-sans-first:10.48 09:44:52 INFO - PROCESS | 1684 | Values: 68.0 66.0 66.0 100.0 74.0 74.0 74.0 70.0 69.0 68.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:97.20 Median:87.00 stddev:13.04 (15.0%) stddev-sans-first:13.75 09:44:52 INFO - PROCESS | 1684 | Values: 101.0 111.0 88.0 88.0 90.0 86.0 86.0 89.0 121.0 112.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:144.50 stddev:11.28 (7.8%) stddev-sans-first:11.60 09:44:52 INFO - PROCESS | 1684 | Values: 136.0 139.0 137.0 141.0 149.0 126.0 163.0 148.0 160.0 140.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:172.50 stddev:26.65 (15.4%) stddev-sans-first:22.18 09:44:52 INFO - PROCESS | 1684 | Values: 227.0 231.0 179.0 162.0 163.0 163.0 165.0 164.0 166.0 180.0 09:44:52 INFO - PROCESS | 1684 | 09:44:52 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:68.00 stddev:10.58 (15.6%) stddev-sans-first:11.07 09:44:52 INFO - PROCESS | 1684 | Values: 67.0 67.0 66.0 67.0 69.0 64.0 59.0 89.0 85.0 86.0 09:44:52 INFO - PROCESS | 1684 | -------- Summary: end -------- 09:44:52 INFO - PROCESS | 1684 | 09:44:53 INFO - TEST-INFO | 1684: exit 0 09:44:53 INFO - TEST-OK | kraken | took 59959ms 09:44:53 INFO - SUITE-END | took 1171s 09:44:53 INFO - Completed test suite (00:19:32) 09:44:53 INFO - javascript benchmark 09:44:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7213.251892489472, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3117.2206948262933, 3439.29494453637, 3498.1429549760305, 3522.2251104756942, 3528.717702583792, 4374.868753937387, 4537.773111344436, 5730.025895597748, 5812.360640329561, 5858.945389829829, 5617.859553511164, 5770.884582308351, 5796.3334216565, 5820.330661973874, 5861.824145275638, 5175.171972484412, 5226.895462090756, 5241.633085684004, 5332.840014799563, 5383.0, 5371.301730774994, 5451.536619387357, 5459.426760190182, 5465.125579907216, 5471.890562188753, 5163.948360516403, 5256.053910296145, 5292.550133238679, 5295.576353891679, 5362.4637536246455, 5332.706701131437, 5337.11937530307, 5349.197620356938, 5362.1420572708175, 5370.301860758115, 4374.671899607542, 5184.559312458446, 5282.683039017671, 5295.576353891679, 5368.979893820162, 5585.720713964285, 5716.685582292972, 5734.885302293931, 5812.128180772876, 5840.386759390288, 4853.3690620219495, 6151.569390142692, 6238.4697300729495, 6331.176946996861, 6341.239051313872, 5112.386513618352, 6188.412100850412, 6276.0, 6282.748690052393, 6283.0, 5971.910421343683, 6035.7283922223605, 6047.304559975615, 6050.122732203894, 6084.056971169476, 6308.635075252465, 6324.557280990379, 6342.873142537123, 6370.649614271167, 6417.262014868256, 6103.519504250378, 6117.3402608778015, 6133.478654314434, 6148.1392605035335, 6160.0, 6239.126522286883, 6251.343608920998, 6256.405641464054, 6284.685765711696, 6299.212598425197, 6094.756209751649, 6128.754849806047, 6136.969315153396, 6185.505159587222, 6190.938090619036, 6098.207233059763, 6122.051082082285, 6211.254649442006, 6226.968865155736, 6247.969085100907, 4348.326009468537, 5010.3737032870895, 5059.291699162047, 5067.493250674903, 5068.23976403535, 4530.728156310632, 4542.1824071667415, 4547.704399214041, 4548.363229147922, 4559.726416415026, 5717.685527295956, 5881.676507792113, 5910.8817823643285, 6019.60872543292, 6023.69881505923, 6293.653849038347, 6295.527835412362, 6301.495880329563, 6312.400321969406, 6328.019157030575, 5945.16767652529, 5949.315828679757, 5952.7321270542925, 5960.493358064527, 6000.0, 5411.107167317427, 5435.592330575223, 5453.7818487260065, 5497.257870187474, 5503.972480137573, 6388.904166437507, 6433.163688720437, 6440.61356318613, 6449.516286278642, 6467.062275969958, 6267.6866156692895, 6282.905756413749, 6298.149749783721, 6298.874022519432, 6300.9684951574945, 6249.406306400884, 6338.239411270677, 6381.968090159519, 6439.452646525097, 6442.452391546771, 6217.658028808278, 6218.06728990655, 6284.5600807943, 6292.244930608356, 6297.937020629735, 6182.196314479269, 6279.340669229848, 6281.183446152154, 6289.528285378524, 6295.118683384421, 6141.662208578571, 6149.877002460015, 6155.47678447337, 6185.855616710923, 6208.1308616792785, 6179.16581261524, 6185.567010309415, 6245.375462453719, 6246.281677607133, 6270.905936410866, 5801.680907549957, 5973.193618861398, 6058.3335833057445, 6168.814935551941, 6191.226096737908, 6162.414570615784, 6180.0, 6253.96873015632, 6287.74849006053, 6297.653629050446, 6184.969075154775, 6185.072239164161, 6199.5660303780105, 6214.782482613087, 6222.719977600928], "value": 5757.44274780792, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4396629656823, 518.486698168813, 533.1629341933167, 554.1991821817475, 563.4168635462297, 36437.271254574924, 37614.0, 39698.60301396985, 39802.203955920864, 41711.331546738096, 29400.0, 33681.49477757836, 39898.40152397716, 41044.79477602615, 41503.79248103763, 8500.404971651988, 9235.861462078074, 9374.484403357812, 9638.0, 9667.178289845371, 9418.952905235465, 9434.622615095388, 9528.333016688835, 9557.665481708142, 9564.473953932531, 9564.18704410126, 9637.518124093802, 9642.807143857119, 9669.806603867919, 9670.081342272508, 9552.61789528418, 9627.422354658744, 9633.903660963371, 9635.421874687507, 9645.614175432975, 9303.162715355582, 9350.625974960993, 9421.811563768755, 9490.572924218426, 9497.857532137023, 31189.688103119133, 37426.625733742585, 37795.811020944995, 38203.61796382028, 38253.617463825285, 3273.29624130813, 3306.3056758080834, 3485.19840436701, 3487.4943133245793, 3608.1520842601967, 30216.697833021608, 30905.536416953764, 31012.0696379109, 31074.844625776954, 31324.530132048036, 3200.9839950800097, 3219.983900080508, 3247.171971147366, 3285.9342813143844, 3294.0941241158635, 452148.0, 453925.0, 454418.72790636163, 454963.0, 455628.0, 30093.49532523409, 31782.0, 33671.66328336734, 33876.661233387844, 33893.49159762605, 31134.688653113633, 34861.82569087138, 35035.824820876245, 35251.94244172628, 36875.81562092173, 17090.974541527547, 17196.31214751421, 17223.0, 17243.930728312433, 17244.396446124327, 12631.873681263254, 12820.0, 12986.155899866479, 13099.738005240033, 13110.213387196607, 19158.23367065302, 19798.0, 19805.900970495055, 19874.304399345954, 19947.900260498605, 8424.536650484282, 8450.690143027841, 8501.107383724744, 8556.443831150955, 8567.0, 959.6881013670445, 1069.994650026745, 1116.385987706758, 1137.6928229378022, 1166.416791604198, 29990.55014174789, 30477.08568742941, 30572.54141187884, 30882.69117308843, 31208.531872021937, 1016.2022812092472, 1085.375908852413, 1125.8874112588676, 1173.1260211142753, 1223.7124275795181, 15534.456294029655, 15537.446255374598, 15880.0, 16059.598510037342, 16261.918690406472, 603037.0, 634335.0, 640384.7980760066, 641846.0, 642416.0, 60191.0, 60342.69828650829, 60582.091268631004, 60634.0, 61038.474038149405, 1376.126159888478, 1399.4122468563228, 1420.6448387902817, 1427.6216802547333, 1437.094630382852, 30237.848810755804, 30809.383812324075, 30917.381652367276, 31101.844490777403, 31119.844400777853, 41417.58582414137, 49608.75195623999, 50035.0, 50388.496115039845, 50451.74774126106, 541434.0, 542848.0, 543080.0, 547257.0, 548560.0, 25907.48185036251, 25943.351416214744, 25979.350516237246, 26036.0, 26088.73911260863, 34611.78858739932, 39988.60011399849, 44521.77739111284, 45788.0, 45961.77019114883, 35549.82225088858, 36560.81719591385, 36716.81641591775, 38271.6172838268, 38816.2236755269, 36961.0, 37282.440763388026, 37747.0, 38033.619663804115, 38246.80876595599, 31124.68875311218, 37039.0, 37326.440103399014, 39190.60809391984, 39876.60123398729, 27769.861150694116, 32283.35433291368, 33514.83242583772, 33788.607481028295, 34118.8294058538, 24573.38566535851, 24800.875995619906, 24802.751972480044, 25211.49577008413, 25505.48989020246], "value": 19250.29790281409, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.9462475253465, 390.22734984730243, 390.34829173085797, 390.36760448074114, 407.6718241815339, 14239.78640320396, 15500.612484687888, 15808.367665293403, 21170.30637548994, 21171.788282117173, 19511.804881951175, 19882.602347953034, 20169.798302016974, 21367.252146174887, 21428.785712142875, 5904.114382842587, 5940.584159108864, 6111.236095488064, 6131.264248290211, 6138.938610613904, 6064.484518815906, 6085.269767627891, 6094.756209751627, 6106.81679549612, 6127.601705889125, 5721.31344238692, 6003.159557661931, 6067.24159480065, 6112.81661550152, 6153.90769138461, 5957.612755170921, 6060.969635162033, 6076.756929722828, 6132.632042077467, 6227.470664993481, 5965.3736357682255, 5974.133750606181, 5993.250843644544, 6019.969900150471, 6080.756769729205, 12826.871731282661, 13254.40355184019, 13440.798388024188, 13456.865431345659, 13485.258310792902, 2086.613976414353, 2177.945551361229, 2194.5391467791783, 2227.9108835646716, 2291.32405940248, 10107.989201079834, 10212.846807297896, 10440.634577789817, 12933.0, 12992.155509891827, 1803.9909800450914, 1811.7282407638827, 1897.7722673279295, 1918.2902326139417, 1936.1674479973606, 81844.0, 94720.0, 118314.40842795817, 119367.20949185769, 121278.39360803227, 9466.574004169828, 11238.494267757807, 11418.086553075735, 11555.711107222218, 11559.0, 14718.043327183914, 14720.631984200267, 14727.92636036813, 14734.484293049692, 14747.410103595736, 7004.544704594185, 8476.406651534457, 8550.315974722007, 8727.781805454915, 8758.0, 6926.861462770717, 8654.134586541422, 8662.436941598777, 8747.650093996295, 8758.86861697075, 4261.296886013835, 4337.501187363494, 4530.637548996073, 4552.359631413772, 4668.6498512611015, 1923.9995202494624, 1984.6328429240637, 1987.1058023889307, 2008.9799102009085, 2022.7572691277142, 847.7965288330756, 981.896900825403, 1009.9444530550743, 1011.549860312154, 1015.2791518022287, 19656.410307690792, 20851.374458766262, 20924.476888077614, 21066.84132372734, 21090.367288981353, 970.3741086998988, 975.3221511049894, 1001.7746007148334, 1055.0030221440666, 1069.4759567811716, 10727.731806704895, 10987.230893837355, 11106.278091924, 11112.999830015337, 11115.44422778874, 598934.0, 617612.0, 627310.0, 640221.0, 642351.0, 121449.0, 132317.33841330733, 135159.32420337835, 147219.0, 153842.0, 438.6074463355279, 456.5320546439926, 457.9427571553556, 459.26288307266356, 459.85054857171554, 10172.440515771408, 10980.286281391684, 11214.83177752318, 11216.55133794639, 11390.487428065922, 53600.19599706086, 55025.44974550203, 56437.0, 56782.0, 57331.14003289871, 78669.0, 79142.6042869782, 79560.60219699096, 80732.19267807482, 81198.59400702959, 7819.530828150329, 8145.185481451807, 8262.462939908886, 8517.063123056334, 8531.018932822557, 11680.007199388147, 12946.029047821263, 13029.0, 13152.408141633457, 13290.20258784476, 10529.631147950717, 10576.4711764413, 11152.996230339308, 11232.943835280772, 11439.771204576029, 10070.19438444908, 10695.465226738477, 10735.94632026835, 10903.236773425784, 10938.835917461403, 11311.981921627093, 11498.77002459963, 11521.308721476738, 11633.6509904703, 11644.2431241969, 6561.934380656132, 8215.917840821516, 8359.498430094214, 8550.0, 8677.826443470969, 10501.002404771534, 10636.41499717523, 10898.12814974816, 10922.56309747633, 10924.563017479211], "value": 9152.60031938486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.7363300972816, 1551.7051760165568, 1769.6991511443052, 1917.4822797844583, 1947.1627200303863, 7964.522128672269, 8668.696595619147, 8676.392652514327, 9185.54072296385, 9208.815823683532, 8831.558422078902, 8929.196372326489, 9060.909390906088, 9075.773105672362, 9075.910890693109, 1995.8902260375673, 2388.199953015742, 2433.07543133609, 2435.8903849326734, 2439.792617627495, 1976.2391479280436, 2380.6310021946624, 2390.796782273509, 2391.928242152738, 2436.914707985221, 2387.7254115776645, 2404.843685160468, 2410.8794560272004, 2413.2036427978815, 2432.2946345559853, 1899.4396652987402, 2399.0, 2401.819863510235, 2406.121765555577, 2420.7337192908767, 2376.726676432198, 2385.8926348314367, 2389.976100238993, 2391.342380845264, 2391.4141035446255, 8898.37711360205, 8952.015278319379, 8997.910020899839, 9032.909670903338, 9059.365844390895, 5248.134057880445, 5273.472652734734, 5403.864903377408, 5415.10650742627, 5415.214793854869, 3473.6873681368547, 3586.1751797086554, 3631.237440137574, 3658.2317713280245, 3665.486831843544, 1067.5622994572266, 1071.9035286824146, 1083.2363183955292, 1086.5490821309147, 1087.6954452753162, 11543.191976561644, 11697.005754510878, 11950.641480755592, 11970.58102966392, 11987.94006029973, 4016.0, 4369.47566292047, 4742.810287588527, 4866.732329721899, 4879.365682461328, 8178.386621003448, 9956.303058785816, 9960.601575936882, 9979.80040399188, 9985.0, 4570.0, 5379.67721936685, 5409.486098820606, 5414.7021913795115, 5429.239906413105, 4462.509123996358, 4819.807207711652, 4849.927251091236, 4961.578265847371, 5003.974980125149, 4003.01926028125, 4018.2566225248424, 4057.776822274803, 4095.692823038284, 4130.648894843912, 1329.3486191765965, 1331.5206525650758, 1343.355189509041, 1356.3828458051562, 1357.7080927600416, 879.1691851200554, 962.3888830592624, 966.7534778631403, 980.1619615228876, 1007.9748006299754, 5060.291559181717, 5135.589152867761, 6021.849453763691, 6171.444569988723, 6189.84525386869, 420.9031922657806, 442.15106994570505, 460.67062050633956, 461.8822200338892, 471.24365393543553, 3451.7583769135917, 4072.3280658690983, 4083.244599749056, 4124.546299907008, 4124.6906482013965, 8886.4668119913, 10466.0, 10861.239713219999, 10863.45682715861, 10896.673099807018, 10691.679249622524, 10762.892371076345, 10816.621418250323, 10820.837687434694, 10825.83761243582, 8158.469699469515, 8161.918380816234, 8284.295834853985, 8305.543195124326, 8339.12439193888, 5902.350741418355, 5908.468237858613, 5953.583249172516, 5970.104484327386, 6045.909311360245, 8349.415540912078, 10063.194944404577, 10188.388696678223, 10189.643362482277, 10190.592376304865, 8184.468009579358, 9768.316217864682, 10406.531706073396, 10409.635662751767, 10428.791424171626, 6958.234594194533, 7481.0, 7551.773446796605, 7734.458587898793, 7820.687172513036, 8494.660213591635, 8524.872126917977, 8601.741947741577, 8605.82788344217, 8677.1756683115, 7565.735199268, 7730.613469326398, 7744.922550774646, 7791.727289544839, 7799.610019499116, 7460.515066520658, 7528.360089392463, 7575.393968482618, 7655.655495502604, 7706.653200606098, 7163.7492687755675, 7172.748953786592, 7239.420846332386, 7254.528455650366, 7285.526440781332, 5038.974805125951, 5114.71869047206, 5148.5584036469845, 5201.141811601044, 5211.296474975829, 5066.670666406671, 5074.3657042869645, 5077.974610126926, 5104.0812653721205, 5117.641765076409], "value": 4549.315361641203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [274.57989276407096, 315.82945209586825, 320.5448263465878, 320.91495753625287, 323.3807259098826, 4865.370101016159, 5308.256844041827, 5437.85804980954, 5813.970930145343, 5827.698059266592, 4628.0, 5190.92213616796, 5204.635675502707, 5648.971755141229, 5767.480926716595, 3766.962330376702, 4045.939310910331, 4129.926219183019, 4197.265478541259, 4280.5291417944, 3795.905102372449, 3920.568992317812, 4132.297509423405, 4298.183345164424, 4316.223079845627, 4297.441332626754, 4332.501762297345, 4346.9136912791955, 4382.641381171847, 4432.3794668746405, 3060.9540856887165, 3903.512060992376, 4232.555581663943, 4282.978585107086, 4321.58944900234, 3340.4321265384942, 3686.631336866292, 3688.598332633609, 3693.7045036397026, 3711.5731690855628, 4397.053973837536, 5046.394432668067, 5521.972390138064, 5547.697705452232, 5563.36021357541, 4440.666949978765, 4578.161539845284, 4864.975675121602, 4887.193613053842, 5015.699058056528, 4856.732879691615, 5904.527637788967, 5958.285005799332, 5995.52035837132, 6020.307664618581, 3986.8405263789414, 4020.015096301425, 4115.773632450214, 4166.270902592065, 4212.978935105305, 5636.71816409182, 5885.264341957255, 6257.968710156466, 6330.366963303679, 6334.018227174749, 3473.8784142555396, 4145.0, 4156.189543039079, 4158.08522125132, 4166.58334166587, 3487.093355727529, 3579.319929213441, 4148.875533733993, 4242.363645453207, 4252.340887162495, 4217.957820421818, 4623.514530974267, 4696.1546921554445, 4998.525140111684, 5011.899762004739, 4805.879853003703, 5308.495692909168, 5311.7344132793205, 5896.587238893237, 6068.6358818471035, 1236.3879879459546, 1410.2737090398452, 1460.5545308680742, 1460.7881857130656, 1477.837437881832, 813.0, 875.65411662393, 901.2204443156622, 919.6689191890914, 967.666155176463, 4446.466424029072, 4957.603391728653, 5119.385673719177, 5349.946500534945, 5578.191162281528, 5337.359516857924, 5975.43233392827, 6022.5483088768515, 6168.686742471573, 6200.0, 4865.318855360252, 4906.681065730788, 5420.945790542044, 5518.764900215419, 5632.887342253132, 2771.6973022679713, 2914.3588410549646, 2947.985260073686, 2997.8608128910873, 3094.628644562667, 5673.687947162863, 6111.54163437744, 6358.904616430757, 6360.554761166766, 6404.815109204812, 6023.379829774062, 6164.167837341991, 6342.746290148342, 6348.936510634834, 6377.034678874253, 5557.638753481011, 6323.494120470259, 6367.904481432783, 6404.445532729287, 6410.076976906909, 5323.463597858184, 5769.624974376652, 6129.498272922984, 6177.876442471215, 6206.262246570967, 5154.433012368711, 5420.403755586961, 5497.972510137423, 5726.942730572641, 6095.847603809941, 5026.949730502648, 5613.242212301287, 5634.352049514358, 5646.774129034792, 6002.709417475264, 3984.3664097719798, 4020.638142567183, 4038.4548086008012, 4059.2287465381482, 4073.5926407359025, 5506.449355064461, 5520.806771762969, 5562.888742225214, 6314.6842657866, 6371.585846919936, 5280.313559237275, 5819.566455791103, 6099.176611157614, 6112.755489780359, 6161.661108639068, 5294.523492885504, 5313.495217954288, 5964.97017514927, 6015.278166619859, 6043.7884674036195, 4957.405111386656, 5056.519630635084, 5406.567474602101, 5576.498115169654, 5903.409659034062, 5013.448520662651, 5117.974410127926, 5930.0, 5984.401559844155, 6070.0, 5028.899422011613, 5136.768845401891, 5734.799282025109, 5789.45000224978, 6045.607035542852], "value": 4266.28471321134, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.4559715436188, 715.2454160860293, 722.9277072292768, 791.9802004949877, 812.3176531713359, 12646.747065058706, 14384.352704128312, 15287.541373758804, 16112.46229214242, 16567.337306507725, 13594.320283985811, 15538.533843984698, 15812.9721568098, 15829.050256984588, 15851.920740396281, 819.5615345790004, 851.9105493923141, 907.6278725722472, 910.8223896340216, 911.0297533127232, 724.337231433238, 892.0455113029061, 913.8903331600218, 915.8580420034905, 916.4043371808344, 934.8364036293656, 954.7613096725819, 957.5643082397493, 962.9855552166723, 963.9662611808589, 928.109015345266, 956.7225504603657, 958.6932181701858, 959.7504648791364, 964.9903500965006, 625.7966160997694, 688.1535711075355, 708.2669437132595, 710.5097482736895, 714.8927660850862, 14888.553343399608, 14896.255187240704, 14913.956023078388, 14946.0, 14970.17664028478, 13749.725005499835, 13806.0, 13830.86169138316, 13857.514986975408, 13969.231692256923, 11697.473613687405, 11823.94088029563, 11829.290242585386, 12018.69953251167, 12131.636050918487, 3738.2336620992633, 3818.8090595470117, 3818.866339678098, 3824.5601755797884, 3949.6840252779707, 50170.7491462544, 59979.0, 78618.0, 80203.5989820053, 80486.0, 10663.73340666474, 10685.78628427427, 10690.358578485315, 10792.56829726802, 10918.727031824268, 17480.21339039721, 20577.176912923616, 20737.79262207389, 21017.579648406947, 21043.263485778232, 7714.421418393531, 7748.883766743504, 7850.725224617111, 8007.1592482788465, 8094.635741391651, 3843.5003449551377, 3848.288066707668, 4438.5561443856, 4512.278035514302, 4534.229181039232, 3442.9483557746653, 3447.1554469155217, 3483.0943954571485, 3520.718342532591, 3538.15084379747, 557.4731878374897, 648.2739331948248, 660.4815220052236, 672.8385187554951, 678.2573082474682, 555.3668817547917, 685.869684759894, 701.7473709464589, 712.6508011074536, 719.4388377065897, 9005.414648047987, 9419.576119074658, 9508.952455237679, 9569.952150239344, 9575.0, 587.8530367408148, 672.4452326830384, 681.5501768832547, 697.476892330752, 706.0856191232366, 3814.6566808987322, 4302.161078589707, 4353.791730489991, 4362.8036738346855, 4448.399466072104, 88376.0, 89768.0, 90955.0, 91222.08777912268, 91499.54250228706, 62397.0, 75322.24677753262, 76643.61678191573, 78550.60724696454, 79621.4075718494, 71366.286337137, 71497.64251178711, 71508.0, 71841.28158718556, 71922.0, 7687.769366919001, 8458.492490450593, 8800.17986060808, 8848.911510885066, 8944.731658050268, 34811.65188348084, 45198.77400612976, 46507.0, 46777.76611116923, 46873.0, 61609.0, 63212.0, 63349.68325158345, 63997.360026401, 64337.67831160814, 11472.024877885473, 11596.594119205787, 11662.941685291858, 11707.824382634097, 12190.51237950472, 12229.082818788449, 12503.812442813547, 12520.373981301082, 13049.217046977212, 13223.603291901258, 11722.0, 11845.466953987263, 11887.465064071965, 11932.343721095076, 12165.330906799856, 11727.488080602445, 11968.521259149536, 12084.154109212623, 12111.333876636869, 12401.317927514074, 11576.47905844256, 11747.471363788822, 12259.264444133381, 12615.432305546088, 12647.304398258184, 11010.559577616805, 11086.0, 11088.778224435628, 11105.499772245492, 11593.884061159617, 9450.810983780148, 10685.8931410688, 11310.717232069264, 11344.659660210207, 11375.886241137483], "value": 7153.8030308990255, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 113.0, 123.0, 168.0, 168.0, 115.0, 118.0, 115.0, 116.0], "value": 126.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 117.0, 145.0, 167.0, 119.0, 139.0, 144.0, 142.0, 208.0, 111.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 224.0, 204.0, 242.0, 190.0, 193.0, 195.0, 196.0, 201.0, 196.0], "value": 206.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 81.0, 74.0, 140.0, 58.0, 57.0, 58.0, 61.0, 135.0, 62.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 149.0, 77.0, 59.0, 115.0, 110.0, 57.0, 94.0, 149.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 86.0, 78.0, 106.0, 136.0, 92.0, 91.0, 132.0], "value": 98.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 95.0, 95.0, 94.0, 95.0, 110.0, 92.0, 94.0, 152.0, 155.0], "value": 113.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 98.0, 90.0, 88.0, 143.0, 147.0, 91.0, 91.0, 90.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 59.0, 55.0, 58.0, 54.0, 55.0, 56.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 100.0, 74.0, 74.0, 74.0, 70.0, 69.0, 68.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 88.0, 88.0, 90.0, 86.0, 86.0, 89.0, 121.0, 112.0], "value": 97.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 139.0, 137.0, 141.0, 149.0, 126.0, 163.0, 148.0, 160.0, 140.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [227.0, 231.0, 179.0, 162.0, 163.0, 163.0, 165.0, 164.0, 166.0, 180.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 69.0, 64.0, 59.0, 89.0, 85.0, 86.0], "value": 71.9, "unit": "score"}]}]} 09:44:53 INFO - Return code: 0 09:44:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:44:53 ERROR - # TBPL SUCCESS # 09:44:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:44:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:44:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:44:53 INFO - 2016-05-27 09:44:53.638 screenresolution[1689:11235] starting screenresolution argv=screenresolution get 09:44:53 INFO - 2016-05-27 09:44:53.641 screenresolution[1689:11235] Display 0: 1600x1200x32@60 09:44:53 INFO - 2016-05-27 09:44:53.647 screenresolution[1690:11238] starting screenresolution argv=screenresolution list 09:44:53 INFO - Available Modes on Display 0 09:44:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:44:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:44:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:44:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:44:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:44:53 INFO - Intel Iris: 09:44:53 INFO - Chipset Model: Intel Iris 09:44:53 INFO - Type: GPU 09:44:53 INFO - Bus: Built-In 09:44:53 INFO - VRAM (Dynamic, Max): 1536 MB 09:44:53 INFO - Vendor: Intel (0x8086) 09:44:53 INFO - Device ID: 0x0a2e 09:44:53 INFO - Revision ID: 0x0009 09:44:53 INFO - Displays: 09:44:53 INFO - Display: 09:44:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:44:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:44:53 INFO - Display Serial Number: 1600x1200 60 09:44:53 INFO - Main Display: Yes 09:44:53 INFO - Mirror: Off 09:44:53 INFO - Online: Yes 09:44:53 INFO - Rotation: Supported 09:44:53 INFO - Return code: 0 09:44:53 INFO - Running post-action listener: _resource_record_post_action 09:44:53 INFO - ##### 09:44:53 INFO - ##### Finished run-tests step (success) 09:44:53 INFO - ##### 09:44:53 INFO - Running post-run listener: _resource_record_post_run 09:44:53 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 31157760; Write bytes: 701897216; Read time: 192; Write time: 1964 09:44:53 INFO - TinderboxPrint: CPU usage
54.4% 09:44:53 INFO - TinderboxPrint: I/O read bytes / time
31,157,760 / 192 09:44:53 INFO - TinderboxPrint: I/O write bytes / time
701,897,216 / 1,964 09:44:53 INFO - TinderboxPrint: CPU idle
2,203.3 (45.6%) 09:44:53 INFO - TinderboxPrint: CPU system
971.9 (20.1%) 09:44:53 INFO - TinderboxPrint: CPU user
1,654.5 (34.3%) 09:44:53 INFO - TinderboxPrint: Swap in / out
425,537,536 / 0 09:44:53 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379156992; Write bytes: 375795200; Read time: 27994; Write time: 773 09:44:53 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 30236160; Write bytes: 298015744; Read time: 182; Write time: 1127 09:44:54 INFO - Running post-run listener: _upload_blobber_files 09:44:54 INFO - Blob upload gear active. 09:44:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:54 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 09:44:54 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'] 09:44:54 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 09:44:54 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:55 INFO - (blobuploader) - INFO - Done attempting. 09:44:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:57 INFO - (blobuploader) - INFO - Done attempting. 09:44:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:59 INFO - (blobuploader) - INFO - Done attempting. 09:44:59 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:59 INFO - Return code: 0 09:44:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27ab651214473db5ff623ef406bdb1c79addf4cc991b53c28f02f1f5cf97600239a1f98657b6a80baf3bc5bc98e20acb602d1e53a975de1730bbdedf93776868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80fe3835fd0dcfa1431f45a291adaf378db520beb0ce5fab595373c49343164b7ba544364cfdde647043c127909a66f5bb58ac12168c53c342b0c9429c1170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/732d64c18cfcd4ad6840ac9998725b14630d50b7de390f5a0f5048d94c7a432865a57e1a87c4e58c466258e3329c8397ba7f83b78206115ac816be1965706f38"} 09:44:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:59 INFO - Contents: 09:44:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27ab651214473db5ff623ef406bdb1c79addf4cc991b53c28f02f1f5cf97600239a1f98657b6a80baf3bc5bc98e20acb602d1e53a975de1730bbdedf93776868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80fe3835fd0dcfa1431f45a291adaf378db520beb0ce5fab595373c49343164b7ba544364cfdde647043c127909a66f5bb58ac12168c53c342b0c9429c1170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/732d64c18cfcd4ad6840ac9998725b14630d50b7de390f5a0f5048d94c7a432865a57e1a87c4e58c466258e3329c8397ba7f83b78206115ac816be1965706f38"} 09:44:59 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:59 INFO - Copying logs to upload dir... 09:44:59 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.053624 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-05-27 09:44:59.663019) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 09:44:59.666716) ========= 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.rwd9yybnA4/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.HnFSoWbnRy/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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/27ab651214473db5ff623ef406bdb1c79addf4cc991b53c28f02f1f5cf97600239a1f98657b6a80baf3bc5bc98e20acb602d1e53a975de1730bbdedf93776868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80fe3835fd0dcfa1431f45a291adaf378db520beb0ce5fab595373c49343164b7ba544364cfdde647043c127909a66f5bb58ac12168c53c342b0c9429c1170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/732d64c18cfcd4ad6840ac9998725b14630d50b7de390f5a0f5048d94c7a432865a57e1a87c4e58c466258e3329c8397ba7f83b78206115ac816be1965706f38"} build_url:https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011182 build_url: 'https://queue.taskcluster.net/v1/task/aWjQfbtIQASEu17vmEeX4A/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/27ab651214473db5ff623ef406bdb1c79addf4cc991b53c28f02f1f5cf97600239a1f98657b6a80baf3bc5bc98e20acb602d1e53a975de1730bbdedf93776868", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a80fe3835fd0dcfa1431f45a291adaf378db520beb0ce5fab595373c49343164b7ba544364cfdde647043c127909a66f5bb58ac12168c53c342b0c9429c1170", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/732d64c18cfcd4ad6840ac9998725b14630d50b7de390f5a0f5048d94c7a432865a57e1a87c4e58c466258e3329c8397ba7f83b78206115ac816be1965706f38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-27 09:44:59.696712) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:44:59.697034) ========= 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.rwd9yybnA4/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.HnFSoWbnRy/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.004471 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-27 09:44:59.745076) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 09:44:59.745401) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-27 09:44:59.745747) ========= ========= Total master_lag: 0.22 =========