builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0078 starttime: 1462797317.64 results: success (0) buildid: 20160509005545 builduid: ea7a7eff58c544d79701ff562c295d6e revision: fc51f034e4aca08b76934a832d7dc7db1954b9d2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.640264) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.640719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.640996) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.658651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.658932) ========= 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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-05-09 05:35:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.19M=0.001s 2016-05-09 05:35:17 (8.19 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196599 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.872178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.872500) ========= 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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.020480 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:17.923422) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-09 05:35:17.926803) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc51f034e4aca08b76934a832d7dc7db1954b9d2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev fc51f034e4aca08b76934a832d7dc7db1954b9d2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-05-09 05:35:17,994 truncating revision to first 12 chars 2016-05-09 05:35:17,994 Setting DEBUG logging. 2016-05-09 05:35:17,994 attempt 1/10 2016-05-09 05:35:17,994 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/fc51f034e4ac?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-09 05:35:20,273 unpacking tar archive at: mozilla-beta-fc51f034e4ac/testing/mozharness/ program finished with exit code 0 elapsedTime=2.528556 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-09 05:35:20.472235) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:20.475578) ========= script_repo_revision: fc51f034e4aca08b76934a832d7dc7db1954b9d2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:20.475995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:20.476267) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-09 05:35:20.489838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-09 05:35:20.490109) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:35:20 INFO - MultiFileLogger online at 20160509 05:35:20 in /builds/slave/test 05:35:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:35:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:35:20 INFO - {'append_to_log': False, 05:35:20 INFO - 'base_work_dir': '/builds/slave/test', 05:35:20 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:35:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:35:20 INFO - 'branch': 'Mozilla-Beta', 05:35:20 INFO - 'buildbot_json_path': 'buildprops.json', 05:35:20 INFO - 'config_files': ('talos/mac_config.py',), 05:35:20 INFO - 'default_actions': ('clobber', 05:35:20 INFO - 'read-buildbot-config', 05:35:20 INFO - 'download-and-extract', 05:35:20 INFO - 'populate-webroot', 05:35:20 INFO - 'create-virtualenv', 05:35:20 INFO - 'install', 05:35:20 INFO - 'run-tests'), 05:35:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:35:20 INFO - 'download_minidump_stackwalk': True, 05:35:20 INFO - 'download_symbols': 'ondemand', 05:35:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:35:20 INFO - 'tooltool.py': '/tools/tooltool.py', 05:35:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:35:20 INFO - '/tools/misc-python/virtualenv.py')}, 05:35:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:35:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:35:20 INFO - 'installer_path': 'installer.exe', 05:35:20 INFO - 'log_level': 'info', 05:35:20 INFO - 'log_name': 'talos', 05:35:20 INFO - 'log_to_console': True, 05:35:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:35:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:35:20 INFO - 'opt_config_files': (), 05:35:20 INFO - 'pip_index': False, 05:35:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:20 INFO - 'cmd': ('bash', 05:35:20 INFO - '-c', 05:35:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:20 INFO - 'enabled': True, 05:35:20 INFO - 'halt_on_failure': False, 05:35:20 INFO - 'name': 'check_screen_resolution'},), 05:35:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:35:20 INFO - 'cmd': ('bash', 05:35:20 INFO - '-c', 05:35:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:35:20 INFO - 'enabled': True, 05:35:20 INFO - 'halt_on_failure': False, 05:35:20 INFO - 'name': 'check_screen_resolution'},), 05:35:20 INFO - 'run_cmd_checks_enabled': True, 05:35:20 INFO - 'sps_profile': False, 05:35:20 INFO - 'sps_profile_interval': 0, 05:35:20 INFO - 'suite': 'dromaeojs-e10s', 05:35:20 INFO - 'system_bits': '32', 05:35:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:35:20 INFO - 'title': 't-yosemite-r7-0078', 05:35:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:35:20 INFO - 'use_talos_json': True, 05:35:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:35:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:35:20 INFO - 'work_dir': 'build'} 05:35:20 INFO - ##### 05:35:20 INFO - ##### Running clobber step. 05:35:20 INFO - ##### 05:35:20 INFO - Running pre-action listener: _resource_record_pre_action 05:35:20 INFO - Running main action method: clobber 05:35:20 INFO - rmtree: /builds/slave/test/build 05:35:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:35:22 INFO - Running post-action listener: _resource_record_post_action 05:35:22 INFO - ##### 05:35:22 INFO - ##### Running read-buildbot-config step. 05:35:22 INFO - ##### 05:35:22 INFO - Running pre-action listener: _resource_record_pre_action 05:35:22 INFO - Running main action method: read_buildbot_config 05:35:22 INFO - Using buildbot properties: 05:35:22 INFO - { 05:35:22 INFO - "project": "", 05:35:22 INFO - "product": "firefox", 05:35:22 INFO - "script_repo_revision": "production", 05:35:22 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 05:35:22 INFO - "repository": "", 05:35:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 05:35:22 INFO - "buildid": "20160509005545", 05:35:22 INFO - "pgo_build": "False", 05:35:22 INFO - "basedir": "/builds/slave/test", 05:35:22 INFO - "buildnumber": 18, 05:35:22 INFO - "slavename": "t-yosemite-r7-0078", 05:35:22 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:35:22 INFO - "platform": "yosemite_r7", 05:35:22 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:35:22 INFO - "branch": "mozilla-beta", 05:35:22 INFO - "repo_path": "releases/mozilla-beta", 05:35:22 INFO - "revision": "fc51f034e4aca08b76934a832d7dc7db1954b9d2", 05:35:22 INFO - "stage_platform": "macosx64", 05:35:22 INFO - "builduid": "ea7a7eff58c544d79701ff562c295d6e", 05:35:22 INFO - "slavebuilddir": "test" 05:35:22 INFO - } 05:35:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 05:35:22 INFO - Running post-action listener: _resource_record_post_action 05:35:22 INFO - ##### 05:35:22 INFO - ##### Running download-and-extract step. 05:35:22 INFO - ##### 05:35:22 INFO - Running pre-action listener: _resource_record_pre_action 05:35:22 INFO - Running main action method: download_and_extract 05:35:22 INFO - mkdir: /builds/slave/test/build/tests 05:35:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:22 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:35:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 05:35:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 05:35:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 05:35:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 05:35:23 INFO - Downloaded 1241 bytes. 05:35:23 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 05:35:23 INFO - Using the following test package requirements: 05:35:23 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 05:35:23 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 05:35:23 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 05:35:23 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:35:23 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 05:35:23 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 05:35:23 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 05:35:23 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 05:35:23 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 05:35:23 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 05:35:23 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 05:35:23 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 05:35:23 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 05:35: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')]} 05:35:23 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 05:35:24 INFO - Downloaded 17747440 bytes. 05:35:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:27 INFO - Return code: 0 05:35:27 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:27 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:35:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 05:35:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 05:35:29 INFO - Downloaded 17747440 bytes. 05:35:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:35:32 INFO - Return code: 0 05:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:32 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:35:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 05:35:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 05:35:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 05:35:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 05:35:33 INFO - Downloaded 10845194 bytes. 05:35:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:35:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:35:33 INFO - Return code: 0 05:35:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:33 INFO - https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 05:35:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 05:35:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 05:35:36 INFO - Downloaded 88341384 bytes. 05:35:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:36 INFO - mkdir: /builds/slave/test/properties 05:35:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:35:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:35:36 INFO - Contents: 05:35:36 INFO - build_url:https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - Running post-action listener: set_extra_try_arguments 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running populate-webroot step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: populate_webroot 05:35:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:35:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:35:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:35:37 INFO - '--tppagecycles', 05:35:37 INFO - '7'], 05:35:37 INFO - 'tests': ['tsvgm']}}, 05:35:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:35:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:35:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:35:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:35:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:35:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'tests': ['damp', 'tps']}, 05:35:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['damp', 'tps']}, 05:35:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:35:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:35:37 INFO - 'other': {'tests': ['a11yr', 05:35:37 INFO - 'ts_paint', 05:35:37 INFO - 'tpaint', 05:35:37 INFO - 'sessionrestore', 05:35:37 INFO - 'sessionrestore_no_auto_restore', 05:35:37 INFO - 'tabpaint']}, 05:35:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['a11yr', 05:35:37 INFO - 'ts_paint', 05:35:37 INFO - 'tpaint', 05:35:37 INFO - 'sessionrestore', 05:35:37 INFO - 'sessionrestore_no_auto_restore', 05:35:37 INFO - 'tabpaint']}, 05:35:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['a11yr', 05:35:37 INFO - 'ts_paint', 05:35:37 INFO - 'tpaint', 05:35:37 INFO - 'sessionrestore', 05:35:37 INFO - 'sessionrestore_no_auto_restore', 05:35:37 INFO - 'tabpaint']}, 05:35:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['a11yr', 05:35:37 INFO - 'ts_paint', 05:35:37 INFO - 'tpaint', 05:35:37 INFO - 'sessionrestore', 05:35:37 INFO - 'sessionrestore_no_auto_restore', 05:35:37 INFO - 'tabpaint']}, 05:35:37 INFO - 'other_l64': {'tests': ['a11yr', 05:35:37 INFO - 'ts_paint', 05:35:37 INFO - 'tpaint', 05:35:37 INFO - 'sessionrestore', 05:35:37 INFO - 'sessionrestore_no_auto_restore', 05:35:37 INFO - 'tabpaint']}, 05:35:37 INFO - 'other_nol64': {'tests': ['a11yr', 05:35:37 INFO - 'ts_paint', 05:35:37 INFO - 'tpaint', 05:35:37 INFO - 'sessionrestore', 05:35:37 INFO - 'sessionrestore_no_auto_restore', 05:35:37 INFO - 'tabpaint']}, 05:35:37 INFO - 'svgr': {'tests': ['tsvgx', 05:35:37 INFO - 'tsvgr_opacity', 05:35:37 INFO - 'tart', 05:35:37 INFO - 'tscrollx', 05:35:37 INFO - 'cart']}, 05:35:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['tsvgx', 05:35:37 INFO - 'tsvgr_opacity', 05:35:37 INFO - 'tart', 05:35:37 INFO - 'tscrollx', 05:35:37 INFO - 'cart']}, 05:35:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'tests': ['tp5o']}, 05:35:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'talos_options': ['--e10s'], 05:35:37 INFO - 'tests': ['tp5o']}, 05:35:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'talos_options': ['--xperf_path', 05:35:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:37 INFO - 'tests': ['tp5n']}, 05:35:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:35:37 INFO - 'talos_options': ['--e10s', 05:35:37 INFO - '--xperf_path', 05:35:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:35:37 INFO - 'tests': ['tp5n']}}, 05:35:37 INFO - 'talos.zip': {'path': '', 05:35:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:35:37 INFO - Running post-action listener: _resource_record_post_action 05:35:37 INFO - ##### 05:35:37 INFO - ##### Running create-virtualenv step. 05:35:37 INFO - ##### 05:35:37 INFO - Running pre-action listener: _resource_record_pre_action 05:35:37 INFO - Running main action method: create_virtualenv 05:35:37 INFO - Creating virtualenv /builds/slave/test/build/venv 05:35:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:35:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:35:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:35:37 INFO - Using real prefix '/tools/python27' 05:35:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:35:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:35:40 INFO - Installing pip.................done. 05:35:40 INFO - Return code: 0 05:35:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:35:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:41 INFO - 'HOME': '/Users/cltbld', 05:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:41 INFO - 'LOGNAME': 'cltbld', 05:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:41 INFO - 'MOZ_NO_REMOTE': '1', 05:35:41 INFO - 'NO_EM_RESTART': '1', 05:35:41 INFO - 'PAGER': '/bin/cat', 05:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:41 INFO - 'PWD': '/builds/slave/test', 05:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:41 INFO - 'SHELL': '/bin/bash', 05:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:35:41 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:41 INFO - 'USER': 'cltbld', 05:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:41 INFO - 'XPC_FLAGS': '0x0', 05:35:41 INFO - 'XPC_SERVICE_NAME': '0', 05:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:35:41 INFO - Cleaning up... 05:35:41 INFO - Return code: 0 05:35:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:35:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:35:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:41 INFO - 'HOME': '/Users/cltbld', 05:35:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:41 INFO - 'LOGNAME': 'cltbld', 05:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:41 INFO - 'MOZ_NO_REMOTE': '1', 05:35:41 INFO - 'NO_EM_RESTART': '1', 05:35:41 INFO - 'PAGER': '/bin/cat', 05:35:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:41 INFO - 'PWD': '/builds/slave/test', 05:35:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:41 INFO - 'SHELL': '/bin/bash', 05:35:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:35:41 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:35:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:41 INFO - 'USER': 'cltbld', 05:35:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:41 INFO - 'XPC_FLAGS': '0x0', 05:35:41 INFO - 'XPC_SERVICE_NAME': '0', 05:35:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:41 INFO - Downloading/unpacking psutil>=0.7.1 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35: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 05:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:35:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:44 INFO - Installing collected packages: psutil 05:35:44 INFO - Running setup.py install for psutil 05:35:44 INFO - building 'psutil._psutil_osx' extension 05:35:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:35:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:35:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:35:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:35:45 INFO - building 'psutil._psutil_posix' extension 05:35:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:35:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:35:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:35:45 INFO - ^ 05:35:45 INFO - 1 warning generated. 05:35:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:35:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:35:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:35:45 INFO - Successfully installed psutil 05:35:45 INFO - Cleaning up... 05:35:45 INFO - Return code: 0 05:35:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:45 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 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:35:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:35:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:45 INFO - 'HOME': '/Users/cltbld', 05:35:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:45 INFO - 'LOGNAME': 'cltbld', 05:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:45 INFO - 'MOZ_NO_REMOTE': '1', 05:35:45 INFO - 'NO_EM_RESTART': '1', 05:35:45 INFO - 'PAGER': '/bin/cat', 05:35:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:45 INFO - 'PWD': '/builds/slave/test', 05:35:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:45 INFO - 'SHELL': '/bin/bash', 05:35:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:35:45 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:35:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:45 INFO - 'USER': 'cltbld', 05:35:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:45 INFO - 'XPC_FLAGS': '0x0', 05:35:45 INFO - 'XPC_SERVICE_NAME': '0', 05:35:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:35:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:35:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:35:48 INFO - Installing collected packages: mozsystemmonitor 05:35:48 INFO - Running setup.py install for mozsystemmonitor 05:35:48 INFO - Successfully installed mozsystemmonitor 05:35:48 INFO - Cleaning up... 05:35:48 INFO - Return code: 0 05:35:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:48 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 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:35:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:35:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:35:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:48 INFO - 'HOME': '/Users/cltbld', 05:35:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:48 INFO - 'LOGNAME': 'cltbld', 05:35:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:48 INFO - 'MOZ_NO_REMOTE': '1', 05:35:48 INFO - 'NO_EM_RESTART': '1', 05:35:48 INFO - 'PAGER': '/bin/cat', 05:35:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:48 INFO - 'PWD': '/builds/slave/test', 05:35:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:48 INFO - 'SHELL': '/bin/bash', 05:35:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:35:48 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:35:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:48 INFO - 'USER': 'cltbld', 05:35:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:48 INFO - 'XPC_FLAGS': '0x0', 05:35:48 INFO - 'XPC_SERVICE_NAME': '0', 05:35:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:35:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:35:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:35:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:35:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:35:52 INFO - Downloading docopt-0.6.1.tar.gz 05:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:35:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:35:52 INFO - Running setup.py install for blobuploader 05:35:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:35:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:35:52 INFO - Running setup.py install for requests 05:35:53 INFO - Running setup.py install for docopt 05:35:53 INFO - Successfully installed blobuploader requests docopt 05:35:53 INFO - Cleaning up... 05:35:53 INFO - Return code: 0 05:35:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35: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')]} 05:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35: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')]} 05:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:53 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 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:35:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:35:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:53 INFO - 'HOME': '/Users/cltbld', 05:35:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:53 INFO - 'LOGNAME': 'cltbld', 05:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:53 INFO - 'MOZ_NO_REMOTE': '1', 05:35:53 INFO - 'NO_EM_RESTART': '1', 05:35:53 INFO - 'PAGER': '/bin/cat', 05:35:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:53 INFO - 'PWD': '/builds/slave/test', 05:35:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:53 INFO - 'SHELL': '/bin/bash', 05:35:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:35:53 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:35:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:53 INFO - 'USER': 'cltbld', 05:35:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:53 INFO - 'XPC_FLAGS': '0x0', 05:35:53 INFO - 'XPC_SERVICE_NAME': '0', 05:35:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:53 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-EsBqYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:53 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-j1Ua1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:53 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XbuhgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:53 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-GqeQDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:53 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-3pWO3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-P03N5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-l5OKFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hNNTll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-YaoOKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-4lUggk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-mg7tR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hL9bsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-aMizS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:54 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-J8QBJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-15qAkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LOTG4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:55 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-DjzAlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:35:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:35:55 INFO - Running setup.py install for manifestparser 05:35:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:35:55 INFO - Running setup.py install for mozcrash 05:35:55 INFO - Running setup.py install for mozdebug 05:35:55 INFO - Running setup.py install for mozdevice 05:35:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:35:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:35:55 INFO - Running setup.py install for mozfile 05:35:56 INFO - Running setup.py install for mozhttpd 05:35:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Running setup.py install for mozinfo 05:35:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Running setup.py install for mozInstall 05:35:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Running setup.py install for mozleak 05:35:56 INFO - Running setup.py install for mozlog 05:35:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Running setup.py install for moznetwork 05:35:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:35:56 INFO - Running setup.py install for mozprocess 05:35:57 INFO - Running setup.py install for mozprofile 05:35:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:35:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:35:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:35:57 INFO - Running setup.py install for mozrunner 05:35:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:35:57 INFO - Running setup.py install for mozscreenshot 05:35:57 INFO - Running setup.py install for moztest 05:35:57 INFO - Running setup.py install for mozversion 05:35:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:35:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:35:57 INFO - Cleaning up... 05:35:57 INFO - Return code: 0 05:35:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:35:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:35:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:35:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:35:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:35:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:35:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:35:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:35:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:35:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:35:57 INFO - 'HOME': '/Users/cltbld', 05:35:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:35:57 INFO - 'LOGNAME': 'cltbld', 05:35:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:35:57 INFO - 'MOZ_NO_REMOTE': '1', 05:35:57 INFO - 'NO_EM_RESTART': '1', 05:35:57 INFO - 'PAGER': '/bin/cat', 05:35:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:35:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:35:57 INFO - 'PWD': '/builds/slave/test', 05:35:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:35:57 INFO - 'SHELL': '/bin/bash', 05:35:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:35:57 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:35:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:35:57 INFO - 'USER': 'cltbld', 05:35:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:35:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:35:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:35:57 INFO - 'XPC_FLAGS': '0x0', 05:35:57 INFO - 'XPC_SERVICE_NAME': '0', 05:35:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-L5N_4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-4YUipS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-wtYprB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7oM7qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-8QNrzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ZFUg6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-_s2HDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:35:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:35:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-aHeyg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Cjt3hm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-PbO2X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-0tncLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-YNUzbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-WKinOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-KxqYv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-kJNdc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-C1FlHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:35:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:35:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:35:59 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-DQTpWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:36:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:02 INFO - Downloading blessings-1.6.tar.gz 05:36:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:36:02 INFO - Installing collected packages: blessings 05:36:02 INFO - Running setup.py install for blessings 05:36:02 INFO - Successfully installed blessings 05:36:02 INFO - Cleaning up... 05:36:02 INFO - Return code: 0 05:36:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:36:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:03 INFO - Reading from file tmpfile_stdout 05:36:03 INFO - Current package versions: 05:36:03 INFO - blessings == 1.6 05:36:03 INFO - blobuploader == 1.2.4 05:36:03 INFO - docopt == 0.6.1 05:36:03 INFO - manifestparser == 1.1 05:36:03 INFO - mozInstall == 1.12 05:36:03 INFO - mozcrash == 0.17 05:36:03 INFO - mozdebug == 0.1 05:36:03 INFO - mozdevice == 0.48 05:36:03 INFO - mozfile == 1.2 05:36:03 INFO - mozhttpd == 0.7 05:36:03 INFO - mozinfo == 0.9 05:36:03 INFO - mozleak == 0.1 05:36:03 INFO - mozlog == 3.1 05:36:03 INFO - moznetwork == 0.27 05:36:03 INFO - mozprocess == 0.22 05:36:03 INFO - mozprofile == 0.28 05:36:03 INFO - mozrunner == 6.11 05:36:03 INFO - mozscreenshot == 0.1 05:36:03 INFO - mozsystemmonitor == 0.0 05:36:03 INFO - moztest == 0.7 05:36:03 INFO - mozversion == 1.4 05:36:03 INFO - psutil == 3.1.1 05:36:03 INFO - requests == 1.2.3 05:36:03 INFO - wsgiref == 0.1.2 05:36:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:03 INFO - 'HOME': '/Users/cltbld', 05:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PAGER': '/bin/cat', 05:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:36:03 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - 'XPC_FLAGS': '0x0', 05:36:03 INFO - 'XPC_SERVICE_NAME': '0', 05:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:36:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:36:03 INFO - Cleaning up... 05:36:03 INFO - Return code: 0 05:36:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:03 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 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:36:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:36:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:36:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:03 INFO - 'HOME': '/Users/cltbld', 05:36:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:03 INFO - 'LOGNAME': 'cltbld', 05:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:03 INFO - 'MOZ_NO_REMOTE': '1', 05:36:03 INFO - 'NO_EM_RESTART': '1', 05:36:03 INFO - 'PAGER': '/bin/cat', 05:36:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:03 INFO - 'PWD': '/builds/slave/test', 05:36:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:03 INFO - 'SHELL': '/bin/bash', 05:36:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:36:03 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:36:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:03 INFO - 'USER': 'cltbld', 05:36:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:03 INFO - 'XPC_FLAGS': '0x0', 05:36:03 INFO - 'XPC_SERVICE_NAME': '0', 05:36:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:03 INFO - Downloading/unpacking jsonschema 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:36:05 INFO - Downloading/unpacking functools32 (from jsonschema) 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:06 INFO - Downloading functools32-3.2.3-2.tar.gz 05:36:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:36:06 INFO - warning: no files found matching '*.txt' 05:36:06 INFO - no previously-included directories found matching 'build' 05:36:06 INFO - no previously-included directories found matching 'dist' 05:36:06 INFO - no previously-included directories found matching '.git*' 05:36:06 INFO - Installing collected packages: jsonschema, functools32 05:36:06 INFO - Running setup.py install for functools32 05:36:06 INFO - warning: no files found matching '*.txt' 05:36:06 INFO - no previously-included directories found matching 'build' 05:36:06 INFO - no previously-included directories found matching 'dist' 05:36:06 INFO - no previously-included directories found matching '.git*' 05:36:06 INFO - Successfully installed jsonschema functools32 05:36:06 INFO - Cleaning up... 05:36:06 INFO - Return code: 0 05:36:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:36: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')]} 05:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36: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')]} 05:36:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106d38a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106d3f4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9f80db42c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, '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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:36:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:36:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:36:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:36:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:06 INFO - 'HOME': '/Users/cltbld', 05:36:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:06 INFO - 'LOGNAME': 'cltbld', 05:36:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:06 INFO - 'MOZ_NO_REMOTE': '1', 05:36:06 INFO - 'NO_EM_RESTART': '1', 05:36:06 INFO - 'PAGER': '/bin/cat', 05:36:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:06 INFO - 'PWD': '/builds/slave/test', 05:36:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:06 INFO - 'SHELL': '/bin/bash', 05:36:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:36:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:36:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:06 INFO - 'USER': 'cltbld', 05:36:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:06 INFO - 'XPC_FLAGS': '0x0', 05:36:06 INFO - 'XPC_SERVICE_NAME': '0', 05:36:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:07 INFO - Downloading/unpacking flake8 05:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:36:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:36:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:36:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:36:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:36:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:10 INFO - no previously-included directories found matching 'docs/_build' 05:36:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:36:10 INFO - Running setup.py install for pep8 05:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:36:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:36:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:36:10 INFO - no previously-included directories found matching 'docs/_build' 05:36:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:36:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:36:10 INFO - Cleaning up... 05:36:11 INFO - Return code: 0 05:36:11 INFO - Running post-action listener: _resource_record_post_action 05:36:11 INFO - Running post-action listener: _start_resource_monitoring 05:36:11 INFO - Starting resource monitoring. 05:36:11 INFO - ##### 05:36:11 INFO - ##### Running install step. 05:36:11 INFO - ##### 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: install 05:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:36:11 INFO - Reading from file tmpfile_stdout 05:36:11 INFO - Output received: 05:36:11 INFO - Usage: mozinstall [options] installer 05:36:11 INFO - Options: 05:36:11 INFO - -h, --help show this help message and exit 05:36:11 INFO - -d DEST, --destination=DEST 05:36:11 INFO - Directory to install application into. [default: 05:36:11 INFO - "/builds/slave/test"] 05:36:11 INFO - --app=APP Application being installed. [default: firefox] 05:36:11 INFO - mkdir: /builds/slave/test/build/application 05:36:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:36:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:36:34 INFO - Reading from file tmpfile_stdout 05:36:34 INFO - Output received: 05:36:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:36:34 INFO - Running post-action listener: _resource_record_post_action 05:36:34 INFO - ##### 05:36:34 INFO - ##### Running run-tests step. 05:36:34 INFO - ##### 05:36:34 INFO - Running pre-action listener: _resource_record_pre_action 05:36:34 INFO - Running main action method: run_tests 05:36:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:34 INFO - 2016-05-09 05:36:34.405 screenresolution[2514:53454] starting screenresolution argv=screenresolution get 05:36:34 INFO - 2016-05-09 05:36:34.408 screenresolution[2514:53454] Display 0: 1600x1200x32@60 05:36:34 INFO - 2016-05-09 05:36:34.413 screenresolution[2515:53457] starting screenresolution argv=screenresolution list 05:36:34 INFO - Available Modes on Display 0 05:36:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:34 INFO - Intel Iris: 05:36:34 INFO - Chipset Model: Intel Iris 05:36:34 INFO - Type: GPU 05:36:34 INFO - Bus: Built-In 05:36:34 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:34 INFO - Vendor: Intel (0x8086) 05:36:34 INFO - Device ID: 0x0a2e 05:36:34 INFO - Revision ID: 0x0009 05:36:34 INFO - Displays: 05:36:34 INFO - Display: 05:36:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:34 INFO - Display Serial Number: 1600x1200 60 05:36:34 INFO - Main Display: Yes 05:36:34 INFO - Mirror: Off 05:36:34 INFO - Online: Yes 05:36:34 INFO - Rotation: Supported 05:36:34 INFO - Return code: 0 05:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:36:34 INFO - Python 2.7.3 05:36:34 INFO - Return code: 0 05:36:34 INFO - grabbing minidump binary from tooltool 05:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:34 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 0x106bdcd30>, '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 0x106a40db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106bd3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:36:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:36:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:36:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:36:34 INFO - Return code: 0 05:36:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:36:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:36:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:36:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:36:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:36:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:36:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:36:35 INFO - Return code: 0 05:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:36:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.U1Ho2KL0I2/Render', 05:36:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:35 INFO - 'HOME': '/Users/cltbld', 05:36:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:35 INFO - 'LOGNAME': 'cltbld', 05:36:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:36:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:35 INFO - 'MOZ_NO_REMOTE': '1', 05:36:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:36:35 INFO - 'NO_EM_RESTART': '1', 05:36:35 INFO - 'PAGER': '/bin/cat', 05:36:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:35 INFO - 'PWD': '/builds/slave/test', 05:36:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:36:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:35 INFO - 'SHELL': '/bin/bash', 05:36:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HPmPcJQx3p/Listeners', 05:36:35 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:36:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:35 INFO - 'USER': 'cltbld', 05:36:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:35 INFO - 'XPC_FLAGS': '0x0', 05:36:35 INFO - 'XPC_SERVICE_NAME': '0', 05:36:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:36:36 INFO - mozversion application_buildid: 20160509005545 05:36:36 INFO - mozversion application_changeset: fc51f034e4aca08b76934a832d7dc7db1954b9d2 05:36:36 INFO - mozversion application_display_name: Firefox 05:36:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:36:36 INFO - mozversion application_name: Firefox 05:36:36 INFO - mozversion application_remotingname: firefox 05:36:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:36:36 INFO - mozversion application_vendor: Mozilla 05:36:36 INFO - mozversion application_version: 47.0 05:36:36 INFO - mozversion platform_buildid: 20160509005545 05:36:36 INFO - mozversion platform_changeset: fc51f034e4aca08b76934a832d7dc7db1954b9d2 05:36:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:36:36 INFO - mozversion platform_version: 47.0 05:36:36 INFO - using testdate: 1462797396 05:36:36 INFO - actual date: 1462797396 05:36:36 INFO - starting webserver on 'localhost:58616' 05:36:36 INFO - SUITE-START | Running 2 tests 05:36:36 INFO - TEST-START | dromaeo_css 05:36:36 INFO - operating with platform_type : mac_ 05:36:36 INFO - Initialising browser for dromaeo_css test... 05:36:36 INFO - TEST-INFO | started process 2533 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpPB3AZ1/profile http://localhost:58616/getInfo.html) 05:36:38 INFO - PROCESS | 2533 | __metrics Screen width/height:1600/1200 05:36:38 INFO - PROCESS | 2533 | colorDepth:24 05:36:38 INFO - PROCESS | 2533 | Browser inner width/height: 1024/689 05:36:38 INFO - PROCESS | 2533 | __metrics 05:36:38 ERROR - PROCESS | 2533 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:36:39 INFO - TEST-INFO | 2533: exit 0 05:36:39 INFO - Browser initialized. 05:36:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:36:39 INFO - TEST-INFO | started process 2537 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpPB3AZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:51 INFO - PROCESS | 2537 | RSS: Main: 168394752 05:36:51 INFO - PROCESS | 2537 | 05:37:40 INFO - PROCESS | 2537 | 1462797460940 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:39:50 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58616/tests/dromaeo/cssquery-ext.html) 05:39:51 INFO - PROCESS | 2537 | RSS: Main: 179978240 05:39:51 INFO - PROCESS | 2537 | 05:42:53 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-ext.html (next: http://localhost:58616/tests/dromaeo/cssquery-jquery.html) 05:42:54 INFO - PROCESS | 2537 | RSS: Main: 190279680 05:42:54 INFO - PROCESS | 2537 | 05:45:56 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58616/tests/dromaeo/cssquery-mootools.html) 05:45:56 INFO - PROCESS | 2537 | RSS: Main: 192229376 05:45:56 INFO - PROCESS | 2537 | 05:48:58 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58616/tests/dromaeo/cssquery-prototype.html) 05:48:59 INFO - PROCESS | 2537 | RSS: Main: 195649536 05:48:59 INFO - PROCESS | 2537 | 05:52:01 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58616/tests/dromaeo/cssquery-yui.html) 05:52:02 INFO - PROCESS | 2537 | RSS: Main: 194920448 05:52:02 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | Cycle 1(1): loaded http://localhost:58616/tests/dromaeo/cssquery-yui.html (next: http://localhost:58616/tests/dromaeo/cssquery-dojo.html) 05:55:04 INFO - PROCESS | 2537 | RSS: Main: 200560640 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | __start_tp_report 05:55:04 INFO - PROCESS | 2537 | _x_x_mozilla_page_load 05:55:04 INFO - PROCESS | 2537 | _x_x_mozilla_page_load_details 05:55:04 INFO - PROCESS | 2537 | |i|pagename|runs| 05:55:04 INFO - PROCESS | 2537 | |0;dojo.html;3219.5009773485117;3522.4364101743718;3626.0753507855475;3664.926701465971;3687.2625474905026;5927;5935.258092738408;5953.523718102552;5974.611650242737;5974.641521508713;5850.4734573888345;5914.88170236595;5923.970380148104;5929.051351783715;5978.581499295051;5317.308749862522;5351.57187425005;5354.196870469422;5430.104032834578;5507.779688812443;5285.445028272034;5401.27082843815;5402.729863506828;5408.486193811582;5422.48486393792;5332.546733527654;5362.973185134088;5372.946270537283;5380.811671591495;5408.026555220059;5384.623076384635;5388.084025715599;5392.299001129867;5395.190721391803;5402.702851343174;5302.416734159239;5310.070737620901;5345.465453454663;5349.545288650469;5374.086405311106;4883.12103821312;5565.833025009256;5616.354119276295;5664.688442135681;5713.885792270509;6246.562740608159;6258.87482250357;6275.215598050244;6281.497480201573;6287.276963149205;6150.784722534735;6256.7970706496;6285;6288.245410550718;6314.463270622003;6005;6036.426539478743;6086.056661217563;6115.296740874767;6135.754569817202;6274.215723034621;6310.5898116622275;6356.173697419398;6391.936080639227;6392.264889537762;5749.648832524354;6144.678894037804;6320.020396838498;6324.1778568786685;6326;5779.595428320062;6292.024736165901;6309.242890853127;6318.147050148171;6418.069379939976;6291.402316779899;6295;6313.116163737081;6317.810465685945;6319.905201421982;5189.974050129726;6148.907766383508;6232.594881332699;6286.245650521875;6310.958691815799;5011.6241281904;5079.9840031993745;5080.212567052113;5082.593392528589;5086.9745651271505;4595.724256544551;4615.930761038587;4631.675782695246;4646.721196728139;4659.697119687209;5955.34491205967;5996.1005849122985;6051.425114614105;6062.9090563641585;6088.786892458743;6209.5032397409;6303.086052522451;6309.211348581427;6318.62088274705;6335.271443783931;6084.787032453932;6104.236970378703;6120.051392034153;6128.693565321716;6131.662758548323;5383.569314454912;5511.724413779295;5567.164925261243;5586.441355864381;5595.692236926927;6374.968125159345;6395.360463953567;6412.487001039905;6434.453071488976;6436.452901503425;6280.717367718555;6312.905306420315;6315.115883776367;6321.209848768904;6323.177986861862;6245.96877015612;6325.1144839721555;6332.715027823851;6378.202724659418;6417.1657684500715;6300.149479820349;6329.5569310149685;6351.428371446592;6351.777687780906;6360.427561519486;6233.189685340877;6299.086632438362;6304.432601065926;6305.747770089145;6315.810525684236;6210.4100110489435;6256;6260.40526150015;6290.8427289316305;6305.148804911279;6101.816945491642;6224.346443623354;6271.655058971618;6299.401556852092;6311.810645680637;4878.609711223023;5987.820365389045;6077.24034495688;6081.027035674271;6146.200993870768;5310.787568497217;6167.6916154193;6182.381761823782;6192.659403732658;6199.938000619936;5909.025010873158;5969.418348990571;5999.070144127667;6037.426444487766;6040.939590604038 05:55:04 INFO - PROCESS | 2537 | |1;ext.html;595.217289264617;623.8284471770263;636.5321488705804;646.5700309294319;675.8513127112035;31742.68257317426;35446;39790.40314395286;40047.39928901069;40090.799546002265;40794;41114;41281.17437651245;41387;41396;9570.808583828337;9825.803483930316;9838.950805245964;9844.950775246114;9875.506224688772;9615.567299471506;9943.154831839302;9946.005399460033;9955.900440995605;9965;9914.206863450943;9983.301168918179;9983.550740216671;10019;10031;9862;9946.602135914554;9990.350627209207;10004.699859004242;10030.19758419332;9845.310828242025;9994.250431217615;10007.09936105754;10007.699769006942;10012.499375031219;34159.48760768591;40591.7970410149;40625;40807.591924080676;41297.174056519005;3352.2457447074457;3483.9129021774406;3545.2909418116224;3572.6427357264324;3942.6057394260633;29298.974535891142;29964.70035299641;30090.54864177039;30452.69547304521;30851;2425.357280320716;2791.1347482280557;2833.5041367760764;2877.5539791332376;2886.841223732694;374455;461508.6924565389;474420;475013.99999999657;476138;64427;64854.02718959219;64899.35100648933;65140.674296629164;65186;79598.01004974922;79948;79957.60021199856;79993.80009299864;80663.59668201621;18774.812251877305;18890.527736806416;18909.24363025491;19033.809661903204;19142.61714765697;14182.290885455686;14310.785338219936;14359.353829077716;14401.063930844462;14419.134851908919;22717.864106794925;22999.08003679834;23851.642225366635;23864;23936.760632393452;9574.66488672907;9778.951105244429;9786.804263914682;9803.59811846088;9817.656382026595;919.6435257994405;995.714143327018;1053.6154303679102;1074.1836204484491;1146.3752255021034;30102.84948575243;30226;30294;30550.54174187389;30835.074947751604;1178.0752109593927;1195.6114262864603;1215.8905698487179;1251.4055823483773;1269.7841366967639;15444.691106178037;15580.922095389451;15771.605709857346;16800.243989020524;17146.39987600428;442191;519004;520645;523692.763072372;525167;66185.33814661791;66750.33249667441;66840.99738503926;66875;67034.65930681358;1569.858712715861;1601.8237993820671;1610.2834238763637;1611.81464131624;1614.5882799885953;32195.839020804746;32296.869609563553;32353;32571.166573638504;32797;54602.72698636481;54958;55221.72389138029;55404;55478.613034674454;501760;501964;504971.47514262196;507370;507946;34913.65086349104;35328.64671353254;35460.113497162776;46696;47944.04111917812;44875.775621121684;46537.767311163225;46559.53440465552;47100.7644961773;47708.284375733696;36587;36683.44974825433;37782;38241.80879095587;38362.42456363213;37398.8130059348;37401.5039398421;37402.43896341611;37540;37871.62128378681;34910.65089349074;37396;40731.38902916518;41518;41873;29025;31430.528542072345;34247.486287706204;34819;34925.47611785775;26118.608220877082;26145.24581981532;26268.737312627392;26591.33521661974;26628.733712662626 05:55:04 INFO - PROCESS | 2537 | |2;jquery.html;352.76717366538077;364.95076654617975;379.9506064211652;388.2700523016728;390.6640289351156;19270.421887343404;20341.28805491808;21070.473238169052;22126.446838829037;22147.00338484768;17319.480415587554;20747.481312967182;22242.666360004612;22530.77469225307;22536.54926901461;5979.910301345472;6187.855246779361;6259.280182778971;6270.592411493261;6276.713273778864;6072.453479186872;6204;6272.749090036393;6281.497480201596;6321.6523091229965;5407.945920540803;5956.761729530814;6198.907016394758;6238.750449981995;6261.123442718023;6159.445649891509;6162.22972128484;6192.535559833031;6211.782587609435;6225.906611400787;4588.197065513522;5389.407165211824;5410.945890541084;5432.674039557639;5541.27963364764;14290.356933937997;14544.927275363661;14559;14601.561953141423;19039.809601903944;2154.633712268918;2201.878896660683;2263.502029553512;2537.9492410151693;2726.0458839406247;8518.531480768555;10448.947755261252;10490.21323400748;10502.68491945243;10722.892771072267;1769.1596491666485;1837.3752924005903;1843.170573242033;1873.3349660870467;1963.3429624464559;97401.02598973991;100167;112359;112534.43732781283;115944;11859.46632401544;11868.940655296841;11894.405279735978;11903.464344104363;12029.699257518632;14558;14657.48698795537;14660.853391466162;14697.044692095193;14704.33830477631;7343.706251749977;7972.641231144612;9140.817183656423;9199.402038867453;9265.768355791024;9332.860007099898;9333.953330233306;9346.906530934739;9394.389364691273;9435;4576.771161441915;4644.164050470948;4648.257528058394;4667.603253723471;4670.836520721827;1948.298612499499;1976.8319692825983;1999.8300144487591;2023.5345870449878;2030.1067530286628;885.8882102960872;934.2852717670987;953.2135987809946;982.9557669904872;1039.3036665434176;20825;21572.813495257597;21860.344189674335;21977.67033494467;22102;1000.3197825478744;1009.2733232072895;1012.377387906447;1013.3058854684565;1065.1106326217541;10557.366558006544;11583.247088939192;11664.950154486138;11673.649790506299;11699.23954942926;559570;673711;680190;691424;697743;76286.85569716348;99532;112987;113349.4332528332;126394;887;1025.8717660292464;1061.4056128568027;1063.723431907694;1091.4433638844246;19262.518437039187;19633.60732785308;19799.60400791947;19841.107150178566;19846.60306793885;34284;40984.79507602443;49249.50750492449;56072.439275606725;57366.7131664339;79517.01207469859;81487;81645.367092659;82060;83302.5834870846;8208.09710931785;8221.383396245425;8445.831083378422;8653.350998674998;8771.649134034567;8329.50022998622;9748.171405430334;12723.80914286268;13842.515511957436;13878.254116030585;11733.647990560297;11884.108691847972;11993.940030300142;12026.458809353775;12046.457909394274;11761.529538818351;11797.823032654345;11870.762584748429;11887.583934562248;12077.094217933514;9116.36185467011;9773.657921972697;11962.521499139937;12125.211861228992;12162.452689629165;7015.929840701732;8345.95827020861;8452.943382077241;8555.101714320155;8583.421090720323;11995.160338776202;12048.156629035884;12199.02407807391;12240.08199385032;12250.693732656755 05:55:04 INFO - PROCESS | 2537 | |3;mootools.html;1424.4587056918372;1662.3932264723376;1945.2510783348407;2071.6167509010825;2089.529855782449;7754.961225193873;8385.329173666107;9120.771980700485;9368.06319368063;9376.953115234423;8057.4762640428335;9161.633534658622;9220.124088211609;9281.721548353544;9296.767580810483;2503.662005629235;2591.714911359749;2597.7012643546045;2601.9739802602016;2608.243609353285;2549.630303605976;2604.0234911908033;2606.439615482671;2610.4648547047905;2612.1118819601334;2569.4732579821093;2590.611408288753;2620.1877418000386;2626.540355437791;2629.868506574673;2587.107447930461;2594.5611125542023;2598.194559686494;2614.1765343916604;2614.333344997033;2569.768720815117;2578.342522656729;2612.164107485605;2612.9738702613113;2614.7254538273587;7809.726659566944;9363.25093992479;9434.150926416656;9470.95264523673;9481.241500679998;5778.508826749731;5820.1269809528485;5972.343042265347;5980.102984552308;5981.850453738648;3700.4264339027495;3830.8467661293516;3866.994581408826;3874.4769456123345;3888.786116763577;1083.4636854756866;1084.251866212311;1086.5708045322133;1126.5831642292321;1131.8981291683706;12615.810762838564;12622.55821046259;12662.936685316514;12689.555865544662;12768.553100641433;5079.31429257053;5130;5176.430592634807;5207.140821764367;5213.661112027782;9051.683191088281;9325.860112098324;10747.086497647631;10753.83869241962;10919.836202456969;5142.665726727751;5784.768609255582;5792.333881603585;5953.583249172603;5964.254468191476;4711.599514041276;5150.690958542499;5205.29728486657;5219.582433405394;5250.081235783799;3776.9433458498142;3955.4660120883887;4167.5207351154395;4217.746935183899;4234.9364759528635;1352.6280272925023;1380.6203294094205;1385.0166381868985;1385.210430054859;1393.261571367177;1173.3018853781987;1434.3473719457622;1442.1203066129654;1445.3062529985666;1469.0451206715506;8658.567071646392;8776.561171941377;8799.648014079494;8805;8848.026717061119;529.2273281009692;530.2391068816261;537.5054949446519;543.7036814935869;548.2762753165783;6494.188226471691;6494.805155845333;6529.216494020748;6533.640649764308;6542.771003014872;11236.494357753922;11440.656780296604;11483.540658373739;11665.125115616363;11666.824997625043;11103;11125.721856953642;11188.720281992852;11458.885411145782;11486.942565287287;8804.163604457566;8974.28205743539;8978.775530611656;9014.909850901407;9062.365634405529;8278.503289802631;8313.043999940084;8465.873011904949;8477.618507167315;8496.235338819535;10054.044865737744;10168.593256269667;10181.930897255681;10202.591896324064;10303.948480257552;9036.774080648036;10123.848142277724;10622.468876556295;10697.090747286567;10720.142388609049;7171.928280717126;7605.771826845204;7715.22847715224;7829.412794040356;7893.526388416713;8563.785905352415;8598.097199794182;8712.259457946146;8717.956410218161;8728.170823771732;7518.624068796429;7692.0384951881015;7730.613469326624;7779.066512018368;7811.570363630055;7528.360089392244;7576.507527010726;7585.317321441097;7671.769846904602;7674.9232507674205;8206.425550211667;8243.629036693243;8307.210814972568;8310.168983101641;8310.83378332442;7320.304571065741;7361.227071157451;7425.8143546411775;7439.367653749492;7464.888026679496;6456.192975878015;7544.585047822203;7590.316871481593;7601.7719468416035;7614.961925190339 05:55:04 INFO - PROCESS | 2537 | |4;prototype.html;300.7338505422701;342.7309561993835;346.4647120199292;346.86992377858303;347.47704704419846;5700.745835916097;6945.861082778354;7001.684924178411;7040.436765058796;7055.823604409892;6928.411085057776;6932.826679333007;6967.686454109577;7018.3683468487825;7065.399441047504;4964.851054468371;5055.721935293557;5198.116320225552;5238.738063096849;5241.371035475749;5197.740112994354;5228.058949389108;5233.267342572043;5241.135212689902;5244.632875698702;4145.606167414091;4177.958220417802;5197.168453047513;5210.739463026853;5232.607554433433;4228.788560571975;5212.50481204285;5217.686938783685;5224.294720212761;5235.214717792323;4485.170243504962;4488.955110448886;4495.303227999665;4499.662525310615;4503.527129651372;5375.75809088592;6044.093385992092;6151.723172457206;6811.557248778813;6832.45340372769;6021.307549631804;6057.242844644419;6061.454469097803;6081.148639190517;6091.329953705089;7447.590382528959;7450;7500.324970752658;7506.924930750732;7525.059367579052;5001.574866136383;5003;5010.72441015744;5012.2231054186295;5013.323201367842;7145.928540714526;7881.881771773428;7902.762917112495;7915.96042019792;7941.245581669732;4349.565043495689;4973.925391119136;4981.352424184905;5034.194528875362;5036.420811606712;5110.412302585176;5120.462351453119;5121.411037730634;5126.359205099363;5128.692278463304;6003.0695242237525;6012.7294271757;6033.818985430444;6041.848953776191;6054.636721796706;7446.702131914771;7504.962475187589;7517.887231691529;7548.282913123245;7551.886721699179;1701.8298170182882;1738.9478315650551;1763.4268862619444;1776.538100093985;1787.6782179207867;1139.561268911475;1153.988460115405;1163.03468121459;1170.4849866058908;1172.4899668644166;7084.220735719066;7088.751893683696;7093.148822141273;7102.360787529044;7118.110236220473;7668.578228197391;7682.462227644123;7685.500442471333;7692.46152769312;7693.807654808563;5884.823455296348;6464.870702586016;7057.18842333128;7089.964550177217;7117.288271172842;3342.7325813934826;3958.960410395859;4090.9795451022555;4098.426220329156;4107.712460127822;8056.919430805734;8066.23370779775;8105.27052565272;8130.674773009014;8148.470349427268;8057.677692892219;8078.39412044099;8084.959575202086;8096.919030809617;8131.625375469114;8094.028716553933;8100.189981001853;8112.269895709414;8140.0638926523025;8147.185281471924;7619.733309334147;7826.491278066907;7846.0976987647155;7874.6850125994315;7898.565578893216;7657.387409007155;7679.539227646359;7691;7702.306792388712;7758.8448231033935;6518.804435866931;8107;8107.8378432429845;8111.310538604049;8118.553479558681;4886.047220791911;4940.382452193476;4946.727929963743;4951;4952.57903078228;7480;7490.475666703279;7636.198199189005;7841.5687137208;7859.331956783737;7484.176740558643;7487.588182649789;7520.511166774142;7581.54510729358;7593.772186834404;6383.978563429829;7317.414606831547;7539.283768042027;7558.508696934901;7560.9621951889885;6096.8660968660615;7356.926430735838;7359.153697324662;7362.595057271901;7380.298871607189;6137.925862974051;7160.928390716234;7453.291937265951;7524.360429363565;7596.696132154652;7329.853402932018;7376.18861925177;7380.335769780745;7384.926150738639;7402.851942961003 05:55:04 INFO - PROCESS | 2537 | |5;yui.html;723.1575214874671;764.4190415284382;765.9617019149041;784.211867073591;792.6908505682782;13775.793363099549;16437.42469013585;16542.255598498083;16562.66874662506;16660.66678666429;15281.847181528181;15333.616659583517;15345.92327038366;15351.69296614067;15383.153926534036;782.9491083079581;949.8860136783561;956.3831328792925;976.1458723616818;980.4068538534191;966.2366730283103;970.708787363788;974.8245315843145;979.5200351827589;994.2145704893126;1012.7620009297809;1016.5425558498669;1054.7310435838888;1055.1611468882218;1058.5236643510414;1004.6835246897203;1004.9799004019878;1007.1489591295343;1009.4347165587258;1043.4521876015076;767.0258771360396;770.6108415250319;772.2162005564356;772.7681695491331;774.9883751743729;15452.690946181126;15701.528954131394;15935.681286374323;15936.681266374724;15940.724742020611;11226.719332016683;13538.187708737507;13561.25413102279;13589;13654.931725341408;10300.373663444163;10580.259381843274;10638;10657.84013239802;10888.67333979982;3596.9280614387826;3659.762115462513;3677.5403074615674;3714.9257014859822;3729.049092481427;89240.99999999935;89531;89736;89835.65246521308;89869.55065224698;8281.95859020701;8285.4200205985;8409.075001749803;8410.789730256793;8593.742187734379;22497.43756406103;23693.289201323987;23720.64419033716;23758.287251382488;23765.40586485317;7679.1936846631415;7753.806154846174;7774.1264704269215;7809.765707028798;7879.251471110236;4152.335626299838;4156.7921603919685;4220.894477638084;4259.61663450291;4366.585174408426;3769.0388950817364;3788.3559794834946;3823;3824.521934758155;3848.6536211740518;598.0909018292172;604.7490291528966;670.5507310102244;671.2582596231192;676.3709749932511;598.3448124303881;626.9498440124779;637.2512298049772;644.6003477843767;660.4155322539491;8601.5699215039;8618.138186181457;8668.133186681407;8708.08565100668;8853.69012084574;533.5384892068411;594.3313772006493;624.3943374926314;637.9457746091634;640.7437025189868;3863.8068096595057;4007.8196481158416;4011.919761604752;4146.129312844276;4170.16596680659;99925.50037249767;101704;102087.48956255171;103609.48195258975;103757.48121259497;85427.57286213654;85997;86970;87254;87784;71158.9326160108;72155;72750.90873636899;75015.62492187505;75692.62153689197;7611.88582171279;8669.91330086691;8927.018028016782;9018.323625727966;9066.456012639263;49731.75134124306;51986;53263.668408290105;53417.732911335195;53841.192382115085;54447.45552544424;70730.29269707236;71023.64488177525;74914;75014.24985750292;11595.13036522281;11607.883921161017;11672.766544669228;11774.52901883915;11860.932516073595;12240.510379585074;12481;12569.371531423576;12781.488740450277;13188.80216796768;12044.554653441643;12079.698007549881;12113.878861211275;12256.448459819509;12332.938335308267;10199.13307368882;11617.128715346214;12099.395030248628;12301.815472768094;12649.177803442746;11612.012978896888;11789.823152652545;12170.39148042612;12192.146549741434;12313.32276724753;8895.421797583136;9557.952210238904;9862.654807081717;9896.752581185528;10370.014848589371;9872.160866326156;10010.899891000996;10108.747281318027;10131.341462804894;10174.901313499999 05:55:04 INFO - PROCESS | 2537 | __end_tp_report 05:55:04 INFO - PROCESS | 2537 | __start_cc_report 05:55:04 INFO - PROCESS | 2537 | _x_x_mozilla_cycle_collect,360 05:55:04 INFO - PROCESS | 2537 | __end_cc_report 05:55:04 INFO - PROCESS | 2537 | __startTimestamp1462798504537__endTimestamp 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | ------- Summary: start ------- 05:55:04 INFO - PROCESS | 2537 | Number of tests: 6 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | [#0] dojo.html Cycles:165 Average:5853.64 Median:6101.82 stddev:619.73 (10.2%) stddev-sans-first:586.17 05:55:04 INFO - PROCESS | 2537 | Values: 3219.5 3522.4 3626.1 3664.9 3687.3 5927.0 5935.3 5953.5 5974.6 5974.6 5850.5 5914.9 5924.0 5929.1 5978.6 5317.3 5351.6 5354.2 5430.1 5507.8 5285.4 5401.3 5402.7 5408.5 5422.5 5332.5 5363.0 5372.9 5380.8 5408.0 5384.6 5388.1 5392.3 5395.2 5402.7 5302.4 5310.1 5345.5 5349.5 5374.1 4883.1 5565.8 5616.4 5664.7 5713.9 6246.6 6258.9 6275.2 6281.5 6287.3 6150.8 6256.8 6285.0 6288.2 6314.5 6005.0 6036.4 6086.1 6115.3 6135.8 6274.2 6310.6 6356.2 6391.9 6392.3 5749.6 6144.7 6320.0 6324.2 6326.0 5779.6 6292.0 6309.2 6318.1 6418.1 6291.4 6295.0 6313.1 6317.8 6319.9 5190.0 6148.9 6232.6 6286.2 6311.0 5011.6 5080.0 5080.2 5082.6 5087.0 4595.7 4615.9 4631.7 4646.7 4659.7 5955.3 5996.1 6051.4 6062.9 6088.8 6209.5 6303.1 6309.2 6318.6 6335.3 6084.8 6104.2 6120.1 6128.7 6131.7 5383.6 5511.7 5567.2 5586.4 5595.7 6375.0 6395.4 6412.5 6434.5 6436.5 6280.7 6312.9 6315.1 6321.2 6323.2 6246.0 6325.1 6332.7 6378.2 6417.2 6300.1 6329.6 6351.4 6351.8 6360.4 6233.2 6299.1 6304.4 6305.7 6315.8 6210.4 6256.0 6260.4 6290.8 6305.1 6101.8 6224.3 6271.7 6299.4 6311.8 4878.6 5987.8 6077.2 6081.0 6146.2 5310.8 6167.7 6182.4 6192.7 6199.9 5909.0 5969.4 5999.1 6037.4 6040.9 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | [#1] ext.html Cycles:180 Average:65123.62 Median:38056.72 stddev:129794.02 (341.1%) stddev-sans-first:130067.70 05:55:04 INFO - PROCESS | 2537 | Values: 595.2 623.8 636.5 646.6 675.9 31742.7 35446.0 39790.4 40047.4 40090.8 40794.0 41114.0 41281.2 41387.0 41396.0 9570.8 9825.8 9839.0 9845.0 9875.5 9615.6 9943.2 9946.0 9955.9 9965.0 9914.2 9983.3 9983.6 10019.0 10031.0 9862.0 9946.6 9990.4 10004.7 10030.2 9845.3 9994.3 10007.1 10007.7 10012.5 34159.5 40591.8 40625.0 40807.6 41297.2 3352.2 3483.9 3545.3 3572.6 3942.6 29299.0 29964.7 30090.5 30452.7 30851.0 2425.4 2791.1 2833.5 2877.6 2886.8 374455.0 461508.7 474420.0 475014.0 476138.0 64427.0 64854.0 64899.4 65140.7 65186.0 79598.0 79948.0 79957.6 79993.8 80663.6 18774.8 18890.5 18909.2 19033.8 19142.6 14182.3 14310.8 14359.4 14401.1 14419.1 22717.9 22999.1 23851.6 23864.0 23936.8 9574.7 9779.0 9786.8 9803.6 9817.7 919.6 995.7 1053.6 1074.2 1146.4 30102.8 30226.0 30294.0 30550.5 30835.1 1178.1 1195.6 1215.9 1251.4 1269.8 15444.7 15580.9 15771.6 16800.2 17146.4 442191.0 519004.0 520645.0 523692.8 525167.0 66185.3 66750.3 66841.0 66875.0 67034.7 1569.9 1601.8 1610.3 1611.8 1614.6 32195.8 32296.9 32353.0 32571.2 32797.0 54602.7 54958.0 55221.7 55404.0 55478.6 501760.0 501964.0 504971.5 507370.0 507946.0 34913.7 35328.6 35460.1 46696.0 47944.0 44875.8 46537.8 46559.5 47100.8 47708.3 36587.0 36683.4 37782.0 38241.8 38362.4 37398.8 37401.5 37402.4 37540.0 37871.6 34910.7 37396.0 40731.4 41518.0 41873.0 29025.0 31430.5 34247.5 34819.0 34925.5 26118.6 26145.2 26268.7 26591.3 26628.7 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | [#2] jquery.html Cycles:180 Average:35764.47 Median:22194.83 stddev:109439.76 (493.1%) stddev-sans-first:109714.46 05:55:04 INFO - PROCESS | 2537 | Values: 352.8 365.0 380.0 388.3 390.7 19270.4 20341.3 21070.5 22126.4 22147.0 17319.5 20747.5 22242.7 22530.8 22536.5 5979.9 6187.9 6259.3 6270.6 6276.7 6072.5 6204.0 6272.7 6281.5 6321.7 5407.9 5956.8 6198.9 6238.8 6261.1 6159.4 6162.2 6192.5 6211.8 6225.9 4588.2 5389.4 5410.9 5432.7 5541.3 14290.4 14544.9 14559.0 14601.6 19039.8 2154.6 2201.9 2263.5 2537.9 2726.0 8518.5 10448.9 10490.2 10502.7 10722.9 1769.2 1837.4 1843.2 1873.3 1963.3 97401.0 100167.0 112359.0 112534.4 115944.0 11859.5 11868.9 11894.4 11903.5 12029.7 14558.0 14657.5 14660.9 14697.0 14704.3 7343.7 7972.6 9140.8 9199.4 9265.8 9332.9 9334.0 9346.9 9394.4 9435.0 4576.8 4644.2 4648.3 4667.6 4670.8 1948.3 1976.8 1999.8 2023.5 2030.1 885.9 934.3 953.2 983.0 1039.3 20825.0 21572.8 21860.3 21977.7 22102.0 1000.3 1009.3 1012.4 1013.3 1065.1 10557.4 11583.2 11665.0 11673.6 11699.2 559570.0 673711.0 680190.0 691424.0 697743.0 76286.9 99532.0 112987.0 113349.4 126394.0 887.0 1025.9 1061.4 1063.7 1091.4 19262.5 19633.6 19799.6 19841.1 19846.6 34284.0 40984.8 49249.5 56072.4 57366.7 79517.0 81487.0 81645.4 82060.0 83302.6 8208.1 8221.4 8445.8 8653.4 8771.6 8329.5 9748.2 12723.8 13842.5 13878.3 11733.6 11884.1 11993.9 12026.5 12046.5 11761.5 11797.8 11870.8 11887.6 12077.1 9116.4 9773.7 11962.5 12125.2 12162.5 7015.9 8346.0 8452.9 8555.1 8583.4 11995.2 12048.2 12199.0 12240.1 12250.7 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | [#3] mootools.html Cycles:180 Average:6369.79 Median:5216.62 stddev:3376.68 (64.7%) stddev-sans-first:3365.69 05:55:04 INFO - PROCESS | 2537 | Values: 1424.5 1662.4 1945.3 2071.6 2089.5 7755.0 8385.3 9120.8 9368.1 9377.0 8057.5 9161.6 9220.1 9281.7 9296.8 2503.7 2591.7 2597.7 2602.0 2608.2 2549.6 2604.0 2606.4 2610.5 2612.1 2569.5 2590.6 2620.2 2626.5 2629.9 2587.1 2594.6 2598.2 2614.2 2614.3 2569.8 2578.3 2612.2 2613.0 2614.7 7809.7 9363.3 9434.2 9471.0 9481.2 5778.5 5820.1 5972.3 5980.1 5981.9 3700.4 3830.8 3867.0 3874.5 3888.8 1083.5 1084.3 1086.6 1126.6 1131.9 12615.8 12622.6 12662.9 12689.6 12768.6 5079.3 5130.0 5176.4 5207.1 5213.7 9051.7 9325.9 10747.1 10753.8 10919.8 5142.7 5784.8 5792.3 5953.6 5964.3 4711.6 5150.7 5205.3 5219.6 5250.1 3776.9 3955.5 4167.5 4217.7 4234.9 1352.6 1380.6 1385.0 1385.2 1393.3 1173.3 1434.3 1442.1 1445.3 1469.0 8658.6 8776.6 8799.6 8805.0 8848.0 529.2 530.2 537.5 543.7 548.3 6494.2 6494.8 6529.2 6533.6 6542.8 11236.5 11440.7 11483.5 11665.1 11666.8 11103.0 11125.7 11188.7 11458.9 11486.9 8804.2 8974.3 8978.8 9014.9 9062.4 8278.5 8313.0 8465.9 8477.6 8496.2 10054.0 10168.6 10181.9 10202.6 10303.9 9036.8 10123.8 10622.5 10697.1 10720.1 7171.9 7605.8 7715.2 7829.4 7893.5 8563.8 8598.1 8712.3 8718.0 8728.2 7518.6 7692.0 7730.6 7779.1 7811.6 7528.4 7576.5 7585.3 7671.8 7674.9 8206.4 8243.6 8307.2 8310.2 8310.8 7320.3 7361.2 7425.8 7439.4 7464.9 6456.2 7544.6 7590.3 7601.8 7615.0 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | [#4] prototype.html Cycles:180 Average:6107.22 Median:6984.69 stddev:1962.96 (28.1%) stddev-sans-first:1919.48 05:55:04 INFO - PROCESS | 2537 | Values: 300.7 342.7 346.5 346.9 347.5 5700.7 6945.9 7001.7 7040.4 7055.8 6928.4 6932.8 6967.7 7018.4 7065.4 4964.9 5055.7 5198.1 5238.7 5241.4 5197.7 5228.1 5233.3 5241.1 5244.6 4145.6 4178.0 5197.2 5210.7 5232.6 4228.8 5212.5 5217.7 5224.3 5235.2 4485.2 4489.0 4495.3 4499.7 4503.5 5375.8 6044.1 6151.7 6811.6 6832.5 6021.3 6057.2 6061.5 6081.1 6091.3 7447.6 7450.0 7500.3 7506.9 7525.1 5001.6 5003.0 5010.7 5012.2 5013.3 7145.9 7881.9 7902.8 7916.0 7941.2 4349.6 4973.9 4981.4 5034.2 5036.4 5110.4 5120.5 5121.4 5126.4 5128.7 6003.1 6012.7 6033.8 6041.8 6054.6 7446.7 7505.0 7517.9 7548.3 7551.9 1701.8 1738.9 1763.4 1776.5 1787.7 1139.6 1154.0 1163.0 1170.5 1172.5 7084.2 7088.8 7093.1 7102.4 7118.1 7668.6 7682.5 7685.5 7692.5 7693.8 5884.8 6464.9 7057.2 7090.0 7117.3 3342.7 3959.0 4091.0 4098.4 4107.7 8056.9 8066.2 8105.3 8130.7 8148.5 8057.7 8078.4 8085.0 8096.9 8131.6 8094.0 8100.2 8112.3 8140.1 8147.2 7619.7 7826.5 7846.1 7874.7 7898.6 7657.4 7679.5 7691.0 7702.3 7758.8 6518.8 8107.0 8107.8 8111.3 8118.6 4886.0 4940.4 4946.7 4951.0 4952.6 7480.0 7490.5 7636.2 7841.6 7859.3 7484.2 7487.6 7520.5 7581.5 7593.8 6384.0 7317.4 7539.3 7558.5 7561.0 6096.9 7356.9 7359.2 7362.6 7380.3 6137.9 7160.9 7453.3 7524.4 7596.7 7329.9 7376.2 7380.3 7384.9 7402.9 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - PROCESS | 2537 | [#5] yui.html Cycles:180 Average:19574.03 Median:4195.53 stddev:27991.32 (667.2%) stddev-sans-first:28034.06 05:55:04 INFO - PROCESS | 2537 | Values: 723.2 764.4 766.0 784.2 792.7 13775.8 16437.4 16542.3 16562.7 16660.7 15281.8 15333.6 15345.9 15351.7 15383.2 782.9 949.9 956.4 976.1 980.4 966.2 970.7 974.8 979.5 994.2 1012.8 1016.5 1054.7 1055.2 1058.5 1004.7 1005.0 1007.1 1009.4 1043.5 767.0 770.6 772.2 772.8 775.0 15452.7 15701.5 15935.7 15936.7 15940.7 11226.7 13538.2 13561.3 13589.0 13654.9 10300.4 10580.3 10638.0 10657.8 10888.7 3596.9 3659.8 3677.5 3714.9 3729.0 89241.0 89531.0 89736.0 89835.7 89869.6 8282.0 8285.4 8409.1 8410.8 8593.7 22497.4 23693.3 23720.6 23758.3 23765.4 7679.2 7753.8 7774.1 7809.8 7879.3 4152.3 4156.8 4220.9 4259.6 4366.6 3769.0 3788.4 3823.0 3824.5 3848.7 598.1 604.7 670.6 671.3 676.4 598.3 626.9 637.3 644.6 660.4 8601.6 8618.1 8668.1 8708.1 8853.7 533.5 594.3 624.4 637.9 640.7 3863.8 4007.8 4011.9 4146.1 4170.2 99925.5 101704.0 102087.5 103609.5 103757.5 85427.6 85997.0 86970.0 87254.0 87784.0 71158.9 72155.0 72750.9 75015.6 75692.6 7611.9 8669.9 8927.0 9018.3 9066.5 49731.8 51986.0 53263.7 53417.7 53841.2 54447.5 70730.3 71023.6 74914.0 75014.2 11595.1 11607.9 11672.8 11774.5 11860.9 12240.5 12481.0 12569.4 12781.5 13188.8 12044.6 12079.7 12113.9 12256.4 12332.9 10199.1 11617.1 12099.4 12301.8 12649.2 11612.0 11789.8 12170.4 12192.1 12313.3 8895.4 9558.0 9862.7 9896.8 10370.0 9872.2 10010.9 10108.7 10131.3 10174.9 05:55:04 INFO - PROCESS | 2537 | -------- Summary: end -------- 05:55:04 INFO - PROCESS | 2537 | 05:55:04 INFO - TEST-INFO | 2537: exit 0 05:55:05 INFO - TEST-OK | dromaeo_css | took 1108883ms 05:55:05 INFO - TEST-START | kraken 05:55:05 INFO - operating with platform_type : mac_ 05:55:05 INFO - Initialising browser for kraken test... 05:55:05 INFO - TEST-INFO | started process 2542 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpfthzwf/profile http://localhost:58616/getInfo.html) 05:55:07 INFO - PROCESS | 2542 | __metrics Screen width/height:1600/1200 05:55:07 INFO - PROCESS | 2542 | colorDepth:24 05:55:07 INFO - PROCESS | 2542 | Browser inner width/height: 1024/689 05:55:07 INFO - PROCESS | 2542 | __metrics 05:55:07 ERROR - PROCESS | 2542 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 05:55:08 INFO - TEST-INFO | 2542: exit 0 05:55:08 INFO - Browser initialized. 05:55:08 INFO - Running cycle 1/1 for kraken test... 05:55:08 INFO - TEST-INFO | started process 2546 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpfthzwf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:55:20 INFO - PROCESS | 2546 | RSS: Main: 168116224 05:55:20 INFO - PROCESS | 2546 | 05:55:22 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-beat-detection) 05:55:23 INFO - PROCESS | 2546 | RSS: Main: 179609600 05:55:23 INFO - PROCESS | 2546 | 05:55:25 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-dft) 05:55:26 INFO - PROCESS | 2546 | RSS: Main: 188526592 05:55:26 INFO - PROCESS | 2546 | 05:55:29 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-fft) 05:55:30 INFO - PROCESS | 2546 | RSS: Main: 191115264 05:55:30 INFO - PROCESS | 2546 | 05:55:32 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58616/tests/kraken/driver.html?testName=audio-oscillator) 05:55:33 INFO - PROCESS | 2546 | RSS: Main: 192159744 05:55:33 INFO - PROCESS | 2546 | 05:55:35 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58616/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:55:35 INFO - PROCESS | 2546 | RSS: Main: 193978368 05:55:35 INFO - PROCESS | 2546 | 05:55:38 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58616/tests/kraken/driver.html?testName=imaging-darkroom) 05:55:39 INFO - PROCESS | 2546 | RSS: Main: 195059712 05:55:39 INFO - PROCESS | 2546 | 05:55:42 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58616/tests/kraken/driver.html?testName=imaging-desaturate) 05:55:42 INFO - PROCESS | 2546 | RSS: Main: 194654208 05:55:42 INFO - PROCESS | 2546 | 05:55:45 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58616/tests/kraken/driver.html?testName=json-parse-financial) 05:55:46 INFO - PROCESS | 2546 | RSS: Main: 194969600 05:55:46 INFO - PROCESS | 2546 | 05:55:48 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58616/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:55:48 INFO - PROCESS | 2546 | RSS: Main: 194318336 05:55:48 INFO - PROCESS | 2546 | 05:55:50 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:55:51 INFO - PROCESS | 2546 | RSS: Main: 194093056 05:55:51 INFO - PROCESS | 2546 | 05:55:53 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:55:53 INFO - PROCESS | 2546 | RSS: Main: 194105344 05:55:53 INFO - PROCESS | 2546 | 05:55:56 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:55:57 INFO - PROCESS | 2546 | RSS: Main: 194080768 05:55:57 INFO - PROCESS | 2546 | 05:55:59 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:56:00 INFO - PROCESS | 2546 | RSS: Main: 194170880 05:56:00 INFO - PROCESS | 2546 | 05:56:01 INFO - PROCESS | 2546 | Cycle 1(1): loaded http://localhost:58616/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58616/tests/kraken/driver.html?testName=ai-astar) 05:56:02 INFO - PROCESS | 2546 | RSS: Main: 195891200 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | __start_tp_report 05:56:02 INFO - PROCESS | 2546 | _x_x_mozilla_page_load 05:56:02 INFO - PROCESS | 2546 | _x_x_mozilla_page_load_details 05:56:02 INFO - PROCESS | 2546 | |i|pagename|runs| 05:56:02 INFO - PROCESS | 2546 | |0;ai-astar;117;112;116;116;117;129;113;115;115;115 05:56:02 INFO - PROCESS | 2546 | |1;audio-beat-detection;152;122;145;185;149;143;137;122;157;118 05:56:02 INFO - PROCESS | 2546 | |2;audio-dft;266;265;220;275;273;196;193;195;196;200 05:56:02 INFO - PROCESS | 2546 | |3;audio-fft;72;77;73;116;58;46;67;76;160;81 05:56:02 INFO - PROCESS | 2546 | |4;audio-oscillator;86;86;120;77;82;77;132;95;64;105 05:56:02 INFO - PROCESS | 2546 | |5;imaging-gaussian-blur;91;87;99;94;137;112;89;131;136;90 05:56:02 INFO - PROCESS | 2546 | |6;imaging-darkroom;111;96;98;107;108;150;96;97;97;97 05:56:02 INFO - PROCESS | 2546 | |7;imaging-desaturate;122;149;93;90;91;93;117;83;146;97 05:56:02 INFO - PROCESS | 2546 | |8;json-parse-financial;55;60;60;58;59;60;60;80;86;81 05:56:02 INFO - PROCESS | 2546 | |9;json-stringify-tinderbox;67;69;68;68;75;73;66;66;66;70 05:56:02 INFO - PROCESS | 2546 | |10;stanford-crypto-aes;84;81;81;83;80;82;83;85;84;87 05:56:02 INFO - PROCESS | 2546 | |11;stanford-crypto-ccm;129;130;143;152;106;109;138;147;126;135 05:56:02 INFO - PROCESS | 2546 | |12;stanford-crypto-pbkdf2;140;141;176;140;126;175;140;138;132;137 05:56:02 INFO - PROCESS | 2546 | |13;stanford-crypto-sha256-iterative;87;100;94;76;65;67;64;66;67;69 05:56:02 INFO - PROCESS | 2546 | __end_tp_report 05:56:02 INFO - PROCESS | 2546 | __start_cc_report 05:56:02 INFO - PROCESS | 2546 | _x_x_mozilla_cycle_collect,907 05:56:02 INFO - PROCESS | 2546 | __end_cc_report 05:56:02 INFO - PROCESS | 2546 | __startTimestamp1462798562156__endTimestamp 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | ------- Summary: start ------- 05:56:02 INFO - PROCESS | 2546 | Number of tests: 14 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#0] ai-astar Cycles:10 Average:116.50 Median:116.00 stddev:4.67 (4.0%) stddev-sans-first:4.95 05:56:02 INFO - PROCESS | 2546 | Values: 117.0 112.0 116.0 116.0 117.0 129.0 113.0 115.0 115.0 115.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:147.00 stddev:20.07 (13.7%) stddev-sans-first:21.02 05:56:02 INFO - PROCESS | 2546 | Values: 152.0 122.0 145.0 185.0 149.0 143.0 137.0 122.0 157.0 118.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#2] audio-dft Cycles:10 Average:227.90 Median:242.50 stddev:36.90 (15.2%) stddev-sans-first:36.48 05:56:02 INFO - PROCESS | 2546 | Values: 266.0 265.0 220.0 275.0 273.0 196.0 193.0 195.0 196.0 200.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#3] audio-fft Cycles:10 Average:82.60 Median:72.50 stddev:32.62 (45.0%) stddev-sans-first:34.37 05:56:02 INFO - PROCESS | 2546 | Values: 72.0 77.0 73.0 116.0 58.0 46.0 67.0 76.0 160.0 81.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:79.50 stddev:20.99 (26.4%) stddev-sans-first:22.14 05:56:02 INFO - PROCESS | 2546 | Values: 86.0 86.0 120.0 77.0 82.0 77.0 132.0 95.0 64.0 105.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#5] imaging-gaussian-blur Cycles:10 Average:106.60 Median:89.50 stddev:20.66 (23.1%) stddev-sans-first:21.13 05:56:02 INFO - PROCESS | 2546 | Values: 91.0 87.0 99.0 94.0 137.0 112.0 89.0 131.0 136.0 90.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#6] imaging-darkroom Cycles:10 Average:105.70 Median:96.50 stddev:16.57 (17.2%) stddev-sans-first:17.47 05:56:02 INFO - PROCESS | 2546 | Values: 111.0 96.0 98.0 107.0 108.0 150.0 96.0 97.0 97.0 97.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#7] imaging-desaturate Cycles:10 Average:108.10 Median:90.50 stddev:24.06 (26.6%) stddev-sans-first:24.99 05:56:02 INFO - PROCESS | 2546 | Values: 122.0 149.0 93.0 90.0 91.0 93.0 117.0 83.0 146.0 97.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:60.00 stddev:11.54 (19.2%) stddev-sans-first:11.55 05:56:02 INFO - PROCESS | 2546 | Values: 55.0 60.0 60.0 58.0 59.0 60.0 60.0 80.0 86.0 81.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:68.50 stddev:3.08 (4.5%) stddev-sans-first:3.20 05:56:02 INFO - PROCESS | 2546 | Values: 67.0 69.0 68.0 68.0 75.0 73.0 66.0 66.0 66.0 70.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:2.11 (2.5%) stddev-sans-first:2.20 05:56:02 INFO - PROCESS | 2546 | Values: 84.0 81.0 81.0 83.0 80.0 82.0 83.0 85.0 84.0 87.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:136.50 stddev:15.06 (11.0%) stddev-sans-first:15.95 05:56:02 INFO - PROCESS | 2546 | Values: 129.0 130.0 143.0 152.0 106.0 109.0 138.0 147.0 126.0 135.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:140.00 stddev:16.97 (12.1%) stddev-sans-first:17.92 05:56:02 INFO - PROCESS | 2546 | Values: 140.0 141.0 176.0 140.0 126.0 175.0 140.0 138.0 132.0 137.0 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - PROCESS | 2546 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.50 Median:68.00 stddev:13.31 (19.6%) stddev-sans-first:13.45 05:56:02 INFO - PROCESS | 2546 | Values: 87.0 100.0 94.0 76.0 65.0 67.0 64.0 66.0 67.0 69.0 05:56:02 INFO - PROCESS | 2546 | -------- Summary: end -------- 05:56:02 INFO - PROCESS | 2546 | 05:56:02 INFO - TEST-INFO | 2546: exit 0 05:56:02 INFO - TEST-OK | kraken | took 57825ms 05:56:02 INFO - SUITE-END | took 1166s 05:56:03 INFO - Completed test suite (00:19:27) 05:56:03 INFO - javascript benchmark 05:56:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3219.5009773485117, 3522.4364101743718, 3626.0753507855475, 3664.926701465971, 3687.2625474905026, 5927.0, 5935.258092738408, 5953.523718102552, 5974.611650242737, 5974.641521508713, 5850.4734573888345, 5914.88170236595, 5923.970380148104, 5929.051351783715, 5978.581499295051, 5317.308749862522, 5351.57187425005, 5354.196870469422, 5430.104032834578, 5507.779688812443, 5285.445028272034, 5401.27082843815, 5402.729863506828, 5408.486193811582, 5422.48486393792, 5332.546733527654, 5362.973185134088, 5372.946270537283, 5380.811671591495, 5408.026555220059, 5384.623076384635, 5388.084025715599, 5392.299001129867, 5395.190721391803, 5402.702851343174, 5302.416734159239, 5310.070737620901, 5345.465453454663, 5349.545288650469, 5374.086405311106, 4883.12103821312, 5565.833025009256, 5616.354119276295, 5664.688442135681, 5713.885792270509, 6246.562740608159, 6258.87482250357, 6275.215598050244, 6281.497480201573, 6287.276963149205, 6150.784722534735, 6256.7970706496, 6285.0, 6288.245410550718, 6314.463270622003, 6005.0, 6036.426539478743, 6086.056661217563, 6115.296740874767, 6135.754569817202, 6274.215723034621, 6310.5898116622275, 6356.173697419398, 6391.936080639227, 6392.264889537762, 5749.648832524354, 6144.678894037804, 6320.020396838498, 6324.1778568786685, 6326.0, 5779.595428320062, 6292.024736165901, 6309.242890853127, 6318.147050148171, 6418.069379939976, 6291.402316779899, 6295.0, 6313.116163737081, 6317.810465685945, 6319.905201421982, 5189.974050129726, 6148.907766383508, 6232.594881332699, 6286.245650521875, 6310.958691815799, 5011.6241281904, 5079.9840031993745, 5080.212567052113, 5082.593392528589, 5086.9745651271505, 4595.724256544551, 4615.930761038587, 4631.675782695246, 4646.721196728139, 4659.697119687209, 5955.34491205967, 5996.1005849122985, 6051.425114614105, 6062.9090563641585, 6088.786892458743, 6209.5032397409, 6303.086052522451, 6309.211348581427, 6318.62088274705, 6335.271443783931, 6084.787032453932, 6104.236970378703, 6120.051392034153, 6128.693565321716, 6131.662758548323, 5383.569314454912, 5511.724413779295, 5567.164925261243, 5586.441355864381, 5595.692236926927, 6374.968125159345, 6395.360463953567, 6412.487001039905, 6434.453071488976, 6436.452901503425, 6280.717367718555, 6312.905306420315, 6315.115883776367, 6321.209848768904, 6323.177986861862, 6245.96877015612, 6325.1144839721555, 6332.715027823851, 6378.202724659418, 6417.1657684500715, 6300.149479820349, 6329.5569310149685, 6351.428371446592, 6351.777687780906, 6360.427561519486, 6233.189685340877, 6299.086632438362, 6304.432601065926, 6305.747770089145, 6315.810525684236, 6210.4100110489435, 6256.0, 6260.40526150015, 6290.8427289316305, 6305.148804911279, 6101.816945491642, 6224.346443623354, 6271.655058971618, 6299.401556852092, 6311.810645680637, 4878.609711223023, 5987.820365389045, 6077.24034495688, 6081.027035674271, 6146.200993870768, 5310.787568497217, 6167.6916154193, 6182.381761823782, 6192.659403732658, 6199.938000619936, 5909.025010873158, 5969.418348990571, 5999.070144127667, 6037.426444487766, 6040.939590604038], "unit": "score", "name": "dojo.html", "value": 5817.37514354566}, {"lowerIsBetter": false, "replicates": [595.217289264617, 623.8284471770263, 636.5321488705804, 646.5700309294319, 675.8513127112035, 31742.68257317426, 35446.0, 39790.40314395286, 40047.39928901069, 40090.799546002265, 40794.0, 41114.0, 41281.17437651245, 41387.0, 41396.0, 9570.808583828337, 9825.803483930316, 9838.950805245964, 9844.950775246114, 9875.506224688772, 9615.567299471506, 9943.154831839302, 9946.005399460033, 9955.900440995605, 9965.0, 9914.206863450943, 9983.301168918179, 9983.550740216671, 10019.0, 10031.0, 9862.0, 9946.602135914554, 9990.350627209207, 10004.699859004242, 10030.19758419332, 9845.310828242025, 9994.250431217615, 10007.09936105754, 10007.699769006942, 10012.499375031219, 34159.48760768591, 40591.7970410149, 40625.0, 40807.591924080676, 41297.174056519005, 3352.2457447074457, 3483.9129021774406, 3545.2909418116224, 3572.6427357264324, 3942.6057394260633, 29298.974535891142, 29964.70035299641, 30090.54864177039, 30452.69547304521, 30851.0, 2425.357280320716, 2791.1347482280557, 2833.5041367760764, 2877.5539791332376, 2886.841223732694, 374455.0, 461508.6924565389, 474420.0, 475013.99999999657, 476138.0, 64427.0, 64854.02718959219, 64899.35100648933, 65140.674296629164, 65186.0, 79598.01004974922, 79948.0, 79957.60021199856, 79993.80009299864, 80663.59668201621, 18774.812251877305, 18890.527736806416, 18909.24363025491, 19033.809661903204, 19142.61714765697, 14182.290885455686, 14310.785338219936, 14359.353829077716, 14401.063930844462, 14419.134851908919, 22717.864106794925, 22999.08003679834, 23851.642225366635, 23864.0, 23936.760632393452, 9574.66488672907, 9778.951105244429, 9786.804263914682, 9803.59811846088, 9817.656382026595, 919.6435257994405, 995.714143327018, 1053.6154303679102, 1074.1836204484491, 1146.3752255021034, 30102.84948575243, 30226.0, 30294.0, 30550.54174187389, 30835.074947751604, 1178.0752109593927, 1195.6114262864603, 1215.8905698487179, 1251.4055823483773, 1269.7841366967639, 15444.691106178037, 15580.922095389451, 15771.605709857346, 16800.243989020524, 17146.39987600428, 442191.0, 519004.0, 520645.0, 523692.763072372, 525167.0, 66185.33814661791, 66750.33249667441, 66840.99738503926, 66875.0, 67034.65930681358, 1569.858712715861, 1601.8237993820671, 1610.2834238763637, 1611.81464131624, 1614.5882799885953, 32195.839020804746, 32296.869609563553, 32353.0, 32571.166573638504, 32797.0, 54602.72698636481, 54958.0, 55221.72389138029, 55404.0, 55478.613034674454, 501760.0, 501964.0, 504971.47514262196, 507370.0, 507946.0, 34913.65086349104, 35328.64671353254, 35460.113497162776, 46696.0, 47944.04111917812, 44875.775621121684, 46537.767311163225, 46559.53440465552, 47100.7644961773, 47708.284375733696, 36587.0, 36683.44974825433, 37782.0, 38241.80879095587, 38362.42456363213, 37398.8130059348, 37401.5039398421, 37402.43896341611, 37540.0, 37871.62128378681, 34910.65089349074, 37396.0, 40731.38902916518, 41518.0, 41873.0, 29025.0, 31430.528542072345, 34247.486287706204, 34819.0, 34925.47611785775, 26118.608220877082, 26145.24581981532, 26268.737312627392, 26591.33521661974, 26628.733712662626], "unit": "score", "name": "ext.html", "value": 21061.643012397028}, {"lowerIsBetter": false, "replicates": [352.76717366538077, 364.95076654617975, 379.9506064211652, 388.2700523016728, 390.6640289351156, 19270.421887343404, 20341.28805491808, 21070.473238169052, 22126.446838829037, 22147.00338484768, 17319.480415587554, 20747.481312967182, 22242.666360004612, 22530.77469225307, 22536.54926901461, 5979.910301345472, 6187.855246779361, 6259.280182778971, 6270.592411493261, 6276.713273778864, 6072.453479186872, 6204.0, 6272.749090036393, 6281.497480201596, 6321.6523091229965, 5407.945920540803, 5956.761729530814, 6198.907016394758, 6238.750449981995, 6261.123442718023, 6159.445649891509, 6162.22972128484, 6192.535559833031, 6211.782587609435, 6225.906611400787, 4588.197065513522, 5389.407165211824, 5410.945890541084, 5432.674039557639, 5541.27963364764, 14290.356933937997, 14544.927275363661, 14559.0, 14601.561953141423, 19039.809601903944, 2154.633712268918, 2201.878896660683, 2263.502029553512, 2537.9492410151693, 2726.0458839406247, 8518.531480768555, 10448.947755261252, 10490.21323400748, 10502.68491945243, 10722.892771072267, 1769.1596491666485, 1837.3752924005903, 1843.170573242033, 1873.3349660870467, 1963.3429624464559, 97401.02598973991, 100167.0, 112359.0, 112534.43732781283, 115944.0, 11859.46632401544, 11868.940655296841, 11894.405279735978, 11903.464344104363, 12029.699257518632, 14558.0, 14657.48698795537, 14660.853391466162, 14697.044692095193, 14704.33830477631, 7343.706251749977, 7972.641231144612, 9140.817183656423, 9199.402038867453, 9265.768355791024, 9332.860007099898, 9333.953330233306, 9346.906530934739, 9394.389364691273, 9435.0, 4576.771161441915, 4644.164050470948, 4648.257528058394, 4667.603253723471, 4670.836520721827, 1948.298612499499, 1976.8319692825983, 1999.8300144487591, 2023.5345870449878, 2030.1067530286628, 885.8882102960872, 934.2852717670987, 953.2135987809946, 982.9557669904872, 1039.3036665434176, 20825.0, 21572.813495257597, 21860.344189674335, 21977.67033494467, 22102.0, 1000.3197825478744, 1009.2733232072895, 1012.377387906447, 1013.3058854684565, 1065.1106326217541, 10557.366558006544, 11583.247088939192, 11664.950154486138, 11673.649790506299, 11699.23954942926, 559570.0, 673711.0, 680190.0, 691424.0, 697743.0, 76286.85569716348, 99532.0, 112987.0, 113349.4332528332, 126394.0, 887.0, 1025.8717660292464, 1061.4056128568027, 1063.723431907694, 1091.4433638844246, 19262.518437039187, 19633.60732785308, 19799.60400791947, 19841.107150178566, 19846.60306793885, 34284.0, 40984.79507602443, 49249.50750492449, 56072.439275606725, 57366.7131664339, 79517.01207469859, 81487.0, 81645.367092659, 82060.0, 83302.5834870846, 8208.09710931785, 8221.383396245425, 8445.831083378422, 8653.350998674998, 8771.649134034567, 8329.50022998622, 9748.171405430334, 12723.80914286268, 13842.515511957436, 13878.254116030585, 11733.647990560297, 11884.108691847972, 11993.940030300142, 12026.458809353775, 12046.457909394274, 11761.529538818351, 11797.823032654345, 11870.762584748429, 11887.583934562248, 12077.094217933514, 9116.36185467011, 9773.657921972697, 11962.521499139937, 12125.211861228992, 12162.452689629165, 7015.929840701732, 8345.95827020861, 8452.943382077241, 8555.101714320155, 8583.421090720323, 11995.160338776202, 12048.156629035884, 12199.02407807391, 12240.08199385032, 12250.693732656755], "unit": "score", "name": "jquery.html", "value": 9621.928971559202}, {"lowerIsBetter": false, "replicates": [1424.4587056918372, 1662.3932264723376, 1945.2510783348407, 2071.6167509010825, 2089.529855782449, 7754.961225193873, 8385.329173666107, 9120.771980700485, 9368.06319368063, 9376.953115234423, 8057.4762640428335, 9161.633534658622, 9220.124088211609, 9281.721548353544, 9296.767580810483, 2503.662005629235, 2591.714911359749, 2597.7012643546045, 2601.9739802602016, 2608.243609353285, 2549.630303605976, 2604.0234911908033, 2606.439615482671, 2610.4648547047905, 2612.1118819601334, 2569.4732579821093, 2590.611408288753, 2620.1877418000386, 2626.540355437791, 2629.868506574673, 2587.107447930461, 2594.5611125542023, 2598.194559686494, 2614.1765343916604, 2614.333344997033, 2569.768720815117, 2578.342522656729, 2612.164107485605, 2612.9738702613113, 2614.7254538273587, 7809.726659566944, 9363.25093992479, 9434.150926416656, 9470.95264523673, 9481.241500679998, 5778.508826749731, 5820.1269809528485, 5972.343042265347, 5980.102984552308, 5981.850453738648, 3700.4264339027495, 3830.8467661293516, 3866.994581408826, 3874.4769456123345, 3888.786116763577, 1083.4636854756866, 1084.251866212311, 1086.5708045322133, 1126.5831642292321, 1131.8981291683706, 12615.810762838564, 12622.55821046259, 12662.936685316514, 12689.555865544662, 12768.553100641433, 5079.31429257053, 5130.0, 5176.430592634807, 5207.140821764367, 5213.661112027782, 9051.683191088281, 9325.860112098324, 10747.086497647631, 10753.83869241962, 10919.836202456969, 5142.665726727751, 5784.768609255582, 5792.333881603585, 5953.583249172603, 5964.254468191476, 4711.599514041276, 5150.690958542499, 5205.29728486657, 5219.582433405394, 5250.081235783799, 3776.9433458498142, 3955.4660120883887, 4167.5207351154395, 4217.746935183899, 4234.9364759528635, 1352.6280272925023, 1380.6203294094205, 1385.0166381868985, 1385.210430054859, 1393.261571367177, 1173.3018853781987, 1434.3473719457622, 1442.1203066129654, 1445.3062529985666, 1469.0451206715506, 8658.567071646392, 8776.561171941377, 8799.648014079494, 8805.0, 8848.026717061119, 529.2273281009692, 530.2391068816261, 537.5054949446519, 543.7036814935869, 548.2762753165783, 6494.188226471691, 6494.805155845333, 6529.216494020748, 6533.640649764308, 6542.771003014872, 11236.494357753922, 11440.656780296604, 11483.540658373739, 11665.125115616363, 11666.824997625043, 11103.0, 11125.721856953642, 11188.720281992852, 11458.885411145782, 11486.942565287287, 8804.163604457566, 8974.28205743539, 8978.775530611656, 9014.909850901407, 9062.365634405529, 8278.503289802631, 8313.043999940084, 8465.873011904949, 8477.618507167315, 8496.235338819535, 10054.044865737744, 10168.593256269667, 10181.930897255681, 10202.591896324064, 10303.948480257552, 9036.774080648036, 10123.848142277724, 10622.468876556295, 10697.090747286567, 10720.142388609049, 7171.928280717126, 7605.771826845204, 7715.22847715224, 7829.412794040356, 7893.526388416713, 8563.785905352415, 8598.097199794182, 8712.259457946146, 8717.956410218161, 8728.170823771732, 7518.624068796429, 7692.0384951881015, 7730.613469326624, 7779.066512018368, 7811.570363630055, 7528.360089392244, 7576.507527010726, 7585.317321441097, 7671.769846904602, 7674.9232507674205, 8206.425550211667, 8243.629036693243, 8307.210814972568, 8310.168983101641, 8310.83378332442, 7320.304571065741, 7361.227071157451, 7425.8143546411775, 7439.367653749492, 7464.888026679496, 6456.192975878015, 7544.585047822203, 7590.316871481593, 7601.7719468416035, 7614.961925190339], "unit": "score", "name": "mootools.html", "value": 5113.9029363589025}, {"lowerIsBetter": false, "replicates": [300.7338505422701, 342.7309561993835, 346.4647120199292, 346.86992377858303, 347.47704704419846, 5700.745835916097, 6945.861082778354, 7001.684924178411, 7040.436765058796, 7055.823604409892, 6928.411085057776, 6932.826679333007, 6967.686454109577, 7018.3683468487825, 7065.399441047504, 4964.851054468371, 5055.721935293557, 5198.116320225552, 5238.738063096849, 5241.371035475749, 5197.740112994354, 5228.058949389108, 5233.267342572043, 5241.135212689902, 5244.632875698702, 4145.606167414091, 4177.958220417802, 5197.168453047513, 5210.739463026853, 5232.607554433433, 4228.788560571975, 5212.50481204285, 5217.686938783685, 5224.294720212761, 5235.214717792323, 4485.170243504962, 4488.955110448886, 4495.303227999665, 4499.662525310615, 4503.527129651372, 5375.75809088592, 6044.093385992092, 6151.723172457206, 6811.557248778813, 6832.45340372769, 6021.307549631804, 6057.242844644419, 6061.454469097803, 6081.148639190517, 6091.329953705089, 7447.590382528959, 7450.0, 7500.324970752658, 7506.924930750732, 7525.059367579052, 5001.574866136383, 5003.0, 5010.72441015744, 5012.2231054186295, 5013.323201367842, 7145.928540714526, 7881.881771773428, 7902.762917112495, 7915.96042019792, 7941.245581669732, 4349.565043495689, 4973.925391119136, 4981.352424184905, 5034.194528875362, 5036.420811606712, 5110.412302585176, 5120.462351453119, 5121.411037730634, 5126.359205099363, 5128.692278463304, 6003.0695242237525, 6012.7294271757, 6033.818985430444, 6041.848953776191, 6054.636721796706, 7446.702131914771, 7504.962475187589, 7517.887231691529, 7548.282913123245, 7551.886721699179, 1701.8298170182882, 1738.9478315650551, 1763.4268862619444, 1776.538100093985, 1787.6782179207867, 1139.561268911475, 1153.988460115405, 1163.03468121459, 1170.4849866058908, 1172.4899668644166, 7084.220735719066, 7088.751893683696, 7093.148822141273, 7102.360787529044, 7118.110236220473, 7668.578228197391, 7682.462227644123, 7685.500442471333, 7692.46152769312, 7693.807654808563, 5884.823455296348, 6464.870702586016, 7057.18842333128, 7089.964550177217, 7117.288271172842, 3342.7325813934826, 3958.960410395859, 4090.9795451022555, 4098.426220329156, 4107.712460127822, 8056.919430805734, 8066.23370779775, 8105.27052565272, 8130.674773009014, 8148.470349427268, 8057.677692892219, 8078.39412044099, 8084.959575202086, 8096.919030809617, 8131.625375469114, 8094.028716553933, 8100.189981001853, 8112.269895709414, 8140.0638926523025, 8147.185281471924, 7619.733309334147, 7826.491278066907, 7846.0976987647155, 7874.6850125994315, 7898.565578893216, 7657.387409007155, 7679.539227646359, 7691.0, 7702.306792388712, 7758.8448231033935, 6518.804435866931, 8107.0, 8107.8378432429845, 8111.310538604049, 8118.553479558681, 4886.047220791911, 4940.382452193476, 4946.727929963743, 4951.0, 4952.57903078228, 7480.0, 7490.475666703279, 7636.198199189005, 7841.5687137208, 7859.331956783737, 7484.176740558643, 7487.588182649789, 7520.511166774142, 7581.54510729358, 7593.772186834404, 6383.978563429829, 7317.414606831547, 7539.283768042027, 7558.508696934901, 7560.9621951889885, 6096.8660968660615, 7356.926430735838, 7359.153697324662, 7362.595057271901, 7380.298871607189, 6137.925862974051, 7160.928390716234, 7453.291937265951, 7524.360429363565, 7596.696132154652, 7329.853402932018, 7376.18861925177, 7380.335769780745, 7384.926150738639, 7402.851942961003], "unit": "score", "name": "prototype.html", "value": 5451.800155518433}, {"lowerIsBetter": false, "replicates": [723.1575214874671, 764.4190415284382, 765.9617019149041, 784.211867073591, 792.6908505682782, 13775.793363099549, 16437.42469013585, 16542.255598498083, 16562.66874662506, 16660.66678666429, 15281.847181528181, 15333.616659583517, 15345.92327038366, 15351.69296614067, 15383.153926534036, 782.9491083079581, 949.8860136783561, 956.3831328792925, 976.1458723616818, 980.4068538534191, 966.2366730283103, 970.708787363788, 974.8245315843145, 979.5200351827589, 994.2145704893126, 1012.7620009297809, 1016.5425558498669, 1054.7310435838888, 1055.1611468882218, 1058.5236643510414, 1004.6835246897203, 1004.9799004019878, 1007.1489591295343, 1009.4347165587258, 1043.4521876015076, 767.0258771360396, 770.6108415250319, 772.2162005564356, 772.7681695491331, 774.9883751743729, 15452.690946181126, 15701.528954131394, 15935.681286374323, 15936.681266374724, 15940.724742020611, 11226.719332016683, 13538.187708737507, 13561.25413102279, 13589.0, 13654.931725341408, 10300.373663444163, 10580.259381843274, 10638.0, 10657.84013239802, 10888.67333979982, 3596.9280614387826, 3659.762115462513, 3677.5403074615674, 3714.9257014859822, 3729.049092481427, 89240.99999999935, 89531.0, 89736.0, 89835.65246521308, 89869.55065224698, 8281.95859020701, 8285.4200205985, 8409.075001749803, 8410.789730256793, 8593.742187734379, 22497.43756406103, 23693.289201323987, 23720.64419033716, 23758.287251382488, 23765.40586485317, 7679.1936846631415, 7753.806154846174, 7774.1264704269215, 7809.765707028798, 7879.251471110236, 4152.335626299838, 4156.7921603919685, 4220.894477638084, 4259.61663450291, 4366.585174408426, 3769.0388950817364, 3788.3559794834946, 3823.0, 3824.521934758155, 3848.6536211740518, 598.0909018292172, 604.7490291528966, 670.5507310102244, 671.2582596231192, 676.3709749932511, 598.3448124303881, 626.9498440124779, 637.2512298049772, 644.6003477843767, 660.4155322539491, 8601.5699215039, 8618.138186181457, 8668.133186681407, 8708.08565100668, 8853.69012084574, 533.5384892068411, 594.3313772006493, 624.3943374926314, 637.9457746091634, 640.7437025189868, 3863.8068096595057, 4007.8196481158416, 4011.919761604752, 4146.129312844276, 4170.16596680659, 99925.50037249767, 101704.0, 102087.48956255171, 103609.48195258975, 103757.48121259497, 85427.57286213654, 85997.0, 86970.0, 87254.0, 87784.0, 71158.9326160108, 72155.0, 72750.90873636899, 75015.62492187505, 75692.62153689197, 7611.88582171279, 8669.91330086691, 8927.018028016782, 9018.323625727966, 9066.456012639263, 49731.75134124306, 51986.0, 53263.668408290105, 53417.732911335195, 53841.192382115085, 54447.45552544424, 70730.29269707236, 71023.64488177525, 74914.0, 75014.24985750292, 11595.13036522281, 11607.883921161017, 11672.766544669228, 11774.52901883915, 11860.932516073595, 12240.510379585074, 12481.0, 12569.371531423576, 12781.488740450277, 13188.80216796768, 12044.554653441643, 12079.698007549881, 12113.878861211275, 12256.448459819509, 12332.938335308267, 10199.13307368882, 11617.128715346214, 12099.395030248628, 12301.815472768094, 12649.177803442746, 11612.012978896888, 11789.823152652545, 12170.39148042612, 12192.146549741434, 12313.32276724753, 8895.421797583136, 9557.952210238904, 9862.654807081717, 9896.752581185528, 10370.014848589371, 9872.160866326156, 10010.899891000996, 10108.747281318027, 10131.341462804894, 10174.901313499999], "unit": "score", "name": "yui.html", "value": 7283.814714246095}], "name": "dromaeo_css", "value": 7880.028397846599}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 112.0, 116.0, 116.0, 117.0, 129.0, 113.0, 115.0, 115.0, 115.0], "unit": "score", "name": "ai-astar", "value": 116.5}, {"lowerIsBetter": true, "replicates": [152.0, 122.0, 145.0, 185.0, 149.0, 143.0, 137.0, 122.0, 157.0, 118.0], "unit": "score", "name": "audio-beat-detection", "value": 143.0}, {"lowerIsBetter": true, "replicates": [266.0, 265.0, 220.0, 275.0, 273.0, 196.0, 193.0, 195.0, 196.0, 200.0], "unit": "score", "name": "audio-dft", "value": 227.9}, {"lowerIsBetter": true, "replicates": [72.0, 77.0, 73.0, 116.0, 58.0, 46.0, 67.0, 76.0, 160.0, 81.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 120.0, 77.0, 82.0, 77.0, 132.0, 95.0, 64.0, 105.0], "unit": "score", "name": "audio-oscillator", "value": 92.4}, {"lowerIsBetter": true, "replicates": [91.0, 87.0, 99.0, 94.0, 137.0, 112.0, 89.0, 131.0, 136.0, 90.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 106.6}, {"lowerIsBetter": true, "replicates": [111.0, 96.0, 98.0, 107.0, 108.0, 150.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 105.7}, {"lowerIsBetter": true, "replicates": [122.0, 149.0, 93.0, 90.0, 91.0, 93.0, 117.0, 83.0, 146.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 108.1}, {"lowerIsBetter": true, "replicates": [55.0, 60.0, 60.0, 58.0, 59.0, 60.0, 60.0, 80.0, 86.0, 81.0], "unit": "score", "name": "json-parse-financial", "value": 65.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 75.0, 73.0, 66.0, 66.0, 66.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 81.0, 83.0, 80.0, 82.0, 83.0, 85.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [129.0, 130.0, 143.0, 152.0, 106.0, 109.0, 138.0, 147.0, 126.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.5}, {"lowerIsBetter": true, "replicates": [140.0, 141.0, 176.0, 140.0, 126.0, 175.0, 140.0, 138.0, 132.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [87.0, 100.0, 94.0, 76.0, 65.0, 67.0, 64.0, 66.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.5}], "name": "kraken", "value": 1552.0}]} 05:56:03 INFO - Return code: 0 05:56:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:56:03 ERROR - # TBPL SUCCESS # 05:56:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:56:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:56:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:56:03 INFO - 2016-05-09 05:56:03.474 screenresolution[2551:56175] starting screenresolution argv=screenresolution get 05:56:03 INFO - 2016-05-09 05:56:03.476 screenresolution[2551:56175] Display 0: 1600x1200x32@60 05:56:03 INFO - 2016-05-09 05:56:03.482 screenresolution[2552:56178] starting screenresolution argv=screenresolution list 05:56:03 INFO - Available Modes on Display 0 05:56:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:56:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:56:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:56:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:56:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:56:03 INFO - Intel Iris: 05:56:03 INFO - Chipset Model: Intel Iris 05:56:03 INFO - Type: GPU 05:56:03 INFO - Bus: Built-In 05:56:03 INFO - VRAM (Dynamic, Max): 1536 MB 05:56:03 INFO - Vendor: Intel (0x8086) 05:56:03 INFO - Device ID: 0x0a2e 05:56:03 INFO - Revision ID: 0x0009 05:56:03 INFO - Displays: 05:56:03 INFO - Display: 05:56:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:56:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:56:03 INFO - Display Serial Number: 1600x1200 60 05:56:03 INFO - Main Display: Yes 05:56:03 INFO - Mirror: Off 05:56:03 INFO - Online: Yes 05:56:03 INFO - Rotation: Supported 05:56:03 INFO - Return code: 0 05:56:03 INFO - Running post-action listener: _resource_record_post_action 05:56:03 INFO - Running post-run listener: _resource_record_post_run 05:56:04 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 393216; Write bytes: 510513664; Read time: 5; Write time: 1983 05:56:04 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 202549760; Write bytes: 199079424; Read time: 19075; Write time: 428 05:56:04 INFO - run-tests - Wall time: 1169s; CPU: 53.0%; Read bytes: 393216; Write bytes: 300588032; Read time: 5; Write time: 1520 05:56:04 INFO - Running post-run listener: _upload_blobber_files 05:56:04 INFO - Blob upload gear active. 05:56:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:56:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:56:04 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:56:04 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:56:05 INFO - (blobuploader) - INFO - Open directory for files ... 05:56:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:56:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:56:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:06 INFO - (blobuploader) - INFO - Done attempting. 05:56:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:56:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:56:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:56:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:56:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:56:07 INFO - (blobuploader) - INFO - Done attempting. 05:56:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:56:07 INFO - Return code: 0 05:56:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:56:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:56:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6544406aaaa8faa8e4e1a247fbb84114a5355015c49c514c95ca729c6f704c719d2a8f3fbd59e5bda63f09b3aff43ba285a9e0ff4aefd3f687e7207a675c33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/194b5ac10e4065887297d0eaeac6c16a30928a896840ecd7c562f3cf3ff8956e96d3f9328b2177b55627af8ae36c4a716fb1dd5f775066671f1ad3f80d5f3fe2"} 05:56:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:56:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:56:07 INFO - Contents: 05:56:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6544406aaaa8faa8e4e1a247fbb84114a5355015c49c514c95ca729c6f704c719d2a8f3fbd59e5bda63f09b3aff43ba285a9e0ff4aefd3f687e7207a675c33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/194b5ac10e4065887297d0eaeac6c16a30928a896840ecd7c562f3cf3ff8956e96d3f9328b2177b55627af8ae36c4a716fb1dd5f775066671f1ad3f80d5f3fe2"} 05:56:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:56:07 INFO - Copying logs to upload dir... 05:56:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:56:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.907631 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-05-09 05:56:07.447853) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:07.450948) ========= 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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/Mozilla-Beta/sha512/3c6544406aaaa8faa8e4e1a247fbb84114a5355015c49c514c95ca729c6f704c719d2a8f3fbd59e5bda63f09b3aff43ba285a9e0ff4aefd3f687e7207a675c33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/194b5ac10e4065887297d0eaeac6c16a30928a896840ecd7c562f3cf3ff8956e96d3f9328b2177b55627af8ae36c4a716fb1dd5f775066671f1ad3f80d5f3fe2"} build_url:https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/D_vUHmeKR_2mA7juCS2aMw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3c6544406aaaa8faa8e4e1a247fbb84114a5355015c49c514c95ca729c6f704c719d2a8f3fbd59e5bda63f09b3aff43ba285a9e0ff4aefd3f687e7207a675c33", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/194b5ac10e4065887297d0eaeac6c16a30928a896840ecd7c562f3cf3ff8956e96d3f9328b2177b55627af8ae36c4a716fb1dd5f775066671f1ad3f80d5f3fe2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:07.481821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:07.482134) ========= 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.U1Ho2KL0I2/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.HPmPcJQx3p/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.004804 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-09 05:56:07.529228) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:56:07.529608) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-09 05:56:07.529929) ========= ========= Total master_lag: 0.18 =========