builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0232 starttime: 1467541924.28 results: success (0) buildid: 20160703011523 builduid: d5f10c7169954150ac34f80025790374 revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.279707) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.280241) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.280574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.370195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.370614) ========= 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.18CmUFYJcv/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.EOOwpVmEdA/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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-07-03 03:32:04-- 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.52M=0.001s 2016-07-03 03:32:04 (8.52 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.572439 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.973230) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:04.973561) ========= 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.18CmUFYJcv/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.EOOwpVmEdA/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.020576 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:05.059224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 03:32:05.059543) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --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 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.18CmUFYJcv/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.EOOwpVmEdA/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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-07-03 03:32:05,140 truncating revision to first 12 chars 2016-07-03 03:32:05,140 Setting DEBUG logging. 2016-07-03 03:32:05,140 attempt 1/10 2016-07-03 03:32:05,140 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/13ce99eb20be?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-03 03:32:06,267 unpacking tar archive at: mozilla-beta-13ce99eb20be/testing/mozharness/ program finished with exit code 0 elapsedTime=1.403472 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-03 03:32:06.492471) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:06.492810) ========= script_repo_revision: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:06.493331) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:06.494091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-03 03:32:06.599346) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-03 03:32:06.599715) ========= /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.18CmUFYJcv/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.EOOwpVmEdA/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32:06 INFO - MultiFileLogger online at 20160703 03:32:06 in /builds/slave/test 03:32:06 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 03:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:32:06 INFO - {'append_to_log': False, 03:32:06 INFO - 'base_work_dir': '/builds/slave/test', 03:32:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 03:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:32:06 INFO - 'branch': 'Mozilla-Beta', 03:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 03:32:06 INFO - 'config_files': ('talos/mac_config.py',), 03:32:06 INFO - 'default_actions': ('clobber', 03:32:06 INFO - 'read-buildbot-config', 03:32:06 INFO - 'download-and-extract', 03:32:06 INFO - 'populate-webroot', 03:32:06 INFO - 'create-virtualenv', 03:32:06 INFO - 'install', 03:32:06 INFO - 'run-tests'), 03:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:32:06 INFO - 'download_minidump_stackwalk': True, 03:32:06 INFO - 'download_symbols': 'ondemand', 03:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 03:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 03:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:32:06 INFO - 'installer_path': 'installer.exe', 03:32:06 INFO - 'log_level': 'info', 03:32:06 INFO - 'log_name': 'talos', 03:32:06 INFO - 'log_to_console': True, 03:32:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:32:06 INFO - 'opt_config_files': (), 03:32:06 INFO - 'pip_index': False, 03:32:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:32:06 INFO - 'cmd': ('bash', 03:32:06 INFO - '-c', 03:32:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:32:06 INFO - 'enabled': True, 03:32:06 INFO - 'halt_on_failure': False, 03:32:06 INFO - 'name': 'check_screen_resolution'},), 03:32:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:32:06 INFO - 'cmd': ('bash', 03:32:06 INFO - '-c', 03:32:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:32:06 INFO - 'enabled': True, 03:32:06 INFO - 'halt_on_failure': False, 03:32:06 INFO - 'name': 'check_screen_resolution'},), 03:32:06 INFO - 'run_cmd_checks_enabled': True, 03:32:06 INFO - 'sps_profile': False, 03:32:06 INFO - 'sps_profile_interval': 0, 03:32:06 INFO - 'suite': 'dromaeojs-e10s', 03:32:06 INFO - 'system_bits': '32', 03:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:32:06 INFO - 'title': 't-yosemite-r7-0232', 03:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:32:06 INFO - 'use_talos_json': True, 03:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:32:06 INFO - 'work_dir': 'build'} 03:32:06 INFO - ##### 03:32:06 INFO - ##### Running clobber step. 03:32:06 INFO - ##### 03:32:06 INFO - Running pre-action listener: _resource_record_pre_action 03:32:06 INFO - Running main action method: clobber 03:32:06 INFO - rmtree: /builds/slave/test/build 03:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:32:08 INFO - Running post-action listener: _resource_record_post_action 03:32:08 INFO - ##### 03:32:08 INFO - ##### Running read-buildbot-config step. 03:32:08 INFO - ##### 03:32:08 INFO - Running pre-action listener: _resource_record_pre_action 03:32:08 INFO - Running main action method: read_buildbot_config 03:32:08 INFO - Using buildbot properties: 03:32:08 INFO - { 03:32:08 INFO - "project": "", 03:32:08 INFO - "product": "firefox", 03:32:08 INFO - "script_repo_revision": "production", 03:32:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 03:32:08 INFO - "repository": "", 03:32:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 03:32:08 INFO - "buildid": "20160703011523", 03:32:08 INFO - "pgo_build": "False", 03:32:08 INFO - "basedir": "/builds/slave/test", 03:32:08 INFO - "buildnumber": 20, 03:32:08 INFO - "slavename": "t-yosemite-r7-0232", 03:32:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:32:08 INFO - "platform": "yosemite_r7", 03:32:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 03:32:08 INFO - "branch": "mozilla-beta", 03:32:08 INFO - "repo_path": "releases/mozilla-beta", 03:32:08 INFO - "revision": "13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67", 03:32:08 INFO - "stage_platform": "macosx64", 03:32:08 INFO - "builduid": "d5f10c7169954150ac34f80025790374", 03:32:08 INFO - "slavebuilddir": "test" 03:32:08 INFO - } 03:32:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 03:32:08 INFO - Running post-action listener: _resource_record_post_action 03:32:08 INFO - ##### 03:32:08 INFO - ##### Running download-and-extract step. 03:32:08 INFO - ##### 03:32:08 INFO - Running pre-action listener: _resource_record_pre_action 03:32:08 INFO - Running main action method: download_and_extract 03:32:08 INFO - mkdir: /builds/slave/test/build/tests 03:32:08 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')]} 03:32:08 INFO - https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:32:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 03:32:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 03:32:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:32:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 03:32:10 INFO - Downloaded 1165 bytes. 03:32:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 03:32:10 INFO - Using the following test package requirements: 03:32:10 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:32:10 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 03:32:10 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 03:32:10 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 03:32:10 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 03:32:10 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 03:32:10 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 03:32:10 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 03:32:10 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 03:32:10 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 03:32:10 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 03:32:10 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 03:32:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:10 INFO - https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:32:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:32:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:32:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:32:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 03:32:13 INFO - Downloaded 18351398 bytes. 03:32:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:32:16 INFO - Return code: 0 03:32:16 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 03:32:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:16 INFO - https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:32:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:32:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 03:32:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 03:32:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 03:32:26 INFO - Downloaded 18351398 bytes. 03:32:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 03:32:29 INFO - Return code: 0 03:32:29 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')]} 03:32:29 INFO - https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:32:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 03:32:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 03:32:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 03:32:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 03:32:30 INFO - Downloaded 10840145 bytes. 03:32:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:32:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 03:32:31 INFO - Return code: 0 03:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:31 INFO - https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 03:32:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:32:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:32:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 03:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 03:32:33 INFO - Downloaded 86196771 bytes. 03:32:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:32:33 INFO - mkdir: /builds/slave/test/properties 03:32:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:33 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:33 INFO - Contents: 03:32:33 INFO - build_url:https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 03:32:34 INFO - Running post-action listener: _resource_record_post_action 03:32:34 INFO - Running post-action listener: set_extra_try_arguments 03:32:34 INFO - ##### 03:32:34 INFO - ##### Running populate-webroot step. 03:32:34 INFO - ##### 03:32:34 INFO - Running pre-action listener: _resource_record_pre_action 03:32:34 INFO - Running main action method: populate_webroot 03:32:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:32:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:32:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:32:34 INFO - '--tppagecycles', 03:32:34 INFO - '7'], 03:32:34 INFO - 'tests': ['tsvgm']}}, 03:32:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:32:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:32:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['damp', 'tps']}, 03:32:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'tests': ['damp', 'tps']}, 03:32:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['dromaeo_dom']}, 03:32:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['a11yr', 03:32:34 INFO - 'ts_paint', 03:32:34 INFO - 'tpaint', 03:32:34 INFO - 'sessionrestore', 03:32:34 INFO - 'sessionrestore_no_auto_restore', 03:32:34 INFO - 'tabpaint']}, 03:32:34 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:34 INFO - 'ts_paint', 03:32:34 INFO - 'tpaint', 03:32:34 INFO - 'sessionrestore', 03:32:34 INFO - 'sessionrestore_no_auto_restore', 03:32:34 INFO - 'tabpaint']}, 03:32:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:32:34 INFO - 'ts_paint', 03:32:34 INFO - 'tpaint', 03:32:34 INFO - 'sessionrestore', 03:32:34 INFO - 'sessionrestore_no_auto_restore', 03:32:34 INFO - 'tabpaint']}, 03:32:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:32:34 INFO - 'ts_paint', 03:32:34 INFO - 'tpaint', 03:32:34 INFO - 'sessionrestore', 03:32:34 INFO - 'sessionrestore_no_auto_restore', 03:32:34 INFO - 'tabpaint']}, 03:32:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['a11yr', 03:32:34 INFO - 'ts_paint', 03:32:34 INFO - 'tpaint', 03:32:34 INFO - 'sessionrestore', 03:32:34 INFO - 'sessionrestore_no_auto_restore', 03:32:34 INFO - 'tabpaint']}, 03:32:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['a11yr', 03:32:34 INFO - 'ts_paint', 03:32:34 INFO - 'tpaint', 03:32:34 INFO - 'sessionrestore', 03:32:34 INFO - 'sessionrestore_no_auto_restore', 03:32:34 INFO - 'tabpaint']}, 03:32:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['tsvgx', 03:32:34 INFO - 'tsvgr_opacity', 03:32:34 INFO - 'tart', 03:32:34 INFO - 'tscrollx', 03:32:34 INFO - 'cart']}, 03:32:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:34 INFO - 'tsvgr_opacity', 03:32:34 INFO - 'tart', 03:32:34 INFO - 'tscrollx', 03:32:34 INFO - 'cart']}, 03:32:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'talos_options': ['--disable-e10s'], 03:32:34 INFO - 'tests': ['tp5o']}, 03:32:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'tests': ['tp5o']}, 03:32:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'talos_options': ['--disable-e10s', 03:32:34 INFO - '--xperf_path', 03:32:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:34 INFO - 'tests': ['tp5n']}, 03:32:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:32:34 INFO - 'talos_options': ['--xperf_path', 03:32:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:34 INFO - 'tests': ['tp5n']}}, 03:32:34 INFO - 'talos.zip': {'path': '', 03:32:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:32:34 INFO - Running post-action listener: _resource_record_post_action 03:32:34 INFO - ##### 03:32:34 INFO - ##### Running create-virtualenv step. 03:32:34 INFO - ##### 03:32:34 INFO - Running pre-action listener: _resource_record_pre_action 03:32:34 INFO - Running main action method: create_virtualenv 03:32:34 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:34 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 03:32:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:35 INFO - Using real prefix '/tools/python27' 03:32:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:35 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:38 INFO - Installing pip.................done. 03:32:38 INFO - Return code: 0 03:32:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:32:38 INFO - 'HOME': '/Users/cltbld', 03:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:32:38 INFO - 'LOGNAME': 'cltbld', 03:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:38 INFO - 'MOZ_NO_REMOTE': '1', 03:32:38 INFO - 'NO_EM_RESTART': '1', 03:32:38 INFO - 'PAGER': '/bin/cat', 03:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:38 INFO - 'PWD': '/builds/slave/test', 03:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:32:38 INFO - 'SHELL': '/bin/bash', 03:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:32:38 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:32:38 INFO - 'USER': 'cltbld', 03:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:38 INFO - 'XPC_FLAGS': '0x0', 03:32:38 INFO - 'XPC_SERVICE_NAME': '0', 03:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 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 03:32:38 INFO - Cleaning up... 03:32:38 INFO - Return code: 0 03:32:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:32:38 INFO - 'HOME': '/Users/cltbld', 03:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:32:38 INFO - 'LOGNAME': 'cltbld', 03:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:38 INFO - 'MOZ_NO_REMOTE': '1', 03:32:38 INFO - 'NO_EM_RESTART': '1', 03:32:38 INFO - 'PAGER': '/bin/cat', 03:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:38 INFO - 'PWD': '/builds/slave/test', 03:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:32:38 INFO - 'SHELL': '/bin/bash', 03:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:32:38 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:32:38 INFO - 'USER': 'cltbld', 03:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:38 INFO - 'XPC_FLAGS': '0x0', 03:32:38 INFO - 'XPC_SERVICE_NAME': '0', 03:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:39 INFO - Downloading/unpacking psutil>=0.7.1 03:32:39 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 03:32:39 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 03:32:39 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 03:32:39 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 03:32:39 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 03:32:39 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 03:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:41 INFO - Installing collected packages: psutil 03:32:41 INFO - Running setup.py install for psutil 03:32:41 INFO - building 'psutil._psutil_osx' extension 03:32:41 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 03:32:42 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 03:32:42 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 03:32:42 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 03:32:42 INFO - building 'psutil._psutil_posix' extension 03:32:42 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 03:32:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:32:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:32:42 INFO - ^ 03:32:42 INFO - 1 warning generated. 03:32:42 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 03:32:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:42 INFO - Successfully installed psutil 03:32:42 INFO - Cleaning up... 03:32:42 INFO - Return code: 0 03:32:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:42 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 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32:42 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 03:32:42 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 03:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:32:42 INFO - 'HOME': '/Users/cltbld', 03:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:32:42 INFO - 'LOGNAME': 'cltbld', 03:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:42 INFO - 'MOZ_NO_REMOTE': '1', 03:32:42 INFO - 'NO_EM_RESTART': '1', 03:32:42 INFO - 'PAGER': '/bin/cat', 03:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:42 INFO - 'PWD': '/builds/slave/test', 03:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:32:42 INFO - 'SHELL': '/bin/bash', 03:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:32:42 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:32:42 INFO - 'USER': 'cltbld', 03:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:42 INFO - 'XPC_FLAGS': '0x0', 03:32:42 INFO - 'XPC_SERVICE_NAME': '0', 03:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:32:42 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 03:32:42 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 03:32:42 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 03:32:42 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 03:32:42 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 03:32:42 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 03:32:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:32:45 INFO - Installing collected packages: mozsystemmonitor 03:32:45 INFO - Running setup.py install for mozsystemmonitor 03:32:45 INFO - Successfully installed mozsystemmonitor 03:32:45 INFO - Cleaning up... 03:32:45 INFO - Return code: 0 03:32:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32: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')]} 03:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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')]} 03:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32: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', '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 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:32: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 blobuploader==1.2.4 03:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:32:45 INFO - 'HOME': '/Users/cltbld', 03:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:32:45 INFO - 'LOGNAME': 'cltbld', 03:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:45 INFO - 'MOZ_NO_REMOTE': '1', 03:32:45 INFO - 'NO_EM_RESTART': '1', 03:32:45 INFO - 'PAGER': '/bin/cat', 03:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:45 INFO - 'PWD': '/builds/slave/test', 03:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:32:45 INFO - 'SHELL': '/bin/bash', 03:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:32:45 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:32:45 INFO - 'USER': 'cltbld', 03:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:45 INFO - 'XPC_FLAGS': '0x0', 03:32:45 INFO - 'XPC_SERVICE_NAME': '0', 03:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:45 INFO - Downloading/unpacking blobuploader==1.2.4 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:48 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32: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 03:32:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:49 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 03:32:49 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 03:32:49 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 03:32:49 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 03:32:49 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 03:32:49 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 03:32:49 INFO - Downloading docopt-0.6.1.tar.gz 03:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:49 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:49 INFO - Running setup.py install for blobuploader 03:32:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:49 INFO - Running setup.py install for requests 03:32:50 INFO - Running setup.py install for docopt 03:32:50 INFO - Successfully installed blobuploader requests docopt 03:32:50 INFO - Cleaning up... 03:32:50 INFO - Return code: 0 03:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:50 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 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32:50 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 03:32:50 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 03:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:32:50 INFO - 'HOME': '/Users/cltbld', 03:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:32:50 INFO - 'LOGNAME': 'cltbld', 03:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:50 INFO - 'MOZ_NO_REMOTE': '1', 03:32:50 INFO - 'NO_EM_RESTART': '1', 03:32:50 INFO - 'PAGER': '/bin/cat', 03:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:50 INFO - 'PWD': '/builds/slave/test', 03:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:32:50 INFO - 'SHELL': '/bin/bash', 03:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:32:50 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:32:50 INFO - 'USER': 'cltbld', 03:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:50 INFO - 'XPC_FLAGS': '0x0', 03:32:50 INFO - 'XPC_SERVICE_NAME': '0', 03:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:50 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-J2_mWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-XxUx0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-frZwZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-wsyg5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-5Cgiw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-YDNm7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-nb_jhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-8VHo2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-2kHjQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-k2FgPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:51 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-QT3Kx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:52 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-K7ySQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:52 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-cKCRvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:52 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-2rCWkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:52 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-9t07vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:52 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-TNLmY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:52 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-MeNn8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:52 INFO - Running setup.py install for manifestparser 03:32:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:52 INFO - Running setup.py install for mozcrash 03:32:53 INFO - Running setup.py install for mozdebug 03:32:53 INFO - Running setup.py install for mozdevice 03:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Running setup.py install for mozfile 03:32:53 INFO - Running setup.py install for mozhttpd 03:32:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Running setup.py install for mozinfo 03:32:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Running setup.py install for mozInstall 03:32:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:53 INFO - Running setup.py install for mozleak 03:32:54 INFO - Running setup.py install for mozlog 03:32:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for moznetwork 03:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozprocess 03:32:54 INFO - Running setup.py install for mozprofile 03:32:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozrunner 03:32:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:54 INFO - Running setup.py install for mozscreenshot 03:32:55 INFO - Running setup.py install for moztest 03:32:55 INFO - Running setup.py install for mozversion 03:32:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:55 INFO - Cleaning up... 03:32:55 INFO - Return code: 0 03:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:55 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')]} 03:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:55 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')]} 03:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:32:55 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 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:32:55 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 03:32:55 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 03:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:32:55 INFO - 'HOME': '/Users/cltbld', 03:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:32:55 INFO - 'LOGNAME': 'cltbld', 03:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:55 INFO - 'MOZ_NO_REMOTE': '1', 03:32:55 INFO - 'NO_EM_RESTART': '1', 03:32:55 INFO - 'PAGER': '/bin/cat', 03:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:55 INFO - 'PWD': '/builds/slave/test', 03:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:32:55 INFO - 'SHELL': '/bin/bash', 03:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:32:55 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:32:55 INFO - 'USER': 'cltbld', 03:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:55 INFO - 'XPC_FLAGS': '0x0', 03:32:55 INFO - 'XPC_SERVICE_NAME': '0', 03:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:32:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-AVHoEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-YncJ4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-CIcXfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:55 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)) 03:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:55 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-v95iem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-4zvoYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-6bPs17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-ZtqviZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-7ryPQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-QRXu73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Rgf25b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-Pnv2XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-5yCT7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:56 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)) 03:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:56 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-6OoJJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:57 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)) 03:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:57 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-U81_Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:57 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)) 03:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:57 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-z4s6nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:57 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)) 03:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:57 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-dO1sVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:57 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)) 03:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:57 INFO - Running setup.py (path:/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/pip-TYabhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:57 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)) 03:32:57 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)) 03:32:57 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)) 03:32:57 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)) 03:32:57 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)) 03:32:57 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)) 03:32:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:32:59 INFO - Downloading blessings-1.6.tar.gz 03:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:33:00 INFO - Installing collected packages: blessings 03:33:00 INFO - Running setup.py install for blessings 03:33:00 INFO - Successfully installed blessings 03:33:00 INFO - Cleaning up... 03:33:00 INFO - Return code: 0 03:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:00 INFO - Reading from file tmpfile_stdout 03:33:00 INFO - Current package versions: 03:33:00 INFO - blessings == 1.6 03:33:00 INFO - blobuploader == 1.2.4 03:33:00 INFO - docopt == 0.6.1 03:33:00 INFO - manifestparser == 1.1 03:33:00 INFO - mozInstall == 1.12 03:33:00 INFO - mozcrash == 0.17 03:33:00 INFO - mozdebug == 0.1 03:33:00 INFO - mozdevice == 0.48 03:33:00 INFO - mozfile == 1.2 03:33:00 INFO - mozhttpd == 0.7 03:33:00 INFO - mozinfo == 0.9 03:33:00 INFO - mozleak == 0.1 03:33:00 INFO - mozlog == 3.1 03:33:00 INFO - moznetwork == 0.27 03:33:00 INFO - mozprocess == 0.22 03:33:00 INFO - mozprofile == 0.28 03:33:00 INFO - mozrunner == 6.11 03:33:00 INFO - mozscreenshot == 0.1 03:33:00 INFO - mozsystemmonitor == 0.0 03:33:00 INFO - moztest == 0.7 03:33:00 INFO - mozversion == 1.4 03:33:00 INFO - psutil == 3.1.1 03:33:00 INFO - requests == 1.2.3 03:33:00 INFO - wsgiref == 0.1.2 03:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 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 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:33:00 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 03:33:00 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 03:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:00 INFO - 'HOME': '/Users/cltbld', 03:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:00 INFO - 'LOGNAME': 'cltbld', 03:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:00 INFO - 'MOZ_NO_REMOTE': '1', 03:33:00 INFO - 'NO_EM_RESTART': '1', 03:33:00 INFO - 'PAGER': '/bin/cat', 03:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:00 INFO - 'PWD': '/builds/slave/test', 03:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:00 INFO - 'SHELL': '/bin/bash', 03:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:33:00 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:00 INFO - 'USER': 'cltbld', 03:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:00 INFO - 'XPC_FLAGS': '0x0', 03:33:00 INFO - 'XPC_SERVICE_NAME': '0', 03:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 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)) 03:33:00 INFO - Cleaning up... 03:33:00 INFO - Return code: 0 03:33:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:00 INFO - 'HOME': '/Users/cltbld', 03:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:00 INFO - 'LOGNAME': 'cltbld', 03:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:00 INFO - 'MOZ_NO_REMOTE': '1', 03:33:00 INFO - 'NO_EM_RESTART': '1', 03:33:00 INFO - 'PAGER': '/bin/cat', 03:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:00 INFO - 'PWD': '/builds/slave/test', 03:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:00 INFO - 'SHELL': '/bin/bash', 03:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:33:00 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:00 INFO - 'USER': 'cltbld', 03:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:00 INFO - 'XPC_FLAGS': '0x0', 03:33:00 INFO - 'XPC_SERVICE_NAME': '0', 03:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:01 INFO - Downloading/unpacking jsonschema 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 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 03:33:01 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 03:33:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:33:03 INFO - Downloading/unpacking functools32 (from jsonschema) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:03 INFO - Downloading functools32-3.2.3-2.tar.gz 03:33:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:33:04 INFO - warning: no files found matching '*.txt' 03:33:04 INFO - no previously-included directories found matching 'build' 03:33:04 INFO - no previously-included directories found matching 'dist' 03:33:04 INFO - no previously-included directories found matching '.git*' 03:33:04 INFO - Installing collected packages: jsonschema, functools32 03:33:04 INFO - Running setup.py install for functools32 03:33:04 INFO - warning: no files found matching '*.txt' 03:33:04 INFO - no previously-included directories found matching 'build' 03:33:04 INFO - no previously-included directories found matching 'dist' 03:33:04 INFO - no previously-included directories found matching '.git*' 03:33:04 INFO - Successfully installed jsonschema functools32 03:33:04 INFO - Cleaning up... 03:33:04 INFO - Return code: 0 03:33:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:33:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db0da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db1d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f90a95c2e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, '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.18CmUFYJcv/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.EOOwpVmEdA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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 03:33:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:33:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:04 INFO - 'HOME': '/Users/cltbld', 03:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:04 INFO - 'LOGNAME': 'cltbld', 03:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:04 INFO - 'MOZ_NO_REMOTE': '1', 03:33:04 INFO - 'NO_EM_RESTART': '1', 03:33:04 INFO - 'PAGER': '/bin/cat', 03:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:04 INFO - 'PWD': '/builds/slave/test', 03:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:04 INFO - 'SHELL': '/bin/bash', 03:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:33:04 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:04 INFO - 'USER': 'cltbld', 03:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:04 INFO - 'XPC_FLAGS': '0x0', 03:33:04 INFO - 'XPC_SERVICE_NAME': '0', 03:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:33:04 INFO - Downloading/unpacking flake8 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:33:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:33:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:33:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33: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 03:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:08 INFO - no previously-included directories found matching 'docs/_build' 03:33:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:33:08 INFO - Running setup.py install for pep8 03:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:33:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:33:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:33:08 INFO - no previously-included directories found matching 'docs/_build' 03:33:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:33:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:33:08 INFO - Cleaning up... 03:33:08 INFO - Return code: 0 03:33:08 INFO - Running post-action listener: _resource_record_post_action 03:33:08 INFO - Running post-action listener: _start_resource_monitoring 03:33:08 INFO - Starting resource monitoring. 03:33:08 INFO - ##### 03:33:08 INFO - ##### Running install step. 03:33:08 INFO - ##### 03:33:08 INFO - Running pre-action listener: _resource_record_pre_action 03:33:08 INFO - Running main action method: install 03:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:33:08 INFO - Reading from file tmpfile_stdout 03:33:08 INFO - Detecting whether we're running mozinstall >=1.0... 03:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:33:08 INFO - Reading from file tmpfile_stdout 03:33:08 INFO - Output received: 03:33:08 INFO - Usage: mozinstall [options] installer 03:33:08 INFO - Options: 03:33:08 INFO - -h, --help show this help message and exit 03:33:08 INFO - -d DEST, --destination=DEST 03:33:08 INFO - Directory to install application into. [default: 03:33:08 INFO - "/builds/slave/test"] 03:33:08 INFO - --app=APP Application being installed. [default: firefox] 03:33:08 INFO - mkdir: /builds/slave/test/build/application 03:33:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:33:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 03:33:30 INFO - Reading from file tmpfile_stdout 03:33:30 INFO - Output received: 03:33:30 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 03:33:30 INFO - Running post-action listener: _resource_record_post_action 03:33:30 INFO - ##### 03:33:30 INFO - ##### Running run-tests step. 03:33:30 INFO - ##### 03:33:30 INFO - Running pre-action listener: _resource_record_pre_action 03:33:30 INFO - Running main action method: run_tests 03:33:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:33:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:33:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:33:30 INFO - 2016-07-03 03:33:30.616 screenresolution[1926:20257] starting screenresolution argv=screenresolution get 03:33:30 INFO - 2016-07-03 03:33:30.618 screenresolution[1926:20257] Display 0: 1600x1200x32@60 03:33:30 INFO - 2016-07-03 03:33:30.624 screenresolution[1927:20260] starting screenresolution argv=screenresolution list 03:33:30 INFO - Available Modes on Display 0 03:33:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:33:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:33:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:33:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:33:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:33:30 INFO - Intel Iris: 03:33:30 INFO - Chipset Model: Intel Iris 03:33:30 INFO - Type: GPU 03:33:30 INFO - Bus: Built-In 03:33:30 INFO - VRAM (Dynamic, Max): 1536 MB 03:33:30 INFO - Vendor: Intel (0x8086) 03:33:30 INFO - Device ID: 0x0a2e 03:33:30 INFO - Revision ID: 0x0009 03:33:30 INFO - Displays: 03:33:30 INFO - Display: 03:33:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:33:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:33:30 INFO - Display Serial Number: 1600x1200 60 03:33:30 INFO - Main Display: Yes 03:33:30 INFO - Mirror: Off 03:33:30 INFO - Online: Yes 03:33:30 INFO - Rotation: Supported 03:33:30 INFO - Return code: 0 03:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:30 INFO - Python 2.7.3 03:33:30 INFO - Return code: 0 03:33:30 INFO - grabbing minidump binary from tooltool 03:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:33:30 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 0x10d9ace00>, '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 0x10d815db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9a7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:30 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 03:33:30 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 03:33:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:30 INFO - Return code: 0 03:33:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:33:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:33:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:33:32 INFO - Return code: 0 03:33:32 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/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--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 03:33:32 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/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0232 --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 03:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.18CmUFYJcv/Render', 03:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:33:32 INFO - 'HOME': '/Users/cltbld', 03:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:33:32 INFO - 'LOGNAME': 'cltbld', 03:33:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:32 INFO - 'MOZ_NO_REMOTE': '1', 03:33:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:32 INFO - 'NO_EM_RESTART': '1', 03:33:32 INFO - 'PAGER': '/bin/cat', 03:33:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:32 INFO - 'PWD': '/builds/slave/test', 03:33:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:33:32 INFO - 'SHELL': '/bin/bash', 03:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EOOwpVmEdA/Listeners', 03:33:32 INFO - 'TMPDIR': '/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/', 03:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:33:32 INFO - 'USER': 'cltbld', 03:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:32 INFO - 'XPC_FLAGS': '0x0', 03:33:32 INFO - 'XPC_SERVICE_NAME': '0', 03:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:33:32 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/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0232', '--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 03:33:32 INFO - mozversion application_buildid: 20160703011523 03:33:32 INFO - mozversion application_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 03:33:32 INFO - mozversion application_display_name: Firefox 03:33:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:32 INFO - mozversion application_name: Firefox 03:33:32 INFO - mozversion application_remotingname: firefox 03:33:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 03:33:32 INFO - mozversion application_vendor: Mozilla 03:33:32 INFO - mozversion application_version: 48.0 03:33:32 INFO - mozversion platform_buildid: 20160703011523 03:33:32 INFO - mozversion platform_changeset: 13ce99eb20be5ebc3ff877ac0b1c12f88e9e4d67 03:33:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 03:33:32 INFO - mozversion platform_version: 48.0 03:33:32 INFO - using testdate: 1467542012 03:33:32 INFO - actual date: 1467542012 03:33:32 INFO - starting webserver on 'localhost:55836' 03:33:32 INFO - SUITE-START | Running 2 tests 03:33:32 INFO - TEST-START | dromaeo_css 03:33:32 INFO - operating with platform_type : mac_ 03:33:32 INFO - Initialising browser for dromaeo_css test... 03:33:32 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpkYE0V0/profile http://localhost:55836/getInfo.html) 03:33:34 INFO - PROCESS | 1945 | __metrics Screen width/height:1600/1200 03:33:34 INFO - PROCESS | 1945 | colorDepth:24 03:33:34 INFO - PROCESS | 1945 | Browser inner width/height: 1024/689 03:33:34 INFO - PROCESS | 1945 | __metrics 03:33:34 ERROR - PROCESS | 1945 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:33:35 INFO - TEST-INFO | 1945: exit 0 03:33:35 INFO - Browser initialized. 03:33:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:35 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpkYE0V0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:47 INFO - PROCESS | 1949 | RSS: Main: 171556864 03:33:47 INFO - PROCESS | 1949 | 03:34:37 INFO - PROCESS | 1949 | 1467542077079 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] 03:36:47 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:55836/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55836/tests/dromaeo/cssquery-ext.html) 03:36:48 INFO - PROCESS | 1949 | RSS: Main: 183873536 03:36:48 INFO - PROCESS | 1949 | 03:39:50 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:55836/tests/dromaeo/cssquery-ext.html (next: http://localhost:55836/tests/dromaeo/cssquery-jquery.html) 03:39:51 INFO - PROCESS | 1949 | RSS: Main: 194605056 03:39:51 INFO - PROCESS | 1949 | 03:42:52 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:55836/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55836/tests/dromaeo/cssquery-mootools.html) 03:42:53 INFO - PROCESS | 1949 | RSS: Main: 196632576 03:42:53 INFO - PROCESS | 1949 | 03:45:55 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:55836/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55836/tests/dromaeo/cssquery-prototype.html) 03:45:55 INFO - PROCESS | 1949 | RSS: Main: 200450048 03:45:55 INFO - PROCESS | 1949 | 03:48:58 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:55836/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55836/tests/dromaeo/cssquery-yui.html) 03:48:59 INFO - PROCESS | 1949 | RSS: Main: 199610368 03:48:59 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:55836/tests/dromaeo/cssquery-yui.html (next: http://localhost:55836/tests/dromaeo/cssquery-dojo.html) 03:52:01 INFO - PROCESS | 1949 | RSS: Main: 205099008 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | __start_tp_report 03:52:01 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 03:52:01 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 03:52:01 INFO - PROCESS | 1949 | |i|pagename|runs| 03:52:01 INFO - PROCESS | 1949 | |0;dojo.html;3552.2007548301635;3590.910227244319;3608.9639103608956;3635.4001589737677;3640.1627625646115;5893.85265368366;5914.88170236595;5957.940420595793;5964;5971.790987315439;5673.943260567393;5930.614510056843;5932;5950.285965684124;5960.5529585281065;5270.472952704718;5271.367435907697;5314.282571852808;5322.760475778599;5446.7276636168235;5226.137687281594;5289.68261904285;5329.120695085307;5332.520073193431;5424.674519528841;4455.643548516127;5317.9468205318035;5332.093544097513;5345.866353341178;5346.973265133669;5279.366476022902;5319.867003324909;5345.091334473149;5347.224652425396;5358.33020872391;5159.69041857486;5199.142141546678;5268.736563171826;5322.973385133088;5349.51854333108;5768.221290125821;5771.913421298684;5792.478676919055;5793.768249270024;5799.246098007275;5132.204508301219;6130.398136742002;6131.132004888173;6195.19405549007;6239.875202495925;6255.437010669061;6268.153799237136;6273.404026617464;6273.6235825850135;6383.553151279412;5911.29064512257;5988.401159884021;5993.820185394445;6001.159837622737;6023.819285421444;6237.781677641261;6265.8746825063245;6283.08895210192;6302.873942521124;6331.620102793847;6183.3816618337805;6199.101130336076;6204.441600255998;6214.067889816563;6214.161088253028;6112.5946701277735;6278.654673992883;6279.560430769802;6291.898917689386;6308.873822523524;6166.136740856284;6191.628502289877;6240.719167637467;6257.906131408033;6259.2488901332135;5483.506484416422;5835.649861008353;6236.875262494725;6249.281332646713;6259.436650701458;4101.200265948111;4334.068175342317;4962.255661650781;4964.503549645006;5012.523810238022;4493.550644935545;4523.773811309421;4542;4559.316102584638;4593.127305811952;5609.821937393193;5814.476697097281;5976.820695379146;6003.219581454383;6082.2093127893095;6164;6226.533010024175;6260.060990851409;6265.27949285838;6340.556161068681;5927.436893495111;6008.279006519246;6113.11552912485;6117.3402608778015;6142.170806941095;5527.44725527444;5567.331920169606;5591.440855914376;5595.468430499096;5601.943980560142;6399.13611662429;6446.580972236883;6484.643344616092;6602.735890564323;6636.13730215069;6289.779857704958;6333.619982801047;6344;6362.268339141058;6378.936210637834;6570.145881035435;6582.210134783857;6616.040674102324;6621.5364924454825;6631.171103612049;5305.336832895888;6086.056661217518;6121.30055227174;6226.408491193511;6242.65665388408;6185.350538193425;6263.060540918898;6269.404406581368;6276.592021518587;6282.560220784501;6249.312575616587;6257.374262573706;6257.7184026719815;6273.309935906956;6284.842878928063;6024.367441418588;6110.419510146529;6182.28903676083;6261.279952805486;6300.243970723543;5296.894062118659;5979.820605381671;6069.51443884497;6132.2947860996555;6143;6126.816195514141;6141.907871382022;6226.25284965807;6245.531585131042;6268.028455589391;6129.938700612936;6209;6213.720382582705;6218.973869311513;6230.096635987847 03:52:01 INFO - PROCESS | 1949 | |1;ext.html;520.8020952038225;564.1481363141656;566.586391933888;573.6988081257342;609.1319869186408;37850.62149378509;38493.61506384936;38999.61000389999;39101.608983910155;39308.60691393085;40893.18213635725;41102.17795644093;41206.38190427146;41537.37693934586;42139.367909481305;9672.371295865763;9793.804123917518;9848.458334791583;9904.851427228561;9911.851322230172;9710.563024663872;9871.457069861155;9890.406575605452;9907.900920990805;9939.304248702558;9890.752731181707;9914.652987145451;9914.801703965917;9922.751931201705;9960.003999600054;9875;9878.407295562289;9878.802423951553;9898.802023959517;9965.950170249138;8954.59704313301;9117.133872282122;9856;9938.652147174815;9980.451075190862;28644.71355286462;39734.60265397338;39794.80102599497;39849.40225896585;40378.59621403807;3285.589301337333;3429.5198672185916;3502.824858757052;3810.9519882032387;4031.879043628696;28538.71461285381;29364.559531607043;29883.551746723817;29985.55021674655;30012.54981175284;2633.3285012321926;2669.853158076305;2805.90179343722;2839.801213915027;2939.088882446427;404226;408615;409598;409710;410807;37452.43821342682;37985;53765.655858603845;63426.68286658537;64238.357616424175;35489.29021419557;36166.09584760402;36355.45466818;36392.27215455729;36454.63545364566;15648.765268520981;16030.919845400931;16079.919600401923;16182.433614823425;16220.107894065939;13677.31613419325;13688.52090176839;13720.245386503639;13767.655808604864;13783.51757688476;8232.794180145544;8307.667693292322;8388.832223355499;8456.704015359433;8526.786830329167;3523.5067090607336;3558.1460449491938;3559.911002224965;3590.7486475946434;3604.18905746205;993.3741742702196;1045.2405649086418;1050.3172937590627;1180.2092597959388;1211.2308683985557;22318.55362892733;30659;30746.846265768527;30983.535246971314;31421;1110.7722916802036;1137.2437329176005;1157.745296034871;1271.192792576702;1293.359786905488;15659.451919183002;15851.920740396225;15925.442609508611;16051.598710032342;16281.348746050262;578333.1083344556;581313;583523;584609;588650;59434.70282648559;61024.69487652533;61815.6909215451;61923.38076619176;61965.69017154976;1534.1408811065617;1547.6981988512132;1549.473179119105;1563.8514341137575;1577.8106627204809;29880;30189.622005146877;30930.0720978371;31009.689903101582;31034.224144396572;51280.48719512906;52448.73775631098;52659;52673.7366313166;52892;511509;529512.3524382353;532370;532518;534433;26555.867220663775;26867.462650747268;27101;27603;27840.86079569589;46515.30227046529;46919.76540117278;46958.76520617375;47896.5210347906;48475.75762121167;38165;38931;39066.414003789396;39171;39173.60826391813;38064.23871522609;38445.423318649686;38608.80695596504;38997.415038775005;39195.608043919194;37932.2413551733;38370;38558.42162367623;38820.8353749388;39416;32987.34025319528;34326.656733433345;34549.48175777315;34777.47833782546;34851.9544413668;25547.616785747858;25903.352416189748;25976;25982.480350392507;26286.342841429116 03:52:01 INFO - PROCESS | 1949 | |2;jquery.html;413.35929309570156;414.1075981260384;417.64082888715683;423.77751680367805;429.2830972276298;20496.180152793888;21132.683009754866;21149.73101613904;21241.57516849662;22097;12385.44265508052;12768.233905965626;17679;21980.670289945665;22012.559748805015;5121.385433747937;5380.542653874416;5681.233033540481;6222.782202622909;6236.03341482071;6106.084087386906;6179.474744646711;6200.565960382775;6218.502519798405;6246.656433896134;5539.058360078776;5549.223108764776;5675.829725108253;5795.942040579604;6201.1008403781425;5499.862503437406;5510.118381059051;5542.86142846428;5627.099664053752;5636.549076073925;5303.4696530346655;5371.248025276464;5489.725513724298;5521.558275337963;5533.253010843525;14041.859581404158;14292.785608215885;15181;26436.206913792616;26779.73220267792;2143.614149453098;2242.473018840571;2250.493638931244;2337.555864385761;2606.5699159638825;9584.856227156599;10111.797764044677;10260.486975651262;10353.327033742782;10377.117944974687;1787.1868299923503;1790.85673146148;1834.0462959261242;1838.678772294733;1873.3536929759211;95323.52338238334;99140.50429747805;100465.49767251116;102399;103127.96872031258;10114.443705596263;11670.649880503599;12064.155509114453;12145.514179432901;12211.877881221075;15390.84609153894;15568.299426525833;15732.606684832741;15737.842621573867;15816.130112843904;7739.651715672809;9184.448933064037;9245.861312080324;9386.812263754824;9391.718248452557;7710.653020614086;7825.37397008238;9453.76365590852;9524.428534287827;9637.37357071788;4821.975890120527;4884.926726099111;4889.877753056131;4904.166291730415;4921.9507804922205;1994.8703334283225;2051.2512932779428;2051.94870128245;2068.1210485543584;2120.7137036500185;936.7189843047058;1001.5142655811925;1043;1064.669952314785;1118.7482816366253;20146.51283484358;21157.365279041653;21443.57112857734;21475.57048859014;21553.676694849277;958.3100167879115;965.7199412170391;1022.8261195596766;1045.72288343589;1072.512007036812;11033.393163376091;11487.540498380138;11504.137189710806;11530;11543.365114918592;573468;582238;641518;642884;644640;71229;73623.26376736272;73919.63040184765;106626;121714;1039.9896001040045;1046.1160319529986;1049.9527521261562;1059.9470026498643;1061.2889364126054;18377.632447351247;18902;19034.904825475784;19040.809591903904;19322.710159347902;52122.478775213276;52695.73652131715;53046.2043069362;53644;54753;74272;76072.23927760651;77101.22898771164;77717;78133.60933195525;8360.874586881324;8443.873341899754;8444.619992100248;8571.100034496289;8591.527465989431;9300.72097837066;12397;12705.42825572833;13062.281574513112;13063.281519516138;11047.889521104686;11300.982911538002;11489.310641361211;11501.309921404743;11554.306741595195;8661.437006594551;10203.642872499428;11135.610253641407;11299.604513841976;11359.943200284277;11382.37396943143;11455.427228638702;11507.769844602893;11511.366874821964;11593.246438981776;8072.273495385443;8375.95812020936;8384;8610.61252243638;8686;8360.205780450848;10765.73085672833;10916.12670986335;11595.362255076052;11951.940240298743 03:52:01 INFO - PROCESS | 1949 | |3;mootools.html;1641.0645931818863;1667.391402138219;1932.4492519631908;2008.2469074097205;2054.753429588448;8335.91664083359;8973.506457144855;9029.187373136416;9146.634134634614;9189.816203675922;8848.336374771901;8933.062028487013;8937.240334571568;8948.194662480375;9068.8639670405;2538.352720056383;2538.911138110162;2552.8468291902454;2555.7827584655233;2566.0762125634756;2531.797456203499;2578.265194419591;2580.0711743772226;2580.096966061882;2582.819202655815;2534.252395543319;2554.2592648132018;2562.3466016165944;2562.3856970108804;2596.389848385628;2558.539462896678;2560.4495033567778;2585.17274472169;2610.464854704781;2622.659054322945;2554.5657238269537;2580.974190258111;2582.1478911959007;2587.3531617095728;2604.596287575429;9153.221976132038;9186.356955013152;9217.723468295962;9218.539073046388;9246.86129708055;5524.696141712204;5609.607327487078;5673.149027645845;5701.458361455655;5728.140778883159;3574.6067932527662;3671.0271777978855;3691.0403295143187;3727.6645101940953;3730.7948062856804;905.7916679163764;915.9358844880861;1044.5195210203315;1057.7461409261798;1060.4750648428999;11932.04543636507;11945.402729863472;11956.521739130338;12363.69090772738;12384.009279257638;4906;4928.112939670894;4928.48250933654;4930.5069493050405;5023;10124.54439550222;10136.594536218616;10140.797184056277;10142.442165680959;10176.745581360377;5508.20131080991;5541.667499950016;5544.279243698294;5550.27846379968;5585.022621041383;4607.9078418431445;4934.210526315772;4996.000799840047;4999.875003124951;5109.284700141983;3646.835892384849;4169.124483858423;4186.1836941796055;4204.74771513704;4321.481422229353;1397.3781667158016;1407.6621610813331;1413.6536548545673;1424.4658253155067;1437.590286768266;866.2463656618781;883.9525162682114;912.6805618033768;920.4477313611914;983.0366241083779;5126.846194614168;6016.759329626853;6028.4272994065495;6041.063635136561;6071.3928607139815;971.7619183299995;992.5583115513527;1026.4046852825343;1047.2983101322131;1049.18163832211;3931.312020396419;4010.19796040793;4014.136960553495;4048.291548978917;4095.89760255996;9146.771330716785;10588.788224235472;10931.890681093246;11021.008109270204;11024.228304018641;10538.894611053945;10671.786564268672;10694.73263168427;10760.784784304271;10804.297720648132;8126.634301456449;8195.877061844078;8391.580420978926;8476.152384761475;8519.531425771642;5981.790637327673;5989.78888367106;6048.667323297261;6092.496814331688;6190.876182476235;9504.572294246915;9522.857157142787;9689.22486201088;9915.553800079158;9946.502674866373;9683.612655493702;10003.14973227284;10140.340877842917;10232.897671023195;10353.63762268317;6097.237845269341;6828.5220034597105;7553.962230188814;7570.242975702386;7607.543547386953;8196.467229630054;8355.206255405727;8385.748427547183;8386.993560772746;8415.789605259917;7400.666969986256;7404.259574042768;7517.436192285491;7630.8092297693;7664.041994750656;7274.30894065063;7331.340179383881;7351.448641351813;7390.482666213314;7454.366378857858;7019.824504387227;7023.297670232936;7041.894371584328;7052;7097.858042839218;4880.316755654282;4924.679895806761;4957.330760347307;4961.957988822388;4981.2030075187795;4852.878678033077;4902.436219834622;4927.940492794067;4962.627802914723;5046.419661738947 03:52:01 INFO - PROCESS | 1949 | |4;prototype.html;333.8230737709014;334.59617451524895;336.5103774008817;342.8679958216086;343.2174641816657;6207.627542347463;6417.326180751018;6908.620025898574;6916.754984102859;6947.861042779142;5285.8942821143555;5945.197398351222;6736.595804251749;7039.929600703991;7045;5077.390713114413;5085.466026067265;5089.821856235014;5098.311727916721;5119.718415487147;4464.620507256887;4674.252119660855;4848.927266090994;4894.3147959285725;5025.120603894322;3854.959161026521;4732.645051621125;4933.901321973558;4998.650094493387;5017.071841709296;4092.7544347339253;4977.153883839738;4993.775280112403;4998.500149985009;5015.824446144367;3672.981635091834;4243.087736136746;4248.87253382399;4255.978565144343;4257;6704.329567043305;6712.53012289135;6718.764843230512;6732.29310922351;6767.932320676829;5125.718085505296;5744.741486633112;5988.431099045583;6006.819795406102;6009.338972712998;6694.794936911354;6833.965830170867;7469.925300746977;7474.551526908403;7510.986016887705;4787.329773831666;4788.162071637485;4793.55528680372;4803.087413391444;4809.495003024702;7935.96032019842;8006;8016.038075430927;8023.919760802376;8037.23646253605;4838.395200599925;4841.8547443576745;4849.58778503824;4858.975705121452;4859.465458799529;4993.051320249141;5133.922991155136;5140.40885298188;5145.125328694131;5148.716820574904;5927.407259274124;5978.8206353809455;5985.25184351956;6012.158297838306;6022.518198544193;7490.325870671666;7552.546847189186;7560.58416787082;7585.279398457138;7591.089069311607;1776.209586733917;1804.9187786549637;1807.9819201808077;1808.873378863467;1814.2833580735798;965.3242730088966;1130.949107290174;1169.3802284789076;1173.2784337632295;1179.0862081886435;5045.798168073309;6240.84544359295;6982.1272340957385;7066.364027237573;7118.394936430358;7823.56970366624;7825.647845846951;7846.607669616496;7863.13505514393;7902.3678105751405;6889.931100688929;7017.7192912282935;7138.607376594233;7152.606606636685;7164.9641751790905;4140.23405669952;4176.14389050244;4185.162967406531;4185.6232939035635;4190.811413486401;8201.79495512605;8236.711715089943;8257.587120643944;8284.71003514886;8301.501909885426;6570.704318305688;8206.261436470626;8226.095129535746;8232.50604963704;8239.382046346547;6697;7883.724069657649;8241.423100382915;8336.166383361615;8357.331413487029;7913.525188488709;7942.205779422012;7960.721374751856;7963.402744794048;7977.521348719096;5473;6750.898736519054;7486.4759466836795;7830.647620856961;7852.1755215703815;6989;7874.21257874208;7962.960185199037;8306.54314012735;8312.792180195544;4830.430110214124;4881.633877459134;4885.926711099408;4887.3890763654545;4896.6572339935865;6376.266729326001;7872.055353357634;7892.802679933047;7901.644426000728;7903.288704016666;6897.793066208022;7633.5419874807685;7640.579768112807;7667.463277570517;7696.807579810549;7394.889076663747;7605.353544948742;7609.505382150142;7613.238676132342;7628.122765881994;7408.111026676834;7452.739154129797;7469.626518674153;7478.326950574475;7505.587192704454;7647.120581133018;7648.464607477423;7653.540787552764;7654.081510218809;7675.961620191863;7484.887726684213;7488.101427828696;7490.325870671666;7496.512726672749;7542.321191092828 03:52:01 INFO - PROCESS | 1949 | |5;yui.html;745.1244787374836;769.1347234361343;777.5606782168076;787.9361523937897;790.9288164065233;15313;15718.292676829542;15907.284172212248;15941.442049528268;16010.519684409472;14368.353424095914;14423.63940901478;14452.710945781078;14480.05879617824;14514.419423223086;773.8877862709903;934.3272843552631;955.1260596554145;975.7853272280087;976.9316147869652;929.4841363043508;958.290864760076;969.3311614985672;969.46194861852;971.7473456901186;981.3228872078279;1007.4912169354466;1020.8162530744463;1028.8045271398448;1031.1647565471992;975.7755716185281;984.6061575369838;1020.0309705779539;1021.9984415273;1027.5838285494349;634.8635043465631;731.6012773038653;749.071151771799;770.7032792374976;771.7221800151941;12509.437075331633;15372.30824612895;15374.077555346716;15412.537623871189;15472.303746331441;13464.730705385935;13504.729905401935;13518.729625407535;13534.120282181626;13616.727665446635;10439.634612788515;10503.317284376568;10579.576816927314;10586.41774702391;10664.893351066545;3630.2376500934834;3635.509206257148;3646.47126166707;3672.467492213641;3695.7896886471476;84071;85159.14840851574;85322;85864;86575;9946.502674866228;9981.900180998242;10083.949580252052;10101.848472272923;10308.639197628198;23602.17392391258;23664.408389790395;23666.64500032501;23697.526049478915;23715.525689486458;7004.474664400191;7745.341645960044;7782.377409807202;7847;7940;3311.7516186286125;3540.6105328413855;4135.441715368447;4247.044415006599;4256.851010214627;3681.834317455721;3750.568684601306;3753.2868754936476;3755.887323380303;3756.6055564165918;593.8568256106977;618.1623899615955;671.5970417749311;673.0745225315192;676.7090151234918;446.3240531803059;522.0186050225552;562.6680258647336;580.422479632768;615.1603061820672;7012.597480503818;8087.959560202279;8550.657973680984;8581.227689507974;8662.436941598777;585.525724163429;619.2320328133237;620.219968689863;635.5678138865524;643.6588608037747;3951.7431366961055;4001.639852413297;4035.7376770509823;4062.309407400749;4105.794710264475;94547.52726236325;96468;97471;97863;99397.50903736449;78245;78918.6054069726;81774.59112704398;83158;83764;57663.84672306614;71401.28598713946;72575;73183.63408183031;74582;7055.259197784364;8768.386212965032;8881.467111973303;8933.017368089375;8941.508217048126;48713.26930095981;49557.752211238716;50190;50388.49611503838;51281;68539.62920741657;69206;71178.93231601427;71186;71968;10922.966849511015;11139.443027848412;11299.152563557602;11494.310341379543;11646.301221926711;12228.08289378318;12245.387730613611;12395.070369722127;12457.377131143225;12628.936855315664;11442.141839361915;11816.46825892854;11893.524259029888;11949.402529873645;12058.019046858228;9936.354136981074;11896.58361957362;11899.405029748305;11906.698266184358;11982.820257696316;11296.717582060513;11371.31772093677;11375.943120284346;11628.418579071182;11628.476718547854;9860.260480464138;9877.654282100091;9954.153896918842;9970.700878973643;10148.54331555067;9774.218062555121;9992.350497217658;10037.046480584333;10053.413112844557;10081.294309398272 03:52:01 INFO - PROCESS | 1949 | __end_tp_report 03:52:01 INFO - PROCESS | 1949 | __start_cc_report 03:52:01 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,392 03:52:01 INFO - PROCESS | 1949 | __end_cc_report 03:52:01 INFO - PROCESS | 1949 | __startTimestamp1467543121390__endTimestamp 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | ------- Summary: start ------- 03:52:01 INFO - PROCESS | 1949 | Number of tests: 6 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | [#0] dojo.html Cycles:165 Average:5827.76 Median:6112.59 stddev:647.82 (10.6%) stddev-sans-first:624.72 03:52:01 INFO - PROCESS | 1949 | Values: 3552.2 3590.9 3609.0 3635.4 3640.2 5893.9 5914.9 5957.9 5964.0 5971.8 5673.9 5930.6 5932.0 5950.3 5960.6 5270.5 5271.4 5314.3 5322.8 5446.7 5226.1 5289.7 5329.1 5332.5 5424.7 4455.6 5317.9 5332.1 5345.9 5347.0 5279.4 5319.9 5345.1 5347.2 5358.3 5159.7 5199.1 5268.7 5323.0 5349.5 5768.2 5771.9 5792.5 5793.8 5799.2 5132.2 6130.4 6131.1 6195.2 6239.9 6255.4 6268.2 6273.4 6273.6 6383.6 5911.3 5988.4 5993.8 6001.2 6023.8 6237.8 6265.9 6283.1 6302.9 6331.6 6183.4 6199.1 6204.4 6214.1 6214.2 6112.6 6278.7 6279.6 6291.9 6308.9 6166.1 6191.6 6240.7 6257.9 6259.2 5483.5 5835.6 6236.9 6249.3 6259.4 4101.2 4334.1 4962.3 4964.5 5012.5 4493.6 4523.8 4542.0 4559.3 4593.1 5609.8 5814.5 5976.8 6003.2 6082.2 6164.0 6226.5 6260.1 6265.3 6340.6 5927.4 6008.3 6113.1 6117.3 6142.2 5527.4 5567.3 5591.4 5595.5 5601.9 6399.1 6446.6 6484.6 6602.7 6636.1 6289.8 6333.6 6344.0 6362.3 6378.9 6570.1 6582.2 6616.0 6621.5 6631.2 5305.3 6086.1 6121.3 6226.4 6242.7 6185.4 6263.1 6269.4 6276.6 6282.6 6249.3 6257.4 6257.7 6273.3 6284.8 6024.4 6110.4 6182.3 6261.3 6300.2 5296.9 5979.8 6069.5 6132.3 6143.0 6126.8 6141.9 6226.3 6245.5 6268.0 6129.9 6209.0 6213.7 6219.0 6230.1 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | [#1] ext.html Cycles:180 Average:63800.69 Median:38875.92 stddev:136610.07 (351.4%) stddev-sans-first:136910.68 03:52:01 INFO - PROCESS | 1949 | Values: 520.8 564.1 566.6 573.7 609.1 37850.6 38493.6 38999.6 39101.6 39308.6 40893.2 41102.2 41206.4 41537.4 42139.4 9672.4 9793.8 9848.5 9904.9 9911.9 9710.6 9871.5 9890.4 9907.9 9939.3 9890.8 9914.7 9914.8 9922.8 9960.0 9875.0 9878.4 9878.8 9898.8 9966.0 8954.6 9117.1 9856.0 9938.7 9980.5 28644.7 39734.6 39794.8 39849.4 40378.6 3285.6 3429.5 3502.8 3811.0 4031.9 28538.7 29364.6 29883.6 29985.6 30012.5 2633.3 2669.9 2805.9 2839.8 2939.1 404226.0 408615.0 409598.0 409710.0 410807.0 37452.4 37985.0 53765.7 63426.7 64238.4 35489.3 36166.1 36355.5 36392.3 36454.6 15648.8 16030.9 16079.9 16182.4 16220.1 13677.3 13688.5 13720.2 13767.7 13783.5 8232.8 8307.7 8388.8 8456.7 8526.8 3523.5 3558.1 3559.9 3590.7 3604.2 993.4 1045.2 1050.3 1180.2 1211.2 22318.6 30659.0 30746.8 30983.5 31421.0 1110.8 1137.2 1157.7 1271.2 1293.4 15659.5 15851.9 15925.4 16051.6 16281.3 578333.1 581313.0 583523.0 584609.0 588650.0 59434.7 61024.7 61815.7 61923.4 61965.7 1534.1 1547.7 1549.5 1563.9 1577.8 29880.0 30189.6 30930.1 31009.7 31034.2 51280.5 52448.7 52659.0 52673.7 52892.0 511509.0 529512.4 532370.0 532518.0 534433.0 26555.9 26867.5 27101.0 27603.0 27840.9 46515.3 46919.8 46958.8 47896.5 48475.8 38165.0 38931.0 39066.4 39171.0 39173.6 38064.2 38445.4 38608.8 38997.4 39195.6 37932.2 38370.0 38558.4 38820.8 39416.0 32987.3 34326.7 34549.5 34777.5 34852.0 25547.6 25903.4 25976.0 25982.5 26286.3 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | [#2] jquery.html Cycles:180 Average:33818.86 Median:22054.78 stddev:101853.95 (461.8%) stddev-sans-first:102108.79 03:52:01 INFO - PROCESS | 1949 | Values: 413.4 414.1 417.6 423.8 429.3 20496.2 21132.7 21149.7 21241.6 22097.0 12385.4 12768.2 17679.0 21980.7 22012.6 5121.4 5380.5 5681.2 6222.8 6236.0 6106.1 6179.5 6200.6 6218.5 6246.7 5539.1 5549.2 5675.8 5795.9 6201.1 5499.9 5510.1 5542.9 5627.1 5636.5 5303.5 5371.2 5489.7 5521.6 5533.3 14041.9 14292.8 15181.0 26436.2 26779.7 2143.6 2242.5 2250.5 2337.6 2606.6 9584.9 10111.8 10260.5 10353.3 10377.1 1787.2 1790.9 1834.0 1838.7 1873.4 95323.5 99140.5 100465.5 102399.0 103128.0 10114.4 11670.6 12064.2 12145.5 12211.9 15390.8 15568.3 15732.6 15737.8 15816.1 7739.7 9184.4 9245.9 9386.8 9391.7 7710.7 7825.4 9453.8 9524.4 9637.4 4822.0 4884.9 4889.9 4904.2 4922.0 1994.9 2051.3 2051.9 2068.1 2120.7 936.7 1001.5 1043.0 1064.7 1118.7 20146.5 21157.4 21443.6 21475.6 21553.7 958.3 965.7 1022.8 1045.7 1072.5 11033.4 11487.5 11504.1 11530.0 11543.4 573468.0 582238.0 641518.0 642884.0 644640.0 71229.0 73623.3 73919.6 106626.0 121714.0 1040.0 1046.1 1050.0 1059.9 1061.3 18377.6 18902.0 19034.9 19040.8 19322.7 52122.5 52695.7 53046.2 53644.0 54753.0 74272.0 76072.2 77101.2 77717.0 78133.6 8360.9 8443.9 8444.6 8571.1 8591.5 9300.7 12397.0 12705.4 13062.3 13063.3 11047.9 11301.0 11489.3 11501.3 11554.3 8661.4 10203.6 11135.6 11299.6 11359.9 11382.4 11455.4 11507.8 11511.4 11593.2 8072.3 8376.0 8384.0 8610.6 8686.0 8360.2 10765.7 10916.1 11595.4 11951.9 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | [#3] mootools.html Cycles:180 Average:5829.43 Median:4959.64 stddev:3187.27 (64.3%) stddev-sans-first:3180.67 03:52:01 INFO - PROCESS | 1949 | Values: 1641.1 1667.4 1932.4 2008.2 2054.8 8335.9 8973.5 9029.2 9146.6 9189.8 8848.3 8933.1 8937.2 8948.2 9068.9 2538.4 2538.9 2552.8 2555.8 2566.1 2531.8 2578.3 2580.1 2580.1 2582.8 2534.3 2554.3 2562.3 2562.4 2596.4 2558.5 2560.4 2585.2 2610.5 2622.7 2554.6 2581.0 2582.1 2587.4 2604.6 9153.2 9186.4 9217.7 9218.5 9246.9 5524.7 5609.6 5673.1 5701.5 5728.1 3574.6 3671.0 3691.0 3727.7 3730.8 905.8 915.9 1044.5 1057.7 1060.5 11932.0 11945.4 11956.5 12363.7 12384.0 4906.0 4928.1 4928.5 4930.5 5023.0 10124.5 10136.6 10140.8 10142.4 10176.7 5508.2 5541.7 5544.3 5550.3 5585.0 4607.9 4934.2 4996.0 4999.9 5109.3 3646.8 4169.1 4186.2 4204.7 4321.5 1397.4 1407.7 1413.7 1424.5 1437.6 866.2 884.0 912.7 920.4 983.0 5126.8 6016.8 6028.4 6041.1 6071.4 971.8 992.6 1026.4 1047.3 1049.2 3931.3 4010.2 4014.1 4048.3 4095.9 9146.8 10588.8 10931.9 11021.0 11024.2 10538.9 10671.8 10694.7 10760.8 10804.3 8126.6 8195.9 8391.6 8476.2 8519.5 5981.8 5989.8 6048.7 6092.5 6190.9 9504.6 9522.9 9689.2 9915.6 9946.5 9683.6 10003.1 10140.3 10232.9 10353.6 6097.2 6828.5 7554.0 7570.2 7607.5 8196.5 8355.2 8385.7 8387.0 8415.8 7400.7 7404.3 7517.4 7630.8 7664.0 7274.3 7331.3 7351.4 7390.5 7454.4 7019.8 7023.3 7041.9 7052.0 7097.9 4880.3 4924.7 4957.3 4962.0 4981.2 4852.9 4902.4 4927.9 4962.6 5046.4 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | [#4] prototype.html Cycles:180 Average:6072.73 Median:6759.42 stddev:2003.02 (29.6%) stddev-sans-first:1961.77 03:52:01 INFO - PROCESS | 1949 | Values: 333.8 334.6 336.5 342.9 343.2 6207.6 6417.3 6908.6 6916.8 6947.9 5285.9 5945.2 6736.6 7039.9 7045.0 5077.4 5085.5 5089.8 5098.3 5119.7 4464.6 4674.3 4848.9 4894.3 5025.1 3855.0 4732.6 4933.9 4998.7 5017.1 4092.8 4977.2 4993.8 4998.5 5015.8 3673.0 4243.1 4248.9 4256.0 4257.0 6704.3 6712.5 6718.8 6732.3 6767.9 5125.7 5744.7 5988.4 6006.8 6009.3 6694.8 6834.0 7469.9 7474.6 7511.0 4787.3 4788.2 4793.6 4803.1 4809.5 7936.0 8006.0 8016.0 8023.9 8037.2 4838.4 4841.9 4849.6 4859.0 4859.5 4993.1 5133.9 5140.4 5145.1 5148.7 5927.4 5978.8 5985.3 6012.2 6022.5 7490.3 7552.5 7560.6 7585.3 7591.1 1776.2 1804.9 1808.0 1808.9 1814.3 965.3 1130.9 1169.4 1173.3 1179.1 5045.8 6240.8 6982.1 7066.4 7118.4 7823.6 7825.6 7846.6 7863.1 7902.4 6889.9 7017.7 7138.6 7152.6 7165.0 4140.2 4176.1 4185.2 4185.6 4190.8 8201.8 8236.7 8257.6 8284.7 8301.5 6570.7 8206.3 8226.1 8232.5 8239.4 6697.0 7883.7 8241.4 8336.2 8357.3 7913.5 7942.2 7960.7 7963.4 7977.5 5473.0 6750.9 7486.5 7830.6 7852.2 6989.0 7874.2 7963.0 8306.5 8312.8 4830.4 4881.6 4885.9 4887.4 4896.7 6376.3 7872.1 7892.8 7901.6 7903.3 6897.8 7633.5 7640.6 7667.5 7696.8 7394.9 7605.4 7609.5 7613.2 7628.1 7408.1 7452.7 7469.6 7478.3 7505.6 7647.1 7648.5 7653.5 7654.1 7676.0 7484.9 7488.1 7490.3 7496.5 7542.3 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - PROCESS | 1949 | [#5] yui.html Cycles:180 Average:18952.68 Median:49873.88 stddev:26723.56 (53.6%) stddev-sans-first:26763.55 03:52:01 INFO - PROCESS | 1949 | Values: 745.1 769.1 777.6 787.9 790.9 15313.0 15718.3 15907.3 15941.4 16010.5 14368.4 14423.6 14452.7 14480.1 14514.4 773.9 934.3 955.1 975.8 976.9 929.5 958.3 969.3 969.5 971.7 981.3 1007.5 1020.8 1028.8 1031.2 975.8 984.6 1020.0 1022.0 1027.6 634.9 731.6 749.1 770.7 771.7 12509.4 15372.3 15374.1 15412.5 15472.3 13464.7 13504.7 13518.7 13534.1 13616.7 10439.6 10503.3 10579.6 10586.4 10664.9 3630.2 3635.5 3646.5 3672.5 3695.8 84071.0 85159.1 85322.0 85864.0 86575.0 9946.5 9981.9 10083.9 10101.8 10308.6 23602.2 23664.4 23666.6 23697.5 23715.5 7004.5 7745.3 7782.4 7847.0 7940.0 3311.8 3540.6 4135.4 4247.0 4256.9 3681.8 3750.6 3753.3 3755.9 3756.6 593.9 618.2 671.6 673.1 676.7 446.3 522.0 562.7 580.4 615.2 7012.6 8088.0 8550.7 8581.2 8662.4 585.5 619.2 620.2 635.6 643.7 3951.7 4001.6 4035.7 4062.3 4105.8 94547.5 96468.0 97471.0 97863.0 99397.5 78245.0 78918.6 81774.6 83158.0 83764.0 57663.8 71401.3 72575.0 73183.6 74582.0 7055.3 8768.4 8881.5 8933.0 8941.5 48713.3 49557.8 50190.0 50388.5 51281.0 68539.6 69206.0 71178.9 71186.0 71968.0 10923.0 11139.4 11299.2 11494.3 11646.3 12228.1 12245.4 12395.1 12457.4 12628.9 11442.1 11816.5 11893.5 11949.4 12058.0 9936.4 11896.6 11899.4 11906.7 11982.8 11296.7 11371.3 11375.9 11628.4 11628.5 9860.3 9877.7 9954.2 9970.7 10148.5 9774.2 9992.4 10037.0 10053.4 10081.3 03:52:01 INFO - PROCESS | 1949 | -------- Summary: end -------- 03:52:01 INFO - PROCESS | 1949 | 03:52:01 INFO - TEST-INFO | 1949: exit 0 03:52:01 INFO - TEST-OK | dromaeo_css | took 1109627ms 03:52:01 INFO - TEST-START | kraken 03:52:01 INFO - operating with platform_type : mac_ 03:52:01 INFO - Initialising browser for kraken test... 03:52:01 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpBLFWez/profile http://localhost:55836/getInfo.html) 03:52:04 INFO - PROCESS | 1982 | __metrics Screen width/height:1600/1200 03:52:04 INFO - PROCESS | 1982 | colorDepth:24 03:52:04 INFO - PROCESS | 1982 | Browser inner width/height: 1024/689 03:52:04 INFO - PROCESS | 1982 | __metrics 03:52:04 ERROR - PROCESS | 1982 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 03:52:05 INFO - TEST-INFO | 1982: exit 0 03:52:05 INFO - Browser initialized. 03:52:05 INFO - Running cycle 1/1 for kraken test... 03:52:05 INFO - TEST-INFO | started process 1986 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/T/tmpBLFWez/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:52:17 INFO - PROCESS | 1986 | RSS: Main: 171065344 03:52:17 INFO - PROCESS | 1986 | 03:52:19 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55836/tests/kraken/driver.html?testName=audio-beat-detection) 03:52:20 INFO - PROCESS | 1986 | RSS: Main: 183754752 03:52:20 INFO - PROCESS | 1986 | 03:52:23 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55836/tests/kraken/driver.html?testName=audio-dft) 03:52:23 INFO - PROCESS | 1986 | RSS: Main: 192958464 03:52:23 INFO - PROCESS | 1986 | 03:52:27 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55836/tests/kraken/driver.html?testName=audio-fft) 03:52:27 INFO - PROCESS | 1986 | RSS: Main: 196489216 03:52:27 INFO - PROCESS | 1986 | 03:52:29 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55836/tests/kraken/driver.html?testName=audio-oscillator) 03:52:30 INFO - PROCESS | 1986 | RSS: Main: 196624384 03:52:30 INFO - PROCESS | 1986 | 03:52:32 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55836/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:32 INFO - PROCESS | 1986 | RSS: Main: 197734400 03:52:32 INFO - PROCESS | 1986 | 03:52:35 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55836/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:36 INFO - PROCESS | 1986 | RSS: Main: 198656000 03:52:36 INFO - PROCESS | 1986 | 03:52:39 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55836/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:39 INFO - PROCESS | 1986 | RSS: Main: 198524928 03:52:39 INFO - PROCESS | 1986 | 03:52:42 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55836/tests/kraken/driver.html?testName=json-parse-financial) 03:52:43 INFO - PROCESS | 1986 | RSS: Main: 198676480 03:52:43 INFO - PROCESS | 1986 | 03:52:44 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55836/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:45 INFO - PROCESS | 1986 | RSS: Main: 197550080 03:52:45 INFO - PROCESS | 1986 | 03:52:47 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:47 INFO - PROCESS | 1986 | RSS: Main: 197718016 03:52:47 INFO - PROCESS | 1986 | 03:52:49 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:50 INFO - PROCESS | 1986 | RSS: Main: 197976064 03:52:50 INFO - PROCESS | 1986 | 03:52:53 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:53 INFO - PROCESS | 1986 | RSS: Main: 198807552 03:52:53 INFO - PROCESS | 1986 | 03:52:56 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:57 INFO - PROCESS | 1986 | RSS: Main: 198189056 03:52:57 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | Cycle 1(1): loaded http://localhost:55836/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55836/tests/kraken/driver.html?testName=ai-astar) 03:52:59 INFO - PROCESS | 1986 | RSS: Main: 199958528 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | __start_tp_report 03:52:59 INFO - PROCESS | 1986 | _x_x_mozilla_page_load 03:52:59 INFO - PROCESS | 1986 | _x_x_mozilla_page_load_details 03:52:59 INFO - PROCESS | 1986 | |i|pagename|runs| 03:52:59 INFO - PROCESS | 1986 | |0;ai-astar;113;119;108;114;121;116;106;118;116;116 03:52:59 INFO - PROCESS | 1986 | |1;audio-beat-detection;191;134;142;166;123;140;118;157;159;117 03:52:59 INFO - PROCESS | 1986 | |2;audio-dft;196;197;194;199;200;192;196;193;199;201 03:52:59 INFO - PROCESS | 1986 | |3;audio-fft;63;69;80;143;57;56;56;68;124;57 03:52:59 INFO - PROCESS | 1986 | |4;audio-oscillator;75;83;126;76;87;96;132;70;77;142 03:52:59 INFO - PROCESS | 1986 | |5;imaging-gaussian-blur;88;85;88;85;89;100;107;90;88;85 03:52:59 INFO - PROCESS | 1986 | |6;imaging-darkroom;116;90;143;142;94;94;96;95;94;94 03:52:59 INFO - PROCESS | 1986 | |7;imaging-desaturate;90;100;90;93;90;89;91;91;90;89 03:52:59 INFO - PROCESS | 1986 | |8;json-parse-financial;58;63;65;64;65;65;63;79;63;60 03:52:59 INFO - PROCESS | 1986 | |9;json-stringify-tinderbox;61;69;65;72;76;80;74;70;66;68 03:52:59 INFO - PROCESS | 1986 | |10;stanford-crypto-aes;81;79;82;81;81;98;79;80;85;82 03:52:59 INFO - PROCESS | 1986 | |11;stanford-crypto-ccm;144;150;115;153;128;162;110;149;171;152 03:52:59 INFO - PROCESS | 1986 | |12;stanford-crypto-pbkdf2;162;162;172;166;161;159;164;156;157;180 03:52:59 INFO - PROCESS | 1986 | |13;stanford-crypto-sha256-iterative;70;82;93;93;96;93;89;68;69;67 03:52:59 INFO - PROCESS | 1986 | __end_tp_report 03:52:59 INFO - PROCESS | 1986 | __start_cc_report 03:52:59 INFO - PROCESS | 1986 | _x_x_mozilla_cycle_collect,1045 03:52:59 INFO - PROCESS | 1986 | __end_cc_report 03:52:59 INFO - PROCESS | 1986 | __startTimestamp1467543179435__endTimestamp 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | ------- Summary: start ------- 03:52:59 INFO - PROCESS | 1986 | Number of tests: 14 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#0] ai-astar Cycles:10 Average:114.70 Median:116.00 stddev:4.69 (4.0%) stddev-sans-first:4.94 03:52:59 INFO - PROCESS | 1986 | Values: 113.0 119.0 108.0 114.0 121.0 116.0 106.0 118.0 116.0 116.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:149.50 stddev:23.68 (15.8%) stddev-sans-first:18.26 03:52:59 INFO - PROCESS | 1986 | Values: 191.0 134.0 142.0 166.0 123.0 140.0 118.0 157.0 159.0 117.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#2] audio-dft Cycles:10 Average:196.70 Median:198.00 stddev:3.06 (1.5%) stddev-sans-first:3.23 03:52:59 INFO - PROCESS | 1986 | Values: 196.0 197.0 194.0 199.0 200.0 192.0 196.0 193.0 199.0 201.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#3] audio-fft Cycles:10 Average:77.30 Median:60.00 stddev:30.91 (51.5%) stddev-sans-first:32.34 03:52:59 INFO - PROCESS | 1986 | Values: 63.0 69.0 80.0 143.0 57.0 56.0 56.0 68.0 124.0 57.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:76.50 stddev:26.75 (35.0%) stddev-sans-first:27.22 03:52:59 INFO - PROCESS | 1986 | Values: 75.0 83.0 126.0 76.0 87.0 96.0 132.0 70.0 77.0 142.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:88.00 stddev:7.26 (8.3%) stddev-sans-first:7.64 03:52:59 INFO - PROCESS | 1986 | Values: 88.0 85.0 88.0 85.0 89.0 100.0 107.0 90.0 88.0 85.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#6] imaging-darkroom Cycles:10 Average:105.80 Median:94.00 stddev:20.60 (21.9%) stddev-sans-first:21.51 03:52:59 INFO - PROCESS | 1986 | Values: 116.0 90.0 143.0 142.0 94.0 94.0 96.0 95.0 94.0 94.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:90.00 stddev:3.27 (3.6%) stddev-sans-first:3.43 03:52:59 INFO - PROCESS | 1986 | Values: 90.0 100.0 90.0 93.0 90.0 89.0 91.0 91.0 90.0 89.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.50 stddev:5.58 (8.7%) stddev-sans-first:5.40 03:52:59 INFO - PROCESS | 1986 | Values: 58.0 63.0 65.0 64.0 65.0 65.0 63.0 79.0 63.0 60.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:5.61 (7.9%) stddev-sans-first:4.88 03:52:59 INFO - PROCESS | 1986 | Values: 61.0 69.0 65.0 72.0 76.0 80.0 74.0 70.0 66.0 68.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:81.50 stddev:5.61 (6.9%) stddev-sans-first:5.92 03:52:59 INFO - PROCESS | 1986 | Values: 81.0 79.0 82.0 81.0 81.0 98.0 79.0 80.0 85.0 82.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:151.00 stddev:19.74 (13.1%) stddev-sans-first:20.94 03:52:59 INFO - PROCESS | 1986 | Values: 144.0 150.0 115.0 153.0 128.0 162.0 110.0 149.0 171.0 152.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.90 Median:163.00 stddev:7.29 (4.5%) stddev-sans-first:7.70 03:52:59 INFO - PROCESS | 1986 | Values: 162.0 162.0 172.0 166.0 161.0 159.0 164.0 156.0 157.0 180.0 03:52:59 INFO - PROCESS | 1986 | 03:52:59 INFO - PROCESS | 1986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:82.00 Median:91.00 stddev:12.21 (13.4%) stddev-sans-first:12.16 03:52:59 INFO - PROCESS | 1986 | Values: 70.0 82.0 93.0 93.0 96.0 93.0 89.0 68.0 69.0 67.0 03:52:59 INFO - PROCESS | 1986 | -------- Summary: end -------- 03:52:59 INFO - PROCESS | 1986 | 03:53:00 INFO - TEST-INFO | 1986: exit 0 03:53:00 INFO - TEST-OK | kraken | took 58311ms 03:53:00 INFO - SUITE-END | took 1167s 03:53:00 INFO - Completed test suite (00:19:28) 03:53:00 INFO - javascript benchmark 03:53:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3552.2007548301635, 3590.910227244319, 3608.9639103608956, 3635.4001589737677, 3640.1627625646115, 5893.85265368366, 5914.88170236595, 5957.940420595793, 5964.0, 5971.790987315439, 5673.943260567393, 5930.614510056843, 5932.0, 5950.285965684124, 5960.5529585281065, 5270.472952704718, 5271.367435907697, 5314.282571852808, 5322.760475778599, 5446.7276636168235, 5226.137687281594, 5289.68261904285, 5329.120695085307, 5332.520073193431, 5424.674519528841, 4455.643548516127, 5317.9468205318035, 5332.093544097513, 5345.866353341178, 5346.973265133669, 5279.366476022902, 5319.867003324909, 5345.091334473149, 5347.224652425396, 5358.33020872391, 5159.69041857486, 5199.142141546678, 5268.736563171826, 5322.973385133088, 5349.51854333108, 5768.221290125821, 5771.913421298684, 5792.478676919055, 5793.768249270024, 5799.246098007275, 5132.204508301219, 6130.398136742002, 6131.132004888173, 6195.19405549007, 6239.875202495925, 6255.437010669061, 6268.153799237136, 6273.404026617464, 6273.6235825850135, 6383.553151279412, 5911.29064512257, 5988.401159884021, 5993.820185394445, 6001.159837622737, 6023.819285421444, 6237.781677641261, 6265.8746825063245, 6283.08895210192, 6302.873942521124, 6331.620102793847, 6183.3816618337805, 6199.101130336076, 6204.441600255998, 6214.067889816563, 6214.161088253028, 6112.5946701277735, 6278.654673992883, 6279.560430769802, 6291.898917689386, 6308.873822523524, 6166.136740856284, 6191.628502289877, 6240.719167637467, 6257.906131408033, 6259.2488901332135, 5483.506484416422, 5835.649861008353, 6236.875262494725, 6249.281332646713, 6259.436650701458, 4101.200265948111, 4334.068175342317, 4962.255661650781, 4964.503549645006, 5012.523810238022, 4493.550644935545, 4523.773811309421, 4542.0, 4559.316102584638, 4593.127305811952, 5609.821937393193, 5814.476697097281, 5976.820695379146, 6003.219581454383, 6082.2093127893095, 6164.0, 6226.533010024175, 6260.060990851409, 6265.27949285838, 6340.556161068681, 5927.436893495111, 6008.279006519246, 6113.11552912485, 6117.3402608778015, 6142.170806941095, 5527.44725527444, 5567.331920169606, 5591.440855914376, 5595.468430499096, 5601.943980560142, 6399.13611662429, 6446.580972236883, 6484.643344616092, 6602.735890564323, 6636.13730215069, 6289.779857704958, 6333.619982801047, 6344.0, 6362.268339141058, 6378.936210637834, 6570.145881035435, 6582.210134783857, 6616.040674102324, 6621.5364924454825, 6631.171103612049, 5305.336832895888, 6086.056661217518, 6121.30055227174, 6226.408491193511, 6242.65665388408, 6185.350538193425, 6263.060540918898, 6269.404406581368, 6276.592021518587, 6282.560220784501, 6249.312575616587, 6257.374262573706, 6257.7184026719815, 6273.309935906956, 6284.842878928063, 6024.367441418588, 6110.419510146529, 6182.28903676083, 6261.279952805486, 6300.243970723543, 5296.894062118659, 5979.820605381671, 6069.51443884497, 6132.2947860996555, 6143.0, 6126.816195514141, 6141.907871382022, 6226.25284965807, 6245.531585131042, 6268.028455589391, 6129.938700612936, 6209.0, 6213.720382582705, 6218.973869311513, 6230.096635987847], "value": 5788.664857754693, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [520.8020952038225, 564.1481363141656, 566.586391933888, 573.6988081257342, 609.1319869186408, 37850.62149378509, 38493.61506384936, 38999.61000389999, 39101.608983910155, 39308.60691393085, 40893.18213635725, 41102.17795644093, 41206.38190427146, 41537.37693934586, 42139.367909481305, 9672.371295865763, 9793.804123917518, 9848.458334791583, 9904.851427228561, 9911.851322230172, 9710.563024663872, 9871.457069861155, 9890.406575605452, 9907.900920990805, 9939.304248702558, 9890.752731181707, 9914.652987145451, 9914.801703965917, 9922.751931201705, 9960.003999600054, 9875.0, 9878.407295562289, 9878.802423951553, 9898.802023959517, 9965.950170249138, 8954.59704313301, 9117.133872282122, 9856.0, 9938.652147174815, 9980.451075190862, 28644.71355286462, 39734.60265397338, 39794.80102599497, 39849.40225896585, 40378.59621403807, 3285.589301337333, 3429.5198672185916, 3502.824858757052, 3810.9519882032387, 4031.879043628696, 28538.71461285381, 29364.559531607043, 29883.551746723817, 29985.55021674655, 30012.54981175284, 2633.3285012321926, 2669.853158076305, 2805.90179343722, 2839.801213915027, 2939.088882446427, 404226.0, 408615.0, 409598.0, 409710.0, 410807.0, 37452.43821342682, 37985.0, 53765.655858603845, 63426.68286658537, 64238.357616424175, 35489.29021419557, 36166.09584760402, 36355.45466818, 36392.27215455729, 36454.63545364566, 15648.765268520981, 16030.919845400931, 16079.919600401923, 16182.433614823425, 16220.107894065939, 13677.31613419325, 13688.52090176839, 13720.245386503639, 13767.655808604864, 13783.51757688476, 8232.794180145544, 8307.667693292322, 8388.832223355499, 8456.704015359433, 8526.786830329167, 3523.5067090607336, 3558.1460449491938, 3559.911002224965, 3590.7486475946434, 3604.18905746205, 993.3741742702196, 1045.2405649086418, 1050.3172937590627, 1180.2092597959388, 1211.2308683985557, 22318.55362892733, 30659.0, 30746.846265768527, 30983.535246971314, 31421.0, 1110.7722916802036, 1137.2437329176005, 1157.745296034871, 1271.192792576702, 1293.359786905488, 15659.451919183002, 15851.920740396225, 15925.442609508611, 16051.598710032342, 16281.348746050262, 578333.1083344556, 581313.0, 583523.0, 584609.0, 588650.0, 59434.70282648559, 61024.69487652533, 61815.6909215451, 61923.38076619176, 61965.69017154976, 1534.1408811065617, 1547.6981988512132, 1549.473179119105, 1563.8514341137575, 1577.8106627204809, 29880.0, 30189.622005146877, 30930.0720978371, 31009.689903101582, 31034.224144396572, 51280.48719512906, 52448.73775631098, 52659.0, 52673.7366313166, 52892.0, 511509.0, 529512.3524382353, 532370.0, 532518.0, 534433.0, 26555.867220663775, 26867.462650747268, 27101.0, 27603.0, 27840.86079569589, 46515.30227046529, 46919.76540117278, 46958.76520617375, 47896.5210347906, 48475.75762121167, 38165.0, 38931.0, 39066.414003789396, 39171.0, 39173.60826391813, 38064.23871522609, 38445.423318649686, 38608.80695596504, 38997.415038775005, 39195.608043919194, 37932.2413551733, 38370.0, 38558.42162367623, 38820.8353749388, 39416.0, 32987.34025319528, 34326.656733433345, 34549.48175777315, 34777.47833782546, 34851.9544413668, 25547.616785747858, 25903.352416189748, 25976.0, 25982.480350392507, 26286.342841429116], "value": 18894.064230585365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.35929309570156, 414.1075981260384, 417.64082888715683, 423.77751680367805, 429.2830972276298, 20496.180152793888, 21132.683009754866, 21149.73101613904, 21241.57516849662, 22097.0, 12385.44265508052, 12768.233905965626, 17679.0, 21980.670289945665, 22012.559748805015, 5121.385433747937, 5380.542653874416, 5681.233033540481, 6222.782202622909, 6236.03341482071, 6106.084087386906, 6179.474744646711, 6200.565960382775, 6218.502519798405, 6246.656433896134, 5539.058360078776, 5549.223108764776, 5675.829725108253, 5795.942040579604, 6201.1008403781425, 5499.862503437406, 5510.118381059051, 5542.86142846428, 5627.099664053752, 5636.549076073925, 5303.4696530346655, 5371.248025276464, 5489.725513724298, 5521.558275337963, 5533.253010843525, 14041.859581404158, 14292.785608215885, 15181.0, 26436.206913792616, 26779.73220267792, 2143.614149453098, 2242.473018840571, 2250.493638931244, 2337.555864385761, 2606.5699159638825, 9584.856227156599, 10111.797764044677, 10260.486975651262, 10353.327033742782, 10377.117944974687, 1787.1868299923503, 1790.85673146148, 1834.0462959261242, 1838.678772294733, 1873.3536929759211, 95323.52338238334, 99140.50429747805, 100465.49767251116, 102399.0, 103127.96872031258, 10114.443705596263, 11670.649880503599, 12064.155509114453, 12145.514179432901, 12211.877881221075, 15390.84609153894, 15568.299426525833, 15732.606684832741, 15737.842621573867, 15816.130112843904, 7739.651715672809, 9184.448933064037, 9245.861312080324, 9386.812263754824, 9391.718248452557, 7710.653020614086, 7825.37397008238, 9453.76365590852, 9524.428534287827, 9637.37357071788, 4821.975890120527, 4884.926726099111, 4889.877753056131, 4904.166291730415, 4921.9507804922205, 1994.8703334283225, 2051.2512932779428, 2051.94870128245, 2068.1210485543584, 2120.7137036500185, 936.7189843047058, 1001.5142655811925, 1043.0, 1064.669952314785, 1118.7482816366253, 20146.51283484358, 21157.365279041653, 21443.57112857734, 21475.57048859014, 21553.676694849277, 958.3100167879115, 965.7199412170391, 1022.8261195596766, 1045.72288343589, 1072.512007036812, 11033.393163376091, 11487.540498380138, 11504.137189710806, 11530.0, 11543.365114918592, 573468.0, 582238.0, 641518.0, 642884.0, 644640.0, 71229.0, 73623.26376736272, 73919.63040184765, 106626.0, 121714.0, 1039.9896001040045, 1046.1160319529986, 1049.9527521261562, 1059.9470026498643, 1061.2889364126054, 18377.632447351247, 18902.0, 19034.904825475784, 19040.809591903904, 19322.710159347902, 52122.478775213276, 52695.73652131715, 53046.2043069362, 53644.0, 54753.0, 74272.0, 76072.23927760651, 77101.22898771164, 77717.0, 78133.60933195525, 8360.874586881324, 8443.873341899754, 8444.619992100248, 8571.100034496289, 8591.527465989431, 9300.72097837066, 12397.0, 12705.42825572833, 13062.281574513112, 13063.281519516138, 11047.889521104686, 11300.982911538002, 11489.310641361211, 11501.309921404743, 11554.306741595195, 8661.437006594551, 10203.642872499428, 11135.610253641407, 11299.604513841976, 11359.943200284277, 11382.37396943143, 11455.427228638702, 11507.769844602893, 11511.366874821964, 11593.246438981776, 8072.273495385443, 8375.95812020936, 8384.0, 8610.61252243638, 8686.0, 8360.205780450848, 10765.73085672833, 10916.12670986335, 11595.362255076052, 11951.940240298743], "value": 9516.068813913429, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1641.0645931818863, 1667.391402138219, 1932.4492519631908, 2008.2469074097205, 2054.753429588448, 8335.91664083359, 8973.506457144855, 9029.187373136416, 9146.634134634614, 9189.816203675922, 8848.336374771901, 8933.062028487013, 8937.240334571568, 8948.194662480375, 9068.8639670405, 2538.352720056383, 2538.911138110162, 2552.8468291902454, 2555.7827584655233, 2566.0762125634756, 2531.797456203499, 2578.265194419591, 2580.0711743772226, 2580.096966061882, 2582.819202655815, 2534.252395543319, 2554.2592648132018, 2562.3466016165944, 2562.3856970108804, 2596.389848385628, 2558.539462896678, 2560.4495033567778, 2585.17274472169, 2610.464854704781, 2622.659054322945, 2554.5657238269537, 2580.974190258111, 2582.1478911959007, 2587.3531617095728, 2604.596287575429, 9153.221976132038, 9186.356955013152, 9217.723468295962, 9218.539073046388, 9246.86129708055, 5524.696141712204, 5609.607327487078, 5673.149027645845, 5701.458361455655, 5728.140778883159, 3574.6067932527662, 3671.0271777978855, 3691.0403295143187, 3727.6645101940953, 3730.7948062856804, 905.7916679163764, 915.9358844880861, 1044.5195210203315, 1057.7461409261798, 1060.4750648428999, 11932.04543636507, 11945.402729863472, 11956.521739130338, 12363.69090772738, 12384.009279257638, 4906.0, 4928.112939670894, 4928.48250933654, 4930.5069493050405, 5023.0, 10124.54439550222, 10136.594536218616, 10140.797184056277, 10142.442165680959, 10176.745581360377, 5508.20131080991, 5541.667499950016, 5544.279243698294, 5550.27846379968, 5585.022621041383, 4607.9078418431445, 4934.210526315772, 4996.000799840047, 4999.875003124951, 5109.284700141983, 3646.835892384849, 4169.124483858423, 4186.1836941796055, 4204.74771513704, 4321.481422229353, 1397.3781667158016, 1407.6621610813331, 1413.6536548545673, 1424.4658253155067, 1437.590286768266, 866.2463656618781, 883.9525162682114, 912.6805618033768, 920.4477313611914, 983.0366241083779, 5126.846194614168, 6016.759329626853, 6028.4272994065495, 6041.063635136561, 6071.3928607139815, 971.7619183299995, 992.5583115513527, 1026.4046852825343, 1047.2983101322131, 1049.18163832211, 3931.312020396419, 4010.19796040793, 4014.136960553495, 4048.291548978917, 4095.89760255996, 9146.771330716785, 10588.788224235472, 10931.890681093246, 11021.008109270204, 11024.228304018641, 10538.894611053945, 10671.786564268672, 10694.73263168427, 10760.784784304271, 10804.297720648132, 8126.634301456449, 8195.877061844078, 8391.580420978926, 8476.152384761475, 8519.531425771642, 5981.790637327673, 5989.78888367106, 6048.667323297261, 6092.496814331688, 6190.876182476235, 9504.572294246915, 9522.857157142787, 9689.22486201088, 9915.553800079158, 9946.502674866373, 9683.612655493702, 10003.14973227284, 10140.340877842917, 10232.897671023195, 10353.63762268317, 6097.237845269341, 6828.5220034597105, 7553.962230188814, 7570.242975702386, 7607.543547386953, 8196.467229630054, 8355.206255405727, 8385.748427547183, 8386.993560772746, 8415.789605259917, 7400.666969986256, 7404.259574042768, 7517.436192285491, 7630.8092297693, 7664.041994750656, 7274.30894065063, 7331.340179383881, 7351.448641351813, 7390.482666213314, 7454.366378857858, 7019.824504387227, 7023.297670232936, 7041.894371584328, 7052.0, 7097.858042839218, 4880.316755654282, 4924.679895806761, 4957.330760347307, 4961.957988822388, 4981.2030075187795, 4852.878678033077, 4902.436219834622, 4927.940492794067, 4962.627802914723, 5046.419661738947], "value": 4740.351648763063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.8230737709014, 334.59617451524895, 336.5103774008817, 342.8679958216086, 343.2174641816657, 6207.627542347463, 6417.326180751018, 6908.620025898574, 6916.754984102859, 6947.861042779142, 5285.8942821143555, 5945.197398351222, 6736.595804251749, 7039.929600703991, 7045.0, 5077.390713114413, 5085.466026067265, 5089.821856235014, 5098.311727916721, 5119.718415487147, 4464.620507256887, 4674.252119660855, 4848.927266090994, 4894.3147959285725, 5025.120603894322, 3854.959161026521, 4732.645051621125, 4933.901321973558, 4998.650094493387, 5017.071841709296, 4092.7544347339253, 4977.153883839738, 4993.775280112403, 4998.500149985009, 5015.824446144367, 3672.981635091834, 4243.087736136746, 4248.87253382399, 4255.978565144343, 4257.0, 6704.329567043305, 6712.53012289135, 6718.764843230512, 6732.29310922351, 6767.932320676829, 5125.718085505296, 5744.741486633112, 5988.431099045583, 6006.819795406102, 6009.338972712998, 6694.794936911354, 6833.965830170867, 7469.925300746977, 7474.551526908403, 7510.986016887705, 4787.329773831666, 4788.162071637485, 4793.55528680372, 4803.087413391444, 4809.495003024702, 7935.96032019842, 8006.0, 8016.038075430927, 8023.919760802376, 8037.23646253605, 4838.395200599925, 4841.8547443576745, 4849.58778503824, 4858.975705121452, 4859.465458799529, 4993.051320249141, 5133.922991155136, 5140.40885298188, 5145.125328694131, 5148.716820574904, 5927.407259274124, 5978.8206353809455, 5985.25184351956, 6012.158297838306, 6022.518198544193, 7490.325870671666, 7552.546847189186, 7560.58416787082, 7585.279398457138, 7591.089069311607, 1776.209586733917, 1804.9187786549637, 1807.9819201808077, 1808.873378863467, 1814.2833580735798, 965.3242730088966, 1130.949107290174, 1169.3802284789076, 1173.2784337632295, 1179.0862081886435, 5045.798168073309, 6240.84544359295, 6982.1272340957385, 7066.364027237573, 7118.394936430358, 7823.56970366624, 7825.647845846951, 7846.607669616496, 7863.13505514393, 7902.3678105751405, 6889.931100688929, 7017.7192912282935, 7138.607376594233, 7152.606606636685, 7164.9641751790905, 4140.23405669952, 4176.14389050244, 4185.162967406531, 4185.6232939035635, 4190.811413486401, 8201.79495512605, 8236.711715089943, 8257.587120643944, 8284.71003514886, 8301.501909885426, 6570.704318305688, 8206.261436470626, 8226.095129535746, 8232.50604963704, 8239.382046346547, 6697.0, 7883.724069657649, 8241.423100382915, 8336.166383361615, 8357.331413487029, 7913.525188488709, 7942.205779422012, 7960.721374751856, 7963.402744794048, 7977.521348719096, 5473.0, 6750.898736519054, 7486.4759466836795, 7830.647620856961, 7852.1755215703815, 6989.0, 7874.21257874208, 7962.960185199037, 8306.54314012735, 8312.792180195544, 4830.430110214124, 4881.633877459134, 4885.926711099408, 4887.3890763654545, 4896.6572339935865, 6376.266729326001, 7872.055353357634, 7892.802679933047, 7901.644426000728, 7903.288704016666, 6897.793066208022, 7633.5419874807685, 7640.579768112807, 7667.463277570517, 7696.807579810549, 7394.889076663747, 7605.353544948742, 7609.505382150142, 7613.238676132342, 7628.122765881994, 7408.111026676834, 7452.739154129797, 7469.626518674153, 7478.326950574475, 7505.587192704454, 7647.120581133018, 7648.464607477423, 7653.540787552764, 7654.081510218809, 7675.961620191863, 7484.887726684213, 7488.101427828696, 7490.325870671666, 7496.512726672749, 7542.321191092828], "value": 5411.517970318999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.1244787374836, 769.1347234361343, 777.5606782168076, 787.9361523937897, 790.9288164065233, 15313.0, 15718.292676829542, 15907.284172212248, 15941.442049528268, 16010.519684409472, 14368.353424095914, 14423.63940901478, 14452.710945781078, 14480.05879617824, 14514.419423223086, 773.8877862709903, 934.3272843552631, 955.1260596554145, 975.7853272280087, 976.9316147869652, 929.4841363043508, 958.290864760076, 969.3311614985672, 969.46194861852, 971.7473456901186, 981.3228872078279, 1007.4912169354466, 1020.8162530744463, 1028.8045271398448, 1031.1647565471992, 975.7755716185281, 984.6061575369838, 1020.0309705779539, 1021.9984415273, 1027.5838285494349, 634.8635043465631, 731.6012773038653, 749.071151771799, 770.7032792374976, 771.7221800151941, 12509.437075331633, 15372.30824612895, 15374.077555346716, 15412.537623871189, 15472.303746331441, 13464.730705385935, 13504.729905401935, 13518.729625407535, 13534.120282181626, 13616.727665446635, 10439.634612788515, 10503.317284376568, 10579.576816927314, 10586.41774702391, 10664.893351066545, 3630.2376500934834, 3635.509206257148, 3646.47126166707, 3672.467492213641, 3695.7896886471476, 84071.0, 85159.14840851574, 85322.0, 85864.0, 86575.0, 9946.502674866228, 9981.900180998242, 10083.949580252052, 10101.848472272923, 10308.639197628198, 23602.17392391258, 23664.408389790395, 23666.64500032501, 23697.526049478915, 23715.525689486458, 7004.474664400191, 7745.341645960044, 7782.377409807202, 7847.0, 7940.0, 3311.7516186286125, 3540.6105328413855, 4135.441715368447, 4247.044415006599, 4256.851010214627, 3681.834317455721, 3750.568684601306, 3753.2868754936476, 3755.887323380303, 3756.6055564165918, 593.8568256106977, 618.1623899615955, 671.5970417749311, 673.0745225315192, 676.7090151234918, 446.3240531803059, 522.0186050225552, 562.6680258647336, 580.422479632768, 615.1603061820672, 7012.597480503818, 8087.959560202279, 8550.657973680984, 8581.227689507974, 8662.436941598777, 585.525724163429, 619.2320328133237, 620.219968689863, 635.5678138865524, 643.6588608037747, 3951.7431366961055, 4001.639852413297, 4035.7376770509823, 4062.309407400749, 4105.794710264475, 94547.52726236325, 96468.0, 97471.0, 97863.0, 99397.50903736449, 78245.0, 78918.6054069726, 81774.59112704398, 83158.0, 83764.0, 57663.84672306614, 71401.28598713946, 72575.0, 73183.63408183031, 74582.0, 7055.259197784364, 8768.386212965032, 8881.467111973303, 8933.017368089375, 8941.508217048126, 48713.26930095981, 49557.752211238716, 50190.0, 50388.49611503838, 51281.0, 68539.62920741657, 69206.0, 71178.93231601427, 71186.0, 71968.0, 10922.966849511015, 11139.443027848412, 11299.152563557602, 11494.310341379543, 11646.301221926711, 12228.08289378318, 12245.387730613611, 12395.070369722127, 12457.377131143225, 12628.936855315664, 11442.141839361915, 11816.46825892854, 11893.524259029888, 11949.402529873645, 12058.019046858228, 9936.354136981074, 11896.58361957362, 11899.405029748305, 11906.698266184358, 11982.820257696316, 11296.717582060513, 11371.31772093677, 11375.943120284346, 11628.418579071182, 11628.476718547854, 9860.260480464138, 9877.654282100091, 9954.153896918842, 9970.700878973643, 10148.54331555067, 9774.218062555121, 9992.350497217658, 10037.046480584333, 10053.413112844557, 10081.294309398272], "value": 7139.444721886738, "unit": "score"}], "name": "dromaeo_css", "value": 7586.3240167746935, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 119.0, 108.0, 114.0, 121.0, 116.0, 106.0, 118.0, 116.0, 116.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 134.0, 142.0, 166.0, 123.0, 140.0, 118.0, 157.0, 159.0, 117.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 197.0, 194.0, 199.0, 200.0, 192.0, 196.0, 193.0, 199.0, 201.0], "value": 196.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 80.0, 143.0, 57.0, 56.0, 56.0, 68.0, 124.0, 57.0], "value": 77.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 126.0, 76.0, 87.0, 96.0, 132.0, 70.0, 77.0, 142.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 85.0, 89.0, 100.0, 107.0, 90.0, 88.0, 85.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 90.0, 143.0, 142.0, 94.0, 94.0, 96.0, 95.0, 94.0, 94.0], "value": 105.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 100.0, 90.0, 93.0, 90.0, 89.0, 91.0, 91.0, 90.0, 89.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 65.0, 64.0, 65.0, 65.0, 63.0, 79.0, 63.0, 60.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 69.0, 65.0, 72.0, 76.0, 80.0, 74.0, 70.0, 66.0, 68.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 82.0, 81.0, 81.0, 98.0, 79.0, 80.0, 85.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 115.0, 153.0, 128.0, 162.0, 110.0, 149.0, 171.0, 152.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 172.0, 166.0, 161.0, 159.0, 164.0, 156.0, 157.0, 180.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 93.0, 93.0, 96.0, 93.0, 89.0, 68.0, 69.0, 67.0], "value": 82.0, "unit": "score"}], "name": "kraken", "value": 1524.1, "alertThreshold": 2.0}]} 03:53:00 INFO - Return code: 0 03:53:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:53:00 ERROR - # TBPL SUCCESS # 03:53:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:53:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:53:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:53:00 INFO - 2016-07-03 03:53:00.763 screenresolution[1991:23083] starting screenresolution argv=screenresolution get 03:53:00 INFO - 2016-07-03 03:53:00.765 screenresolution[1991:23083] Display 0: 1600x1200x32@60 03:53:00 INFO - 2016-07-03 03:53:00.771 screenresolution[1992:23086] starting screenresolution argv=screenresolution list 03:53:00 INFO - Available Modes on Display 0 03:53:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:53:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:53:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:53:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:53:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:53:01 INFO - Intel Iris: 03:53:01 INFO - Chipset Model: Intel Iris 03:53:01 INFO - Type: GPU 03:53:01 INFO - Bus: Built-In 03:53:01 INFO - VRAM (Dynamic, Max): 1536 MB 03:53:01 INFO - Vendor: Intel (0x8086) 03:53:01 INFO - Device ID: 0x0a2e 03:53:01 INFO - Revision ID: 0x0009 03:53:01 INFO - Displays: 03:53:01 INFO - Display: 03:53:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:53:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:53:01 INFO - Display Serial Number: 1600x1200 60 03:53:01 INFO - Main Display: Yes 03:53:01 INFO - Mirror: Off 03:53:01 INFO - Online: Yes 03:53:01 INFO - Rotation: Supported 03:53:01 INFO - Return code: 0 03:53:01 INFO - Running post-action listener: _resource_record_post_action 03:53:01 INFO - Running post-run listener: _resource_record_post_run 03:53:02 INFO - Total resource usage - Wall time: 1191s; CPU: 53.0%; Read bytes: 557056; Write bytes: 498679808; Read time: 7; Write time: 1592 03:53:02 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180679168; Write bytes: 176146432; Read time: 16373; Write time: 394 03:53:02 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 557056; Write bytes: 302151680; Read time: 7; Write time: 1143 03:53:02 INFO - Running post-run listener: _upload_blobber_files 03:53:02 INFO - Blob upload gear active. 03:53:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:53:02 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 03:53:02 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'] 03:53:02 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 03:53:02 INFO - (blobuploader) - INFO - Open directory for files ... 03:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:03 INFO - (blobuploader) - INFO - Done attempting. 03:53:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:53:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:53:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:53:04 INFO - (blobuploader) - INFO - Done attempting. 03:53:04 INFO - (blobuploader) - INFO - Iteration through files over. 03:53:04 INFO - Return code: 0 03:53:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:53:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:53:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/081da906a783afb5cc783a44531023dfb3881efc46e405d3a14bf04b7e2e1d8844308062480bcf757f3dc579346004cf4c4d9edb625a89695608e21c52c95136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa389babd0f4bd2536f516c51d70d3bae9979868de161e340f43a8dd13b790ef10763b87f919e282579f6bba176d886a43451d45549d2096bb4883a717526dfa"} 03:53:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:53:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:53:04 INFO - Contents: 03:53:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/081da906a783afb5cc783a44531023dfb3881efc46e405d3a14bf04b7e2e1d8844308062480bcf757f3dc579346004cf4c4d9edb625a89695608e21c52c95136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa389babd0f4bd2536f516c51d70d3bae9979868de161e340f43a8dd13b790ef10763b87f919e282579f6bba176d886a43451d45549d2096bb4883a717526dfa"} 03:53:04 INFO - Running post-run listener: copy_logs_to_upload_dir 03:53:04 INFO - Copying logs to upload dir... 03:53:04 INFO - mkdir: /builds/slave/test/build/upload/logs 03:53:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.595680 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-03 03:53:04.245114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:53:04.248498) ========= 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.18CmUFYJcv/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.EOOwpVmEdA/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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/081da906a783afb5cc783a44531023dfb3881efc46e405d3a14bf04b7e2e1d8844308062480bcf757f3dc579346004cf4c4d9edb625a89695608e21c52c95136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa389babd0f4bd2536f516c51d70d3bae9979868de161e340f43a8dd13b790ef10763b87f919e282579f6bba176d886a43451d45549d2096bb4883a717526dfa"} build_url:https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011186 build_url: 'https://queue.taskcluster.net/v1/task/N4C2xOyaQ-eZ_yvOTsKpjw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/081da906a783afb5cc783a44531023dfb3881efc46e405d3a14bf04b7e2e1d8844308062480bcf757f3dc579346004cf4c4d9edb625a89695608e21c52c95136", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/aa389babd0f4bd2536f516c51d70d3bae9979868de161e340f43a8dd13b790ef10763b87f919e282579f6bba176d886a43451d45549d2096bb4883a717526dfa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 03:53:04.281137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:53:04.281492) ========= 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.18CmUFYJcv/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.EOOwpVmEdA/Listeners TMPDIR=/var/folders/8n/198zz2_16l7gkp94nf1ypm3000000w/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.005430 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 03:53:04.329744) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:53:04.330079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 03:53:04.330404) ========= ========= Total master_lag: 0.24 =========