builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0132 starttime: 1461870581.5 results: success (0) buildid: 20160428085749 builduid: 1f6ffafd21614741b9c8bb262308a9ad revision: 4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 12:09:41.497773) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 12:09:41.498170) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-04-28 12:09:41.498441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 3 secs) (at 2016-04-28 12:09:44.968453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:09:44.968712) ========= 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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:09:45-- 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% 211M=0s 2016-04-28 12:09:45 (211 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.487196 ========= master_lag: 0.15 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:09:45.607289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-28 12:09:45.607558) ========= 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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.019498 ========= master_lag: 5.18 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-04-28 12:09:50.804313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-28 12:09:50.804617) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f --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 4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:09:51,808 truncating revision to first 12 chars 2016-04-28 12:09:51,808 Setting DEBUG logging. 2016-04-28 12:09:51,808 attempt 1/10 2016-04-28 12:09:51,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4dc48f3688f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 12:09:52,479 unpacking tar archive at: fx-team-4dc48f3688f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.921972 ========= master_lag: 4.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2016-04-28 12:09:55.760951) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 12:09:55.761223) ========= script_repo_revision: 4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 12:09:55.761582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-04-28 12:09:55.761860) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 9 secs) (at 2016-04-28 12:10:05.197803) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-28 12:10:05.198076) ========= /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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:05 INFO - MultiFileLogger online at 20160428 12:10:05 in /builds/slave/test 12:10:05 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 12:10:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:10:05 INFO - {'append_to_log': False, 12:10:05 INFO - 'base_work_dir': '/builds/slave/test', 12:10:05 INFO - 'blob_upload_branch': 'Fx-Team', 12:10:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:10:05 INFO - 'branch': 'Fx-Team', 12:10:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:10:05 INFO - 'config_files': ('talos/mac_config.py',), 12:10:05 INFO - 'default_actions': ('clobber', 12:10:05 INFO - 'read-buildbot-config', 12:10:05 INFO - 'download-and-extract', 12:10:05 INFO - 'populate-webroot', 12:10:05 INFO - 'create-virtualenv', 12:10:05 INFO - 'install', 12:10:05 INFO - 'run-tests'), 12:10:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:10:05 INFO - 'download_minidump_stackwalk': True, 12:10:05 INFO - 'download_symbols': 'ondemand', 12:10:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:10:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:10:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:10:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:10:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:10:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:10:05 INFO - 'installer_path': 'installer.exe', 12:10:05 INFO - 'log_level': 'info', 12:10:05 INFO - 'log_name': 'talos', 12:10:05 INFO - 'log_to_console': True, 12:10:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:10:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:10:05 INFO - 'opt_config_files': (), 12:10:05 INFO - 'pip_index': False, 12:10:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:10:05 INFO - 'cmd': ('bash', 12:10:05 INFO - '-c', 12:10:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:10:05 INFO - 'enabled': True, 12:10:05 INFO - 'halt_on_failure': False, 12:10:05 INFO - 'name': 'check_screen_resolution'},), 12:10:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:10:05 INFO - 'cmd': ('bash', 12:10:05 INFO - '-c', 12:10:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:10:05 INFO - 'enabled': True, 12:10:05 INFO - 'halt_on_failure': False, 12:10:05 INFO - 'name': 'check_screen_resolution'},), 12:10:05 INFO - 'run_cmd_checks_enabled': True, 12:10:05 INFO - 'sps_profile': False, 12:10:05 INFO - 'sps_profile_interval': 0, 12:10:05 INFO - 'suite': 'dromaeojs-e10s', 12:10:05 INFO - 'system_bits': '32', 12:10:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:10:05 INFO - 'title': 't-yosemite-r7-0132', 12:10:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:10:05 INFO - 'use_talos_json': True, 12:10:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:10:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:10:05 INFO - 'work_dir': 'build'} 12:10:05 INFO - ##### 12:10:05 INFO - ##### Running clobber step. 12:10:05 INFO - ##### 12:10:05 INFO - Running pre-action listener: _resource_record_pre_action 12:10:05 INFO - Running main action method: clobber 12:10:05 INFO - rmtree: /builds/slave/test/build 12:10:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:10:06 INFO - Running post-action listener: _resource_record_post_action 12:10:06 INFO - ##### 12:10:06 INFO - ##### Running read-buildbot-config step. 12:10:06 INFO - ##### 12:10:06 INFO - Running pre-action listener: _resource_record_pre_action 12:10:06 INFO - Running main action method: read_buildbot_config 12:10:06 INFO - Using buildbot properties: 12:10:06 INFO - { 12:10:06 INFO - "project": "", 12:10:06 INFO - "product": "firefox", 12:10:06 INFO - "script_repo_revision": "production", 12:10:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:10:06 INFO - "repository": "", 12:10:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:10:06 INFO - "buildid": "20160428085749", 12:10:06 INFO - "pgo_build": "False", 12:10:06 INFO - "basedir": "/builds/slave/test", 12:10:06 INFO - "buildnumber": 656, 12:10:06 INFO - "slavename": "t-yosemite-r7-0132", 12:10:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:10:06 INFO - "platform": "yosemite_r7", 12:10:06 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 12:10:06 INFO - "branch": "fx-team", 12:10:06 INFO - "repo_path": "integration/fx-team", 12:10:06 INFO - "revision": "4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f", 12:10:06 INFO - "stage_platform": "macosx64", 12:10:06 INFO - "builduid": "1f6ffafd21614741b9c8bb262308a9ad", 12:10:06 INFO - "slavebuilddir": "test" 12:10:06 INFO - } 12:10:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 12:10:06 INFO - Running post-action listener: _resource_record_post_action 12:10:06 INFO - ##### 12:10:06 INFO - ##### Running download-and-extract step. 12:10:06 INFO - ##### 12:10:06 INFO - Running pre-action listener: _resource_record_pre_action 12:10:06 INFO - Running main action method: download_and_extract 12:10:06 INFO - mkdir: /builds/slave/test/build/tests 12:10: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')]} 12:10:06 INFO - https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 12:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:10 INFO - Downloaded 1199 bytes. 12:10:10 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 12:10:10 INFO - Using the following test package requirements: 12:10:10 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:10:10 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 12:10:10 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 12:10:10 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'jsshell-mac.zip'], 12:10:10 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 12:10:10 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 12:10:10 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 12:10:10 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 12:10:10 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 12:10:10 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 12:10:10 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 12:10:10 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:10:10 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')]} 12:10:10 INFO - https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:10:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:10:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:10:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:13 INFO - Downloaded 18124066 bytes. 12:10:13 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'] 12:10:13 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 12:10:16 INFO - Return code: 0 12:10:16 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 12:10: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')]} 12:10:16 INFO - https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:10:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:10:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 12:10:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:17 INFO - Downloaded 18124066 bytes. 12:10:17 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'] 12:10:17 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 12:10:21 INFO - Return code: 0 12:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:21 INFO - https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 12:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:22 INFO - Downloaded 10840145 bytes. 12:10:22 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'] 12:10:22 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 12:10:23 INFO - Return code: 0 12:10: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')]} 12:10:23 INFO - https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 12:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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 12:10:26 INFO - Downloaded 110275006 bytes. 12:10:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:26 INFO - mkdir: /builds/slave/test/properties 12:10:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:10:26 INFO - Writing to file /builds/slave/test/properties/build_url 12:10:26 INFO - Contents: 12:10:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 12:10:27 INFO - Running post-action listener: _resource_record_post_action 12:10:27 INFO - Running post-action listener: set_extra_try_arguments 12:10:27 INFO - ##### 12:10:27 INFO - ##### Running populate-webroot step. 12:10:27 INFO - ##### 12:10:27 INFO - Running pre-action listener: _resource_record_pre_action 12:10:27 INFO - Running main action method: populate_webroot 12:10:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:10:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:10:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:10:27 INFO - '--tppagecycles', 12:10:27 INFO - '7'], 12:10:27 INFO - 'tests': ['tsvgm']}}, 12:10:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:10:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:10:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:10:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:10:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:10:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['damp', 'tps']}, 12:10:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'tests': ['damp', 'tps']}, 12:10:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['dromaeo_dom']}, 12:10:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:10:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['a11yr', 12:10:27 INFO - 'ts_paint', 12:10:27 INFO - 'tpaint', 12:10:27 INFO - 'sessionrestore', 12:10:27 INFO - 'sessionrestore_no_auto_restore', 12:10:27 INFO - 'tabpaint']}, 12:10:27 INFO - 'other-e10s': {'tests': ['a11yr', 12:10:27 INFO - 'ts_paint', 12:10:27 INFO - 'tpaint', 12:10:27 INFO - 'sessionrestore', 12:10:27 INFO - 'sessionrestore_no_auto_restore', 12:10:27 INFO - 'tabpaint']}, 12:10:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:10:27 INFO - 'ts_paint', 12:10:27 INFO - 'tpaint', 12:10:27 INFO - 'sessionrestore', 12:10:27 INFO - 'sessionrestore_no_auto_restore', 12:10:27 INFO - 'tabpaint']}, 12:10:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:10:27 INFO - 'ts_paint', 12:10:27 INFO - 'tpaint', 12:10:27 INFO - 'sessionrestore', 12:10:27 INFO - 'sessionrestore_no_auto_restore', 12:10:27 INFO - 'tabpaint']}, 12:10:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['a11yr', 12:10:27 INFO - 'ts_paint', 12:10:27 INFO - 'tpaint', 12:10:27 INFO - 'sessionrestore', 12:10:27 INFO - 'sessionrestore_no_auto_restore', 12:10:27 INFO - 'tabpaint']}, 12:10:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['a11yr', 12:10:27 INFO - 'ts_paint', 12:10:27 INFO - 'tpaint', 12:10:27 INFO - 'sessionrestore', 12:10:27 INFO - 'sessionrestore_no_auto_restore', 12:10:27 INFO - 'tabpaint']}, 12:10:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['tsvgx', 12:10:27 INFO - 'tsvgr_opacity', 12:10:27 INFO - 'tart', 12:10:27 INFO - 'tscrollx', 12:10:27 INFO - 'cart']}, 12:10:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:10:27 INFO - 'tsvgr_opacity', 12:10:27 INFO - 'tart', 12:10:27 INFO - 'tscrollx', 12:10:27 INFO - 'cart']}, 12:10:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'talos_options': ['--disable-e10s'], 12:10:27 INFO - 'tests': ['tp5o']}, 12:10:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'tests': ['tp5o']}, 12:10:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'talos_options': ['--disable-e10s', 12:10:27 INFO - '--xperf_path', 12:10:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:27 INFO - 'tests': ['tp5n']}, 12:10:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:10:27 INFO - 'talos_options': ['--xperf_path', 12:10:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:10:27 INFO - 'tests': ['tp5n']}}, 12:10:27 INFO - 'talos.zip': {'path': '', 12:10:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:10:27 INFO - Running post-action listener: _resource_record_post_action 12:10:27 INFO - ##### 12:10:27 INFO - ##### Running create-virtualenv step. 12:10:27 INFO - ##### 12:10:27 INFO - Running pre-action listener: _resource_record_pre_action 12:10:27 INFO - Running main action method: create_virtualenv 12:10:27 INFO - Creating virtualenv /builds/slave/test/build/venv 12:10:27 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 12:10:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:10:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:10:27 INFO - Using real prefix '/tools/python27' 12:10:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:10:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:10:30 INFO - Installing pip.................done. 12:10:30 INFO - Return code: 0 12:10:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:10:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:10:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:30 INFO - 'HOME': '/Users/cltbld', 12:10:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:30 INFO - 'LOGNAME': 'cltbld', 12:10:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:30 INFO - 'MOZ_NO_REMOTE': '1', 12:10:30 INFO - 'NO_EM_RESTART': '1', 12:10:30 INFO - 'PAGER': '/bin/cat', 12:10:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:30 INFO - 'PWD': '/builds/slave/test', 12:10:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:30 INFO - 'SHELL': '/bin/bash', 12:10:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:30 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:30 INFO - 'USER': 'cltbld', 12:10:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:30 INFO - 'XPC_FLAGS': '0x0', 12:10:30 INFO - 'XPC_SERVICE_NAME': '0', 12:10:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:31 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 12:10:31 INFO - Cleaning up... 12:10:31 INFO - Return code: 0 12:10:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:10: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')]} 12:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10: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')]} 12:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:31 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:31 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 12:10:31 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 12:10:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:31 INFO - 'HOME': '/Users/cltbld', 12:10:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:31 INFO - 'LOGNAME': 'cltbld', 12:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:31 INFO - 'MOZ_NO_REMOTE': '1', 12:10:31 INFO - 'NO_EM_RESTART': '1', 12:10:31 INFO - 'PAGER': '/bin/cat', 12:10:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:31 INFO - 'PWD': '/builds/slave/test', 12:10:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:31 INFO - 'SHELL': '/bin/bash', 12:10:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:31 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:31 INFO - 'USER': 'cltbld', 12:10:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:31 INFO - 'XPC_FLAGS': '0x0', 12:10:31 INFO - 'XPC_SERVICE_NAME': '0', 12:10:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:31 INFO - Downloading/unpacking psutil>=0.7.1 12:10:31 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 12:10:31 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 12:10:31 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 12:10:31 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 12:10:31 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 12:10:31 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 12:10:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:10:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:34 INFO - Installing collected packages: psutil 12:10:34 INFO - Running setup.py install for psutil 12:10:34 INFO - building 'psutil._psutil_osx' extension 12:10:34 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 12:10:35 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 12:10:35 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 12:10:35 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 12:10:35 INFO - building 'psutil._psutil_posix' extension 12:10:35 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 12:10:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:10:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:10:35 INFO - ^ 12:10:35 INFO - 1 warning generated. 12:10:35 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 12:10:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:10:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:10:35 INFO - Successfully installed psutil 12:10:35 INFO - Cleaning up... 12:10:35 INFO - Return code: 0 12:10:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:10:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:35 INFO - 'HOME': '/Users/cltbld', 12:10:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:35 INFO - 'LOGNAME': 'cltbld', 12:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:35 INFO - 'MOZ_NO_REMOTE': '1', 12:10:35 INFO - 'NO_EM_RESTART': '1', 12:10:35 INFO - 'PAGER': '/bin/cat', 12:10:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:35 INFO - 'PWD': '/builds/slave/test', 12:10:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:35 INFO - 'SHELL': '/bin/bash', 12:10:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:35 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:35 INFO - 'USER': 'cltbld', 12:10:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:35 INFO - 'XPC_FLAGS': '0x0', 12:10:35 INFO - 'XPC_SERVICE_NAME': '0', 12:10:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:10:38 INFO - Installing collected packages: mozsystemmonitor 12:10:38 INFO - Running setup.py install for mozsystemmonitor 12:10:38 INFO - Successfully installed mozsystemmonitor 12:10:38 INFO - Cleaning up... 12:10:38 INFO - Return code: 0 12:10:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:38 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:38 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 12:10:38 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 12:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:38 INFO - 'HOME': '/Users/cltbld', 12:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:38 INFO - 'LOGNAME': 'cltbld', 12:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:38 INFO - 'MOZ_NO_REMOTE': '1', 12:10:38 INFO - 'NO_EM_RESTART': '1', 12:10:38 INFO - 'PAGER': '/bin/cat', 12:10:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:38 INFO - 'PWD': '/builds/slave/test', 12:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:38 INFO - 'SHELL': '/bin/bash', 12:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:38 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:38 INFO - 'USER': 'cltbld', 12:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:38 INFO - 'XPC_FLAGS': '0x0', 12:10:38 INFO - 'XPC_SERVICE_NAME': '0', 12:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:38 INFO - Downloading/unpacking blobuploader==1.2.4 12:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:10:41 INFO - Downloading blobuploader-1.2.4.tar.gz 12:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:10:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:10:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10:42 INFO - Downloading docopt-0.6.1.tar.gz 12:10:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:10:42 INFO - Installing collected packages: blobuploader, requests, docopt 12:10:42 INFO - Running setup.py install for blobuploader 12:10:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:10:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:10:42 INFO - Running setup.py install for requests 12:10:43 INFO - Running setup.py install for docopt 12:10:43 INFO - Successfully installed blobuploader requests docopt 12:10:43 INFO - Cleaning up... 12:10:43 INFO - Return code: 0 12:10:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:43 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:43 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 12:10:43 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 12:10:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:43 INFO - 'HOME': '/Users/cltbld', 12:10:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:43 INFO - 'LOGNAME': 'cltbld', 12:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:43 INFO - 'MOZ_NO_REMOTE': '1', 12:10:43 INFO - 'NO_EM_RESTART': '1', 12:10:43 INFO - 'PAGER': '/bin/cat', 12:10:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:43 INFO - 'PWD': '/builds/slave/test', 12:10:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:43 INFO - 'SHELL': '/bin/bash', 12:10:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:43 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:43 INFO - 'USER': 'cltbld', 12:10:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:43 INFO - 'XPC_FLAGS': '0x0', 12:10:43 INFO - 'XPC_SERVICE_NAME': '0', 12:10:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:43 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-lIFmqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:43 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-kqUuop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:43 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-gOrChQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-dKNmoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-NEcE1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-7bvPqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-UOjRG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-XgPCuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-wXqqHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-0WgUgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-v4UexM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-8zOrmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:44 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ArTOuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-8MIcyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-46O6BB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TyJe0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:45 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-E1rKkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:10:45 INFO - Running setup.py install for manifestparser 12:10:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:10:45 INFO - Running setup.py install for mozcrash 12:10:45 INFO - Running setup.py install for mozdebug 12:10:45 INFO - Running setup.py install for mozdevice 12:10:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Running setup.py install for mozfile 12:10:46 INFO - Running setup.py install for mozhttpd 12:10:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Running setup.py install for mozinfo 12:10:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Running setup.py install for mozInstall 12:10:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Running setup.py install for mozleak 12:10:46 INFO - Running setup.py install for mozlog 12:10:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:10:46 INFO - Running setup.py install for moznetwork 12:10:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:10:47 INFO - Running setup.py install for mozprocess 12:10:47 INFO - Running setup.py install for mozprofile 12:10:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:10:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:10:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:10:47 INFO - Running setup.py install for mozrunner 12:10:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:10:47 INFO - Running setup.py install for mozscreenshot 12:10:47 INFO - Running setup.py install for moztest 12:10:47 INFO - Running setup.py install for mozversion 12:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:10:48 INFO - Cleaning up... 12:10:48 INFO - Return code: 0 12:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:48 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:48 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 12:10:48 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 12:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:48 INFO - 'HOME': '/Users/cltbld', 12:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:48 INFO - 'LOGNAME': 'cltbld', 12:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:48 INFO - 'MOZ_NO_REMOTE': '1', 12:10:48 INFO - 'NO_EM_RESTART': '1', 12:10:48 INFO - 'PAGER': '/bin/cat', 12:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:48 INFO - 'PWD': '/builds/slave/test', 12:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:48 INFO - 'SHELL': '/bin/bash', 12:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:48 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:48 INFO - 'USER': 'cltbld', 12:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:48 INFO - 'XPC_FLAGS': '0x0', 12:10:48 INFO - 'XPC_SERVICE_NAME': '0', 12:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-qkDkVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:10:48 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)) 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-nIt8Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:10:48 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)) 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-FNeirU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:10:48 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)) 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-irsrRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:10:48 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)) 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-5Mk6J9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:10:48 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)) 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-eOofzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:10:48 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)) 12:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:10:48 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-jsMjUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-BlAG4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-sLLCKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-XIYK6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-UdG3RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-qVKUWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-fCA99A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-SD8fJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-haSOc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:10:49 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)) 12:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:10:49 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-zXO90v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:10:50 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)) 12:10:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:10:50 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-fPUv3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:10:50 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)) 12:10:50 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)) 12:10:50 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)) 12:10:50 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)) 12:10:50 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)) 12:10:50 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)) 12:10:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10:52 INFO - Downloading blessings-1.6.tar.gz 12:10:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:10:52 INFO - Installing collected packages: blessings 12:10:52 INFO - Running setup.py install for blessings 12:10:52 INFO - Successfully installed blessings 12:10:52 INFO - Cleaning up... 12:10:52 INFO - Return code: 0 12:10:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:10:53 INFO - Reading from file tmpfile_stdout 12:10:53 INFO - Current package versions: 12:10:53 INFO - blessings == 1.6 12:10:53 INFO - blobuploader == 1.2.4 12:10:53 INFO - docopt == 0.6.1 12:10:53 INFO - manifestparser == 1.1 12:10:53 INFO - mozInstall == 1.12 12:10:53 INFO - mozcrash == 0.17 12:10:53 INFO - mozdebug == 0.1 12:10:53 INFO - mozdevice == 0.48 12:10:53 INFO - mozfile == 1.2 12:10:53 INFO - mozhttpd == 0.7 12:10:53 INFO - mozinfo == 0.9 12:10:53 INFO - mozleak == 0.1 12:10:53 INFO - mozlog == 3.1 12:10:53 INFO - moznetwork == 0.27 12:10:53 INFO - mozprocess == 0.22 12:10:53 INFO - mozprofile == 0.28 12:10:53 INFO - mozrunner == 6.11 12:10:53 INFO - mozscreenshot == 0.1 12:10:53 INFO - mozsystemmonitor == 0.0 12:10:53 INFO - moztest == 0.7 12:10:53 INFO - mozversion == 1.4 12:10:53 INFO - psutil == 3.1.1 12:10:53 INFO - requests == 1.2.3 12:10:53 INFO - wsgiref == 0.1.2 12:10:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:53 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:53 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 12:10:53 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 12:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:53 INFO - 'HOME': '/Users/cltbld', 12:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:53 INFO - 'LOGNAME': 'cltbld', 12:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:53 INFO - 'MOZ_NO_REMOTE': '1', 12:10:53 INFO - 'NO_EM_RESTART': '1', 12:10:53 INFO - 'PAGER': '/bin/cat', 12:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:53 INFO - 'PWD': '/builds/slave/test', 12:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:53 INFO - 'SHELL': '/bin/bash', 12:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:53 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:53 INFO - 'USER': 'cltbld', 12:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:53 INFO - 'XPC_FLAGS': '0x0', 12:10:53 INFO - 'XPC_SERVICE_NAME': '0', 12:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 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)) 12:10:53 INFO - Cleaning up... 12:10:53 INFO - Return code: 0 12:10:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:10:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:53 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:53 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 12:10:53 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 12:10:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:53 INFO - 'HOME': '/Users/cltbld', 12:10:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:53 INFO - 'LOGNAME': 'cltbld', 12:10:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:53 INFO - 'MOZ_NO_REMOTE': '1', 12:10:53 INFO - 'NO_EM_RESTART': '1', 12:10:53 INFO - 'PAGER': '/bin/cat', 12:10:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:53 INFO - 'PWD': '/builds/slave/test', 12:10:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:53 INFO - 'SHELL': '/bin/bash', 12:10:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:53 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:53 INFO - 'USER': 'cltbld', 12:10:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:53 INFO - 'XPC_FLAGS': '0x0', 12:10:53 INFO - 'XPC_SERVICE_NAME': '0', 12:10:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:53 INFO - Downloading/unpacking jsonschema 12:10:53 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 12:10:53 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 12:10:53 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 12:10:53 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 12:10:53 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 12:10:53 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 12:10:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:10:56 INFO - Downloading/unpacking functools32 (from jsonschema) 12:10:56 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 12:10:56 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 12:10:56 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 12:10:56 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 12:10:56 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 12:10:56 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 12:10:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:10:56 INFO - warning: no files found matching '*.txt' 12:10:56 INFO - no previously-included directories found matching 'build' 12:10:56 INFO - no previously-included directories found matching 'dist' 12:10:56 INFO - no previously-included directories found matching '.git*' 12:10:56 INFO - Installing collected packages: jsonschema, functools32 12:10:56 INFO - Running setup.py install for functools32 12:10:56 INFO - warning: no files found matching '*.txt' 12:10:56 INFO - no previously-included directories found matching 'build' 12:10:56 INFO - no previously-included directories found matching 'dist' 12:10:56 INFO - no previously-included directories found matching '.git*' 12:10:56 INFO - Successfully installed jsonschema functools32 12:10:56 INFO - Cleaning up... 12:10:56 INFO - Return code: 0 12:10:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:10:56 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')]} 12:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:10:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:56 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')]} 12:10:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:10:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:10:56 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 0x100a30a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a40420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff8f9c78b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, '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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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 12:10:56 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 12:10:56 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 12:10:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:10:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:10:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:10:56 INFO - 'HOME': '/Users/cltbld', 12:10:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:10:56 INFO - 'LOGNAME': 'cltbld', 12:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:10:56 INFO - 'MOZ_NO_REMOTE': '1', 12:10:56 INFO - 'NO_EM_RESTART': '1', 12:10:56 INFO - 'PAGER': '/bin/cat', 12:10:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:10:56 INFO - 'PWD': '/builds/slave/test', 12:10:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:10:56 INFO - 'SHELL': '/bin/bash', 12:10:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:10:56 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:10:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:10:56 INFO - 'USER': 'cltbld', 12:10:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:10:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:10:56 INFO - 'XPC_FLAGS': '0x0', 12:10:56 INFO - 'XPC_SERVICE_NAME': '0', 12:10:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:10:57 INFO - Downloading/unpacking flake8 12:10:57 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 12:10:57 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 12:10:57 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 12:10:57 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 12:10:57 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 12:10:57 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 12:10:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:10:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:10:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:10: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 12:11:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:11:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:11:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:11:00 INFO - no previously-included directories found matching 'docs/_build' 12:11:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:11:00 INFO - Running setup.py install for pep8 12:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:11:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:11:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:11:00 INFO - no previously-included directories found matching 'docs/_build' 12:11:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:11:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:11:01 INFO - Cleaning up... 12:11:01 INFO - Return code: 0 12:11:01 INFO - Running post-action listener: _resource_record_post_action 12:11:01 INFO - Running post-action listener: _start_resource_monitoring 12:11:01 INFO - Starting resource monitoring. 12:11:01 INFO - ##### 12:11:01 INFO - ##### Running install step. 12:11:01 INFO - ##### 12:11:01 INFO - Running pre-action listener: _resource_record_pre_action 12:11:01 INFO - Running main action method: install 12:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:11:01 INFO - Reading from file tmpfile_stdout 12:11:01 INFO - Detecting whether we're running mozinstall >=1.0... 12:11:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:11:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:11:01 INFO - Reading from file tmpfile_stdout 12:11:01 INFO - Output received: 12:11:01 INFO - Usage: mozinstall [options] installer 12:11:01 INFO - Options: 12:11:01 INFO - -h, --help show this help message and exit 12:11:01 INFO - -d DEST, --destination=DEST 12:11:01 INFO - Directory to install application into. [default: 12:11:01 INFO - "/builds/slave/test"] 12:11:01 INFO - --app=APP Application being installed. [default: firefox] 12:11:01 INFO - mkdir: /builds/slave/test/build/application 12:11:01 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'] 12:11:01 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 12:11:35 INFO - Reading from file tmpfile_stdout 12:11:35 INFO - Output received: 12:11:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:11:35 INFO - Running post-action listener: _resource_record_post_action 12:11:35 INFO - ##### 12:11:35 INFO - ##### Running run-tests step. 12:11:35 INFO - ##### 12:11:35 INFO - Running pre-action listener: _resource_record_pre_action 12:11:35 INFO - Running main action method: run_tests 12:11:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:11:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:11:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:11:35 INFO - 2016-04-28 12:11:35.456 screenresolution[2239:36855] starting screenresolution argv=screenresolution get 12:11:35 INFO - 2016-04-28 12:11:35.459 screenresolution[2239:36855] Display 0: 1600x1200x32@60 12:11:35 INFO - 2016-04-28 12:11:35.465 screenresolution[2240:36857] starting screenresolution argv=screenresolution list 12:11:35 INFO - Available Modes on Display 0 12:11:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:11:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:11:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:11:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:11:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:11:35 INFO - Intel Iris: 12:11:35 INFO - Chipset Model: Intel Iris 12:11:35 INFO - Type: GPU 12:11:35 INFO - Bus: Built-In 12:11:35 INFO - VRAM (Dynamic, Max): 1536 MB 12:11:35 INFO - Vendor: Intel (0x8086) 12:11:35 INFO - Device ID: 0x0a2e 12:11:35 INFO - Revision ID: 0x0009 12:11:35 INFO - Displays: 12:11:35 INFO - Display: 12:11:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:11:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:11:35 INFO - Display Serial Number: 1600x1200 60 12:11:35 INFO - Main Display: Yes 12:11:35 INFO - Mirror: Off 12:11:35 INFO - Online: Yes 12:11:35 INFO - Rotation: Supported 12:11:35 INFO - Return code: 0 12:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:11:35 INFO - Python 2.7.3 12:11:35 INFO - Return code: 0 12:11:35 INFO - grabbing minidump binary from tooltool 12:11:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:11:35 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 0x1008cfe00>, '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 0x100738db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1008cab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:11:35 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 12:11:35 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 12:11:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:11:35 INFO - Return code: 0 12:11:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:11:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:11:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:11:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:11:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:11:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:11:36 INFO - Return code: 0 12:11:36 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/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 12:11:36 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/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --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 12:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Iy3M6W5LcP/Render', 12:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:11:36 INFO - 'HOME': '/Users/cltbld', 12:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:11:36 INFO - 'LOGNAME': 'cltbld', 12:11:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:11:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:11:36 INFO - 'MOZ_NO_REMOTE': '1', 12:11:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:11:36 INFO - 'NO_EM_RESTART': '1', 12:11:36 INFO - 'PAGER': '/bin/cat', 12:11:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:11:36 INFO - 'PWD': '/builds/slave/test', 12:11:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:11:36 INFO - 'SHELL': '/bin/bash', 12:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ld4gq7AEXY/Listeners', 12:11:36 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 12:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:11:36 INFO - 'USER': 'cltbld', 12:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:11:36 INFO - 'XPC_FLAGS': '0x0', 12:11:36 INFO - 'XPC_SERVICE_NAME': '0', 12:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:11:36 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/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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 12:11:37 INFO - mozversion application_buildid: 20160428085749 12:11:37 INFO - mozversion application_changeset: 4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f 12:11:37 INFO - mozversion application_display_name: Nightly 12:11:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:11:37 INFO - mozversion application_name: Firefox 12:11:37 INFO - mozversion application_remotingname: firefox 12:11:37 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:11:37 INFO - mozversion application_vendor: Mozilla 12:11:37 INFO - mozversion application_version: 49.0a1 12:11:37 INFO - mozversion platform_buildid: 20160428085749 12:11:37 INFO - mozversion platform_changeset: 4dc48f3688f053e2fa74bf6c7beb4dff274ffc1f 12:11:37 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:11:37 INFO - mozversion platform_version: 49.0a1 12:11:37 INFO - using testdate: 1461870697 12:11:37 INFO - actual date: 1461870697 12:11:37 INFO - starting webserver on 'localhost:55848' 12:11:37 INFO - SUITE-START | Running 2 tests 12:11:37 INFO - TEST-START | dromaeo_css 12:11:37 INFO - operating with platform_type : mac_ 12:11:37 INFO - Initialising browser for dromaeo_css test... 12:11:37 INFO - TEST-INFO | started process 2258 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmp4G0Y8Z/profile http://localhost:55848/getInfo.html) 12:11:39 INFO - PROCESS | 2258 | __metrics Screen width/height:1600/1200 12:11:39 INFO - PROCESS | 2258 | colorDepth:24 12:11:39 INFO - PROCESS | 2258 | Browser inner width/height: 1024/689 12:11:39 INFO - PROCESS | 2258 | __metrics 12:11:40 ERROR - PROCESS | 2258 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:11:40 INFO - TEST-INFO | 2258: exit 0 12:11:40 INFO - Browser initialized. 12:11:40 INFO - Running cycle 1/1 for dromaeo_css test... 12:11:40 INFO - TEST-INFO | started process 2261 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmp4G0Y8Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:52 INFO - PROCESS | 2261 | RSS: Main: 249884672 12:11:52 INFO - PROCESS | 2261 | 12:12:42 INFO - PROCESS | 2261 | 1461870762299 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] 12:14:54 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:55848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55848/tests/dromaeo/cssquery-ext.html) 12:14:55 INFO - PROCESS | 2261 | RSS: Main: 261910528 12:14:55 INFO - PROCESS | 2261 | 12:17:57 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:55848/tests/dromaeo/cssquery-ext.html (next: http://localhost:55848/tests/dromaeo/cssquery-jquery.html) 12:17:58 INFO - PROCESS | 2261 | RSS: Main: 274300928 12:17:58 INFO - PROCESS | 2261 | 12:20:59 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:55848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55848/tests/dromaeo/cssquery-mootools.html) 12:21:00 INFO - PROCESS | 2261 | RSS: Main: 275664896 12:21:00 INFO - PROCESS | 2261 | 12:24:02 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:55848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55848/tests/dromaeo/cssquery-prototype.html) 12:24:02 INFO - PROCESS | 2261 | RSS: Main: 277217280 12:24:02 INFO - PROCESS | 2261 | 12:27:05 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:55848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55848/tests/dromaeo/cssquery-yui.html) 12:27:06 INFO - PROCESS | 2261 | RSS: Main: 280059904 12:27:06 INFO - PROCESS | 2261 | 12:30:08 INFO - PROCESS | 2261 | Cycle 1(1): loaded http://localhost:55848/tests/dromaeo/cssquery-yui.html (next: http://localhost:55848/tests/dromaeo/cssquery-dojo.html) 12:30:09 INFO - PROCESS | 2261 | RSS: Main: 281214976 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | __start_tp_report 12:30:09 INFO - PROCESS | 2261 | _x_x_mozilla_page_load 12:30:09 INFO - PROCESS | 2261 | _x_x_mozilla_page_load_details 12:30:09 INFO - PROCESS | 2261 | |i|pagename|runs| 12:30:09 INFO - PROCESS | 2261 | |0;dojo.html;3371.797692138472;3418.162550175207;3453.861845526181;3470.6876381125694;3489.6859282664554;5702.572307076965;5712.200291959129;5719.113537401699;5723.255976723025;5751.856203594913;5624.268845050137;5702.743376548055;5823.417658234174;5824.621399609023;5851.0930805725075;5180.896382072366;5225.738713064351;5267.789288428458;5289.418164001957;5347.064263753847;5215.582753379739;5393.83818485446;5400.648957817729;5441.972790136044;5457.645253058538;4416.911661766747;5143.125668636303;5227.581793456552;5300.867478313035;5341.679499230058;5183.740812959337;5215.791368345262;5232.319798426181;5233.528982391565;5251.73958250021;5148.382194136728;5226.7909283628605;5280.630355875091;5281.551068159211;5323.707196104213;4712.5994290485005;4911.656184067117;5634.098544232944;5680.460356266148;5685.573581981326;4399;5083.822066227701;5279.577633789288;6191.938080619227;6220.813375598739;6118.405988989689;6219.813405597839;6226.097215903714;6240.687965601702;6241.531885108635;4698.553637404441;5760;5808.564357673192;5831.358550559477;5873.353931067579;6240.843978900564;6247.312795592481;6249.375062493805;6275.6548389839;6279.843003924847;5590.2453168821685;5672.829815105553;5687;5811.27359080115;6189.597676151036;6169.352218017133;6247.344028876993;6264.498840092781;6279.497640188774;6285.465735412541;5959.195508606369;6066.86523676236;6135.815925522242;6202.751889924442;6211.503079753609;5373.919391209135;6040.7583696651645;6192.969035154885;6217.96891015542;6241.126242326078;4186.225548273579;4886.218205087169;4948.4309304429735;4961.5534601886;5014.197728363444;4396.274614688605;4410.20616289071;4412.0955204183065;4413.44831896013;4449.17690227309;5757.740901659436;5876.647401155944;5900.232969713909;5928.140419639129;5954.255718035246;6189.288231853395;6218.253809542884;6234.532410069263;6251;6256.436920677161;5857.062869940789;5915.438033386821;5925.881482370329;5940.376260492672;5975.492083172979;5325.760340784674;5377.435369286247;5453.700046497481;5457.481539253765;5461.918071228934;6311.305756366796;6326.620402775664;6330.968345158245;6337.144485494491;6349.6507692077375;6205.2553693557065;6237.220347456568;6238.6880655967925;6238.970569855923;6293.087502312231;6206.503479721521;6288.937110628835;6300.905486417799;6363.6818159090935;6378.2346118466085;5032.6225533084435;6160.168377269011;6198.721057552511;6203.2556093269095;6213.161223234805;6229;6232.501399887908;6232.844178895564;6239.970404883144;6241.78153764616;5945.91081133792;6087.969560152171;6136.478399336106;6181.072839074175;6209.875802484015;6104.8836088941825;6168.35232300602;6211.751529938751;6219.440250377488;6230.408111229426;5156.1492353761205;5973.044312909914;6011.121417906396;6060.787872424444;6077.20996270482;6042.244719410074;6104.9389506106145;6123.540734444845;6138.294096178996;6158.414950579688;6039.305479869871;6047.879042419215;6049.909251361321;6054.152418661479;6062.818115456544 12:30:09 INFO - PROCESS | 2261 | |1;ext.html;508.14631419215715;513.266029577704;533.269420893376;569.1150261343612;573.1402895656515;38153.42769858454;39021.60978390215;39048.609513904856;39058;39143.82568522949;38243.23513529728;41054;41058.178836423256;41194.7940260299;41263.79368103155;8476.449030813008;8738.645509945936;9247.26021918245;9453.574589143505;9563.521823908812;7908.920910790905;9577.61689532418;9679.95160024199;9703.320767546275;9708.90291097087;9655.951720241388;9709.223262139047;9740.561674724619;9744.658936937209;9766.560504777302;9639.325247232697;9701.90298097017;9716.174125199366;9728.221742260637;9757.41455512668;9432.811343773086;9435.481048542328;9552.522373881278;9579.521023948775;9580.712578622582;38775.80612096922;39511.60488395137;39574.802125989474;39807.8009609953;39888;2752.518309295865;3050.7559395248327;3092.226943264184;3339.8497067632015;3595;26682;27528.449431011268;27549.449011019868;27797.305067373476;27972.44055118886;2644.3917898883365;2665.2270841456148;2719.986400067987;2752.146834481317;2768.750812426891;348011;350366;351849.99999999744;355225;355604;29042.564361534594;32213.838930805665;35367.64632353695;35448.64551354505;35572.82213588967;28767;34574.827125864715;35764.82117589395;35837.64162358395;36033.57681020299;14957.775633365509;15260.389584416498;15261.93166478358;15284.617884552752;15335;12736.981041516656;12840;12853.93573032129;12928.159669621444;12941.676458088623;8087.474314169678;8269.30479251752;8276.255137037575;8333.250007499355;8350.791230219293;3061.2040869373677;3410.3861304965344;3413.573303337083;3445.3453843769603;3447.9827600861836;987.8271302522173;1068.3322923173016;1158.4034222375483;1165.3648761425043;1213.769383817072;24065.63901541478;29090;30331.848340758155;30971.69028309733;30973.845130774203;1096.2545469081101;1113.7661091170783;1150.2753265442718;1177.5643012085584;1233.9506419743109;14843.703125937422;15014.624634384008;15036.548903532912;15331.080135191924;15384.384624615113;628462;633767;636837;647226;647805;57380.426195737506;58652;59169.11246331308;59505.70247148823;59720;1472.926353682333;1482.392219190127;1500.9924950375396;1513.3038802150913;1514.833368329483;28939.85530072336;29119.563206551495;29215.269618259714;29644.258893527833;29888.402231955675;52725.47274527359;53502;53511;53638;53664;556536;573902;575740;576708;579112;21935.122595096655;25745.613815793153;26446.206613801616;26748.465030698888;27836.721632783414;43428.697139085874;44218.3367249498;44455.77772111119;45396;45896.31155532603;31572.842135789175;33159.50260746139;37212.13939303078;37532;38007;31257.37485250328;32234.677653224106;37129.257414852094;37221.627783721815;37798.81100594479;28900.710992890643;36922.8153859229;36969.44545831761;37298.881033569036;37675.62324376721;25193;30573.694263057085;31754.841225793723;32006.51990220195;32596.674033259365;20451.59096818085;20619.072141753357;23919.641205381584;24226.51546969086;24303.756962430856 12:30:09 INFO - PROCESS | 2261 | |2;jquery.html;386.3451449792601;392.95088113985736;398.5078428141246;399.37896570832345;404.82794812204804;20412.183512659474;21069.683954740693;21303.68044479334;21326.36020919373;22257.332280031584;21191.258305959254;21208.4697882553;21716;21816.454588635293;22120.889395553;5920.555958303123;6021.157038014681;6040.426159514839;6075.483583895374;6127;5587.636803607753;5949.405059494059;6012.5791194616395;6098.359672234418;6107.114468402079;5631.211630371751;5775.509081728058;5891.440313170242;5910.704464776765;5938.346781853993;5829.737661805208;5859.707014649251;5861.765529378819;5862;5864;5392.91910621341;5760.646248131686;5765.509931655814;5773.538116950634;5816.709164541756;13119.47522099115;13339.733205335839;13588.320583970763;13608.93195534016;13769.967252456107;2175.5431359414542;2197.450637340665;2270.14869423966;2340.169239919838;2449.7917676997477;9056.320775941766;9825.213982881352;10256.538455769509;10375.533101010473;10451.79096418075;1747.4146161036067;1754.9649007019916;1794.9551261218573;1806.1781889240494;1871.644387566358;96339.51830240875;104292.9141417175;104706.47646761793;104720.95279047189;105659.41510877344;11436.199466037464;11654.650360489199;11815.172937894265;11897.940510297392;11998;14871;14877.628059298388;14933.17867517297;14973.251337433085;14983.250837458083;8594.484330940164;8767.25478334336;8828.249598784047;8833.55832208387;9004.36969412135;7308.5614863108385;8915.777105572413;8939.329550283755;8978.775530611656;9022.774430639156;4641.721496710208;4647.7211367317395;4733.508944682414;4749.762511874393;4759.643026773006;1522.5127959052998;1693.0357814696915;1813.8911665300125;1919.1076149590508;1971.9014049297477;754.5397307642334;900.7072701372081;930.9805762689844;951.9571619277149;967.5742673223759;17601;19240.903795481212;20179.899100504404;20247.898760506105;20434.182632694825;854.0093491549773;878.2534845381375;900.149358855888;965.0879918477112;999.0708640963974;9430.387024843363;10526.210534209811;10531.736706582396;10804.567817287221;10805.513751881184;546767.4466143814;549635;555226;555535;556829;93095;95064;133506;135863.32068339596;136276;915.6795121707349;1031.515187861704;1032.1123833503182;1040.458961340114;1050.795094956476;17269.654606908043;17706.937583745017;17908.820911791237;17961.8324808887;17967.460976170736;37034.81482592678;40205.597944020185;51352;51589.32992572514;51809;68688;75464;76123;76295.23704762882;78267;5408.13469844823;6097.939020609737;7238.986541884035;7856.214378562098;8372.486983383622;10883;12368.75262494727;12514.561990330294;12864.807027894401;12878.484860605471;10731.678049658523;10791.730206744895;10841.241113122322;10910.781784364426;10960.28758130719;10860.456977150952;10894;10921.781564368826;10945.890541094806;10954.945225273823;9191.816163676554;11160.944195278971;11192.160587955774;11424.771504569695;11548.884511155116;8072.394570407126;8164.428490005643;8174.468659537111;8235.670573177005;8473.788155296166;9792.72694549704;10542.051215390651;10550.208734344802;11109.888901110886;11215.383153926286 12:30:09 INFO - PROCESS | 2261 | |3;mootools.html;1522.3301747231221;1594;1677.3793696332352;1842.1894366478748;1986.4735845001087;7804.92195078049;8569.143085691428;8611.784705382368;8935.553222338882;8940.19538241558;8647.13528647135;8694.347923905716;8808.77978050549;8811.823763524726;8814.206721395074;2423.6364545318165;2447.730749617541;2460.495598402323;2464.149868295435;2469.715982661999;2408.5784987627094;2477.479729256849;2481.7394173611783;2482.366996415911;2482.8510289382602;2408.1089996701244;2443.3525115844313;2468.0004598137693;2475;2487.166799122296;2433.841800282976;2440.5362981033636;2441.682581264442;2448.755124487555;2466.4943686544216;2430.902763889442;2454.067454367329;2460.520198561281;2465.864377459239;2469.77772000519;8917.375783695144;8982.685606003759;9001.459912405277;9008.189262966365;9033.367664263504;4514.9774251128865;5020.799168033274;5322.654027488201;5443.537299329561;5447.428020057916;2927.3267148555738;3614.4397618369194;3643.3259846928404;3701.168606016373;3738.2336620992633;940.4310392212681;943.4669411782321;953.7853982853871;1036.9740756481074;1053.2416660004785;11608.825867611993;11734.354610496419;11771.411429428494;11781.764364712744;11785.882141178565;4906.55840974314;4913.459519452857;4953.653244272867;4996.250562415594;5001.874953126201;8634.402635512324;10074.194064474825;10087.991200879853;10107.949460252652;10138.124446977332;5397.460253974571;5497.175423686399;5500.22996780451;5517.779288828402;5535.501804837584;4448.822047118079;4825.565699087028;4907.509249075135;4988.9501104988485;5022.995400919831;3489.4765785131926;3513.701335386521;3542.787432754043;4065.8780236592947;4072.592740725963;1363.3864760857655;1375;1386.7919812028276;1386.861313868605;1387.5906607550594;911.9544022798833;913.8126684029758;928.8049509602924;946.8390373636498;957.5978089202413;5736.770529178786;5956.761729530857;6018.789342372996;6019.765947980653;6063.727132279058;450.5629539346828;456.9885752856139;470.3203870407229;476.29746124466135;992.4194346307347;3973.324534829086;4005.439238506611;4021.6380525752825;4074.5517993020744;4096.795160241976;10360.274780765274;10517.421541815274;10617.309874858109;10797.190210734227;10836;10658.040776330168;10699.411532365795;10702.785944281071;10792.730181745519;10944.39805810672;7797.610119494003;8158.388120890957;8254.339652827879;8267.214614611603;8313.958430207811;5940.881182376242;5944.702764861826;6049.911016016983;6119.2350956130485;6130.908036379368;9602.135807777333;9902.306838521234;9913.851292230767;9928;9993.500324983866;8944.150305720947;9529;9770.560324785543;10023.849642255518;10206.540705668114;6884.827879302858;7390.334869861738;7398.96300518494;7627.580483073484;7756.961215193888;8378.916210838057;8409.495430273959;8441.071482136836;8441.746747597583;8487.8726819099;7349.963250183715;7477.364424024019;7538.8314811204355;7576.545407275581;7605.923940760522;7298.4891057625455;7366.189719130784;7377.4098072155175;7448.925510744823;7516.5114267572435;7138.607376594337;7184.1738200105565;7215.891761623685;7224.638768061681;7231.602261875437;4855.5387238212315;4870.366852309177;4974.825881094144;5021.623378246573;5202.97398513005;4744.5492678195515;4854.490278520704;4913.70517768935;4923.729194894315;5049.495050494921 12:30:09 INFO - PROCESS | 2261 | |4;prototype.html;317.419123004901;319.10491072541527;323.4646659778068;328.510519326204;328.83065221410993;5428.308750049964;5558.748706773763;5603.635763675368;5614.887702245953;5626.887462250753;4840.540148685878;5491.395946445888;5503.229547863292;5506.669599824013;5522.91715624266;3452.7583069185166;3457.4640930655787;3474;3879.4374815651713;4063.4311196432523;3239.96760032399;3585.9820700896457;4078.6125318094732;4202.865226388873;4247;3747.550293964728;3992.580779018205;4197.958020419787;4221.746695198282;4242.342436922282;4067.9389809152885;4182.327069172325;4208.263553878074;4229;4249.511306199795;3059.908202753921;3668.3763760160837;3680.3375392429352;3684.613115622848;3685.2261025184475;5198.714070726146;5270.49930256625;5292.417834038252;5296.549793267577;5306.67505982623;4640.953590464086;4874.268859671042;4876;4906.509349065101;4910.7299098549565;5821.81681869299;5823.893460242541;5829.737661805187;5840.532757379399;5890.469857712784;4052.9664935441274;4090.9590904090874;4092.406601042862;4093.03534303533;4100.856470023535;5125.538701516882;5942.3760505146765;6094.756209751605;6134.079888016789;6143.354947730469;3828.5214348206473;3920.8440900216124;3954.189391174802;4116.732412393185;4126.958730412657;3893.552241492208;4038.4144299077057;4183.481839613271;4201.873943781691;4205.684573656988;4088.652464540488;4596.287575425815;4617.792199351037;4868.464468908417;4912.410510738734;4563.977180114078;5547.861303467445;5825.533957283407;5862.560307976919;5897.292324921037;1275.489804078376;1488.8684599704302;1546.536039188239;1547.3501129525625;1552.74379727346;875.6978842299396;884.951327676984;946.5882341181608;982.68062879563;1048.2452634103433;5169.638125331266;5427.864303392446;5538.141588053858;5551.057939292182;5562.805301814417;5264.920691258283;5734.971325143431;5870.501007414332;6104.3590423005835;6105.358937311518;4067.2510820346943;4769.681804787706;5013.774380152902;5069.771860266297;5160.561352285023;2940.573616825591;2959.9112026639236;3490.267043920805;3507.228409749851;3538.610752817188;5823.244007615064;6893.862122757617;6925.203601585882;6971.093757811452;6982.79051628452;6836.111305530249;6888.586684798928;6907.34380233877;6957.408620267232;6985.161780586261;6565.573237739532;6621.4040736333;6960.408365289007;6964.303569642894;6995.26549712283;6215.564910456224;6336.017917222838;6662.700178492077;6711.664416779044;6717.395434410926;5545.805896793754;5760.020796464695;6286.994080947209;6560.179977502812;6567.704453299518;5550.556855217592;6194.783182588588;6723.697433615597;6733.528652994243;6974.407175390149;4010.57888921659;4241.427407300099;4258.6805989550285;4282.571742825692;4289.820299417685;5080.212567052113;6269.592476489013;6438.806835794933;6499.165492359531;6696.464282857457;5002.224655178453;5131.538161565477;5922.963481390825;6455.5468921809415;6469.353064693493;5438.891222175614;6137.570370074052;6422.839429014312;6430.807075787734;6455.128557644658;5477.75350109238;6136.171616831849;6254.405831446005;6290.559660823881;6344.206974128234;5710.543156547383;5754.223179870832;5760.395158508296;5861.1501332307425;5891.469767720926;5471.534919531725;5744.885102298014;5757.856053598526;5769.53843692512;5850.0932355484965 12:30:09 INFO - PROCESS | 2261 | |5;yui.html;670.3665036540469;676.5703778100906;676.9187697476298;697.808102771738;699.2727563334133;14626;14889.55331340059;15073.170975596351;15111.62220944477;15118.244087795621;13601.727965440685;13854;14001.369938352773;14076.296185190751;14085.0844695095;721.8844984802432;894.2577660541767;905.5064989580678;922.3405265235356;934.4346670264495;911.7128104647015;929.4609126706493;933.1182032978837;933.7945651956593;934.9626014959393;824.8020475085966;968.3753978683744;981.1415011864618;983.4492684096892;984.9803003939917;936.6113063078814;963.648268382039;973.7614284500272;977.9364341317827;979.485769970764;715.613568672916;717.1931576975902;717.4475653746638;717.6913927011383;718.396546900606;14992.250387480583;14992.950493465461;15046.924765376212;15089.47186848455;15094.094354338666;12102;12158.51365945361;12186.329751863645;12189.69525761863;12425.937870310681;9313.674021409219;9335.953320233424;9361.251099911991;9394.248460123174;9428.575714092882;2902.9854850725824;3485.7037151842123;3489.70337521311;3490.1972546314237;3491.109767009422;83994;85099.29967858156;85942;86676;87006.99999999936;9398.718038458857;9500.334976551576;9589.136977672042;9708.223342132613;10020.398776073458;22540.436489087904;22542.887285563465;22605.434864128198;22648;22691.432714182276;7440.255974402625;7532.928444677648;7604.9239507605325;7636.31273185416;7872.803179920434;4001.559828418872;4081.8571350002608;4109.404136400205;4122.093139509303;4128.545859955402;3534.3108093921437;3599.85600575974;3639.563252409675;3651.2332410193626;3655.94516082259;635.9951276982357;650.3496503496503;651.9731423008781;652.6149571752594;661.8577005943745;484.5154845154845;525.0601423452055;562.2887047884429;602.5089552015181;610.8900397928327;5901.822945311647;6860.451163906875;6930.341617546325;7033.824154396181;8077.192280771876;501.490986648552;556.2879514221803;564.2720890051869;582.4990508163061;599.8230521996022;3433.639467855889;3636.381815091388;3835;3892.026993251687;4027.2549578328103;88458.11541884499;93073.53463232776;99603.0079398408;100138;103310;59398;78204.2179578197;80943.59528202322;81850.18149818426;86228;74055;74524;74804.12989675193;75133;75919.62040189875;7616.619169041636;7734.6132693366235;7818.726344577913;7872.9405667239325;7904.13054563986;41046.38430423486;41115.97210069653;41157.382639261035;41282.38076428916;41372;59647.70176149265;60776;61042.389576105445;61160.69419652873;61340.159795206215;8500.97988241415;10035.297529172887;10159.593616255266;10327.741806454898;10328.586856525955;11181.385023823768;11183.664490064986;11366.147538934778;11492.080633549464;11588.76822463529;10181.74545636365;10279.743006424898;10508.106810921157;10533.57865685364;10731.678049658523;9157.03851095652;9170.862437063315;9203.907960920305;9450.716478505656;9524.190443812076;10278.640247591598;10302.742431439274;10353.430561318899;10698.572057117628;10711.196660250669;7033.753818616324;8893.288536916902;8896.532072208272;9053.049429809775;9284.118008789153;8741.91258087411;8759.299256059372;9242;9265.873807718413;9277.536123193948 12:30:09 INFO - PROCESS | 2261 | __end_tp_report 12:30:09 INFO - PROCESS | 2261 | __start_cc_report 12:30:09 INFO - PROCESS | 2261 | _x_x_mozilla_cycle_collect,425 12:30:09 INFO - PROCESS | 2261 | __end_cc_report 12:30:09 INFO - PROCESS | 2261 | __startTimestamp1461871809102__endTimestamp 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | ------- Summary: start ------- 12:30:09 INFO - PROCESS | 2261 | Number of tests: 6 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | [#0] dojo.html Cycles:165 Average:5702.67 Median:5940.38 stddev:659.33 (11.1%) stddev-sans-first:635.49 12:30:09 INFO - PROCESS | 2261 | Values: 3371.8 3418.2 3453.9 3470.7 3489.7 5702.6 5712.2 5719.1 5723.3 5751.9 5624.3 5702.7 5823.4 5824.6 5851.1 5180.9 5225.7 5267.8 5289.4 5347.1 5215.6 5393.8 5400.6 5442.0 5457.6 4416.9 5143.1 5227.6 5300.9 5341.7 5183.7 5215.8 5232.3 5233.5 5251.7 5148.4 5226.8 5280.6 5281.6 5323.7 4712.6 4911.7 5634.1 5680.5 5685.6 4399.0 5083.8 5279.6 6191.9 6220.8 6118.4 6219.8 6226.1 6240.7 6241.5 4698.6 5760.0 5808.6 5831.4 5873.4 6240.8 6247.3 6249.4 6275.7 6279.8 5590.2 5672.8 5687.0 5811.3 6189.6 6169.4 6247.3 6264.5 6279.5 6285.5 5959.2 6066.9 6135.8 6202.8 6211.5 5373.9 6040.8 6193.0 6218.0 6241.1 4186.2 4886.2 4948.4 4961.6 5014.2 4396.3 4410.2 4412.1 4413.4 4449.2 5757.7 5876.6 5900.2 5928.1 5954.3 6189.3 6218.3 6234.5 6251.0 6256.4 5857.1 5915.4 5925.9 5940.4 5975.5 5325.8 5377.4 5453.7 5457.5 5461.9 6311.3 6326.6 6331.0 6337.1 6349.7 6205.3 6237.2 6238.7 6239.0 6293.1 6206.5 6288.9 6300.9 6363.7 6378.2 5032.6 6160.2 6198.7 6203.3 6213.2 6229.0 6232.5 6232.8 6240.0 6241.8 5945.9 6088.0 6136.5 6181.1 6209.9 6104.9 6168.4 6211.8 6219.4 6230.4 5156.1 5973.0 6011.1 6060.8 6077.2 6042.2 6104.9 6123.5 6138.3 6158.4 6039.3 6047.9 6049.9 6054.2 6062.8 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | [#1] ext.html Cycles:180 Average:63623.82 Median:35801.23 stddev:143683.14 (401.3%) stddev-sans-first:144008.06 12:30:09 INFO - PROCESS | 2261 | Values: 508.1 513.3 533.3 569.1 573.1 38153.4 39021.6 39048.6 39058.0 39143.8 38243.2 41054.0 41058.2 41194.8 41263.8 8476.4 8738.6 9247.3 9453.6 9563.5 7908.9 9577.6 9680.0 9703.3 9708.9 9656.0 9709.2 9740.6 9744.7 9766.6 9639.3 9701.9 9716.2 9728.2 9757.4 9432.8 9435.5 9552.5 9579.5 9580.7 38775.8 39511.6 39574.8 39807.8 39888.0 2752.5 3050.8 3092.2 3339.8 3595.0 26682.0 27528.4 27549.4 27797.3 27972.4 2644.4 2665.2 2720.0 2752.1 2768.8 348011.0 350366.0 351850.0 355225.0 355604.0 29042.6 32213.8 35367.6 35448.6 35572.8 28767.0 34574.8 35764.8 35837.6 36033.6 14957.8 15260.4 15261.9 15284.6 15335.0 12737.0 12840.0 12853.9 12928.2 12941.7 8087.5 8269.3 8276.3 8333.3 8350.8 3061.2 3410.4 3413.6 3445.3 3448.0 987.8 1068.3 1158.4 1165.4 1213.8 24065.6 29090.0 30331.8 30971.7 30973.8 1096.3 1113.8 1150.3 1177.6 1234.0 14843.7 15014.6 15036.5 15331.1 15384.4 628462.0 633767.0 636837.0 647226.0 647805.0 57380.4 58652.0 59169.1 59505.7 59720.0 1472.9 1482.4 1501.0 1513.3 1514.8 28939.9 29119.6 29215.3 29644.3 29888.4 52725.5 53502.0 53511.0 53638.0 53664.0 556536.0 573902.0 575740.0 576708.0 579112.0 21935.1 25745.6 26446.2 26748.5 27836.7 43428.7 44218.3 44455.8 45396.0 45896.3 31572.8 33159.5 37212.1 37532.0 38007.0 31257.4 32234.7 37129.3 37221.6 37798.8 28900.7 36922.8 36969.4 37298.9 37675.6 25193.0 30573.7 31754.8 32006.5 32596.7 20451.6 20619.1 23919.6 24226.5 24303.8 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | [#2] jquery.html Cycles:180 Average:32452.47 Median:19742.30 stddev:92172.22 (466.9%) stddev-sans-first:92399.34 12:30:09 INFO - PROCESS | 2261 | Values: 386.3 393.0 398.5 399.4 404.8 20412.2 21069.7 21303.7 21326.4 22257.3 21191.3 21208.5 21716.0 21816.5 22120.9 5920.6 6021.2 6040.4 6075.5 6127.0 5587.6 5949.4 6012.6 6098.4 6107.1 5631.2 5775.5 5891.4 5910.7 5938.3 5829.7 5859.7 5861.8 5862.0 5864.0 5392.9 5760.6 5765.5 5773.5 5816.7 13119.5 13339.7 13588.3 13608.9 13770.0 2175.5 2197.5 2270.1 2340.2 2449.8 9056.3 9825.2 10256.5 10375.5 10451.8 1747.4 1755.0 1795.0 1806.2 1871.6 96339.5 104292.9 104706.5 104721.0 105659.4 11436.2 11654.7 11815.2 11897.9 11998.0 14871.0 14877.6 14933.2 14973.3 14983.3 8594.5 8767.3 8828.2 8833.6 9004.4 7308.6 8915.8 8939.3 8978.8 9022.8 4641.7 4647.7 4733.5 4749.8 4759.6 1522.5 1693.0 1813.9 1919.1 1971.9 754.5 900.7 931.0 952.0 967.6 17601.0 19240.9 20179.9 20247.9 20434.2 854.0 878.3 900.1 965.1 999.1 9430.4 10526.2 10531.7 10804.6 10805.5 546767.4 549635.0 555226.0 555535.0 556829.0 93095.0 95064.0 133506.0 135863.3 136276.0 915.7 1031.5 1032.1 1040.5 1050.8 17269.7 17706.9 17908.8 17961.8 17967.5 37034.8 40205.6 51352.0 51589.3 51809.0 68688.0 75464.0 76123.0 76295.2 78267.0 5408.1 6097.9 7239.0 7856.2 8372.5 10883.0 12368.8 12514.6 12864.8 12878.5 10731.7 10791.7 10841.2 10910.8 10960.3 10860.5 10894.0 10921.8 10945.9 10954.9 9191.8 11160.9 11192.2 11424.8 11548.9 8072.4 8164.4 8174.5 8235.7 8473.8 9792.7 10542.1 10550.2 11109.9 11215.4 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | [#3] mootools.html Cycles:180 Average:5733.28 Median:4981.89 stddev:3187.91 (64.0%) stddev-sans-first:3181.15 12:30:09 INFO - PROCESS | 2261 | Values: 1522.3 1594.0 1677.4 1842.2 1986.5 7804.9 8569.1 8611.8 8935.6 8940.2 8647.1 8694.3 8808.8 8811.8 8814.2 2423.6 2447.7 2460.5 2464.1 2469.7 2408.6 2477.5 2481.7 2482.4 2482.9 2408.1 2443.4 2468.0 2475.0 2487.2 2433.8 2440.5 2441.7 2448.8 2466.5 2430.9 2454.1 2460.5 2465.9 2469.8 8917.4 8982.7 9001.5 9008.2 9033.4 4515.0 5020.8 5322.7 5443.5 5447.4 2927.3 3614.4 3643.3 3701.2 3738.2 940.4 943.5 953.8 1037.0 1053.2 11608.8 11734.4 11771.4 11781.8 11785.9 4906.6 4913.5 4953.7 4996.3 5001.9 8634.4 10074.2 10088.0 10107.9 10138.1 5397.5 5497.2 5500.2 5517.8 5535.5 4448.8 4825.6 4907.5 4989.0 5023.0 3489.5 3513.7 3542.8 4065.9 4072.6 1363.4 1375.0 1386.8 1386.9 1387.6 912.0 913.8 928.8 946.8 957.6 5736.8 5956.8 6018.8 6019.8 6063.7 450.6 457.0 470.3 476.3 992.4 3973.3 4005.4 4021.6 4074.6 4096.8 10360.3 10517.4 10617.3 10797.2 10836.0 10658.0 10699.4 10702.8 10792.7 10944.4 7797.6 8158.4 8254.3 8267.2 8314.0 5940.9 5944.7 6049.9 6119.2 6130.9 9602.1 9902.3 9913.9 9928.0 9993.5 8944.2 9529.0 9770.6 10023.8 10206.5 6884.8 7390.3 7399.0 7627.6 7757.0 8378.9 8409.5 8441.1 8441.7 8487.9 7350.0 7477.4 7538.8 7576.5 7605.9 7298.5 7366.2 7377.4 7448.9 7516.5 7138.6 7184.2 7215.9 7224.6 7231.6 4855.5 4870.4 4974.8 5021.6 5203.0 4744.5 4854.5 4913.7 4923.7 5049.5 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | [#4] prototype.html Cycles:180 Average:4893.55 Median:5433.60 stddev:1594.26 (29.3%) stddev-sans-first:1561.30 12:30:09 INFO - PROCESS | 2261 | Values: 317.4 319.1 323.5 328.5 328.8 5428.3 5558.7 5603.6 5614.9 5626.9 4840.5 5491.4 5503.2 5506.7 5522.9 3452.8 3457.5 3474.0 3879.4 4063.4 3240.0 3586.0 4078.6 4202.9 4247.0 3747.6 3992.6 4198.0 4221.7 4242.3 4067.9 4182.3 4208.3 4229.0 4249.5 3059.9 3668.4 3680.3 3684.6 3685.2 5198.7 5270.5 5292.4 5296.5 5306.7 4641.0 4874.3 4876.0 4906.5 4910.7 5821.8 5823.9 5829.7 5840.5 5890.5 4053.0 4091.0 4092.4 4093.0 4100.9 5125.5 5942.4 6094.8 6134.1 6143.4 3828.5 3920.8 3954.2 4116.7 4127.0 3893.6 4038.4 4183.5 4201.9 4205.7 4088.7 4596.3 4617.8 4868.5 4912.4 4564.0 5547.9 5825.5 5862.6 5897.3 1275.5 1488.9 1546.5 1547.4 1552.7 875.7 885.0 946.6 982.7 1048.2 5169.6 5427.9 5538.1 5551.1 5562.8 5264.9 5735.0 5870.5 6104.4 6105.4 4067.3 4769.7 5013.8 5069.8 5160.6 2940.6 2959.9 3490.3 3507.2 3538.6 5823.2 6893.9 6925.2 6971.1 6982.8 6836.1 6888.6 6907.3 6957.4 6985.2 6565.6 6621.4 6960.4 6964.3 6995.3 6215.6 6336.0 6662.7 6711.7 6717.4 5545.8 5760.0 6287.0 6560.2 6567.7 5550.6 6194.8 6723.7 6733.5 6974.4 4010.6 4241.4 4258.7 4282.6 4289.8 5080.2 6269.6 6438.8 6499.2 6696.5 5002.2 5131.5 5923.0 6455.5 6469.4 5438.9 6137.6 6422.8 6430.8 6455.1 5477.8 6136.2 6254.4 6290.6 6344.2 5710.5 5754.2 5760.4 5861.2 5891.5 5471.5 5744.9 5757.9 5769.5 5850.1 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - PROCESS | 2261 | [#5] yui.html Cycles:180 Average:17996.03 Median:651.16 stddev:26206.79 (4024.6%) stddev-sans-first:26248.01 12:30:09 INFO - PROCESS | 2261 | Values: 670.4 676.6 676.9 697.8 699.3 14626.0 14889.6 15073.2 15111.6 15118.2 13601.7 13854.0 14001.4 14076.3 14085.1 721.9 894.3 905.5 922.3 934.4 911.7 929.5 933.1 933.8 935.0 824.8 968.4 981.1 983.4 985.0 936.6 963.6 973.8 977.9 979.5 715.6 717.2 717.4 717.7 718.4 14992.3 14993.0 15046.9 15089.5 15094.1 12102.0 12158.5 12186.3 12189.7 12425.9 9313.7 9336.0 9361.3 9394.2 9428.6 2903.0 3485.7 3489.7 3490.2 3491.1 83994.0 85099.3 85942.0 86676.0 87007.0 9398.7 9500.3 9589.1 9708.2 10020.4 22540.4 22542.9 22605.4 22648.0 22691.4 7440.3 7532.9 7604.9 7636.3 7872.8 4001.6 4081.9 4109.4 4122.1 4128.5 3534.3 3599.9 3639.6 3651.2 3655.9 636.0 650.3 652.0 652.6 661.9 484.5 525.1 562.3 602.5 610.9 5901.8 6860.5 6930.3 7033.8 8077.2 501.5 556.3 564.3 582.5 599.8 3433.6 3636.4 3835.0 3892.0 4027.3 88458.1 93073.5 99603.0 100138.0 103310.0 59398.0 78204.2 80943.6 81850.2 86228.0 74055.0 74524.0 74804.1 75133.0 75919.6 7616.6 7734.6 7818.7 7872.9 7904.1 41046.4 41116.0 41157.4 41282.4 41372.0 59647.7 60776.0 61042.4 61160.7 61340.2 8501.0 10035.3 10159.6 10327.7 10328.6 11181.4 11183.7 11366.1 11492.1 11588.8 10181.7 10279.7 10508.1 10533.6 10731.7 9157.0 9170.9 9203.9 9450.7 9524.2 10278.6 10302.7 10353.4 10698.6 10711.2 7033.8 8893.3 8896.5 9053.0 9284.1 8741.9 8759.3 9242.0 9265.9 9277.5 12:30:09 INFO - PROCESS | 2261 | -------- Summary: end -------- 12:30:09 INFO - PROCESS | 2261 | 12:30:09 INFO - TEST-INFO | 2261: exit 0 12:30:09 INFO - TEST-OK | dromaeo_css | took 1112563ms 12:30:09 INFO - TEST-START | kraken 12:30:09 INFO - operating with platform_type : mac_ 12:30:09 INFO - Initialising browser for kraken test... 12:30:09 INFO - TEST-INFO | started process 2267 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmp2W08SZ/profile http://localhost:55848/getInfo.html) 12:30:12 INFO - PROCESS | 2267 | __metrics Screen width/height:1600/1200 12:30:12 INFO - PROCESS | 2267 | colorDepth:24 12:30:12 INFO - PROCESS | 2267 | Browser inner width/height: 1024/689 12:30:12 INFO - PROCESS | 2267 | __metrics 12:30:12 ERROR - PROCESS | 2267 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 12:30:13 INFO - TEST-INFO | 2267: exit 0 12:30:13 INFO - Browser initialized. 12:30:13 INFO - Running cycle 1/1 for kraken test... 12:30:13 INFO - TEST-INFO | started process 2270 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmp2W08SZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:30:25 INFO - PROCESS | 2270 | RSS: Main: 249991168 12:30:25 INFO - PROCESS | 2270 | 12:30:27 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55848/tests/kraken/driver.html?testName=audio-beat-detection) 12:30:28 INFO - PROCESS | 2270 | RSS: Main: 261955584 12:30:28 INFO - PROCESS | 2270 | 12:30:31 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55848/tests/kraken/driver.html?testName=audio-dft) 12:30:32 INFO - PROCESS | 2270 | RSS: Main: 266641408 12:30:32 INFO - PROCESS | 2270 | 12:30:35 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55848/tests/kraken/driver.html?testName=audio-fft) 12:30:36 INFO - PROCESS | 2270 | RSS: Main: 266944512 12:30:36 INFO - PROCESS | 2270 | 12:30:38 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55848/tests/kraken/driver.html?testName=audio-oscillator) 12:30:38 INFO - PROCESS | 2270 | RSS: Main: 267608064 12:30:38 INFO - PROCESS | 2270 | 12:30:40 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:30:41 INFO - PROCESS | 2270 | RSS: Main: 268685312 12:30:41 INFO - PROCESS | 2270 | 12:30:44 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55848/tests/kraken/driver.html?testName=imaging-darkroom) 12:30:44 INFO - PROCESS | 2270 | RSS: Main: 268701696 12:30:44 INFO - PROCESS | 2270 | 12:30:47 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55848/tests/kraken/driver.html?testName=imaging-desaturate) 12:30:48 INFO - PROCESS | 2270 | RSS: Main: 268673024 12:30:48 INFO - PROCESS | 2270 | 12:30:51 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55848/tests/kraken/driver.html?testName=json-parse-financial) 12:30:51 INFO - PROCESS | 2270 | RSS: Main: 268722176 12:30:51 INFO - PROCESS | 2270 | 12:30:53 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:30:54 INFO - PROCESS | 2270 | RSS: Main: 268132352 12:30:54 INFO - PROCESS | 2270 | 12:30:55 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:30:56 INFO - PROCESS | 2270 | RSS: Main: 268333056 12:30:56 INFO - PROCESS | 2270 | 12:30:58 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:30:59 INFO - PROCESS | 2270 | RSS: Main: 268546048 12:30:59 INFO - PROCESS | 2270 | 12:31:02 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:31:03 INFO - PROCESS | 2270 | RSS: Main: 268632064 12:31:03 INFO - PROCESS | 2270 | 12:31:06 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:31:06 INFO - PROCESS | 2270 | RSS: Main: 268607488 12:31:06 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | Cycle 1(1): loaded http://localhost:55848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55848/tests/kraken/driver.html?testName=ai-astar) 12:31:08 INFO - PROCESS | 2270 | RSS: Main: 270340096 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | __start_tp_report 12:31:08 INFO - PROCESS | 2270 | _x_x_mozilla_page_load 12:31:08 INFO - PROCESS | 2270 | _x_x_mozilla_page_load_details 12:31:08 INFO - PROCESS | 2270 | |i|pagename|runs| 12:31:08 INFO - PROCESS | 2270 | |0;ai-astar;114;111;115;113;116;129;122;166;144;116 12:31:08 INFO - PROCESS | 2270 | |1;audio-beat-detection;160;122;144;166;147;178;174;123;166;156 12:31:08 INFO - PROCESS | 2270 | |2;audio-dft;197;200;206;221;258;274;198;198;204;195 12:31:08 INFO - PROCESS | 2270 | |3;audio-fft;67;80;72;131;56;55;68;60;79;56 12:31:08 INFO - PROCESS | 2270 | |4;audio-oscillator;81;83;123;77;79;78;121;63;88;164 12:31:08 INFO - PROCESS | 2270 | |5;imaging-gaussian-blur;91;89;91;87;91;87;91;88;108;87 12:31:08 INFO - PROCESS | 2270 | |6;imaging-darkroom;125;96;101;110;127;104;110;128;89;93 12:31:08 INFO - PROCESS | 2270 | |7;imaging-desaturate;90;92;109;91;92;89;90;90;109;116 12:31:08 INFO - PROCESS | 2270 | |8;json-parse-financial;61;53;54;52;51;62;76;66;63;69 12:31:08 INFO - PROCESS | 2270 | |9;json-stringify-tinderbox;63;63;71;71;81;74;71;67;66;69 12:31:08 INFO - PROCESS | 2270 | |10;stanford-crypto-aes;80;102;105;109;109;112;86;83;86;83 12:31:08 INFO - PROCESS | 2270 | |11;stanford-crypto-ccm;138;138;156;159;138;133;123;136;195;131 12:31:08 INFO - PROCESS | 2270 | |12;stanford-crypto-pbkdf2;180;172;183;180;175;237;224;227;172;185 12:31:08 INFO - PROCESS | 2270 | |13;stanford-crypto-sha256-iterative;67;93;101;96;87;68;70;67;69;71 12:31:08 INFO - PROCESS | 2270 | __end_tp_report 12:31:08 INFO - PROCESS | 2270 | __start_cc_report 12:31:08 INFO - PROCESS | 2270 | _x_x_mozilla_cycle_collect,1090 12:31:08 INFO - PROCESS | 2270 | __end_cc_report 12:31:08 INFO - PROCESS | 2270 | __startTimestamp1461871868855__endTimestamp 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | ------- Summary: start ------- 12:31:08 INFO - PROCESS | 2270 | Number of tests: 14 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#0] ai-astar Cycles:10 Average:124.60 Median:119.00 stddev:17.60 (14.8%) stddev-sans-first:18.25 12:31:08 INFO - PROCESS | 2270 | Values: 114.0 111.0 115.0 113.0 116.0 129.0 122.0 166.0 144.0 116.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:163.00 stddev:19.54 (12.0%) stddev-sans-first:20.59 12:31:08 INFO - PROCESS | 2270 | Values: 160.0 122.0 144.0 166.0 147.0 178.0 174.0 123.0 166.0 156.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#2] audio-dft Cycles:10 Average:215.10 Median:205.00 stddev:28.08 (13.7%) stddev-sans-first:29.01 12:31:08 INFO - PROCESS | 2270 | Values: 197.0 200.0 206.0 221.0 258.0 274.0 198.0 198.0 204.0 195.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#3] audio-fft Cycles:10 Average:72.40 Median:67.50 stddev:22.55 (33.4%) stddev-sans-first:23.84 12:31:08 INFO - PROCESS | 2270 | Values: 67.0 80.0 72.0 131.0 56.0 55.0 68.0 60.0 79.0 56.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#4] audio-oscillator Cycles:10 Average:95.70 Median:78.50 stddev:30.73 (39.1%) stddev-sans-first:32.13 12:31:08 INFO - PROCESS | 2270 | Values: 81.0 83.0 123.0 77.0 79.0 78.0 121.0 63.0 88.0 164.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#5] imaging-gaussian-blur Cycles:10 Average:91.00 Median:90.00 stddev:6.24 (6.9%) stddev-sans-first:6.61 12:31:08 INFO - PROCESS | 2270 | Values: 91.0 89.0 91.0 87.0 91.0 87.0 91.0 88.0 108.0 87.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#6] imaging-darkroom Cycles:10 Average:108.30 Median:127.50 stddev:14.35 (11.3%) stddev-sans-first:13.88 12:31:08 INFO - PROCESS | 2270 | Values: 125.0 96.0 101.0 110.0 127.0 104.0 110.0 128.0 89.0 93.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:90.00 stddev:10.25 (11.4%) stddev-sans-first:10.57 12:31:08 INFO - PROCESS | 2270 | Values: 90.0 92.0 109.0 91.0 92.0 89.0 90.0 90.0 109.0 116.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:62.50 stddev:8.25 (13.2%) stddev-sans-first:8.75 12:31:08 INFO - PROCESS | 2270 | Values: 61.0 53.0 54.0 52.0 51.0 62.0 76.0 66.0 63.0 69.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#9] json-stringify-tinderbox Cycles:10 Average:69.60 Median:71.00 stddev:5.40 (7.6%) stddev-sans-first:5.17 12:31:08 INFO - PROCESS | 2270 | Values: 63.0 63.0 71.0 71.0 81.0 74.0 71.0 67.0 66.0 69.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#10] stanford-crypto-aes Cycles:10 Average:95.50 Median:81.50 stddev:12.92 (15.9%) stddev-sans-first:12.43 12:31:08 INFO - PROCESS | 2270 | Values: 80.0 102.0 105.0 109.0 109.0 112.0 86.0 83.0 86.0 83.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#11] stanford-crypto-ccm Cycles:10 Average:144.70 Median:138.00 stddev:20.73 (15.0%) stddev-sans-first:21.85 12:31:08 INFO - PROCESS | 2270 | Values: 138.0 138.0 156.0 159.0 138.0 133.0 123.0 136.0 195.0 131.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.50 Median:184.00 stddev:25.29 (13.7%) stddev-sans-first:26.35 12:31:08 INFO - PROCESS | 2270 | Values: 180.0 172.0 183.0 180.0 175.0 237.0 224.0 227.0 172.0 185.0 12:31:08 INFO - PROCESS | 2270 | 12:31:08 INFO - PROCESS | 2270 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.90 Median:70.50 stddev:13.69 (19.4%) stddev-sans-first:13.83 12:31:08 INFO - PROCESS | 2270 | Values: 67.0 93.0 101.0 96.0 87.0 68.0 70.0 67.0 69.0 71.0 12:31:08 INFO - PROCESS | 2270 | -------- Summary: end -------- 12:31:08 INFO - PROCESS | 2270 | 12:31:09 INFO - TEST-INFO | 2270: exit 0 12:31:09 INFO - TEST-OK | kraken | took 59952ms 12:31:09 INFO - SUITE-END | took 1172s 12:31:10 INFO - Completed test suite (00:19:32) 12:31:10 INFO - javascript benchmark 12:31:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3371.797692138472, 3418.162550175207, 3453.861845526181, 3470.6876381125694, 3489.6859282664554, 5702.572307076965, 5712.200291959129, 5719.113537401699, 5723.255976723025, 5751.856203594913, 5624.268845050137, 5702.743376548055, 5823.417658234174, 5824.621399609023, 5851.0930805725075, 5180.896382072366, 5225.738713064351, 5267.789288428458, 5289.418164001957, 5347.064263753847, 5215.582753379739, 5393.83818485446, 5400.648957817729, 5441.972790136044, 5457.645253058538, 4416.911661766747, 5143.125668636303, 5227.581793456552, 5300.867478313035, 5341.679499230058, 5183.740812959337, 5215.791368345262, 5232.319798426181, 5233.528982391565, 5251.73958250021, 5148.382194136728, 5226.7909283628605, 5280.630355875091, 5281.551068159211, 5323.707196104213, 4712.5994290485005, 4911.656184067117, 5634.098544232944, 5680.460356266148, 5685.573581981326, 4399.0, 5083.822066227701, 5279.577633789288, 6191.938080619227, 6220.813375598739, 6118.405988989689, 6219.813405597839, 6226.097215903714, 6240.687965601702, 6241.531885108635, 4698.553637404441, 5760.0, 5808.564357673192, 5831.358550559477, 5873.353931067579, 6240.843978900564, 6247.312795592481, 6249.375062493805, 6275.6548389839, 6279.843003924847, 5590.2453168821685, 5672.829815105553, 5687.0, 5811.27359080115, 6189.597676151036, 6169.352218017133, 6247.344028876993, 6264.498840092781, 6279.497640188774, 6285.465735412541, 5959.195508606369, 6066.86523676236, 6135.815925522242, 6202.751889924442, 6211.503079753609, 5373.919391209135, 6040.7583696651645, 6192.969035154885, 6217.96891015542, 6241.126242326078, 4186.225548273579, 4886.218205087169, 4948.4309304429735, 4961.5534601886, 5014.197728363444, 4396.274614688605, 4410.20616289071, 4412.0955204183065, 4413.44831896013, 4449.17690227309, 5757.740901659436, 5876.647401155944, 5900.232969713909, 5928.140419639129, 5954.255718035246, 6189.288231853395, 6218.253809542884, 6234.532410069263, 6251.0, 6256.436920677161, 5857.062869940789, 5915.438033386821, 5925.881482370329, 5940.376260492672, 5975.492083172979, 5325.760340784674, 5377.435369286247, 5453.700046497481, 5457.481539253765, 5461.918071228934, 6311.305756366796, 6326.620402775664, 6330.968345158245, 6337.144485494491, 6349.6507692077375, 6205.2553693557065, 6237.220347456568, 6238.6880655967925, 6238.970569855923, 6293.087502312231, 6206.503479721521, 6288.937110628835, 6300.905486417799, 6363.6818159090935, 6378.2346118466085, 5032.6225533084435, 6160.168377269011, 6198.721057552511, 6203.2556093269095, 6213.161223234805, 6229.0, 6232.501399887908, 6232.844178895564, 6239.970404883144, 6241.78153764616, 5945.91081133792, 6087.969560152171, 6136.478399336106, 6181.072839074175, 6209.875802484015, 6104.8836088941825, 6168.35232300602, 6211.751529938751, 6219.440250377488, 6230.408111229426, 5156.1492353761205, 5973.044312909914, 6011.121417906396, 6060.787872424444, 6077.20996270482, 6042.244719410074, 6104.9389506106145, 6123.540734444845, 6138.294096178996, 6158.414950579688, 6039.305479869871, 6047.879042419215, 6049.909251361321, 6054.152418661479, 6062.818115456544], "value": 5663.353161959332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.14631419215715, 513.266029577704, 533.269420893376, 569.1150261343612, 573.1402895656515, 38153.42769858454, 39021.60978390215, 39048.609513904856, 39058.0, 39143.82568522949, 38243.23513529728, 41054.0, 41058.178836423256, 41194.7940260299, 41263.79368103155, 8476.449030813008, 8738.645509945936, 9247.26021918245, 9453.574589143505, 9563.521823908812, 7908.920910790905, 9577.61689532418, 9679.95160024199, 9703.320767546275, 9708.90291097087, 9655.951720241388, 9709.223262139047, 9740.561674724619, 9744.658936937209, 9766.560504777302, 9639.325247232697, 9701.90298097017, 9716.174125199366, 9728.221742260637, 9757.41455512668, 9432.811343773086, 9435.481048542328, 9552.522373881278, 9579.521023948775, 9580.712578622582, 38775.80612096922, 39511.60488395137, 39574.802125989474, 39807.8009609953, 39888.0, 2752.518309295865, 3050.7559395248327, 3092.226943264184, 3339.8497067632015, 3595.0, 26682.0, 27528.449431011268, 27549.449011019868, 27797.305067373476, 27972.44055118886, 2644.3917898883365, 2665.2270841456148, 2719.986400067987, 2752.146834481317, 2768.750812426891, 348011.0, 350366.0, 351849.99999999744, 355225.0, 355604.0, 29042.564361534594, 32213.838930805665, 35367.64632353695, 35448.64551354505, 35572.82213588967, 28767.0, 34574.827125864715, 35764.82117589395, 35837.64162358395, 36033.57681020299, 14957.775633365509, 15260.389584416498, 15261.93166478358, 15284.617884552752, 15335.0, 12736.981041516656, 12840.0, 12853.93573032129, 12928.159669621444, 12941.676458088623, 8087.474314169678, 8269.30479251752, 8276.255137037575, 8333.250007499355, 8350.791230219293, 3061.2040869373677, 3410.3861304965344, 3413.573303337083, 3445.3453843769603, 3447.9827600861836, 987.8271302522173, 1068.3322923173016, 1158.4034222375483, 1165.3648761425043, 1213.769383817072, 24065.63901541478, 29090.0, 30331.848340758155, 30971.69028309733, 30973.845130774203, 1096.2545469081101, 1113.7661091170783, 1150.2753265442718, 1177.5643012085584, 1233.9506419743109, 14843.703125937422, 15014.624634384008, 15036.548903532912, 15331.080135191924, 15384.384624615113, 628462.0, 633767.0, 636837.0, 647226.0, 647805.0, 57380.426195737506, 58652.0, 59169.11246331308, 59505.70247148823, 59720.0, 1472.926353682333, 1482.392219190127, 1500.9924950375396, 1513.3038802150913, 1514.833368329483, 28939.85530072336, 29119.563206551495, 29215.269618259714, 29644.258893527833, 29888.402231955675, 52725.47274527359, 53502.0, 53511.0, 53638.0, 53664.0, 556536.0, 573902.0, 575740.0, 576708.0, 579112.0, 21935.122595096655, 25745.613815793153, 26446.206613801616, 26748.465030698888, 27836.721632783414, 43428.697139085874, 44218.3367249498, 44455.77772111119, 45396.0, 45896.31155532603, 31572.842135789175, 33159.50260746139, 37212.13939303078, 37532.0, 38007.0, 31257.37485250328, 32234.677653224106, 37129.257414852094, 37221.627783721815, 37798.81100594479, 28900.710992890643, 36922.8153859229, 36969.44545831761, 37298.881033569036, 37675.62324376721, 25193.0, 30573.694263057085, 31754.841225793723, 32006.51990220195, 32596.674033259365, 20451.59096818085, 20619.072141753357, 23919.641205381584, 24226.51546969086, 24303.756962430856], "value": 17929.693260789536, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3451449792601, 392.95088113985736, 398.5078428141246, 399.37896570832345, 404.82794812204804, 20412.183512659474, 21069.683954740693, 21303.68044479334, 21326.36020919373, 22257.332280031584, 21191.258305959254, 21208.4697882553, 21716.0, 21816.454588635293, 22120.889395553, 5920.555958303123, 6021.157038014681, 6040.426159514839, 6075.483583895374, 6127.0, 5587.636803607753, 5949.405059494059, 6012.5791194616395, 6098.359672234418, 6107.114468402079, 5631.211630371751, 5775.509081728058, 5891.440313170242, 5910.704464776765, 5938.346781853993, 5829.737661805208, 5859.707014649251, 5861.765529378819, 5862.0, 5864.0, 5392.91910621341, 5760.646248131686, 5765.509931655814, 5773.538116950634, 5816.709164541756, 13119.47522099115, 13339.733205335839, 13588.320583970763, 13608.93195534016, 13769.967252456107, 2175.5431359414542, 2197.450637340665, 2270.14869423966, 2340.169239919838, 2449.7917676997477, 9056.320775941766, 9825.213982881352, 10256.538455769509, 10375.533101010473, 10451.79096418075, 1747.4146161036067, 1754.9649007019916, 1794.9551261218573, 1806.1781889240494, 1871.644387566358, 96339.51830240875, 104292.9141417175, 104706.47646761793, 104720.95279047189, 105659.41510877344, 11436.199466037464, 11654.650360489199, 11815.172937894265, 11897.940510297392, 11998.0, 14871.0, 14877.628059298388, 14933.17867517297, 14973.251337433085, 14983.250837458083, 8594.484330940164, 8767.25478334336, 8828.249598784047, 8833.55832208387, 9004.36969412135, 7308.5614863108385, 8915.777105572413, 8939.329550283755, 8978.775530611656, 9022.774430639156, 4641.721496710208, 4647.7211367317395, 4733.508944682414, 4749.762511874393, 4759.643026773006, 1522.5127959052998, 1693.0357814696915, 1813.8911665300125, 1919.1076149590508, 1971.9014049297477, 754.5397307642334, 900.7072701372081, 930.9805762689844, 951.9571619277149, 967.5742673223759, 17601.0, 19240.903795481212, 20179.899100504404, 20247.898760506105, 20434.182632694825, 854.0093491549773, 878.2534845381375, 900.149358855888, 965.0879918477112, 999.0708640963974, 9430.387024843363, 10526.210534209811, 10531.736706582396, 10804.567817287221, 10805.513751881184, 546767.4466143814, 549635.0, 555226.0, 555535.0, 556829.0, 93095.0, 95064.0, 133506.0, 135863.32068339596, 136276.0, 915.6795121707349, 1031.515187861704, 1032.1123833503182, 1040.458961340114, 1050.795094956476, 17269.654606908043, 17706.937583745017, 17908.820911791237, 17961.8324808887, 17967.460976170736, 37034.81482592678, 40205.597944020185, 51352.0, 51589.32992572514, 51809.0, 68688.0, 75464.0, 76123.0, 76295.23704762882, 78267.0, 5408.13469844823, 6097.939020609737, 7238.986541884035, 7856.214378562098, 8372.486983383622, 10883.0, 12368.75262494727, 12514.561990330294, 12864.807027894401, 12878.484860605471, 10731.678049658523, 10791.730206744895, 10841.241113122322, 10910.781784364426, 10960.28758130719, 10860.456977150952, 10894.0, 10921.781564368826, 10945.890541094806, 10954.945225273823, 9191.816163676554, 11160.944195278971, 11192.160587955774, 11424.771504569695, 11548.884511155116, 8072.394570407126, 8164.428490005643, 8174.468659537111, 8235.670573177005, 8473.788155296166, 9792.72694549704, 10542.051215390651, 10550.208734344802, 11109.888901110886, 11215.383153926286], "value": 9227.286843807251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1522.3301747231221, 1594.0, 1677.3793696332352, 1842.1894366478748, 1986.4735845001087, 7804.92195078049, 8569.143085691428, 8611.784705382368, 8935.553222338882, 8940.19538241558, 8647.13528647135, 8694.347923905716, 8808.77978050549, 8811.823763524726, 8814.206721395074, 2423.6364545318165, 2447.730749617541, 2460.495598402323, 2464.149868295435, 2469.715982661999, 2408.5784987627094, 2477.479729256849, 2481.7394173611783, 2482.366996415911, 2482.8510289382602, 2408.1089996701244, 2443.3525115844313, 2468.0004598137693, 2475.0, 2487.166799122296, 2433.841800282976, 2440.5362981033636, 2441.682581264442, 2448.755124487555, 2466.4943686544216, 2430.902763889442, 2454.067454367329, 2460.520198561281, 2465.864377459239, 2469.77772000519, 8917.375783695144, 8982.685606003759, 9001.459912405277, 9008.189262966365, 9033.367664263504, 4514.9774251128865, 5020.799168033274, 5322.654027488201, 5443.537299329561, 5447.428020057916, 2927.3267148555738, 3614.4397618369194, 3643.3259846928404, 3701.168606016373, 3738.2336620992633, 940.4310392212681, 943.4669411782321, 953.7853982853871, 1036.9740756481074, 1053.2416660004785, 11608.825867611993, 11734.354610496419, 11771.411429428494, 11781.764364712744, 11785.882141178565, 4906.55840974314, 4913.459519452857, 4953.653244272867, 4996.250562415594, 5001.874953126201, 8634.402635512324, 10074.194064474825, 10087.991200879853, 10107.949460252652, 10138.124446977332, 5397.460253974571, 5497.175423686399, 5500.22996780451, 5517.779288828402, 5535.501804837584, 4448.822047118079, 4825.565699087028, 4907.509249075135, 4988.9501104988485, 5022.995400919831, 3489.4765785131926, 3513.701335386521, 3542.787432754043, 4065.8780236592947, 4072.592740725963, 1363.3864760857655, 1375.0, 1386.7919812028276, 1386.861313868605, 1387.5906607550594, 911.9544022798833, 913.8126684029758, 928.8049509602924, 946.8390373636498, 957.5978089202413, 5736.770529178786, 5956.761729530857, 6018.789342372996, 6019.765947980653, 6063.727132279058, 450.5629539346828, 456.9885752856139, 470.3203870407229, 476.29746124466135, 992.4194346307347, 3973.324534829086, 4005.439238506611, 4021.6380525752825, 4074.5517993020744, 4096.795160241976, 10360.274780765274, 10517.421541815274, 10617.309874858109, 10797.190210734227, 10836.0, 10658.040776330168, 10699.411532365795, 10702.785944281071, 10792.730181745519, 10944.39805810672, 7797.610119494003, 8158.388120890957, 8254.339652827879, 8267.214614611603, 8313.958430207811, 5940.881182376242, 5944.702764861826, 6049.911016016983, 6119.2350956130485, 6130.908036379368, 9602.135807777333, 9902.306838521234, 9913.851292230767, 9928.0, 9993.500324983866, 8944.150305720947, 9529.0, 9770.560324785543, 10023.849642255518, 10206.540705668114, 6884.827879302858, 7390.334869861738, 7398.96300518494, 7627.580483073484, 7756.961215193888, 8378.916210838057, 8409.495430273959, 8441.071482136836, 8441.746747597583, 8487.8726819099, 7349.963250183715, 7477.364424024019, 7538.8314811204355, 7576.545407275581, 7605.923940760522, 7298.4891057625455, 7366.189719130784, 7377.4098072155175, 7448.925510744823, 7516.5114267572435, 7138.607376594337, 7184.1738200105565, 7215.891761623685, 7224.638768061681, 7231.602261875437, 4855.5387238212315, 4870.366852309177, 4974.825881094144, 5021.623378246573, 5202.97398513005, 4744.5492678195515, 4854.490278520704, 4913.70517768935, 4923.729194894315, 5049.495050494921], "value": 4578.522362427284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.419123004901, 319.10491072541527, 323.4646659778068, 328.510519326204, 328.83065221410993, 5428.308750049964, 5558.748706773763, 5603.635763675368, 5614.887702245953, 5626.887462250753, 4840.540148685878, 5491.395946445888, 5503.229547863292, 5506.669599824013, 5522.91715624266, 3452.7583069185166, 3457.4640930655787, 3474.0, 3879.4374815651713, 4063.4311196432523, 3239.96760032399, 3585.9820700896457, 4078.6125318094732, 4202.865226388873, 4247.0, 3747.550293964728, 3992.580779018205, 4197.958020419787, 4221.746695198282, 4242.342436922282, 4067.9389809152885, 4182.327069172325, 4208.263553878074, 4229.0, 4249.511306199795, 3059.908202753921, 3668.3763760160837, 3680.3375392429352, 3684.613115622848, 3685.2261025184475, 5198.714070726146, 5270.49930256625, 5292.417834038252, 5296.549793267577, 5306.67505982623, 4640.953590464086, 4874.268859671042, 4876.0, 4906.509349065101, 4910.7299098549565, 5821.81681869299, 5823.893460242541, 5829.737661805187, 5840.532757379399, 5890.469857712784, 4052.9664935441274, 4090.9590904090874, 4092.406601042862, 4093.03534303533, 4100.856470023535, 5125.538701516882, 5942.3760505146765, 6094.756209751605, 6134.079888016789, 6143.354947730469, 3828.5214348206473, 3920.8440900216124, 3954.189391174802, 4116.732412393185, 4126.958730412657, 3893.552241492208, 4038.4144299077057, 4183.481839613271, 4201.873943781691, 4205.684573656988, 4088.652464540488, 4596.287575425815, 4617.792199351037, 4868.464468908417, 4912.410510738734, 4563.977180114078, 5547.861303467445, 5825.533957283407, 5862.560307976919, 5897.292324921037, 1275.489804078376, 1488.8684599704302, 1546.536039188239, 1547.3501129525625, 1552.74379727346, 875.6978842299396, 884.951327676984, 946.5882341181608, 982.68062879563, 1048.2452634103433, 5169.638125331266, 5427.864303392446, 5538.141588053858, 5551.057939292182, 5562.805301814417, 5264.920691258283, 5734.971325143431, 5870.501007414332, 6104.3590423005835, 6105.358937311518, 4067.2510820346943, 4769.681804787706, 5013.774380152902, 5069.771860266297, 5160.561352285023, 2940.573616825591, 2959.9112026639236, 3490.267043920805, 3507.228409749851, 3538.610752817188, 5823.244007615064, 6893.862122757617, 6925.203601585882, 6971.093757811452, 6982.79051628452, 6836.111305530249, 6888.586684798928, 6907.34380233877, 6957.408620267232, 6985.161780586261, 6565.573237739532, 6621.4040736333, 6960.408365289007, 6964.303569642894, 6995.26549712283, 6215.564910456224, 6336.017917222838, 6662.700178492077, 6711.664416779044, 6717.395434410926, 5545.805896793754, 5760.020796464695, 6286.994080947209, 6560.179977502812, 6567.704453299518, 5550.556855217592, 6194.783182588588, 6723.697433615597, 6733.528652994243, 6974.407175390149, 4010.57888921659, 4241.427407300099, 4258.6805989550285, 4282.571742825692, 4289.820299417685, 5080.212567052113, 6269.592476489013, 6438.806835794933, 6499.165492359531, 6696.464282857457, 5002.224655178453, 5131.538161565477, 5922.963481390825, 6455.5468921809415, 6469.353064693493, 5438.891222175614, 6137.570370074052, 6422.839429014312, 6430.807075787734, 6455.128557644658, 5477.75350109238, 6136.171616831849, 6254.405831446005, 6290.559660823881, 6344.206974128234, 5710.543156547383, 5754.223179870832, 5760.395158508296, 5861.1501332307425, 5891.469767720926, 5471.534919531725, 5744.885102298014, 5757.856053598526, 5769.53843692512, 5850.0932355484965], "value": 4392.358869875696, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.3665036540469, 676.5703778100906, 676.9187697476298, 697.808102771738, 699.2727563334133, 14626.0, 14889.55331340059, 15073.170975596351, 15111.62220944477, 15118.244087795621, 13601.727965440685, 13854.0, 14001.369938352773, 14076.296185190751, 14085.0844695095, 721.8844984802432, 894.2577660541767, 905.5064989580678, 922.3405265235356, 934.4346670264495, 911.7128104647015, 929.4609126706493, 933.1182032978837, 933.7945651956593, 934.9626014959393, 824.8020475085966, 968.3753978683744, 981.1415011864618, 983.4492684096892, 984.9803003939917, 936.6113063078814, 963.648268382039, 973.7614284500272, 977.9364341317827, 979.485769970764, 715.613568672916, 717.1931576975902, 717.4475653746638, 717.6913927011383, 718.396546900606, 14992.250387480583, 14992.950493465461, 15046.924765376212, 15089.47186848455, 15094.094354338666, 12102.0, 12158.51365945361, 12186.329751863645, 12189.69525761863, 12425.937870310681, 9313.674021409219, 9335.953320233424, 9361.251099911991, 9394.248460123174, 9428.575714092882, 2902.9854850725824, 3485.7037151842123, 3489.70337521311, 3490.1972546314237, 3491.109767009422, 83994.0, 85099.29967858156, 85942.0, 86676.0, 87006.99999999936, 9398.718038458857, 9500.334976551576, 9589.136977672042, 9708.223342132613, 10020.398776073458, 22540.436489087904, 22542.887285563465, 22605.434864128198, 22648.0, 22691.432714182276, 7440.255974402625, 7532.928444677648, 7604.9239507605325, 7636.31273185416, 7872.803179920434, 4001.559828418872, 4081.8571350002608, 4109.404136400205, 4122.093139509303, 4128.545859955402, 3534.3108093921437, 3599.85600575974, 3639.563252409675, 3651.2332410193626, 3655.94516082259, 635.9951276982357, 650.3496503496503, 651.9731423008781, 652.6149571752594, 661.8577005943745, 484.5154845154845, 525.0601423452055, 562.2887047884429, 602.5089552015181, 610.8900397928327, 5901.822945311647, 6860.451163906875, 6930.341617546325, 7033.824154396181, 8077.192280771876, 501.490986648552, 556.2879514221803, 564.2720890051869, 582.4990508163061, 599.8230521996022, 3433.639467855889, 3636.381815091388, 3835.0, 3892.026993251687, 4027.2549578328103, 88458.11541884499, 93073.53463232776, 99603.0079398408, 100138.0, 103310.0, 59398.0, 78204.2179578197, 80943.59528202322, 81850.18149818426, 86228.0, 74055.0, 74524.0, 74804.12989675193, 75133.0, 75919.62040189875, 7616.619169041636, 7734.6132693366235, 7818.726344577913, 7872.9405667239325, 7904.13054563986, 41046.38430423486, 41115.97210069653, 41157.382639261035, 41282.38076428916, 41372.0, 59647.70176149265, 60776.0, 61042.389576105445, 61160.69419652873, 61340.159795206215, 8500.97988241415, 10035.297529172887, 10159.593616255266, 10327.741806454898, 10328.586856525955, 11181.385023823768, 11183.664490064986, 11366.147538934778, 11492.080633549464, 11588.76822463529, 10181.74545636365, 10279.743006424898, 10508.106810921157, 10533.57865685364, 10731.678049658523, 9157.03851095652, 9170.862437063315, 9203.907960920305, 9450.716478505656, 9524.190443812076, 10278.640247591598, 10302.742431439274, 10353.430561318899, 10698.572057117628, 10711.196660250669, 7033.753818616324, 8893.288536916902, 8896.532072208272, 9053.049429809775, 9284.118008789153, 8741.91258087411, 8759.299256059372, 9242.0, 9265.873807718413, 9277.536123193948], "value": 6678.850289133939, "unit": "score"}], "name": "dromaeo_css", "value": 7079.142745248892, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 115.0, 113.0, 116.0, 129.0, 122.0, 166.0, 144.0, 116.0], "value": 124.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 144.0, 166.0, 147.0, 178.0, 174.0, 123.0, 166.0, 156.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 206.0, 221.0, 258.0, 274.0, 198.0, 198.0, 204.0, 195.0], "value": 215.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 80.0, 72.0, 131.0, 56.0, 55.0, 68.0, 60.0, 79.0, 56.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 123.0, 77.0, 79.0, 78.0, 121.0, 63.0, 88.0, 164.0], "value": 95.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 91.0, 87.0, 91.0, 87.0, 91.0, 88.0, 108.0, 87.0], "value": 91.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 96.0, 101.0, 110.0, 127.0, 104.0, 110.0, 128.0, 89.0, 93.0], "value": 108.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 109.0, 91.0, 92.0, 89.0, 90.0, 90.0, 109.0, 116.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 53.0, 54.0, 52.0, 51.0, 62.0, 76.0, 66.0, 63.0, 69.0], "value": 60.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 71.0, 71.0, 81.0, 74.0, 71.0, 67.0, 66.0, 69.0], "value": 69.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 102.0, 105.0, 109.0, 109.0, 112.0, 86.0, 83.0, 86.0, 83.0], "value": 95.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 156.0, 159.0, 138.0, 133.0, 123.0, 136.0, 195.0, 131.0], "value": 144.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 172.0, 183.0, 180.0, 175.0, 237.0, 224.0, 227.0, 172.0, 185.0], "value": 193.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 93.0, 101.0, 96.0, 87.0, 68.0, 70.0, 67.0, 69.0, 71.0], "value": 78.9, "unit": "score"}], "name": "kraken", "value": 1600.4, "alertThreshold": 2.0}]} 12:31:10 INFO - Return code: 0 12:31:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:31:10 ERROR - # TBPL SUCCESS # 12:31:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:31:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:31:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:31:10 INFO - 2016-04-28 12:31:10.148 screenresolution[2275:39504] starting screenresolution argv=screenresolution get 12:31:10 INFO - 2016-04-28 12:31:10.150 screenresolution[2275:39504] Display 0: 1600x1200x32@60 12:31:10 INFO - 2016-04-28 12:31:10.156 screenresolution[2276:39507] starting screenresolution argv=screenresolution list 12:31:10 INFO - Available Modes on Display 0 12:31:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:31:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:31:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:31:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:31:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:31:10 INFO - Intel Iris: 12:31:10 INFO - Chipset Model: Intel Iris 12:31:10 INFO - Type: GPU 12:31:10 INFO - Bus: Built-In 12:31:10 INFO - VRAM (Dynamic, Max): 1536 MB 12:31:10 INFO - Vendor: Intel (0x8086) 12:31:10 INFO - Device ID: 0x0a2e 12:31:10 INFO - Revision ID: 0x0009 12:31:10 INFO - Displays: 12:31:10 INFO - Display: 12:31:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:31:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:31:10 INFO - Display Serial Number: 1600x1200 60 12:31:10 INFO - Main Display: Yes 12:31:10 INFO - Mirror: Off 12:31:10 INFO - Online: Yes 12:31:10 INFO - Rotation: Supported 12:31:10 INFO - Return code: 0 12:31:10 INFO - Running post-action listener: _resource_record_post_action 12:31:10 INFO - Running post-run listener: _resource_record_post_run 12:31:11 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 684032; Write bytes: 696333824; Read time: 7; Write time: 1881 12:31:11 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 391401984; Write bytes: 385730048; Read time: 29702; Write time: 685 12:31:11 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 684032; Write bytes: 297062400; Read time: 7; Write time: 1161 12:31:11 INFO - Running post-run listener: _upload_blobber_files 12:31:11 INFO - Blob upload gear active. 12:31:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:31:11 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 12:31:11 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'] 12:31:11 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 12:31:11 INFO - (blobuploader) - INFO - Open directory for files ... 12:31:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:31:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:31:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:12 INFO - (blobuploader) - INFO - Done attempting. 12:31:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:31:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:31:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:31:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:31:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:31:13 INFO - (blobuploader) - INFO - Done attempting. 12:31:13 INFO - (blobuploader) - INFO - Iteration through files over. 12:31:13 INFO - Return code: 0 12:31:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:31:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:31:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fe6c5e457b046b7e7cca47ca935a7200763bc31cd4d0881dc29ed0732b7340dc6b28f3c12404d1d5268a73ef586b8f5b28f08a0a706e69434898b14288c3ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285c9dedfc2cc26b686270675165b41998740156205e04a80aa0c8bb0f65c9fd1875b8f8fccd8428994103b6dd756a1e96725a85390f8b79ce8993a2a5478403"} 12:31:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:31:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:31:13 INFO - Contents: 12:31:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fe6c5e457b046b7e7cca47ca935a7200763bc31cd4d0881dc29ed0732b7340dc6b28f3c12404d1d5268a73ef586b8f5b28f08a0a706e69434898b14288c3ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285c9dedfc2cc26b686270675165b41998740156205e04a80aa0c8bb0f65c9fd1875b8f8fccd8428994103b6dd756a1e96725a85390f8b79ce8993a2a5478403"} 12:31:13 INFO - Running post-run listener: copy_logs_to_upload_dir 12:31:13 INFO - Copying logs to upload dir... 12:31:13 INFO - mkdir: /builds/slave/test/build/upload/logs 12:31:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.288832 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-28 12:31:13.627959) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 12:31:13.631243) ========= 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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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/8fe6c5e457b046b7e7cca47ca935a7200763bc31cd4d0881dc29ed0732b7340dc6b28f3c12404d1d5268a73ef586b8f5b28f08a0a706e69434898b14288c3ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285c9dedfc2cc26b686270675165b41998740156205e04a80aa0c8bb0f65c9fd1875b8f8fccd8428994103b6dd756a1e96725a85390f8b79ce8993a2a5478403"} build_url:https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/Xoz2t3jCRviv_mmzl5JVTA/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/8fe6c5e457b046b7e7cca47ca935a7200763bc31cd4d0881dc29ed0732b7340dc6b28f3c12404d1d5268a73ef586b8f5b28f08a0a706e69434898b14288c3ac9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/285c9dedfc2cc26b686270675165b41998740156205e04a80aa0c8bb0f65c9fd1875b8f8fccd8428994103b6dd756a1e96725a85390f8b79ce8993a2a5478403"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 12:31:13.659353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:31:13.659668) ========= 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.Iy3M6W5LcP/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.ld4gq7AEXY/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/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.004443 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 12:31:13.707650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 12:31:13.707966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 12:31:13.708314) ========= ========= Total master_lag: 9.56 =========