builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0160 starttime: 1461865089.86 results: success (0) buildid: 20160428073712 builduid: 13f3b14acfca46618e0c13fc413cc1df revision: 45e67d6b5a6137898898c23ae1fe60ddfcd59ed1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:09.860474) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:09.860844) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-04-28 10:38:09.861113) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-04-28 10:38:13.107454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:13.107871) ========= 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.iTJwsYai4q/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.U8lUCqhvVs/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-28 10:38:13-- 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% 10.0M=0.001s 2016-04-28 10:38:13 (10.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115763 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:13.334794) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:13.335091) ========= 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.iTJwsYai4q/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.U8lUCqhvVs/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.027704 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:13.386973) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 10:38:13.387347) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45e67d6b5a6137898898c23ae1fe60ddfcd59ed1 --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 45e67d6b5a6137898898c23ae1fe60ddfcd59ed1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iTJwsYai4q/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.U8lUCqhvVs/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-28 10:38:13,466 truncating revision to first 12 chars 2016-04-28 10:38:13,466 Setting DEBUG logging. 2016-04-28 10:38:13,467 attempt 1/10 2016-04-28 10:38:13,467 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45e67d6b5a61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 10:38:14,747 unpacking tar archive at: fx-team-45e67d6b5a61/testing/mozharness/ program finished with exit code 0 elapsedTime=1.523858 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 10:38:14.930211) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:14.930600) ========= script_repo_revision: 45e67d6b5a6137898898c23ae1fe60ddfcd59ed1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:14.931309) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:14.931795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 10:38:14.947990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-28 10:38:14.948258) ========= /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.iTJwsYai4q/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.U8lUCqhvVs/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:38:15 INFO - MultiFileLogger online at 20160428 10:38:15 in /builds/slave/test 10:38:15 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 10:38:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:38:15 INFO - {'append_to_log': False, 10:38:15 INFO - 'base_work_dir': '/builds/slave/test', 10:38:15 INFO - 'blob_upload_branch': 'Fx-Team', 10:38:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:38:15 INFO - 'branch': 'Fx-Team', 10:38:15 INFO - 'buildbot_json_path': 'buildprops.json', 10:38:15 INFO - 'config_files': ('talos/mac_config.py',), 10:38:15 INFO - 'default_actions': ('clobber', 10:38:15 INFO - 'read-buildbot-config', 10:38:15 INFO - 'download-and-extract', 10:38:15 INFO - 'populate-webroot', 10:38:15 INFO - 'create-virtualenv', 10:38:15 INFO - 'install', 10:38:15 INFO - 'run-tests'), 10:38:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:38:15 INFO - 'download_minidump_stackwalk': True, 10:38:15 INFO - 'download_symbols': 'ondemand', 10:38:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:38:15 INFO - 'tooltool.py': '/tools/tooltool.py', 10:38:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:38:15 INFO - '/tools/misc-python/virtualenv.py')}, 10:38:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:38:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:38:15 INFO - 'installer_path': 'installer.exe', 10:38:15 INFO - 'log_level': 'info', 10:38:15 INFO - 'log_name': 'talos', 10:38:15 INFO - 'log_to_console': True, 10:38:15 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:38:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:38:15 INFO - 'opt_config_files': (), 10:38:15 INFO - 'pip_index': False, 10:38:15 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:38:15 INFO - 'cmd': ('bash', 10:38:15 INFO - '-c', 10:38:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:38:15 INFO - 'enabled': True, 10:38:15 INFO - 'halt_on_failure': False, 10:38:15 INFO - 'name': 'check_screen_resolution'},), 10:38:15 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:38:15 INFO - 'cmd': ('bash', 10:38:15 INFO - '-c', 10:38:15 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:38:15 INFO - 'enabled': True, 10:38:15 INFO - 'halt_on_failure': False, 10:38:15 INFO - 'name': 'check_screen_resolution'},), 10:38:15 INFO - 'run_cmd_checks_enabled': True, 10:38:15 INFO - 'sps_profile': False, 10:38:15 INFO - 'sps_profile_interval': 0, 10:38:15 INFO - 'suite': 'dromaeojs-e10s', 10:38:15 INFO - 'system_bits': '32', 10:38:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:38:15 INFO - 'title': 't-yosemite-r7-0160', 10:38:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:38:15 INFO - 'use_talos_json': True, 10:38:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:38:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:38:15 INFO - 'work_dir': 'build'} 10:38:15 INFO - ##### 10:38:15 INFO - ##### Running clobber step. 10:38:15 INFO - ##### 10:38:15 INFO - Running pre-action listener: _resource_record_pre_action 10:38:15 INFO - Running main action method: clobber 10:38:15 INFO - rmtree: /builds/slave/test/build 10:38:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:38:16 INFO - Running post-action listener: _resource_record_post_action 10:38:16 INFO - ##### 10:38:16 INFO - ##### Running read-buildbot-config step. 10:38:16 INFO - ##### 10:38:16 INFO - Running pre-action listener: _resource_record_pre_action 10:38:16 INFO - Running main action method: read_buildbot_config 10:38:16 INFO - Using buildbot properties: 10:38:16 INFO - { 10:38:16 INFO - "project": "", 10:38:16 INFO - "product": "firefox", 10:38:16 INFO - "script_repo_revision": "production", 10:38:16 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 10:38:16 INFO - "repository": "", 10:38:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 10:38:16 INFO - "buildid": "20160428073712", 10:38:16 INFO - "pgo_build": "False", 10:38:16 INFO - "basedir": "/builds/slave/test", 10:38:16 INFO - "buildnumber": 655, 10:38:16 INFO - "slavename": "t-yosemite-r7-0160", 10:38:16 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:38:16 INFO - "platform": "yosemite_r7", 10:38:16 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 10:38:16 INFO - "branch": "fx-team", 10:38:16 INFO - "repo_path": "integration/fx-team", 10:38:16 INFO - "revision": "45e67d6b5a6137898898c23ae1fe60ddfcd59ed1", 10:38:16 INFO - "stage_platform": "macosx64", 10:38:16 INFO - "builduid": "13f3b14acfca46618e0c13fc413cc1df", 10:38:16 INFO - "slavebuilddir": "test" 10:38:16 INFO - } 10:38:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 10:38:16 INFO - Running post-action listener: _resource_record_post_action 10:38:16 INFO - ##### 10:38:16 INFO - ##### Running download-and-extract step. 10:38:16 INFO - ##### 10:38:16 INFO - Running pre-action listener: _resource_record_pre_action 10:38:16 INFO - Running main action method: download_and_extract 10:38:16 INFO - mkdir: /builds/slave/test/build/tests 10:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:16 INFO - https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:38:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:38:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 10:38:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:19 INFO - Downloaded 1199 bytes. 10:38:19 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 10:38:19 INFO - Using the following test package requirements: 10:38:19 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:38:19 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 10:38:19 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 10:38:19 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'jsshell-mac.zip'], 10:38:19 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 10:38:19 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 10:38:19 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 10:38:19 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 10:38:19 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 10:38:19 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 10:38:19 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 10:38:19 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:38: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')]} 10:38:19 INFO - https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:20 INFO - Downloaded 18124097 bytes. 10:38:20 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'] 10:38:20 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 10:38:23 INFO - Return code: 0 10:38:23 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 10:38:23 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')]} 10:38:23 INFO - https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:38:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:38:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 10:38:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:25 INFO - Downloaded 18124097 bytes. 10:38:25 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'] 10:38:25 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 10:38:28 INFO - Return code: 0 10:38:28 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')]} 10:38:28 INFO - https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 10:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:31 INFO - Downloaded 10840145 bytes. 10:38:31 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'] 10:38:31 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 10:38:31 INFO - Return code: 0 10:38: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')]} 10:38:31 INFO - https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 10:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a7ckXhheTNOSMDXpvJvPMA/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 10:38:35 INFO - Downloaded 110274020 bytes. 10:38:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:38:35 INFO - mkdir: /builds/slave/test/properties 10:38:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:38:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:38:35 INFO - Contents: 10:38:35 INFO - build_url:https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 10:38:36 INFO - Running post-action listener: _resource_record_post_action 10:38:36 INFO - Running post-action listener: set_extra_try_arguments 10:38:36 INFO - ##### 10:38:36 INFO - ##### Running populate-webroot step. 10:38:36 INFO - ##### 10:38:36 INFO - Running pre-action listener: _resource_record_pre_action 10:38:36 INFO - Running main action method: populate_webroot 10:38:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:38:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:38:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:38:36 INFO - '--tppagecycles', 10:38:36 INFO - '7'], 10:38:36 INFO - 'tests': ['tsvgm']}}, 10:38:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:38:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:38:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:38:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:38:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['damp', 'tps']}, 10:38:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'tests': ['damp', 'tps']}, 10:38:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['dromaeo_dom']}, 10:38:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:38:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['a11yr', 10:38:36 INFO - 'ts_paint', 10:38:36 INFO - 'tpaint', 10:38:36 INFO - 'sessionrestore', 10:38:36 INFO - 'sessionrestore_no_auto_restore', 10:38:36 INFO - 'tabpaint']}, 10:38:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:38:36 INFO - 'ts_paint', 10:38:36 INFO - 'tpaint', 10:38:36 INFO - 'sessionrestore', 10:38:36 INFO - 'sessionrestore_no_auto_restore', 10:38:36 INFO - 'tabpaint']}, 10:38:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:38:36 INFO - 'ts_paint', 10:38:36 INFO - 'tpaint', 10:38:36 INFO - 'sessionrestore', 10:38:36 INFO - 'sessionrestore_no_auto_restore', 10:38:36 INFO - 'tabpaint']}, 10:38:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:38:36 INFO - 'ts_paint', 10:38:36 INFO - 'tpaint', 10:38:36 INFO - 'sessionrestore', 10:38:36 INFO - 'sessionrestore_no_auto_restore', 10:38:36 INFO - 'tabpaint']}, 10:38:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['a11yr', 10:38:36 INFO - 'ts_paint', 10:38:36 INFO - 'tpaint', 10:38:36 INFO - 'sessionrestore', 10:38:36 INFO - 'sessionrestore_no_auto_restore', 10:38:36 INFO - 'tabpaint']}, 10:38:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['a11yr', 10:38:36 INFO - 'ts_paint', 10:38:36 INFO - 'tpaint', 10:38:36 INFO - 'sessionrestore', 10:38:36 INFO - 'sessionrestore_no_auto_restore', 10:38:36 INFO - 'tabpaint']}, 10:38:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['tsvgx', 10:38:36 INFO - 'tsvgr_opacity', 10:38:36 INFO - 'tart', 10:38:36 INFO - 'tscrollx', 10:38:36 INFO - 'cart']}, 10:38:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:38:36 INFO - 'tsvgr_opacity', 10:38:36 INFO - 'tart', 10:38:36 INFO - 'tscrollx', 10:38:36 INFO - 'cart']}, 10:38:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'talos_options': ['--disable-e10s'], 10:38:36 INFO - 'tests': ['tp5o']}, 10:38:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'tests': ['tp5o']}, 10:38:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'talos_options': ['--disable-e10s', 10:38:36 INFO - '--xperf_path', 10:38:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:36 INFO - 'tests': ['tp5n']}, 10:38:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:36 INFO - 'talos_options': ['--xperf_path', 10:38:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:36 INFO - 'tests': ['tp5n']}}, 10:38:36 INFO - 'talos.zip': {'path': '', 10:38:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:38:36 INFO - Running post-action listener: _resource_record_post_action 10:38:36 INFO - ##### 10:38:36 INFO - ##### Running create-virtualenv step. 10:38:36 INFO - ##### 10:38:36 INFO - Running pre-action listener: _resource_record_pre_action 10:38:36 INFO - Running main action method: create_virtualenv 10:38:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:38:36 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 10:38:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:38:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:38:36 INFO - Using real prefix '/tools/python27' 10:38:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:38:37 INFO - Installing distribute.............................................................................................................................................................................................done. 10:38:40 INFO - Installing pip.................done. 10:38:40 INFO - Return code: 0 10:38:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:40 INFO - 'HOME': '/Users/cltbld', 10:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:40 INFO - 'LOGNAME': 'cltbld', 10:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:40 INFO - 'MOZ_NO_REMOTE': '1', 10:38:40 INFO - 'NO_EM_RESTART': '1', 10:38:40 INFO - 'PAGER': '/bin/cat', 10:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:40 INFO - 'PWD': '/builds/slave/test', 10:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:40 INFO - 'SHELL': '/bin/bash', 10:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:38:40 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:40 INFO - 'USER': 'cltbld', 10:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:40 INFO - 'XPC_FLAGS': '0x0', 10:38:40 INFO - 'XPC_SERVICE_NAME': '0', 10:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:40 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 10:38:40 INFO - Cleaning up... 10:38:40 INFO - Return code: 0 10:38:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:40 INFO - 'HOME': '/Users/cltbld', 10:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:40 INFO - 'LOGNAME': 'cltbld', 10:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:40 INFO - 'MOZ_NO_REMOTE': '1', 10:38:40 INFO - 'NO_EM_RESTART': '1', 10:38:40 INFO - 'PAGER': '/bin/cat', 10:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:40 INFO - 'PWD': '/builds/slave/test', 10:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:40 INFO - 'SHELL': '/bin/bash', 10:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:38:40 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:40 INFO - 'USER': 'cltbld', 10:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:40 INFO - 'XPC_FLAGS': '0x0', 10:38:40 INFO - 'XPC_SERVICE_NAME': '0', 10:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:41 INFO - Downloading/unpacking psutil>=0.7.1 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:38:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:43 INFO - Installing collected packages: psutil 10:38:43 INFO - Running setup.py install for psutil 10:38:43 INFO - building 'psutil._psutil_osx' extension 10:38:43 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 10:38:44 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 10:38:44 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 10:38:44 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 10:38:44 INFO - building 'psutil._psutil_posix' extension 10:38:44 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 10:38:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:38:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:38:44 INFO - ^ 10:38:44 INFO - 1 warning generated. 10:38:44 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 10:38:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:44 INFO - Successfully installed psutil 10:38:44 INFO - Cleaning up... 10:38:44 INFO - Return code: 0 10:38:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:44 INFO - 'HOME': '/Users/cltbld', 10:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:44 INFO - 'LOGNAME': 'cltbld', 10:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:44 INFO - 'MOZ_NO_REMOTE': '1', 10:38:44 INFO - 'NO_EM_RESTART': '1', 10:38:44 INFO - 'PAGER': '/bin/cat', 10:38:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:44 INFO - 'PWD': '/builds/slave/test', 10:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:44 INFO - 'SHELL': '/bin/bash', 10:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:38:44 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:44 INFO - 'USER': 'cltbld', 10:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:44 INFO - 'XPC_FLAGS': '0x0', 10:38:44 INFO - 'XPC_SERVICE_NAME': '0', 10:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:38:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:38:47 INFO - Installing collected packages: mozsystemmonitor 10:38:47 INFO - Running setup.py install for mozsystemmonitor 10:38:47 INFO - Successfully installed mozsystemmonitor 10:38:47 INFO - Cleaning up... 10:38:47 INFO - Return code: 0 10:38:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:47 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 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:38:47 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 10:38:47 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 10:38:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:38:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:47 INFO - 'HOME': '/Users/cltbld', 10:38:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:47 INFO - 'LOGNAME': 'cltbld', 10:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:47 INFO - 'MOZ_NO_REMOTE': '1', 10:38:47 INFO - 'NO_EM_RESTART': '1', 10:38:47 INFO - 'PAGER': '/bin/cat', 10:38:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:47 INFO - 'PWD': '/builds/slave/test', 10:38:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:47 INFO - 'SHELL': '/bin/bash', 10:38:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:38:47 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:38:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:47 INFO - 'USER': 'cltbld', 10:38:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:47 INFO - 'XPC_FLAGS': '0x0', 10:38:47 INFO - 'XPC_SERVICE_NAME': '0', 10:38:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:38:48 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 10:38:48 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 10:38:48 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 10:38:48 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 10:38:48 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 10:38:48 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 10:38:50 INFO - Downloading blobuploader-1.2.4.tar.gz 10:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:38:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:38:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:38:51 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 10:38:51 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 10:38:51 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 10:38:51 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 10:38:51 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 10:38:51 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 10:38:51 INFO - Downloading docopt-0.6.1.tar.gz 10:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:38:51 INFO - Installing collected packages: blobuploader, requests, docopt 10:38:51 INFO - Running setup.py install for blobuploader 10:38:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:38:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:38:51 INFO - Running setup.py install for requests 10:38:52 INFO - Running setup.py install for docopt 10:38:52 INFO - Successfully installed blobuploader requests docopt 10:38:52 INFO - Cleaning up... 10:38:52 INFO - Return code: 0 10:38:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:52 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 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:38:52 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 10:38:52 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 10:38:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:38:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:52 INFO - 'HOME': '/Users/cltbld', 10:38:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:52 INFO - 'LOGNAME': 'cltbld', 10:38:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:52 INFO - 'MOZ_NO_REMOTE': '1', 10:38:52 INFO - 'NO_EM_RESTART': '1', 10:38:52 INFO - 'PAGER': '/bin/cat', 10:38:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:52 INFO - 'PWD': '/builds/slave/test', 10:38:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:52 INFO - 'SHELL': '/bin/bash', 10:38:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:38:52 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:38:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:52 INFO - 'USER': 'cltbld', 10:38:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:52 INFO - 'XPC_FLAGS': '0x0', 10:38:52 INFO - 'XPC_SERVICE_NAME': '0', 10:38:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:52 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-TAed08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-pkw41u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-naic69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-xtgyzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-8Aqnrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-C2Gfj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-k7Xl9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-TrEqIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-gnEVno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:53 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-LPIbAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-6BwRz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-MF_i_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-Lv7Jvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-iELokQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-SA9KuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-9FcmOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:54 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-hCQmPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:54 INFO - Running setup.py install for manifestparser 10:38:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:54 INFO - Running setup.py install for mozcrash 10:38:55 INFO - Running setup.py install for mozdebug 10:38:55 INFO - Running setup.py install for mozdevice 10:38:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Running setup.py install for mozfile 10:38:55 INFO - Running setup.py install for mozhttpd 10:38:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Running setup.py install for mozinfo 10:38:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Running setup.py install for mozInstall 10:38:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:55 INFO - Running setup.py install for mozleak 10:38:56 INFO - Running setup.py install for mozlog 10:38:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:56 INFO - Running setup.py install for moznetwork 10:38:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:56 INFO - Running setup.py install for mozprocess 10:38:56 INFO - Running setup.py install for mozprofile 10:38:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:56 INFO - Running setup.py install for mozrunner 10:38:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:56 INFO - Running setup.py install for mozscreenshot 10:38:57 INFO - Running setup.py install for moztest 10:38:57 INFO - Running setup.py install for mozversion 10:38:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:57 INFO - Cleaning up... 10:38:57 INFO - Return code: 0 10:38:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:57 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 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:38:57 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 10:38:57 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 10:38:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:38:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:38:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:38:57 INFO - 'HOME': '/Users/cltbld', 10:38:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:38:57 INFO - 'LOGNAME': 'cltbld', 10:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:57 INFO - 'MOZ_NO_REMOTE': '1', 10:38:57 INFO - 'NO_EM_RESTART': '1', 10:38:57 INFO - 'PAGER': '/bin/cat', 10:38:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:57 INFO - 'PWD': '/builds/slave/test', 10:38:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:38:57 INFO - 'SHELL': '/bin/bash', 10:38:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:38:57 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:38:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:38:57 INFO - 'USER': 'cltbld', 10:38:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:38:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:57 INFO - 'XPC_FLAGS': '0x0', 10:38:57 INFO - 'XPC_SERVICE_NAME': '0', 10:38:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:57 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-9nU760-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:57 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)) 10:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:57 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-4eeHT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:57 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)) 10:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:57 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-i8VLah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:57 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)) 10:38:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:57 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-y8PRQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-2UvrGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-t5E9TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-DBd5Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-xZ3MC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-XaWxL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-aUwRtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-1DY2Gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-9w0Shs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-iggMES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:58 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)) 10:38:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:58 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-4NlThy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:59 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)) 10:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-CLJMCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:59 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)) 10:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-YE8Bz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:59 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)) 10:38:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:59 INFO - Running setup.py (path:/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/pip-1azvrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:59 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)) 10:38:59 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)) 10:38:59 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)) 10:38:59 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)) 10:38:59 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)) 10:38:59 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)) 10:38:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:59 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 10:38:59 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 10:38:59 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 10:38:59 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 10:38:59 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 10:38:59 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 10:39:01 INFO - Downloading blessings-1.6.tar.gz 10:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:39:01 INFO - Installing collected packages: blessings 10:39:01 INFO - Running setup.py install for blessings 10:39:02 INFO - Successfully installed blessings 10:39:02 INFO - Cleaning up... 10:39:02 INFO - Return code: 0 10:39:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:02 INFO - Reading from file tmpfile_stdout 10:39:02 INFO - Current package versions: 10:39:02 INFO - blessings == 1.6 10:39:02 INFO - blobuploader == 1.2.4 10:39:02 INFO - docopt == 0.6.1 10:39:02 INFO - manifestparser == 1.1 10:39:02 INFO - mozInstall == 1.12 10:39:02 INFO - mozcrash == 0.17 10:39:02 INFO - mozdebug == 0.1 10:39:02 INFO - mozdevice == 0.48 10:39:02 INFO - mozfile == 1.2 10:39:02 INFO - mozhttpd == 0.7 10:39:02 INFO - mozinfo == 0.9 10:39:02 INFO - mozleak == 0.1 10:39:02 INFO - mozlog == 3.1 10:39:02 INFO - moznetwork == 0.27 10:39:02 INFO - mozprocess == 0.22 10:39:02 INFO - mozprofile == 0.28 10:39:02 INFO - mozrunner == 6.11 10:39:02 INFO - mozscreenshot == 0.1 10:39:02 INFO - mozsystemmonitor == 0.0 10:39:02 INFO - moztest == 0.7 10:39:02 INFO - mozversion == 1.4 10:39:02 INFO - psutil == 3.1.1 10:39:02 INFO - requests == 1.2.3 10:39:02 INFO - wsgiref == 0.1.2 10:39:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:02 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 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:39:02 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 10:39:02 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 10:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:02 INFO - 'HOME': '/Users/cltbld', 10:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:02 INFO - 'LOGNAME': 'cltbld', 10:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:02 INFO - 'MOZ_NO_REMOTE': '1', 10:39:02 INFO - 'NO_EM_RESTART': '1', 10:39:02 INFO - 'PAGER': '/bin/cat', 10:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:02 INFO - 'PWD': '/builds/slave/test', 10:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:02 INFO - 'SHELL': '/bin/bash', 10:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:39:02 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:02 INFO - 'USER': 'cltbld', 10:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:02 INFO - 'XPC_FLAGS': '0x0', 10:39:02 INFO - 'XPC_SERVICE_NAME': '0', 10:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 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)) 10:39:02 INFO - Cleaning up... 10:39:02 INFO - Return code: 0 10:39:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:02 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 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:39:02 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 10:39:02 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 10:39:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:39:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:02 INFO - 'HOME': '/Users/cltbld', 10:39:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:02 INFO - 'LOGNAME': 'cltbld', 10:39:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:02 INFO - 'MOZ_NO_REMOTE': '1', 10:39:02 INFO - 'NO_EM_RESTART': '1', 10:39:02 INFO - 'PAGER': '/bin/cat', 10:39:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:02 INFO - 'PWD': '/builds/slave/test', 10:39:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:02 INFO - 'SHELL': '/bin/bash', 10:39:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:39:02 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:39:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:02 INFO - 'USER': 'cltbld', 10:39:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:02 INFO - 'XPC_FLAGS': '0x0', 10:39:02 INFO - 'XPC_SERVICE_NAME': '0', 10:39:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:02 INFO - Downloading/unpacking jsonschema 10:39:02 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 10:39:02 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 10:39:02 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 10:39:02 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 10:39:02 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 10:39:02 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 10:39:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:39:05 INFO - Downloading/unpacking functools32 (from jsonschema) 10:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:05 INFO - Downloading functools32-3.2.3-2.tar.gz 10:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:39:05 INFO - warning: no files found matching '*.txt' 10:39:05 INFO - no previously-included directories found matching 'build' 10:39:05 INFO - no previously-included directories found matching 'dist' 10:39:05 INFO - no previously-included directories found matching '.git*' 10:39:05 INFO - Installing collected packages: jsonschema, functools32 10:39:05 INFO - Running setup.py install for functools32 10:39:05 INFO - warning: no files found matching '*.txt' 10:39:05 INFO - no previously-included directories found matching 'build' 10:39:05 INFO - no previously-included directories found matching 'dist' 10:39:05 INFO - no previously-included directories found matching '.git*' 10:39:06 INFO - Successfully installed jsonschema functools32 10:39:06 INFO - Cleaning up... 10:39:06 INFO - Return code: 0 10:39:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:39:06 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')]} 10:39:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:39:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:06 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')]} 10:39:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:39:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:39:06 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 0x10098ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10099b420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd582d8fa50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, '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.iTJwsYai4q/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.U8lUCqhvVs/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:39:06 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 10:39:06 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 10:39:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:39:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:06 INFO - 'HOME': '/Users/cltbld', 10:39:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:06 INFO - 'LOGNAME': 'cltbld', 10:39:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:06 INFO - 'MOZ_NO_REMOTE': '1', 10:39:06 INFO - 'NO_EM_RESTART': '1', 10:39:06 INFO - 'PAGER': '/bin/cat', 10:39:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:06 INFO - 'PWD': '/builds/slave/test', 10:39:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:06 INFO - 'SHELL': '/bin/bash', 10:39:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:39:06 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:39:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:06 INFO - 'USER': 'cltbld', 10:39:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:06 INFO - 'XPC_FLAGS': '0x0', 10:39:06 INFO - 'XPC_SERVICE_NAME': '0', 10:39:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:39:06 INFO - Downloading/unpacking flake8 10:39:06 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 10:39:06 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 10:39:06 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 10:39:06 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 10:39:06 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 10:39:06 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 10:39:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:39:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:39:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:39:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 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 10:39:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:39:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:39:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:39:09 INFO - no previously-included directories found matching 'docs/_build' 10:39:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:39:10 INFO - Running setup.py install for pep8 10:39:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:39:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:39:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:39:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:39:10 INFO - no previously-included directories found matching 'docs/_build' 10:39:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:39:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:39:10 INFO - Cleaning up... 10:39:10 INFO - Return code: 0 10:39:10 INFO - Running post-action listener: _resource_record_post_action 10:39:10 INFO - Running post-action listener: _start_resource_monitoring 10:39:10 INFO - Starting resource monitoring. 10:39:10 INFO - ##### 10:39:10 INFO - ##### Running install step. 10:39:10 INFO - ##### 10:39:10 INFO - Running pre-action listener: _resource_record_pre_action 10:39:10 INFO - Running main action method: install 10:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:39:10 INFO - Reading from file tmpfile_stdout 10:39:10 INFO - Detecting whether we're running mozinstall >=1.0... 10:39:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:39:10 INFO - Reading from file tmpfile_stdout 10:39:10 INFO - Output received: 10:39:10 INFO - Usage: mozinstall [options] installer 10:39:10 INFO - Options: 10:39:10 INFO - -h, --help show this help message and exit 10:39:10 INFO - -d DEST, --destination=DEST 10:39:10 INFO - Directory to install application into. [default: 10:39:10 INFO - "/builds/slave/test"] 10:39:10 INFO - --app=APP Application being installed. [default: firefox] 10:39:10 INFO - mkdir: /builds/slave/test/build/application 10:39:10 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'] 10:39:10 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 10:39:44 INFO - Reading from file tmpfile_stdout 10:39:44 INFO - Output received: 10:39:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:39:44 INFO - Running post-action listener: _resource_record_post_action 10:39:44 INFO - ##### 10:39:44 INFO - ##### Running run-tests step. 10:39:44 INFO - ##### 10:39:44 INFO - Running pre-action listener: _resource_record_pre_action 10:39:44 INFO - Running main action method: run_tests 10:39:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:39:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:39:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:39:44 INFO - 2016-04-28 10:39:44.356 screenresolution[1647:7688] starting screenresolution argv=screenresolution get 10:39:44 INFO - 2016-04-28 10:39:44.358 screenresolution[1647:7688] Display 0: 1600x1200x32@60 10:39:44 INFO - 2016-04-28 10:39:44.364 screenresolution[1648:7690] starting screenresolution argv=screenresolution list 10:39:44 INFO - Available Modes on Display 0 10:39:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:39:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:39:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:39:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:39:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:39:44 INFO - Intel Iris: 10:39:44 INFO - Chipset Model: Intel Iris 10:39:44 INFO - Type: GPU 10:39:44 INFO - Bus: Built-In 10:39:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:39:44 INFO - Vendor: Intel (0x8086) 10:39:44 INFO - Device ID: 0x0a2e 10:39:44 INFO - Revision ID: 0x0009 10:39:44 INFO - Displays: 10:39:44 INFO - Display: 10:39:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:39:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:39:44 INFO - Display Serial Number: 1600x1200 60 10:39:44 INFO - Main Display: Yes 10:39:44 INFO - Mirror: Off 10:39:44 INFO - Online: Yes 10:39:44 INFO - Rotation: Supported 10:39:44 INFO - Return code: 0 10:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:39:44 INFO - Python 2.7.3 10:39:44 INFO - Return code: 0 10:39:44 INFO - grabbing minidump binary from tooltool 10:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:39:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10082ae00>, '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 0x100693db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100825b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:39:44 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 10:39:44 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 10:39:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:39:44 INFO - Return code: 0 10:39:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:39:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:39:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:39:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:39:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:39:45 INFO - Return code: 0 10:39:45 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/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:39:45 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/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0160 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iTJwsYai4q/Render', 10:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:39:45 INFO - 'HOME': '/Users/cltbld', 10:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:39:45 INFO - 'LOGNAME': 'cltbld', 10:39:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:39:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:39:45 INFO - 'MOZ_NO_REMOTE': '1', 10:39:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:39:45 INFO - 'NO_EM_RESTART': '1', 10:39:45 INFO - 'PAGER': '/bin/cat', 10:39:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:39:45 INFO - 'PWD': '/builds/slave/test', 10:39:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:39:45 INFO - 'SHELL': '/bin/bash', 10:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.U8lUCqhvVs/Listeners', 10:39:45 INFO - 'TMPDIR': '/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/', 10:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:39:45 INFO - 'USER': 'cltbld', 10:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:39:45 INFO - 'XPC_FLAGS': '0x0', 10:39:45 INFO - 'XPC_SERVICE_NAME': '0', 10:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:39:45 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/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0160', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:39:46 INFO - mozversion application_buildid: 20160428073712 10:39:46 INFO - mozversion application_changeset: 45e67d6b5a6137898898c23ae1fe60ddfcd59ed1 10:39:46 INFO - mozversion application_display_name: Nightly 10:39:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:39:46 INFO - mozversion application_name: Firefox 10:39:46 INFO - mozversion application_remotingname: firefox 10:39:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:39:46 INFO - mozversion application_vendor: Mozilla 10:39:46 INFO - mozversion application_version: 49.0a1 10:39:46 INFO - mozversion platform_buildid: 20160428073712 10:39:46 INFO - mozversion platform_changeset: 45e67d6b5a6137898898c23ae1fe60ddfcd59ed1 10:39:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:39:46 INFO - mozversion platform_version: 49.0a1 10:39:46 INFO - using testdate: 1461865186 10:39:46 INFO - actual date: 1461865186 10:39:46 INFO - starting webserver on 'localhost:49276' 10:39:46 INFO - SUITE-START | Running 2 tests 10:39:46 INFO - TEST-START | dromaeo_css 10:39:46 INFO - operating with platform_type : mac_ 10:39:46 INFO - Initialising browser for dromaeo_css test... 10:39:46 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpHyfUio/profile http://localhost:49276/getInfo.html) 10:39:49 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 10:39:49 INFO - PROCESS | 1666 | colorDepth:24 10:39:49 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 10:39:49 INFO - PROCESS | 1666 | __metrics 10:39:49 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:39:50 INFO - TEST-INFO | 1666: exit 0 10:39:50 INFO - Browser initialized. 10:39:50 INFO - Running cycle 1/1 for dromaeo_css test... 10:39:50 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpHyfUio/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:40:01 INFO - PROCESS | 1669 | RSS: Main: 249626624 10:40:01 INFO - PROCESS | 1669 | 10:40:51 INFO - PROCESS | 1669 | 1461865251626 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] 10:43:01 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 10:43:03 INFO - PROCESS | 1669 | RSS: Main: 261832704 10:43:03 INFO - PROCESS | 1669 | 10:46:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 10:46:05 INFO - PROCESS | 1669 | RSS: Main: 273395712 10:46:05 INFO - PROCESS | 1669 | 10:49:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 10:49:08 INFO - PROCESS | 1669 | RSS: Main: 275222528 10:49:08 INFO - PROCESS | 1669 | 10:52:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 10:52:10 INFO - PROCESS | 1669 | RSS: Main: 277049344 10:52:10 INFO - PROCESS | 1669 | 10:55:13 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 10:55:13 INFO - PROCESS | 1669 | RSS: Main: 279977984 10:55:13 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 10:58:16 INFO - PROCESS | 1669 | RSS: Main: 280612864 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | __start_tp_report 10:58:16 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 10:58:16 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 10:58:16 INFO - PROCESS | 1669 | |i|pagename|runs| 10:58:16 INFO - PROCESS | 1669 | |0;dojo.html;3359.2945481448896;3434.3989801784687;3462.4633181856807;3496.0036389628954;3509;5010.974945125278;5041.294218809369;5266.183741520066;5679.602427830043;5713.457221563945;5565.443455654433;5659.151127330902;5668.518175955039;5771.595988280811;5795.4784069433745;5107.361579802525;5204.193350030751;5235.162374020158;5258.13240815265;5314.9468505314835;117.8920421668557;5112.9774045190925;5167.509086636764;5200.8699782505555;5215.426303106655;5187.144121219994;5199.454057323965;5216.765245563959;5219.895602087956;5232.3459567554055;5179.352580927384;5239.607029472805;5239.607029472805;5246.65896716716;5283.1546952487415;5136.409312929024;5167.276581278624;5185.429602743695;5188.143956247215;5283.365996080495;5408.107662235727;5518.972405137989;5535.501804837544;5539.723013849291;5540.722963851791;5682.7442765075675;6047.15339852421;6149.323574406856;6153.753849846001;6174.7530098796;6119.602225855305;6127.036821038878;6172.567920245585;6177.845553861144;6180.2892667343385;5853.85365365865;5874.353821079678;5874.5887787854435;5880.970595146997;5904.852378690482;5216.191490319006;6105.217149441772;6224.128621992924;6249.187605611241;6251.031090181029;4618.584327410482;4966.1061009018;6065.665553578206;6097.675918347081;6133.080037994337;5429.321334833146;6153.384661533811;6160.383961603804;6187.195664563668;6217.4715149212825;6032.577719559677;6057.363976782374;6099.115628233882;6154.353792851775;6158.876822463526;5777.700017496029;6071.635701857903;6079.300880398722;6079.513638908877;6132.908006379907;4033.4756481657196;4315.352697095461;4739.928901066487;4809.398825146856;4872.074305881871;4332.415123958225;4373.2565463871215;4394.560543945644;4452.755098469551;4525.117602067631;5338.519533242027;5758.3090029196765;5779.075347944393;5861.765529378862;5897.085951677497;6098.603590766586;6121.173641558333;6126.264848218153;6127.509799216052;6140.6929653517145;5731.426857314235;5793.95708772425;5858.384869588717;5892.705364731746;5896.911546326808;5341.225522299244;5374.462553744673;5375.892482150335;5381.13901775714;5382.78468861249;6295.716692748837;6320.273168585672;6326.873462530815;6334.683265836782;6335.619862808247;6115.449609535163;6145.525073982301;6186.226721659793;6207.34822843613;6208.565400421927;5234.345706786652;6294.464970477561;6296.905546416899;6297.779577714941;6299.590526615755;6141.9385806143155;6152.077188421773;6170.907436388368;6194.318624951342;6217.285012223471;6126.365000174342;6136.171616831849;6147.907781383372;6211.875762484816;6236.968815155895;6109.327973922954;6134.693265336805;6142.293636231891;6143.907841382472;6148.815535533941;6017.939820601738;6057.1519987200945;6083.087536869505;6125.479334256638;6142.877142457037;4766;5287.154055351125;5470.632341914521;5823.330317013429;6020.307664618625;6081.574289799849;6103.328633850362;6110.847228819315;6117.785877494266;6124.6325220486915;5945.524358051259;6033.336333003278;6036.124761909587;6045.365236650088;6064.666443345482 10:58:16 INFO - PROCESS | 1669 | |1;ext.html;510.1098582972711;515.1191462598956;536.919462080688;550.8925759476904;589.2663633775949;39558.60441395585;39613.801930990376;40279.19441611166;40384;40486.99999999996;34675.959721208405;41525.96185095374;41775.37336939941;42360.36459453103;42416;9454.858177127331;9627.181689556395;9694.903050969471;9695.903040969606;9715.562799674031;9542;9775.902240977606;9788.461634610094;9866.062724041205;9900.55447504864;9068.8639670405;9240.260779137687;9846.40921544706;9889.456079915602;9892.15916647086;8974.86537701935;9797.80404391908;9801.950990245074;9837.917829038835;9888.555015024342;8277.213664701903;9606.90393096067;9682.273829462818;9705.854412183822;9743.707688769347;35425.29149417023;39728;40798.38802417966;40834.1833163338;41299;2751.4222013377216;2982.194807402011;3061.2193890557987;3091.8763249469994;3217.131374528864;27495;27574.724252757416;27586.724132758616;27590.448191036066;27617.03340383077;2319.617263151578;2625.3174174714713;2645.5899335603012;2653.40298432853;2742.80800343976;371597;378593;378674;382089;382108;36020.63979360173;36295;36336.27327453436;36357.27285454276;36414.63585364165;64072.67963660152;64077;64825.027624585666;65246.34753652403;65458.69082618321;17234.65530689379;17292.913535432242;17453.301867925395;17498.737518937225;17571;10535.683929482127;11520.827187592193;12907.902828259515;13150.07949443549;13221.876140527971;20304.593908121755;20325.593488130155;20343;20434.897825510776;20897.477563061046;7214.819629509304;8504.872426913602;8525.44584601999;8549.931258592676;8601.537738584455;957.9089986451276;976.8778902637171;1037.2117190934794;1131.1742428027585;1163.319458117011;29633.85183074114;30779.538306925413;30833.537496937563;30999.915002974787;31419.900303489267;986.1814693804125;1092.983605245922;1108.728361551425;1131.643532287327;1235.6169587427926;13940.721185576233;15895.682086358209;16118;16222.339252178588;16455.25508781711;571916.4212536815;574853;575372;578179;580500;63885.680571596844;64627;64665;64674.35325646777;64801;1371.9245441500814;1407.3385508810843;1502.2713983717888;1507.8416766239607;1509.7433436315853;29297.974570889917;29982.700172998862;30105.849470752506;30544;31180.688193118687;55328.44671553394;56665.58336041632;57165;57267;57927;577733.2226677679;598565;599746;599986;600433;27506.449871002867;27954.440911182068;28131.71868281291;28299.43401132007;28390;47443;47852.28221576749;48334.516654834406;48671;48892;33091.83454082714;37855.810720947324;39220;39267.80366098151;40255.396169056905;38508.42237366386;38572.80713596414;39210.803945980086;39487;39563.80218098891;38391.2321753569;38544.22911541809;38851.2229755409;39484.40773388459;39870.80064599658;30172.84913575506;33288.667113329524;34570.790022349094;34906.77826276068;35703.82148089243;25190.74809251884;25343.873280633477;25672.202945793615;25789.871050644626;26054.348641283363 10:58:16 INFO - PROCESS | 1669 | |2;jquery.html;387.11544121681965;389.16256157635434;392.3839571872161;394.61525013112214;396.6192455242967;20087.598248035032;21112.366629001117;21161.153553857846;21218.575628487422;22505.09979600818;21235.256766013194;21518.677219841717;21576.78423215771;22311.888440557814;22340.664890026663;5726.7422965966425;5834.737436815353;5936.5250779937505;5955.70221488926;5976.432238937294;5577.553795696354;5765.336986246593;5837;5880.8235752927485;5892.14563888236;5201.621570283878;5617.550595952314;5793.7392817323325;5802.274715660543;5818.941810581903;4973.875653108701;5523.28197334348;5702.201691763156;5774.6535207887455;5836.474717275466;5111.488851114896;5113.130767769489;5125.6155788315655;5152.536271735525;5157.767900444452;25669.358266043313;26210;26435.603465947836;26781.86609066942;26801.06196283121;2128.2763860287423;2185.8579192352604;2481.4292712676006;2482.9751702483104;2614.4640348728653;14717.337719802634;15366.692666146615;15522.61193470161;15562.844371556366;15744.763828542582;1653.437831137407;1682.4532027091245;1695.5337282247358;1737.2442987300565;1738.0961899812153;118961;121622.39188804087;122281.38859305647;122571;124332;8114.715984940617;10198.286119971532;11350.3757293348;11724.706882327839;11795.587154449724;12098.455569499394;14119.941004424709;14491.492797752027;14609.269536523132;14669.92665036668;7740.458167928191;8558.743237702878;8751.518666473277;8856.601452934634;8993.460392376479;7456.3662088721985;8840.823183536293;8950.86573701395;8993.955030224937;9078.500682462396;6202.829009846518;6665.133532640726;7130.429565634737;7179.605121718356;7192.568445893263;1750.5623594101476;1971.0341932453282;1972.8125828046313;1986.2948653228184;2008.0060370116885;915.3043686798081;980.632262901412;1006.3710181136789;1029.953652085658;1081.6268387406333;21077.78922210789;21874.23440179586;21893.781062189493;22018.11927522881;22222.88888555547;992.7815880506278;1001.7195185348114;1008.5965613754411;1055.5355643516982;1072.2279958429917;9238.44569325829;11575.42122893852;11736.413179340998;11819.822702659467;11849.585264515701;238930;242889;243280;244046;245169;86722;93775;119263;121133.39433302953;124988.1251781224;850.6342272822745;1017.7811770469384;1030.5156576409076;1031.2214278219897;1039.1530902314742;18029.549261268574;19188.13653385573;19518.707219392003;19520;19835.801641983973;53901.73049134729;54348.72825635847;55674.721626391605;55981.600459987196;57332.71333643305;74845.6257718708;77755.44489110073;79886;80224;84686.57656711678;8074.636641351036;8150.184981501802;8274.723197676067;8305.750827475185;8359.665613375397;9171.816563668823;11948.820767688318;12693.174943628635;13085.738285234433;13135.671608209872;10852.837207441737;10994;11026.228164028762;11090.279131856403;11096.500657470595;10787.460626968777;10871.565137394417;11102.944485277521;11103.777924441305;11374.431278435879;11138.3873886937;11211.215214935202;11320.716982075513;11413.569710218615;11425.718849840188;8146.5519396433765;8230.971128608924;8292.834143316979;8381.078081410918;8412.327013839;10629.627963021258;10997.725056873642;11318.886811131782;11361.261518001304;11366.033887119687 10:58:16 INFO - PROCESS | 1669 | |3;mootools.html;1439.9424023039076;1653.289085693152;1793.4350679535946;1914.9904250478755;1943.446117856411;7813.3749300056;8462.957685211573;8570.442921210117;8930.821383572333;8956.10438956105;8657.523836189008;8680.565971701406;8716.95641521793;8775.780605484866;8834.60244289007;2441.5727247731666;2467.099508679328;2475.084218839023;2480.9255722328357;2484.167803785725;2204.063273108922;2441.182203961675;2476.938076548083;2526.4441822798954;2537.3910261537285;2478.615814548748;2502.5245203411387;2504.198656429943;2508.648789169518;2510.0963653084964;2445.987770061156;2447.6940382452194;2474.418511649761;2477.0091963214677;2491.476789874129;2414.5291668124723;2455.3247856839334;2459.8155138364514;2483.962740558893;2488.377905523619;8816.162464565856;8817.206451419403;8908.554572271361;8911.019787823334;8915.197632213067;5290.523852853224;5418.620696551243;5519.530839878616;5532.225488431623;5564.165375193713;3564.554430696163;3583.4266517357096;3610.9277814443826;3620.149264922741;3642.289753498069;1009.1724785675749;1058.25921854702;1059.713877253145;1063.3832377221192;1064.350746044912;11674.182807203499;11768.235064720766;11793.528258869635;11798.646040618709;11839.230450020721;4847.006363695434;4898.681585696918;5014;5025.422076461181;5051.393832740095;9914.058164474363;9940.751481213027;10082.143017843418;10162.695119146438;10241.641542545975;5398.217258497496;5406.702631355234;5492.972535137379;5549.7780088796;5584.86037849057;4435.645148388186;4863.294822250754;4972.602191824645;5024.447310795809;5028.019536190408;4141.482314710661;4149.543550209474;4160.105577300835;4169.645580125723;4176.185962986956;1375.7317323122095;1386.8335799703898;1401.2993503248376;1413.152108734751;1414.5685565902293;743.31614914279;844.4637655089062;856.9759137830357;907.4691305586306;926;5732.197492351074;5798;5934.13074881411;5960.433758792908;6074.483668888106;781.7771934998611;834.5326617094447;915.2037727177399;952.4666186935339;955.9187469065068;3899.1811719539214;3929.233799409145;3970.4441378207075;4035.616616421435;4036.1725846201457;10311.690649280534;10792.78414431707;10843.51204195813;10918.672439826818;10963.232573719763;10610.787784244427;10703.304285221435;10851.728706782395;10935.507902144423;10944.01503864656;7994.760157195294;8304.335653147733;8313.501189928624;8346.624401901929;8393.24460798531;5735.028310648119;5742.913856292075;5839.883202336015;5888.499477544286;5917.112433135064;8760.737177884674;8771.81580486626;9979.950100249453;10104.343217690826;10277.74305642365;9912.900870991198;10283.228757843042;10292.330998485075;10423.270371074255;10468.057874791306;6352.555321127662;7098.112735908012;7114.9288507116335;7155.677994490156;7225.783226503213;8496.53269070207;8498.61756220984;8585;8604.526751028754;8611.397202196036;7464.066991626047;7634.389248859967;7704.114026886979;7709.807254818675;7766.456348055582;7358.4849060567385;7376.889346659697;7429.665665044978;7464.141623713125;7531.133919599316;7036.577805331696;7051.471139664443;7110.537815042213;7128;7137.82155446118;4200.66394688418;4796.208625576741;4835.105505481497;4877.244027175793;5062.544371006627;4903.239997800347;4968.3044373788425;4982.4768399317545;5020.121478741133;5227.372715274191 10:58:16 INFO - PROCESS | 1669 | |4;prototype.html;309.3534512868105;314.51250561629473;324.59749910111464;325.4759836662974;326.568929013702;4616.74607896566;5258.7379029033045;5412.025835349636;5499;5552.750126244318;4833.758312084399;5522.944770552293;5533.612647114694;5534.557235421166;5564.888702225963;3553.520274762913;4231.4710661167355;4244;4247.766372849507;4250.341197114452;3932.74437161585;4112.835486580533;4255.191513612419;4279.593438623341;4279.91440171198;3226.887058952937;4193.287141185991;4204.894877628069;4236.322188449849;4253.680973926952;3333.8166400847945;3408.744344174197;3766.679832214265;4205.726627769201;4222.239996800575;3036.3927214556957;3694.4827724118645;3713.517242758451;3713.721470889694;3742.401215805485;4633.351330813689;5262.368515778131;5287.867803304948;5320.388155362144;5345.322842512801;4592.5177856324935;4868.196747536652;4871.902561948741;4885.5358740919555;4887.902241955177;5546.889062218774;5614.905093506768;5831.542114471382;5853.5317174625925;5865;4066.1867626474823;4072.3891416287497;4093.3450647896493;4094.324436467979;4105.501491955415;4866.51334866514;6129;6151.784687535915;6163.229596300463;6232.407921247474;4121.670266378683;4131.111810960658;4131.194417088699;4132.380142978577;4164.354525048622;3739.6447337503437;3930.4890364252465;4194.769287689145;4212.199682060399;4249.553796851348;4813.687110337817;4856.397388861667;4859;4859.198232291632;4886.315915771795;4490.281554951192;5532.834014979557;5644.895307580814;5967.388805022706;5978.910316345258;1230.8953738932112;1531.839156888533;1537.0393504059962;1538.7076455473425;1540.8151021877447;923.9168474837297;1006.6376104602338;1009.2027298434301;1035.1201478743158;1038.7091614347994;4668.5798278155125;4909.618834865088;5330.600204984642;5843.532517398683;5890.67601281925;5605.635633683797;5647.910273198942;6492.123563318986;6533;6545.312742162005;5247.897941432266;5699.544036477072;5830.650160990354;5884.6469211847425;5909.3795151508475;3368.5789276340456;3410;3413.975807257813;3430.5368775215525;3432.845521951518;5960.970195149083;5986.383676407346;6729.966350168315;6752.898706519406;6759.729610815611;5400.324959380077;6158.630482171084;6236.630080569445;6269.62382257066;6270.6864656766975;5482.972585137049;6038.365971573009;6184.443400094013;6316.936830631635;6342.245508533397;4903.847595815052;5112.514311140436;5417.241586178017;6114.480269176992;6183.783567575113;4874.707517548958;6059.363766804422;6112.235970503687;6133.662648554372;6181.567290289637;5445.918311225414;5932.288125424977;6058.363871793398;6335.085860504036;6400.647964362005;4094.897627559335;4158.37624356349;4214.30463973441;4228.175505776344;4310.43964284641;4913.680610760289;5200.5059519345605;5244.056069907453;5310.840674779763;5881.441263080001;5430.565554755531;5798.942010580009;5848.4151584841175;5882.029465138205;5909.645421274738;4804.759762011955;5436.673799572039;5664.631798933056;5880.970595146997;5905.970470147794;4698.765061746967;4996.850094497171;5344.812931547533;5633.605647604629;5769.163471296554;4796.712197268175;4821.722243605377;5493.670379777226;5811.1573821794755;5898.233229680114;4624.77443477472;5566.638168519034;5725.513331366714;5813.505852002458;5829.883402331845 10:58:16 INFO - PROCESS | 1669 | |5;yui.html;623.2365352443258;627.8085184018873;630.4168644004295;644.9000404937234;662.4270006444427;10676.839847402285;12502.249865008105;13472.12431191973;14971.176585287818;15032.722218611403;13692.452301907937;13749.725005499884;13751.037427380088;13762.174269543835;13831.100978436394;726.4297526441744;896.8609865470862;896.9013408525074;929.707142250189;941.8916824565194;900.653248499326;917.6146018672174;942.3356533643799;942.4345392764355;945.862849886766;935.2704890185632;935.7660584853786;969.8011907558969;972.5672075926216;973.1290495006964;940.3323640215456;974.7124598243536;983.3215081593713;983.3264214013424;984.906433888783;690.8169335126196;691.9965400173018;705.6930235347589;717.3113810741694;721.3832173491694;12090.939545302304;12363.443645035995;14307.856921430757;14720.263986800725;14755.631109222248;12194;12276.447559859827;12312.507499700001;12345.75308493834;12607.810882836673;8303.294219991309;9850.408975461496;9913.405195688281;10198.847017294747;10315.07164355204;3473.5831700195886;3481.9825900870333;3512.3853325667906;3564.41187204111;3598.676119149289;72563.0974761009;80023.5998820008;80281.39437211282;80351.19648803496;83767.58116209442;8369.372297077743;8781.473111613324;9112.772180695536;9313;9332.953335233417;21757.912104395033;21980.340589782012;22033.449163771034;22035.449113771963;22035.889820550794;7214.134303883568;7333.303336183054;7374.1151061872915;7435.40516758658;7628.351590114791;4015.1768887378016;4031.6169963853386;4049.6962727794944;4083.8979025524004;4087.162131763041;3510.78935263885;3580.266045460726;3586.049696830342;3592.407252803258;3815.1225218199415;695.6730336741723;707.0560801330179;709.1206903439697;710.0946293475756;711.6015031582331;535.5421114946743;539.700466241232;579.2701196492366;579.6116601876753;583.7110630238059;6531.771388001397;7944.682212711542;8359.247667709935;8458.957705211435;8506.234438900405;555.7832445346318;575.1200662985639;582.3943099176809;597.9028482734144;638.256431257589;3920.7843568604;3934.9016274593364;3955.980220098881;3985.3822657488136;4052.04958899077;102330;106337;107091;108889;110370;85173.29653406897;86527;89553;90051.54974225086;91054.54472727593;61220.69389653023;75817;76522.61738691271;79866.6006669963;80167.59916200499;7783.377329813715;7838.960805195938;7860.096088949844;7903.407244456574;7936.246056624612;47880.521194789;48494.757526212146;48544.514554854;48581.27128093011;49428;64938.35061649323;65062.349376507525;72748;74456.62771686107;75144;8191.508509489449;9991.100800927952;10139.442330671884;10437.947810260901;10528.315659482108;11107.05590024857;11194.832077519006;11233.326000439672;11236.775264494501;11366.602168924048;10187.592496300065;10614.23888007241;10661.360318380923;10737.14102871784;11053.834192486958;10439.425831579336;10525.73685657834;10558.102561282378;10755.89244107549;10788.136949044214;10432.895671043192;10674.092702120406;10689.251752377259;10703.785924281316;10714.571417143226;7658.23417658252;8919.197272245528;8931;9092.636294548143;9126.323302010262;8708.955632963884;8913.930328360639;8947.821043578962;9410.153086222273;9636.518174091407 10:58:16 INFO - PROCESS | 1669 | __end_tp_report 10:58:16 INFO - PROCESS | 1669 | __start_cc_report 10:58:16 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,423 10:58:16 INFO - PROCESS | 1669 | __end_cc_report 10:58:16 INFO - PROCESS | 1669 | __startTimestamp1461866296771__endTimestamp 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | ------- Summary: start ------- 10:58:16 INFO - PROCESS | 1669 | Number of tests: 6 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5624.87 Median:5892.71 stddev:776.53 (13.2%) stddev-sans-first:758.29 10:58:16 INFO - PROCESS | 1669 | Values: 3359.3 3434.4 3462.5 3496.0 3509.0 5011.0 5041.3 5266.2 5679.6 5713.5 5565.4 5659.2 5668.5 5771.6 5795.5 5107.4 5204.2 5235.2 5258.1 5314.9 117.9 5113.0 5167.5 5200.9 5215.4 5187.1 5199.5 5216.8 5219.9 5232.3 5179.4 5239.6 5239.6 5246.7 5283.2 5136.4 5167.3 5185.4 5188.1 5283.4 5408.1 5519.0 5535.5 5539.7 5540.7 5682.7 6047.2 6149.3 6153.8 6174.8 6119.6 6127.0 6172.6 6177.8 6180.3 5853.9 5874.4 5874.6 5881.0 5904.9 5216.2 6105.2 6224.1 6249.2 6251.0 4618.6 4966.1 6065.7 6097.7 6133.1 5429.3 6153.4 6160.4 6187.2 6217.5 6032.6 6057.4 6099.1 6154.4 6158.9 5777.7 6071.6 6079.3 6079.5 6132.9 4033.5 4315.4 4739.9 4809.4 4872.1 4332.4 4373.3 4394.6 4452.8 4525.1 5338.5 5758.3 5779.1 5861.8 5897.1 6098.6 6121.2 6126.3 6127.5 6140.7 5731.4 5794.0 5858.4 5892.7 5896.9 5341.2 5374.5 5375.9 5381.1 5382.8 6295.7 6320.3 6326.9 6334.7 6335.6 6115.4 6145.5 6186.2 6207.3 6208.6 5234.3 6294.5 6296.9 6297.8 6299.6 6141.9 6152.1 6170.9 6194.3 6217.3 6126.4 6136.2 6147.9 6211.9 6237.0 6109.3 6134.7 6142.3 6143.9 6148.8 6017.9 6057.2 6083.1 6125.5 6142.9 4766.0 5287.2 5470.6 5823.3 6020.3 6081.6 6103.3 6110.8 6117.8 6124.6 5945.5 6033.3 6036.1 6045.4 6064.7 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:65691.96 Median:39031.01 stddev:140417.46 (359.8%) stddev-sans-first:140726.08 10:58:16 INFO - PROCESS | 1669 | Values: 510.1 515.1 536.9 550.9 589.3 39558.6 39613.8 40279.2 40384.0 40487.0 34676.0 41526.0 41775.4 42360.4 42416.0 9454.9 9627.2 9694.9 9695.9 9715.6 9542.0 9775.9 9788.5 9866.1 9900.6 9068.9 9240.3 9846.4 9889.5 9892.2 8974.9 9797.8 9802.0 9837.9 9888.6 8277.2 9606.9 9682.3 9705.9 9743.7 35425.3 39728.0 40798.4 40834.2 41299.0 2751.4 2982.2 3061.2 3091.9 3217.1 27495.0 27574.7 27586.7 27590.4 27617.0 2319.6 2625.3 2645.6 2653.4 2742.8 371597.0 378593.0 378674.0 382089.0 382108.0 36020.6 36295.0 36336.3 36357.3 36414.6 64072.7 64077.0 64825.0 65246.3 65458.7 17234.7 17292.9 17453.3 17498.7 17571.0 10535.7 11520.8 12907.9 13150.1 13221.9 20304.6 20325.6 20343.0 20434.9 20897.5 7214.8 8504.9 8525.4 8549.9 8601.5 957.9 976.9 1037.2 1131.2 1163.3 29633.9 30779.5 30833.5 30999.9 31419.9 986.2 1093.0 1108.7 1131.6 1235.6 13940.7 15895.7 16118.0 16222.3 16455.3 571916.4 574853.0 575372.0 578179.0 580500.0 63885.7 64627.0 64665.0 64674.4 64801.0 1371.9 1407.3 1502.3 1507.8 1509.7 29298.0 29982.7 30105.8 30544.0 31180.7 55328.4 56665.6 57165.0 57267.0 57927.0 577733.2 598565.0 599746.0 599986.0 600433.0 27506.4 27954.4 28131.7 28299.4 28390.0 47443.0 47852.3 48334.5 48671.0 48892.0 33091.8 37855.8 39220.0 39267.8 40255.4 38508.4 38572.8 39210.8 39487.0 39563.8 38391.2 38544.2 38851.2 39484.4 39870.8 30172.8 33288.7 34570.8 34906.8 35703.8 25190.7 25343.9 25672.2 25789.9 26054.3 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:25144.68 Median:22326.28 stddev:46366.12 (207.7%) stddev-sans-first:46458.92 10:58:16 INFO - PROCESS | 1669 | Values: 387.1 389.2 392.4 394.6 396.6 20087.6 21112.4 21161.2 21218.6 22505.1 21235.3 21518.7 21576.8 22311.9 22340.7 5726.7 5834.7 5936.5 5955.7 5976.4 5577.6 5765.3 5837.0 5880.8 5892.1 5201.6 5617.6 5793.7 5802.3 5818.9 4973.9 5523.3 5702.2 5774.7 5836.5 5111.5 5113.1 5125.6 5152.5 5157.8 25669.4 26210.0 26435.6 26781.9 26801.1 2128.3 2185.9 2481.4 2483.0 2614.5 14717.3 15366.7 15522.6 15562.8 15744.8 1653.4 1682.5 1695.5 1737.2 1738.1 118961.0 121622.4 122281.4 122571.0 124332.0 8114.7 10198.3 11350.4 11724.7 11795.6 12098.5 14119.9 14491.5 14609.3 14669.9 7740.5 8558.7 8751.5 8856.6 8993.5 7456.4 8840.8 8950.9 8994.0 9078.5 6202.8 6665.1 7130.4 7179.6 7192.6 1750.6 1971.0 1972.8 1986.3 2008.0 915.3 980.6 1006.4 1030.0 1081.6 21077.8 21874.2 21893.8 22018.1 22222.9 992.8 1001.7 1008.6 1055.5 1072.2 9238.4 11575.4 11736.4 11819.8 11849.6 238930.0 242889.0 243280.0 244046.0 245169.0 86722.0 93775.0 119263.0 121133.4 124988.1 850.6 1017.8 1030.5 1031.2 1039.2 18029.5 19188.1 19518.7 19520.0 19835.8 53901.7 54348.7 55674.7 55981.6 57332.7 74845.6 77755.4 79886.0 80224.0 84686.6 8074.6 8150.2 8274.7 8305.8 8359.7 9171.8 11948.8 12693.2 13085.7 13135.7 10852.8 10994.0 11026.2 11090.3 11096.5 10787.5 10871.6 11102.9 11103.8 11374.4 11138.4 11211.2 11320.7 11413.6 11425.7 8146.6 8231.0 8292.8 8381.1 8412.3 10629.6 10997.7 11318.9 11361.3 11366.0 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5770.12 Median:4998.24 stddev:3190.42 (63.8%) stddev-sans-first:3182.77 10:58:16 INFO - PROCESS | 1669 | Values: 1439.9 1653.3 1793.4 1915.0 1943.4 7813.4 8463.0 8570.4 8930.8 8956.1 8657.5 8680.6 8717.0 8775.8 8834.6 2441.6 2467.1 2475.1 2480.9 2484.2 2204.1 2441.2 2476.9 2526.4 2537.4 2478.6 2502.5 2504.2 2508.6 2510.1 2446.0 2447.7 2474.4 2477.0 2491.5 2414.5 2455.3 2459.8 2484.0 2488.4 8816.2 8817.2 8908.6 8911.0 8915.2 5290.5 5418.6 5519.5 5532.2 5564.2 3564.6 3583.4 3610.9 3620.1 3642.3 1009.2 1058.3 1059.7 1063.4 1064.4 11674.2 11768.2 11793.5 11798.6 11839.2 4847.0 4898.7 5014.0 5025.4 5051.4 9914.1 9940.8 10082.1 10162.7 10241.6 5398.2 5406.7 5493.0 5549.8 5584.9 4435.6 4863.3 4972.6 5024.4 5028.0 4141.5 4149.5 4160.1 4169.6 4176.2 1375.7 1386.8 1401.3 1413.2 1414.6 743.3 844.5 857.0 907.5 926.0 5732.2 5798.0 5934.1 5960.4 6074.5 781.8 834.5 915.2 952.5 955.9 3899.2 3929.2 3970.4 4035.6 4036.2 10311.7 10792.8 10843.5 10918.7 10963.2 10610.8 10703.3 10851.7 10935.5 10944.0 7994.8 8304.3 8313.5 8346.6 8393.2 5735.0 5742.9 5839.9 5888.5 5917.1 8760.7 8771.8 9980.0 10104.3 10277.7 9912.9 10283.2 10292.3 10423.3 10468.1 6352.6 7098.1 7114.9 7155.7 7225.8 8496.5 8498.6 8585.0 8604.5 8611.4 7464.1 7634.4 7704.1 7709.8 7766.5 7358.5 7376.9 7429.7 7464.1 7531.1 7036.6 7051.5 7110.5 7128.0 7137.8 4200.7 4796.2 4835.1 4877.2 5062.5 4903.2 4968.3 4982.5 5020.1 5227.4 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4752.20 Median:5156.51 stddev:1450.17 (28.1%) stddev-sans-first:1415.37 10:58:16 INFO - PROCESS | 1669 | Values: 309.4 314.5 324.6 325.5 326.6 4616.7 5258.7 5412.0 5499.0 5552.8 4833.8 5522.9 5533.6 5534.6 5564.9 3553.5 4231.5 4244.0 4247.8 4250.3 3932.7 4112.8 4255.2 4279.6 4279.9 3226.9 4193.3 4204.9 4236.3 4253.7 3333.8 3408.7 3766.7 4205.7 4222.2 3036.4 3694.5 3713.5 3713.7 3742.4 4633.4 5262.4 5287.9 5320.4 5345.3 4592.5 4868.2 4871.9 4885.5 4887.9 5546.9 5614.9 5831.5 5853.5 5865.0 4066.2 4072.4 4093.3 4094.3 4105.5 4866.5 6129.0 6151.8 6163.2 6232.4 4121.7 4131.1 4131.2 4132.4 4164.4 3739.6 3930.5 4194.8 4212.2 4249.6 4813.7 4856.4 4859.0 4859.2 4886.3 4490.3 5532.8 5644.9 5967.4 5978.9 1230.9 1531.8 1537.0 1538.7 1540.8 923.9 1006.6 1009.2 1035.1 1038.7 4668.6 4909.6 5330.6 5843.5 5890.7 5605.6 5647.9 6492.1 6533.0 6545.3 5247.9 5699.5 5830.7 5884.6 5909.4 3368.6 3410.0 3414.0 3430.5 3432.8 5961.0 5986.4 6730.0 6752.9 6759.7 5400.3 6158.6 6236.6 6269.6 6270.7 5483.0 6038.4 6184.4 6316.9 6342.2 4903.8 5112.5 5417.2 6114.5 6183.8 4874.7 6059.4 6112.2 6133.7 6181.6 5445.9 5932.3 6058.4 6335.1 6400.6 4094.9 4158.4 4214.3 4228.2 4310.4 4913.7 5200.5 5244.1 5310.8 5881.4 5430.6 5798.9 5848.4 5882.0 5909.6 4804.8 5436.7 5664.6 5881.0 5906.0 4698.8 4996.9 5344.8 5633.6 5769.2 4796.7 4821.7 5493.7 5811.2 5898.2 4624.8 5566.6 5725.5 5813.5 5829.9 10:58:16 INFO - PROCESS | 1669 | 10:58:16 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:18849.69 Median:625.52 stddev:28031.38 (4481.3%) stddev-sans-first:28076.60 10:58:16 INFO - PROCESS | 1669 | Values: 623.2 627.8 630.4 644.9 662.4 10676.8 12502.2 13472.1 14971.2 15032.7 13692.5 13749.7 13751.0 13762.2 13831.1 726.4 896.9 896.9 929.7 941.9 900.7 917.6 942.3 942.4 945.9 935.3 935.8 969.8 972.6 973.1 940.3 974.7 983.3 983.3 984.9 690.8 692.0 705.7 717.3 721.4 12090.9 12363.4 14307.9 14720.3 14755.6 12194.0 12276.4 12312.5 12345.8 12607.8 8303.3 9850.4 9913.4 10198.8 10315.1 3473.6 3482.0 3512.4 3564.4 3598.7 72563.1 80023.6 80281.4 80351.2 83767.6 8369.4 8781.5 9112.8 9313.0 9333.0 21757.9 21980.3 22033.4 22035.4 22035.9 7214.1 7333.3 7374.1 7435.4 7628.4 4015.2 4031.6 4049.7 4083.9 4087.2 3510.8 3580.3 3586.0 3592.4 3815.1 695.7 707.1 709.1 710.1 711.6 535.5 539.7 579.3 579.6 583.7 6531.8 7944.7 8359.2 8459.0 8506.2 555.8 575.1 582.4 597.9 638.3 3920.8 3934.9 3956.0 3985.4 4052.0 102330.0 106337.0 107091.0 108889.0 110370.0 85173.3 86527.0 89553.0 90051.5 91054.5 61220.7 75817.0 76522.6 79866.6 80167.6 7783.4 7839.0 7860.1 7903.4 7936.2 47880.5 48494.8 48544.5 48581.3 49428.0 64938.4 65062.3 72748.0 74456.6 75144.0 8191.5 9991.1 10139.4 10437.9 10528.3 11107.1 11194.8 11233.3 11236.8 11366.6 10187.6 10614.2 10661.4 10737.1 11053.8 10439.4 10525.7 10558.1 10755.9 10788.1 10432.9 10674.1 10689.3 10703.8 10714.6 7658.2 8919.2 8931.0 9092.6 9126.3 8709.0 8913.9 8947.8 9410.2 9636.5 10:58:16 INFO - PROCESS | 1669 | -------- Summary: end -------- 10:58:16 INFO - PROCESS | 1669 | 10:58:17 INFO - TEST-INFO | 1669: exit 0 10:58:17 INFO - TEST-OK | dromaeo_css | took 1111278ms 10:58:17 INFO - TEST-START | kraken 10:58:17 INFO - operating with platform_type : mac_ 10:58:17 INFO - Initialising browser for kraken test... 10:58:17 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpWhnHzC/profile http://localhost:49276/getInfo.html) 10:58:20 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 10:58:20 INFO - PROCESS | 1677 | colorDepth:24 10:58:20 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 10:58:20 INFO - PROCESS | 1677 | __metrics 10:58:20 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 10:58:20 INFO - TEST-INFO | 1677: exit 0 10:58:20 INFO - Browser initialized. 10:58:20 INFO - Running cycle 1/1 for kraken test... 10:58:20 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/tmpWhnHzC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:32 INFO - PROCESS | 1680 | RSS: Main: 249831424 10:58:32 INFO - PROCESS | 1680 | 10:58:35 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 10:58:36 INFO - PROCESS | 1680 | RSS: Main: 261931008 10:58:36 INFO - PROCESS | 1680 | 10:58:39 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 10:58:40 INFO - PROCESS | 1680 | RSS: Main: 266752000 10:58:40 INFO - PROCESS | 1680 | 10:58:43 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 10:58:44 INFO - PROCESS | 1680 | RSS: Main: 266854400 10:58:44 INFO - PROCESS | 1680 | 10:58:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 10:58:46 INFO - PROCESS | 1680 | RSS: Main: 267460608 10:58:46 INFO - PROCESS | 1680 | 10:58:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:58:49 INFO - PROCESS | 1680 | RSS: Main: 267898880 10:58:49 INFO - PROCESS | 1680 | 10:58:52 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 10:58:53 INFO - PROCESS | 1680 | RSS: Main: 267984896 10:58:53 INFO - PROCESS | 1680 | 10:58:55 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 10:58:56 INFO - PROCESS | 1680 | RSS: Main: 268165120 10:58:56 INFO - PROCESS | 1680 | 10:58:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 10:58:59 INFO - PROCESS | 1680 | RSS: Main: 268320768 10:58:59 INFO - PROCESS | 1680 | 10:59:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:59:02 INFO - PROCESS | 1680 | RSS: Main: 267857920 10:59:02 INFO - PROCESS | 1680 | 10:59:03 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:59:04 INFO - PROCESS | 1680 | RSS: Main: 267911168 10:59:04 INFO - PROCESS | 1680 | 10:59:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:59:07 INFO - PROCESS | 1680 | RSS: Main: 268120064 10:59:07 INFO - PROCESS | 1680 | 10:59:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:59:10 INFO - PROCESS | 1680 | RSS: Main: 268398592 10:59:10 INFO - PROCESS | 1680 | 10:59:13 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:59:14 INFO - PROCESS | 1680 | RSS: Main: 268390400 10:59:14 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 10:59:16 INFO - PROCESS | 1680 | RSS: Main: 269930496 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | __start_tp_report 10:59:16 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 10:59:16 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 10:59:16 INFO - PROCESS | 1680 | |i|pagename|runs| 10:59:16 INFO - PROCESS | 1680 | |0;ai-astar;116;110;117;116;116;127;115;126;167;163 10:59:16 INFO - PROCESS | 1680 | |1;audio-beat-detection;156;138;182;200;125;146;142;127;168;122 10:59:16 INFO - PROCESS | 1680 | |2;audio-dft;197;206;238;199;200;199;199;200;202;202 10:59:16 INFO - PROCESS | 1680 | |3;audio-fft;65;78;74;135;81;81;95;77;74;55 10:59:16 INFO - PROCESS | 1680 | |4;audio-oscillator;75;125;168;111;77;73;156;116;116;135 10:59:16 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;86;88;101;135;85;89;88;88;84 10:59:16 INFO - PROCESS | 1680 | |6;imaging-darkroom;95;95;95;96;96;95;95;96;95;95 10:59:16 INFO - PROCESS | 1680 | |7;imaging-desaturate;91;93;92;90;89;90;89;92;90;92 10:59:16 INFO - PROCESS | 1680 | |8;json-parse-financial;61;61;62;62;62;62;62;77;65;61 10:59:16 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;66;65;73;70;75;72;64;68;66;70 10:59:16 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;86;82;85;83;86;85;83;83;85;86 10:59:16 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;139;126;133;149;155;123;152;136;194;143 10:59:16 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;226;217;171;173;172;171;178;170;169;168 10:59:16 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;70;70;75;70;72;68;65;71;68;68 10:59:16 INFO - PROCESS | 1680 | __end_tp_report 10:59:16 INFO - PROCESS | 1680 | __start_cc_report 10:59:16 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1075 10:59:16 INFO - PROCESS | 1680 | __end_cc_report 10:59:16 INFO - PROCESS | 1680 | __startTimestamp1461866356431__endTimestamp 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | ------- Summary: start ------- 10:59:16 INFO - PROCESS | 1680 | Number of tests: 14 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:127.30 Median:121.50 stddev:20.53 (16.9%) stddev-sans-first:21.36 10:59:16 INFO - PROCESS | 1680 | Values: 116.0 110.0 117.0 116.0 116.0 127.0 115.0 126.0 167.0 163.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:151.00 stddev:25.91 (17.2%) stddev-sans-first:27.41 10:59:16 INFO - PROCESS | 1680 | Values: 156.0 138.0 182.0 200.0 125.0 146.0 142.0 127.0 168.0 122.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:204.20 Median:201.00 stddev:12.13 (6.0%) stddev-sans-first:12.58 10:59:16 INFO - PROCESS | 1680 | Values: 197.0 206.0 238.0 199.0 200.0 199.0 199.0 200.0 202.0 202.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:81.50 Median:77.50 stddev:21.51 (27.8%) stddev-sans-first:21.97 10:59:16 INFO - PROCESS | 1680 | Values: 65.0 78.0 74.0 135.0 81.0 81.0 95.0 77.0 74.0 55.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:115.20 Median:162.00 stddev:33.02 (20.4%) stddev-sans-first:31.66 10:59:16 INFO - PROCESS | 1680 | Values: 75.0 125.0 168.0 111.0 77.0 73.0 156.0 116.0 116.0 135.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:88.00 stddev:15.41 (17.5%) stddev-sans-first:16.23 10:59:16 INFO - PROCESS | 1680 | Values: 88.0 86.0 88.0 101.0 135.0 85.0 89.0 88.0 88.0 84.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:59:16 INFO - PROCESS | 1680 | Values: 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:91.50 stddev:1.40 (1.5%) stddev-sans-first:1.48 10:59:16 INFO - PROCESS | 1680 | Values: 91.0 93.0 92.0 90.0 89.0 90.0 89.0 92.0 90.0 92.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:62.00 stddev:4.88 (7.9%) stddev-sans-first:5.09 10:59:16 INFO - PROCESS | 1680 | Values: 61.0 61.0 62.0 62.0 62.0 62.0 62.0 77.0 65.0 61.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:70.00 stddev:3.70 (5.3%) stddev-sans-first:3.77 10:59:16 INFO - PROCESS | 1680 | Values: 66.0 65.0 73.0 70.0 75.0 72.0 64.0 68.0 66.0 70.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:1.51 (1.8%) stddev-sans-first:1.48 10:59:16 INFO - PROCESS | 1680 | Values: 86.0 82.0 85.0 83.0 86.0 85.0 83.0 83.0 85.0 86.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:20.21 (13.8%) stddev-sans-first:21.32 10:59:16 INFO - PROCESS | 1680 | Values: 139.0 126.0 133.0 149.0 155.0 123.0 152.0 136.0 194.0 143.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:172.50 stddev:21.36 (12.4%) stddev-sans-first:15.44 10:59:16 INFO - PROCESS | 1680 | Values: 226.0 217.0 171.0 173.0 172.0 171.0 178.0 170.0 169.0 168.0 10:59:16 INFO - PROCESS | 1680 | 10:59:16 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:2.71 (3.9%) stddev-sans-first:2.87 10:59:16 INFO - PROCESS | 1680 | Values: 70.0 70.0 75.0 70.0 72.0 68.0 65.0 71.0 68.0 68.0 10:59:16 INFO - PROCESS | 1680 | -------- Summary: end -------- 10:59:16 INFO - PROCESS | 1680 | 10:59:17 INFO - TEST-INFO | 1680: exit 0 10:59:17 INFO - TEST-OK | kraken | took 59927ms 10:59:17 INFO - SUITE-END | took 1171s 10:59:17 INFO - Completed test suite (00:19:31) 10:59:17 INFO - javascript benchmark 10:59:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3359.2945481448896, 3434.3989801784687, 3462.4633181856807, 3496.0036389628954, 3509.0, 5010.974945125278, 5041.294218809369, 5266.183741520066, 5679.602427830043, 5713.457221563945, 5565.443455654433, 5659.151127330902, 5668.518175955039, 5771.595988280811, 5795.4784069433745, 5107.361579802525, 5204.193350030751, 5235.162374020158, 5258.13240815265, 5314.9468505314835, 117.8920421668557, 5112.9774045190925, 5167.509086636764, 5200.8699782505555, 5215.426303106655, 5187.144121219994, 5199.454057323965, 5216.765245563959, 5219.895602087956, 5232.3459567554055, 5179.352580927384, 5239.607029472805, 5239.607029472805, 5246.65896716716, 5283.1546952487415, 5136.409312929024, 5167.276581278624, 5185.429602743695, 5188.143956247215, 5283.365996080495, 5408.107662235727, 5518.972405137989, 5535.501804837544, 5539.723013849291, 5540.722963851791, 5682.7442765075675, 6047.15339852421, 6149.323574406856, 6153.753849846001, 6174.7530098796, 6119.602225855305, 6127.036821038878, 6172.567920245585, 6177.845553861144, 6180.2892667343385, 5853.85365365865, 5874.353821079678, 5874.5887787854435, 5880.970595146997, 5904.852378690482, 5216.191490319006, 6105.217149441772, 6224.128621992924, 6249.187605611241, 6251.031090181029, 4618.584327410482, 4966.1061009018, 6065.665553578206, 6097.675918347081, 6133.080037994337, 5429.321334833146, 6153.384661533811, 6160.383961603804, 6187.195664563668, 6217.4715149212825, 6032.577719559677, 6057.363976782374, 6099.115628233882, 6154.353792851775, 6158.876822463526, 5777.700017496029, 6071.635701857903, 6079.300880398722, 6079.513638908877, 6132.908006379907, 4033.4756481657196, 4315.352697095461, 4739.928901066487, 4809.398825146856, 4872.074305881871, 4332.415123958225, 4373.2565463871215, 4394.560543945644, 4452.755098469551, 4525.117602067631, 5338.519533242027, 5758.3090029196765, 5779.075347944393, 5861.765529378862, 5897.085951677497, 6098.603590766586, 6121.173641558333, 6126.264848218153, 6127.509799216052, 6140.6929653517145, 5731.426857314235, 5793.95708772425, 5858.384869588717, 5892.705364731746, 5896.911546326808, 5341.225522299244, 5374.462553744673, 5375.892482150335, 5381.13901775714, 5382.78468861249, 6295.716692748837, 6320.273168585672, 6326.873462530815, 6334.683265836782, 6335.619862808247, 6115.449609535163, 6145.525073982301, 6186.226721659793, 6207.34822843613, 6208.565400421927, 5234.345706786652, 6294.464970477561, 6296.905546416899, 6297.779577714941, 6299.590526615755, 6141.9385806143155, 6152.077188421773, 6170.907436388368, 6194.318624951342, 6217.285012223471, 6126.365000174342, 6136.171616831849, 6147.907781383372, 6211.875762484816, 6236.968815155895, 6109.327973922954, 6134.693265336805, 6142.293636231891, 6143.907841382472, 6148.815535533941, 6017.939820601738, 6057.1519987200945, 6083.087536869505, 6125.479334256638, 6142.877142457037, 4766.0, 5287.154055351125, 5470.632341914521, 5823.330317013429, 6020.307664618625, 6081.574289799849, 6103.328633850362, 6110.847228819315, 6117.785877494266, 6124.6325220486915, 5945.524358051259, 6033.336333003278, 6036.124761909587, 6045.365236650088, 6064.666443345482], "value": 5579.971106530176, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.1098582972711, 515.1191462598956, 536.919462080688, 550.8925759476904, 589.2663633775949, 39558.60441395585, 39613.801930990376, 40279.19441611166, 40384.0, 40486.99999999996, 34675.959721208405, 41525.96185095374, 41775.37336939941, 42360.36459453103, 42416.0, 9454.858177127331, 9627.181689556395, 9694.903050969471, 9695.903040969606, 9715.562799674031, 9542.0, 9775.902240977606, 9788.461634610094, 9866.062724041205, 9900.55447504864, 9068.8639670405, 9240.260779137687, 9846.40921544706, 9889.456079915602, 9892.15916647086, 8974.86537701935, 9797.80404391908, 9801.950990245074, 9837.917829038835, 9888.555015024342, 8277.213664701903, 9606.90393096067, 9682.273829462818, 9705.854412183822, 9743.707688769347, 35425.29149417023, 39728.0, 40798.38802417966, 40834.1833163338, 41299.0, 2751.4222013377216, 2982.194807402011, 3061.2193890557987, 3091.8763249469994, 3217.131374528864, 27495.0, 27574.724252757416, 27586.724132758616, 27590.448191036066, 27617.03340383077, 2319.617263151578, 2625.3174174714713, 2645.5899335603012, 2653.40298432853, 2742.80800343976, 371597.0, 378593.0, 378674.0, 382089.0, 382108.0, 36020.63979360173, 36295.0, 36336.27327453436, 36357.27285454276, 36414.63585364165, 64072.67963660152, 64077.0, 64825.027624585666, 65246.34753652403, 65458.69082618321, 17234.65530689379, 17292.913535432242, 17453.301867925395, 17498.737518937225, 17571.0, 10535.683929482127, 11520.827187592193, 12907.902828259515, 13150.07949443549, 13221.876140527971, 20304.593908121755, 20325.593488130155, 20343.0, 20434.897825510776, 20897.477563061046, 7214.819629509304, 8504.872426913602, 8525.44584601999, 8549.931258592676, 8601.537738584455, 957.9089986451276, 976.8778902637171, 1037.2117190934794, 1131.1742428027585, 1163.319458117011, 29633.85183074114, 30779.538306925413, 30833.537496937563, 30999.915002974787, 31419.900303489267, 986.1814693804125, 1092.983605245922, 1108.728361551425, 1131.643532287327, 1235.6169587427926, 13940.721185576233, 15895.682086358209, 16118.0, 16222.339252178588, 16455.25508781711, 571916.4212536815, 574853.0, 575372.0, 578179.0, 580500.0, 63885.680571596844, 64627.0, 64665.0, 64674.35325646777, 64801.0, 1371.9245441500814, 1407.3385508810843, 1502.2713983717888, 1507.8416766239607, 1509.7433436315853, 29297.974570889917, 29982.700172998862, 30105.849470752506, 30544.0, 31180.688193118687, 55328.44671553394, 56665.58336041632, 57165.0, 57267.0, 57927.0, 577733.2226677679, 598565.0, 599746.0, 599986.0, 600433.0, 27506.449871002867, 27954.440911182068, 28131.71868281291, 28299.43401132007, 28390.0, 47443.0, 47852.28221576749, 48334.516654834406, 48671.0, 48892.0, 33091.83454082714, 37855.810720947324, 39220.0, 39267.80366098151, 40255.396169056905, 38508.42237366386, 38572.80713596414, 39210.803945980086, 39487.0, 39563.80218098891, 38391.2321753569, 38544.22911541809, 38851.2229755409, 39484.40773388459, 39870.80064599658, 30172.84913575506, 33288.667113329524, 34570.790022349094, 34906.77826276068, 35703.82148089243, 25190.74809251884, 25343.873280633477, 25672.202945793615, 25789.871050644626, 26054.348641283363], "value": 19733.455121724277, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.11544121681965, 389.16256157635434, 392.3839571872161, 394.61525013112214, 396.6192455242967, 20087.598248035032, 21112.366629001117, 21161.153553857846, 21218.575628487422, 22505.09979600818, 21235.256766013194, 21518.677219841717, 21576.78423215771, 22311.888440557814, 22340.664890026663, 5726.7422965966425, 5834.737436815353, 5936.5250779937505, 5955.70221488926, 5976.432238937294, 5577.553795696354, 5765.336986246593, 5837.0, 5880.8235752927485, 5892.14563888236, 5201.621570283878, 5617.550595952314, 5793.7392817323325, 5802.274715660543, 5818.941810581903, 4973.875653108701, 5523.28197334348, 5702.201691763156, 5774.6535207887455, 5836.474717275466, 5111.488851114896, 5113.130767769489, 5125.6155788315655, 5152.536271735525, 5157.767900444452, 25669.358266043313, 26210.0, 26435.603465947836, 26781.86609066942, 26801.06196283121, 2128.2763860287423, 2185.8579192352604, 2481.4292712676006, 2482.9751702483104, 2614.4640348728653, 14717.337719802634, 15366.692666146615, 15522.61193470161, 15562.844371556366, 15744.763828542582, 1653.437831137407, 1682.4532027091245, 1695.5337282247358, 1737.2442987300565, 1738.0961899812153, 118961.0, 121622.39188804087, 122281.38859305647, 122571.0, 124332.0, 8114.715984940617, 10198.286119971532, 11350.3757293348, 11724.706882327839, 11795.587154449724, 12098.455569499394, 14119.941004424709, 14491.492797752027, 14609.269536523132, 14669.92665036668, 7740.458167928191, 8558.743237702878, 8751.518666473277, 8856.601452934634, 8993.460392376479, 7456.3662088721985, 8840.823183536293, 8950.86573701395, 8993.955030224937, 9078.500682462396, 6202.829009846518, 6665.133532640726, 7130.429565634737, 7179.605121718356, 7192.568445893263, 1750.5623594101476, 1971.0341932453282, 1972.8125828046313, 1986.2948653228184, 2008.0060370116885, 915.3043686798081, 980.632262901412, 1006.3710181136789, 1029.953652085658, 1081.6268387406333, 21077.78922210789, 21874.23440179586, 21893.781062189493, 22018.11927522881, 22222.88888555547, 992.7815880506278, 1001.7195185348114, 1008.5965613754411, 1055.5355643516982, 1072.2279958429917, 9238.44569325829, 11575.42122893852, 11736.413179340998, 11819.822702659467, 11849.585264515701, 238930.0, 242889.0, 243280.0, 244046.0, 245169.0, 86722.0, 93775.0, 119263.0, 121133.39433302953, 124988.1251781224, 850.6342272822745, 1017.7811770469384, 1030.5156576409076, 1031.2214278219897, 1039.1530902314742, 18029.549261268574, 19188.13653385573, 19518.707219392003, 19520.0, 19835.801641983973, 53901.73049134729, 54348.72825635847, 55674.721626391605, 55981.600459987196, 57332.71333643305, 74845.6257718708, 77755.44489110073, 79886.0, 80224.0, 84686.57656711678, 8074.636641351036, 8150.184981501802, 8274.723197676067, 8305.750827475185, 8359.665613375397, 9171.816563668823, 11948.820767688318, 12693.174943628635, 13085.738285234433, 13135.671608209872, 10852.837207441737, 10994.0, 11026.228164028762, 11090.279131856403, 11096.500657470595, 10787.460626968777, 10871.565137394417, 11102.944485277521, 11103.777924441305, 11374.431278435879, 11138.3873886937, 11211.215214935202, 11320.716982075513, 11413.569710218615, 11425.718849840188, 8146.5519396433765, 8230.971128608924, 8292.834143316979, 8381.078081410918, 8412.327013839, 10629.627963021258, 10997.725056873642, 11318.886811131782, 11361.261518001304, 11366.033887119687], "value": 9574.674778589233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1439.9424023039076, 1653.289085693152, 1793.4350679535946, 1914.9904250478755, 1943.446117856411, 7813.3749300056, 8462.957685211573, 8570.442921210117, 8930.821383572333, 8956.10438956105, 8657.523836189008, 8680.565971701406, 8716.95641521793, 8775.780605484866, 8834.60244289007, 2441.5727247731666, 2467.099508679328, 2475.084218839023, 2480.9255722328357, 2484.167803785725, 2204.063273108922, 2441.182203961675, 2476.938076548083, 2526.4441822798954, 2537.3910261537285, 2478.615814548748, 2502.5245203411387, 2504.198656429943, 2508.648789169518, 2510.0963653084964, 2445.987770061156, 2447.6940382452194, 2474.418511649761, 2477.0091963214677, 2491.476789874129, 2414.5291668124723, 2455.3247856839334, 2459.8155138364514, 2483.962740558893, 2488.377905523619, 8816.162464565856, 8817.206451419403, 8908.554572271361, 8911.019787823334, 8915.197632213067, 5290.523852853224, 5418.620696551243, 5519.530839878616, 5532.225488431623, 5564.165375193713, 3564.554430696163, 3583.4266517357096, 3610.9277814443826, 3620.149264922741, 3642.289753498069, 1009.1724785675749, 1058.25921854702, 1059.713877253145, 1063.3832377221192, 1064.350746044912, 11674.182807203499, 11768.235064720766, 11793.528258869635, 11798.646040618709, 11839.230450020721, 4847.006363695434, 4898.681585696918, 5014.0, 5025.422076461181, 5051.393832740095, 9914.058164474363, 9940.751481213027, 10082.143017843418, 10162.695119146438, 10241.641542545975, 5398.217258497496, 5406.702631355234, 5492.972535137379, 5549.7780088796, 5584.86037849057, 4435.645148388186, 4863.294822250754, 4972.602191824645, 5024.447310795809, 5028.019536190408, 4141.482314710661, 4149.543550209474, 4160.105577300835, 4169.645580125723, 4176.185962986956, 1375.7317323122095, 1386.8335799703898, 1401.2993503248376, 1413.152108734751, 1414.5685565902293, 743.31614914279, 844.4637655089062, 856.9759137830357, 907.4691305586306, 926.0, 5732.197492351074, 5798.0, 5934.13074881411, 5960.433758792908, 6074.483668888106, 781.7771934998611, 834.5326617094447, 915.2037727177399, 952.4666186935339, 955.9187469065068, 3899.1811719539214, 3929.233799409145, 3970.4441378207075, 4035.616616421435, 4036.1725846201457, 10311.690649280534, 10792.78414431707, 10843.51204195813, 10918.672439826818, 10963.232573719763, 10610.787784244427, 10703.304285221435, 10851.728706782395, 10935.507902144423, 10944.01503864656, 7994.760157195294, 8304.335653147733, 8313.501189928624, 8346.624401901929, 8393.24460798531, 5735.028310648119, 5742.913856292075, 5839.883202336015, 5888.499477544286, 5917.112433135064, 8760.737177884674, 8771.81580486626, 9979.950100249453, 10104.343217690826, 10277.74305642365, 9912.900870991198, 10283.228757843042, 10292.330998485075, 10423.270371074255, 10468.057874791306, 6352.555321127662, 7098.112735908012, 7114.9288507116335, 7155.677994490156, 7225.783226503213, 8496.53269070207, 8498.61756220984, 8585.0, 8604.526751028754, 8611.397202196036, 7464.066991626047, 7634.389248859967, 7704.114026886979, 7709.807254818675, 7766.456348055582, 7358.4849060567385, 7376.889346659697, 7429.665665044978, 7464.141623713125, 7531.133919599316, 7036.577805331696, 7051.471139664443, 7110.537815042213, 7128.0, 7137.82155446118, 4200.66394688418, 4796.208625576741, 4835.105505481497, 4877.244027175793, 5062.544371006627, 4903.239997800347, 4968.3044373788425, 4982.4768399317545, 5020.121478741133, 5227.372715274191], "value": 4658.291025702857, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.3534512868105, 314.51250561629473, 324.59749910111464, 325.4759836662974, 326.568929013702, 4616.74607896566, 5258.7379029033045, 5412.025835349636, 5499.0, 5552.750126244318, 4833.758312084399, 5522.944770552293, 5533.612647114694, 5534.557235421166, 5564.888702225963, 3553.520274762913, 4231.4710661167355, 4244.0, 4247.766372849507, 4250.341197114452, 3932.74437161585, 4112.835486580533, 4255.191513612419, 4279.593438623341, 4279.91440171198, 3226.887058952937, 4193.287141185991, 4204.894877628069, 4236.322188449849, 4253.680973926952, 3333.8166400847945, 3408.744344174197, 3766.679832214265, 4205.726627769201, 4222.239996800575, 3036.3927214556957, 3694.4827724118645, 3713.517242758451, 3713.721470889694, 3742.401215805485, 4633.351330813689, 5262.368515778131, 5287.867803304948, 5320.388155362144, 5345.322842512801, 4592.5177856324935, 4868.196747536652, 4871.902561948741, 4885.5358740919555, 4887.902241955177, 5546.889062218774, 5614.905093506768, 5831.542114471382, 5853.5317174625925, 5865.0, 4066.1867626474823, 4072.3891416287497, 4093.3450647896493, 4094.324436467979, 4105.501491955415, 4866.51334866514, 6129.0, 6151.784687535915, 6163.229596300463, 6232.407921247474, 4121.670266378683, 4131.111810960658, 4131.194417088699, 4132.380142978577, 4164.354525048622, 3739.6447337503437, 3930.4890364252465, 4194.769287689145, 4212.199682060399, 4249.553796851348, 4813.687110337817, 4856.397388861667, 4859.0, 4859.198232291632, 4886.315915771795, 4490.281554951192, 5532.834014979557, 5644.895307580814, 5967.388805022706, 5978.910316345258, 1230.8953738932112, 1531.839156888533, 1537.0393504059962, 1538.7076455473425, 1540.8151021877447, 923.9168474837297, 1006.6376104602338, 1009.2027298434301, 1035.1201478743158, 1038.7091614347994, 4668.5798278155125, 4909.618834865088, 5330.600204984642, 5843.532517398683, 5890.67601281925, 5605.635633683797, 5647.910273198942, 6492.123563318986, 6533.0, 6545.312742162005, 5247.897941432266, 5699.544036477072, 5830.650160990354, 5884.6469211847425, 5909.3795151508475, 3368.5789276340456, 3410.0, 3413.975807257813, 3430.5368775215525, 3432.845521951518, 5960.970195149083, 5986.383676407346, 6729.966350168315, 6752.898706519406, 6759.729610815611, 5400.324959380077, 6158.630482171084, 6236.630080569445, 6269.62382257066, 6270.6864656766975, 5482.972585137049, 6038.365971573009, 6184.443400094013, 6316.936830631635, 6342.245508533397, 4903.847595815052, 5112.514311140436, 5417.241586178017, 6114.480269176992, 6183.783567575113, 4874.707517548958, 6059.363766804422, 6112.235970503687, 6133.662648554372, 6181.567290289637, 5445.918311225414, 5932.288125424977, 6058.363871793398, 6335.085860504036, 6400.647964362005, 4094.897627559335, 4158.37624356349, 4214.30463973441, 4228.175505776344, 4310.43964284641, 4913.680610760289, 5200.5059519345605, 5244.056069907453, 5310.840674779763, 5881.441263080001, 5430.565554755531, 5798.942010580009, 5848.4151584841175, 5882.029465138205, 5909.645421274738, 4804.759762011955, 5436.673799572039, 5664.631798933056, 5880.970595146997, 5905.970470147794, 4698.765061746967, 4996.850094497171, 5344.812931547533, 5633.605647604629, 5769.163471296554, 4796.712197268175, 4821.722243605377, 5493.670379777226, 5811.1573821794755, 5898.233229680114, 4624.77443477472, 5566.638168519034, 5725.513331366714, 5813.505852002458, 5829.883402331845], "value": 4303.155074589391, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.2365352443258, 627.8085184018873, 630.4168644004295, 644.9000404937234, 662.4270006444427, 10676.839847402285, 12502.249865008105, 13472.12431191973, 14971.176585287818, 15032.722218611403, 13692.452301907937, 13749.725005499884, 13751.037427380088, 13762.174269543835, 13831.100978436394, 726.4297526441744, 896.8609865470862, 896.9013408525074, 929.707142250189, 941.8916824565194, 900.653248499326, 917.6146018672174, 942.3356533643799, 942.4345392764355, 945.862849886766, 935.2704890185632, 935.7660584853786, 969.8011907558969, 972.5672075926216, 973.1290495006964, 940.3323640215456, 974.7124598243536, 983.3215081593713, 983.3264214013424, 984.906433888783, 690.8169335126196, 691.9965400173018, 705.6930235347589, 717.3113810741694, 721.3832173491694, 12090.939545302304, 12363.443645035995, 14307.856921430757, 14720.263986800725, 14755.631109222248, 12194.0, 12276.447559859827, 12312.507499700001, 12345.75308493834, 12607.810882836673, 8303.294219991309, 9850.408975461496, 9913.405195688281, 10198.847017294747, 10315.07164355204, 3473.5831700195886, 3481.9825900870333, 3512.3853325667906, 3564.41187204111, 3598.676119149289, 72563.0974761009, 80023.5998820008, 80281.39437211282, 80351.19648803496, 83767.58116209442, 8369.372297077743, 8781.473111613324, 9112.772180695536, 9313.0, 9332.953335233417, 21757.912104395033, 21980.340589782012, 22033.449163771034, 22035.449113771963, 22035.889820550794, 7214.134303883568, 7333.303336183054, 7374.1151061872915, 7435.40516758658, 7628.351590114791, 4015.1768887378016, 4031.6169963853386, 4049.6962727794944, 4083.8979025524004, 4087.162131763041, 3510.78935263885, 3580.266045460726, 3586.049696830342, 3592.407252803258, 3815.1225218199415, 695.6730336741723, 707.0560801330179, 709.1206903439697, 710.0946293475756, 711.6015031582331, 535.5421114946743, 539.700466241232, 579.2701196492366, 579.6116601876753, 583.7110630238059, 6531.771388001397, 7944.682212711542, 8359.247667709935, 8458.957705211435, 8506.234438900405, 555.7832445346318, 575.1200662985639, 582.3943099176809, 597.9028482734144, 638.256431257589, 3920.7843568604, 3934.9016274593364, 3955.980220098881, 3985.3822657488136, 4052.04958899077, 102330.0, 106337.0, 107091.0, 108889.0, 110370.0, 85173.29653406897, 86527.0, 89553.0, 90051.54974225086, 91054.54472727593, 61220.69389653023, 75817.0, 76522.61738691271, 79866.6006669963, 80167.59916200499, 7783.377329813715, 7838.960805195938, 7860.096088949844, 7903.407244456574, 7936.246056624612, 47880.521194789, 48494.757526212146, 48544.514554854, 48581.27128093011, 49428.0, 64938.35061649323, 65062.349376507525, 72748.0, 74456.62771686107, 75144.0, 8191.508509489449, 9991.100800927952, 10139.442330671884, 10437.947810260901, 10528.315659482108, 11107.05590024857, 11194.832077519006, 11233.326000439672, 11236.775264494501, 11366.602168924048, 10187.592496300065, 10614.23888007241, 10661.360318380923, 10737.14102871784, 11053.834192486958, 10439.425831579336, 10525.73685657834, 10558.102561282378, 10755.89244107549, 10788.136949044214, 10432.895671043192, 10674.092702120406, 10689.251752377259, 10703.785924281316, 10714.571417143226, 7658.23417658252, 8919.197272245528, 8931.0, 9092.636294548143, 9126.323302010262, 8708.955632963884, 8913.930328360639, 8947.821043578962, 9410.153086222273, 9636.518174091407], "value": 6800.067055844744, "unit": "score"}], "name": "dromaeo_css", "value": 7237.493427563372, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 110.0, 117.0, 116.0, 116.0, 127.0, 115.0, 126.0, 167.0, 163.0], "value": 127.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 138.0, 182.0, 200.0, 125.0, 146.0, 142.0, 127.0, 168.0, 122.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 206.0, 238.0, 199.0, 200.0, 199.0, 199.0, 200.0, 202.0, 202.0], "value": 204.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 78.0, 74.0, 135.0, 81.0, 81.0, 95.0, 77.0, 74.0, 55.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 125.0, 168.0, 111.0, 77.0, 73.0, 156.0, 116.0, 116.0, 135.0], "value": 115.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 101.0, 135.0, 85.0, 89.0, 88.0, 88.0, 84.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 93.0, 92.0, 90.0, 89.0, 90.0, 89.0, 92.0, 90.0, 92.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 62.0, 62.0, 62.0, 62.0, 77.0, 65.0, 61.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 73.0, 70.0, 75.0, 72.0, 64.0, 68.0, 66.0, 70.0], "value": 68.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 85.0, 83.0, 86.0, 85.0, 83.0, 83.0, 85.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 126.0, 133.0, 149.0, 155.0, 123.0, 152.0, 136.0, 194.0, 143.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [226.0, 217.0, 171.0, 173.0, 172.0, 171.0, 178.0, 170.0, 169.0, 168.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 75.0, 70.0, 72.0, 68.0, 65.0, 71.0, 68.0, 68.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1571.1000000000001, "alertThreshold": 2.0}]} 10:59:17 INFO - Return code: 0 10:59:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:59:17 ERROR - # TBPL SUCCESS # 10:59:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:59:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:59:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:59:17 INFO - 2016-04-28 10:59:17.758 screenresolution[1685:10496] starting screenresolution argv=screenresolution get 10:59:17 INFO - 2016-04-28 10:59:17.761 screenresolution[1685:10496] Display 0: 1600x1200x32@60 10:59:17 INFO - 2016-04-28 10:59:17.767 screenresolution[1686:10499] starting screenresolution argv=screenresolution list 10:59:17 INFO - Available Modes on Display 0 10:59:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:59:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:59:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:59:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:59:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:59:18 INFO - Intel Iris: 10:59:18 INFO - Chipset Model: Intel Iris 10:59:18 INFO - Type: GPU 10:59:18 INFO - Bus: Built-In 10:59:18 INFO - VRAM (Dynamic, Max): 1536 MB 10:59:18 INFO - Vendor: Intel (0x8086) 10:59:18 INFO - Device ID: 0x0a2e 10:59:18 INFO - Revision ID: 0x0009 10:59:18 INFO - Displays: 10:59:18 INFO - Display: 10:59:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:59:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:59:18 INFO - Display Serial Number: 1600x1200 60 10:59:18 INFO - Main Display: Yes 10:59:18 INFO - Mirror: Off 10:59:18 INFO - Online: Yes 10:59:18 INFO - Rotation: Supported 10:59:18 INFO - Return code: 0 10:59:18 INFO - Running post-action listener: _resource_record_post_action 10:59:18 INFO - Running post-run listener: _resource_record_post_run 10:59:19 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 37438976; Write bytes: 695928832; Read time: 393; Write time: 1791 10:59:19 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 380172800; Write bytes: 368190976; Read time: 28122; Write time: 668 10:59:19 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 31194624; Write bytes: 298254848; Read time: 311; Write time: 1072 10:59:19 INFO - Running post-run listener: _upload_blobber_files 10:59:19 INFO - Blob upload gear active. 10:59:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:59:19 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 10:59:19 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'] 10:59:19 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 10:59:19 INFO - (blobuploader) - INFO - Open directory for files ... 10:59:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:59:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:59:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:20 INFO - (blobuploader) - INFO - Done attempting. 10:59:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:59:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:59:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:59:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:59:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:59:21 INFO - (blobuploader) - INFO - Done attempting. 10:59:21 INFO - (blobuploader) - INFO - Iteration through files over. 10:59:21 INFO - Return code: 0 10:59:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:59:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:59:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7a98a4b9a3e2f86f9a6b488f4c4138426f850c94a0c038562b5ab9ddc91c5d074351a2923b6a68d137b73586bd4e91f04cd9b8a904ea7523c87376be4d246ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d4dd10626870d67151869e90c89916a95f6a7a94e3e4deb9cb5d573fed033c1290e7c7b029f001f8c34077bfbe1ae3b7ac1522ada7be52c6b6c8a7d58461a06"} 10:59:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:59:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:59:21 INFO - Contents: 10:59:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7a98a4b9a3e2f86f9a6b488f4c4138426f850c94a0c038562b5ab9ddc91c5d074351a2923b6a68d137b73586bd4e91f04cd9b8a904ea7523c87376be4d246ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d4dd10626870d67151869e90c89916a95f6a7a94e3e4deb9cb5d573fed033c1290e7c7b029f001f8c34077bfbe1ae3b7ac1522ada7be52c6b6c8a7d58461a06"} 10:59:21 INFO - Running post-run listener: copy_logs_to_upload_dir 10:59:21 INFO - Copying logs to upload dir... 10:59:21 INFO - mkdir: /builds/slave/test/build/upload/logs 10:59:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.755698 ========= master_lag: 0.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-28 10:59:21.979187) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 10:59:21.982205) ========= 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.iTJwsYai4q/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.U8lUCqhvVs/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c7a98a4b9a3e2f86f9a6b488f4c4138426f850c94a0c038562b5ab9ddc91c5d074351a2923b6a68d137b73586bd4e91f04cd9b8a904ea7523c87376be4d246ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d4dd10626870d67151869e90c89916a95f6a7a94e3e4deb9cb5d573fed033c1290e7c7b029f001f8c34077bfbe1ae3b7ac1522ada7be52c6b6c8a7d58461a06"} build_url:https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010979 build_url: 'https://queue.taskcluster.net/v1/task/a7ckXhheTNOSMDXpvJvPMA/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/c7a98a4b9a3e2f86f9a6b488f4c4138426f850c94a0c038562b5ab9ddc91c5d074351a2923b6a68d137b73586bd4e91f04cd9b8a904ea7523c87376be4d246ee", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8d4dd10626870d67151869e90c89916a95f6a7a94e3e4deb9cb5d573fed033c1290e7c7b029f001f8c34077bfbe1ae3b7ac1522ada7be52c6b6c8a7d58461a06"}' ========= master_lag: 0.70 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 10:59:22.695857) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:59:22.696140) ========= 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.iTJwsYai4q/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.U8lUCqhvVs/Listeners TMPDIR=/var/folders/sw/56y5nypd5nvd19g5t_5x1crw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005241 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 10:59:22.732333) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 10:59:22.732605) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 10:59:22.733153) ========= ========= Total master_lag: 1.16 =========