builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0012 starttime: 1461183210.48 results: success (0) buildid: 20160420110249 builduid: 562744aed783432f9de25064e09a31a0 revision: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.478996) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.479497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.479798) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.499031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.499358) ========= 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.NN61ZRbDN0/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.quugX0lupa/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-20 13:13:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2016-04-20 13:13:30 (168 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.601190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.601511) ========= 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.NN61ZRbDN0/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.quugX0lupa/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.026263 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:30.650288) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 13:13:30.650931) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NN61ZRbDN0/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.quugX0lupa/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-20 13:13:30,725 truncating revision to first 12 chars 2016-04-20 13:13:30,725 Setting DEBUG logging. 2016-04-20 13:13:30,725 attempt 1/10 2016-04-20 13:13:30,725 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30c5dbcee7dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 13:13:32,469 unpacking tar archive at: mozilla-central-30c5dbcee7dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.992381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 13:13:32.660341) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:32.660683) ========= script_repo_revision: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:32.661077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:32.661348) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 13:13:32.674690) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 49 secs) (at 2016-04-20 13:13:32.674989) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NN61ZRbDN0/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.quugX0lupa/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:13:32 INFO - MultiFileLogger online at 20160420 13:13:32 in /builds/slave/test 13:13:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 13:13:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:13:32 INFO - {'append_to_log': False, 13:13:32 INFO - 'base_work_dir': '/builds/slave/test', 13:13:32 INFO - 'blob_upload_branch': 'Firefox', 13:13:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:13:32 INFO - 'branch': 'Firefox', 13:13:32 INFO - 'buildbot_json_path': 'buildprops.json', 13:13:32 INFO - 'config_files': ('talos/mac_config.py',), 13:13:32 INFO - 'default_actions': ('clobber', 13:13:32 INFO - 'read-buildbot-config', 13:13:32 INFO - 'download-and-extract', 13:13:32 INFO - 'populate-webroot', 13:13:32 INFO - 'create-virtualenv', 13:13:32 INFO - 'install', 13:13:32 INFO - 'run-tests'), 13:13:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:13:32 INFO - 'download_minidump_stackwalk': True, 13:13:32 INFO - 'download_symbols': 'ondemand', 13:13:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:13:32 INFO - 'tooltool.py': '/tools/tooltool.py', 13:13:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:13:32 INFO - '/tools/misc-python/virtualenv.py')}, 13:13:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:13:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:13:32 INFO - 'installer_path': 'installer.exe', 13:13:32 INFO - 'log_level': 'info', 13:13:32 INFO - 'log_name': 'talos', 13:13:32 INFO - 'log_to_console': True, 13:13:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:13:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:13:32 INFO - 'opt_config_files': (), 13:13:32 INFO - 'pip_index': False, 13:13:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:13:32 INFO - 'cmd': ('bash', 13:13:32 INFO - '-c', 13:13:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:13:32 INFO - 'enabled': True, 13:13:32 INFO - 'halt_on_failure': False, 13:13:32 INFO - 'name': 'check_screen_resolution'},), 13:13:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:13:32 INFO - 'cmd': ('bash', 13:13:32 INFO - '-c', 13:13:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:13:32 INFO - 'enabled': True, 13:13:32 INFO - 'halt_on_failure': False, 13:13:32 INFO - 'name': 'check_screen_resolution'},), 13:13:32 INFO - 'run_cmd_checks_enabled': True, 13:13:32 INFO - 'sps_profile': False, 13:13:32 INFO - 'sps_profile_interval': 0, 13:13:32 INFO - 'suite': 'dromaeojs-e10s', 13:13:32 INFO - 'system_bits': '32', 13:13:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:13:32 INFO - 'title': 't-yosemite-r7-0012', 13:13:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:13:32 INFO - 'use_talos_json': True, 13:13:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:13:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:13:32 INFO - 'work_dir': 'build'} 13:13:32 INFO - ##### 13:13:32 INFO - ##### Running clobber step. 13:13:32 INFO - ##### 13:13:32 INFO - Running pre-action listener: _resource_record_pre_action 13:13:32 INFO - Running main action method: clobber 13:13:32 INFO - rmtree: /builds/slave/test/build 13:13:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:13:34 INFO - Running post-action listener: _resource_record_post_action 13:13:34 INFO - ##### 13:13:34 INFO - ##### Running read-buildbot-config step. 13:13:34 INFO - ##### 13:13:34 INFO - Running pre-action listener: _resource_record_pre_action 13:13:34 INFO - Running main action method: read_buildbot_config 13:13:34 INFO - Using buildbot properties: 13:13:34 INFO - { 13:13:34 INFO - "project": "", 13:13:34 INFO - "product": "firefox", 13:13:34 INFO - "script_repo_revision": "production", 13:13:34 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 13:13:34 INFO - "repository": "", 13:13:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 13:13:34 INFO - "buildid": "20160420110249", 13:13:34 INFO - "pgo_build": "False", 13:13:34 INFO - "basedir": "/builds/slave/test", 13:13:34 INFO - "buildnumber": 248, 13:13:34 INFO - "slavename": "t-yosemite-r7-0012", 13:13:34 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:13:34 INFO - "platform": "yosemite_r7", 13:13:34 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 13:13:34 INFO - "branch": "mozilla-central", 13:13:34 INFO - "repo_path": "mozilla-central", 13:13:34 INFO - "revision": "30c5dbcee7ddeafcaffa50e01429c45d459bb8fc", 13:13:34 INFO - "stage_platform": "macosx64", 13:13:34 INFO - "builduid": "562744aed783432f9de25064e09a31a0", 13:13:34 INFO - "slavebuilddir": "test" 13:13:34 INFO - } 13:13:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 13:13:34 INFO - Running post-action listener: _resource_record_post_action 13:13:34 INFO - ##### 13:13:34 INFO - ##### Running download-and-extract step. 13:13:34 INFO - ##### 13:13:34 INFO - Running pre-action listener: _resource_record_pre_action 13:13:34 INFO - Running main action method: download_and_extract 13:13:34 INFO - mkdir: /builds/slave/test/build/tests 13:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:13:34 INFO - https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:13:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:13:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 13:13:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:13:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 13:13:46 INFO - Downloaded 1199 bytes. 13:13:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 13:13:46 INFO - Using the following test package requirements: 13:13:46 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:13:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 13:13:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 13:13:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'jsshell-mac.zip'], 13:13:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 13:13:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 13:13:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 13:13:46 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 13:13:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 13:13:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 13:13:46 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 13:13:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:13:46 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')]} 13:13:46 INFO - https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:13:48 INFO - Downloaded 18096112 bytes. 13:13:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:13:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:13:51 INFO - Return code: 0 13:13:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:13:51 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')]} 13:13:51 INFO - https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 13:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:14:04 INFO - Downloaded 18096112 bytes. 13:14:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:14:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 13:14:08 INFO - Return code: 0 13:14: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')]} 13:14:08 INFO - https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 13:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:14:28 INFO - Downloaded 10845952 bytes. 13:14:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 13:14:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 13:14:28 INFO - Return code: 0 13:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:14:28 INFO - https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:14:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:14:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:14:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 13:14:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 13:17:35 INFO - Downloaded 110040345 bytes. 13:17:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:17:35 INFO - mkdir: /builds/slave/test/properties 13:17:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:17:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:17:35 INFO - Contents: 13:17:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 13:17:37 INFO - Running post-action listener: _resource_record_post_action 13:17:37 INFO - Running post-action listener: set_extra_try_arguments 13:17:37 INFO - ##### 13:17:37 INFO - ##### Running populate-webroot step. 13:17:37 INFO - ##### 13:17:37 INFO - Running pre-action listener: _resource_record_pre_action 13:17:37 INFO - Running main action method: populate_webroot 13:17:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:17:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:17:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:17:37 INFO - '--tppagecycles', 13:17:37 INFO - '7'], 13:17:37 INFO - 'tests': ['tsvgm']}}, 13:17:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:17:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:17:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:17:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:17:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:17:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['damp', 'tps']}, 13:17:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'tests': ['damp', 'tps']}, 13:17:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['dromaeo_dom']}, 13:17:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:17:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['a11yr', 13:17:37 INFO - 'ts_paint', 13:17:37 INFO - 'tpaint', 13:17:37 INFO - 'sessionrestore', 13:17:37 INFO - 'sessionrestore_no_auto_restore', 13:17:37 INFO - 'tabpaint']}, 13:17:37 INFO - 'other-e10s': {'tests': ['a11yr', 13:17:37 INFO - 'ts_paint', 13:17:37 INFO - 'tpaint', 13:17:37 INFO - 'sessionrestore', 13:17:37 INFO - 'sessionrestore_no_auto_restore', 13:17:37 INFO - 'tabpaint']}, 13:17:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:17:37 INFO - 'ts_paint', 13:17:37 INFO - 'tpaint', 13:17:37 INFO - 'sessionrestore', 13:17:37 INFO - 'sessionrestore_no_auto_restore', 13:17:37 INFO - 'tabpaint']}, 13:17:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:17:37 INFO - 'ts_paint', 13:17:37 INFO - 'tpaint', 13:17:37 INFO - 'sessionrestore', 13:17:37 INFO - 'sessionrestore_no_auto_restore', 13:17:37 INFO - 'tabpaint']}, 13:17:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['a11yr', 13:17:37 INFO - 'ts_paint', 13:17:37 INFO - 'tpaint', 13:17:37 INFO - 'sessionrestore', 13:17:37 INFO - 'sessionrestore_no_auto_restore', 13:17:37 INFO - 'tabpaint']}, 13:17:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['a11yr', 13:17:37 INFO - 'ts_paint', 13:17:37 INFO - 'tpaint', 13:17:37 INFO - 'sessionrestore', 13:17:37 INFO - 'sessionrestore_no_auto_restore', 13:17:37 INFO - 'tabpaint']}, 13:17:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['tsvgx', 13:17:37 INFO - 'tsvgr_opacity', 13:17:37 INFO - 'tart', 13:17:37 INFO - 'tscrollx', 13:17:37 INFO - 'cart']}, 13:17:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:17:37 INFO - 'tsvgr_opacity', 13:17:37 INFO - 'tart', 13:17:37 INFO - 'tscrollx', 13:17:37 INFO - 'cart']}, 13:17:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'talos_options': ['--disable-e10s'], 13:17:37 INFO - 'tests': ['tp5o']}, 13:17:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'tests': ['tp5o']}, 13:17:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'talos_options': ['--disable-e10s', 13:17:37 INFO - '--xperf_path', 13:17:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:37 INFO - 'tests': ['tp5n']}, 13:17:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:17:37 INFO - 'talos_options': ['--xperf_path', 13:17:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:17:37 INFO - 'tests': ['tp5n']}}, 13:17:37 INFO - 'talos.zip': {'path': '', 13:17:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:17:37 INFO - Running post-action listener: _resource_record_post_action 13:17:37 INFO - ##### 13:17:37 INFO - ##### Running create-virtualenv step. 13:17:37 INFO - ##### 13:17:37 INFO - Running pre-action listener: _resource_record_pre_action 13:17:37 INFO - Running main action method: create_virtualenv 13:17:37 INFO - Creating virtualenv /builds/slave/test/build/venv 13:17:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:17:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:17:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:17:37 INFO - Using real prefix '/tools/python27' 13:17:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:17:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:17:40 INFO - Installing pip.................done. 13:17:40 INFO - Return code: 0 13:17:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:17:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:17:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:40 INFO - 'HOME': '/Users/cltbld', 13:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:40 INFO - 'LOGNAME': 'cltbld', 13:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:40 INFO - 'MOZ_NO_REMOTE': '1', 13:17:40 INFO - 'NO_EM_RESTART': '1', 13:17:40 INFO - 'PAGER': '/bin/cat', 13:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:40 INFO - 'PWD': '/builds/slave/test', 13:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:40 INFO - 'SHELL': '/bin/bash', 13:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:17:40 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:40 INFO - 'USER': 'cltbld', 13:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:40 INFO - 'XPC_FLAGS': '0x0', 13:17:40 INFO - 'XPC_SERVICE_NAME': '0', 13:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:17:41 INFO - Cleaning up... 13:17:41 INFO - Return code: 0 13:17:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 13:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:17:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:17:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:41 INFO - 'HOME': '/Users/cltbld', 13:17:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:41 INFO - 'LOGNAME': 'cltbld', 13:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:41 INFO - 'MOZ_NO_REMOTE': '1', 13:17:41 INFO - 'NO_EM_RESTART': '1', 13:17:41 INFO - 'PAGER': '/bin/cat', 13:17:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:41 INFO - 'PWD': '/builds/slave/test', 13:17:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:41 INFO - 'SHELL': '/bin/bash', 13:17:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:17:41 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:17:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:41 INFO - 'USER': 'cltbld', 13:17:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:41 INFO - 'XPC_FLAGS': '0x0', 13:17:41 INFO - 'XPC_SERVICE_NAME': '0', 13:17:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:41 INFO - Downloading/unpacking psutil>=0.7.1 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:44 INFO - Installing collected packages: psutil 13:17:44 INFO - Running setup.py install for psutil 13:17:44 INFO - building 'psutil._psutil_osx' extension 13:17:44 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:17:45 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 13:17:45 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 13:17:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:17:45 INFO - building 'psutil._psutil_posix' extension 13:17:45 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:17:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:17:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:17:45 INFO - ^ 13:17:45 INFO - 1 warning generated. 13:17:45 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:17:45 INFO - Successfully installed psutil 13:17:45 INFO - Cleaning up... 13:17:46 INFO - Return code: 0 13:17:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:17:46 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')]} 13:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:46 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')]} 13:17:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:46 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 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:17:46 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 13:17:46 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 13:17:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:17:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:46 INFO - 'HOME': '/Users/cltbld', 13:17:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:46 INFO - 'LOGNAME': 'cltbld', 13:17:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:46 INFO - 'MOZ_NO_REMOTE': '1', 13:17:46 INFO - 'NO_EM_RESTART': '1', 13:17:46 INFO - 'PAGER': '/bin/cat', 13:17:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:46 INFO - 'PWD': '/builds/slave/test', 13:17:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:46 INFO - 'SHELL': '/bin/bash', 13:17:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:17:46 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:17:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:46 INFO - 'USER': 'cltbld', 13:17:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:46 INFO - 'XPC_FLAGS': '0x0', 13:17:46 INFO - 'XPC_SERVICE_NAME': '0', 13:17:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:17:46 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 13:17:46 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 13:17:46 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 13:17:46 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 13:17:46 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 13:17:46 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 13:17:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:17:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:17:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:17:48 INFO - Installing collected packages: mozsystemmonitor 13:17:48 INFO - Running setup.py install for mozsystemmonitor 13:17:48 INFO - Successfully installed mozsystemmonitor 13:17:48 INFO - Cleaning up... 13:17:48 INFO - Return code: 0 13:17:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:17:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:17:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:48 INFO - 'HOME': '/Users/cltbld', 13:17:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:48 INFO - 'LOGNAME': 'cltbld', 13:17:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:48 INFO - 'MOZ_NO_REMOTE': '1', 13:17:48 INFO - 'NO_EM_RESTART': '1', 13:17:48 INFO - 'PAGER': '/bin/cat', 13:17:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:48 INFO - 'PWD': '/builds/slave/test', 13:17:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:48 INFO - 'SHELL': '/bin/bash', 13:17:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:17:48 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:17:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:48 INFO - 'USER': 'cltbld', 13:17:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:48 INFO - 'XPC_FLAGS': '0x0', 13:17:48 INFO - 'XPC_SERVICE_NAME': '0', 13:17:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:49 INFO - Downloading/unpacking blobuploader==1.2.4 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17: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 13:17:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:17:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:17:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:17:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:17:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:17:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:17:52 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 13:17:52 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 13:17:52 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 13:17:52 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 13:17:52 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 13:17:52 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 13:17:52 INFO - Downloading docopt-0.6.1.tar.gz 13:17:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:17:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:17:52 INFO - Running setup.py install for blobuploader 13:17:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:17:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:17:52 INFO - Running setup.py install for requests 13:17:53 INFO - Running setup.py install for docopt 13:17:53 INFO - Successfully installed blobuploader requests docopt 13:17:53 INFO - Cleaning up... 13:17:53 INFO - Return code: 0 13:17:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:17:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:17:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:53 INFO - 'HOME': '/Users/cltbld', 13:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:53 INFO - 'LOGNAME': 'cltbld', 13:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:53 INFO - 'MOZ_NO_REMOTE': '1', 13:17:53 INFO - 'NO_EM_RESTART': '1', 13:17:53 INFO - 'PAGER': '/bin/cat', 13:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:53 INFO - 'PWD': '/builds/slave/test', 13:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:53 INFO - 'SHELL': '/bin/bash', 13:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:17:53 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:53 INFO - 'USER': 'cltbld', 13:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:53 INFO - 'XPC_FLAGS': '0x0', 13:17:53 INFO - 'XPC_SERVICE_NAME': '0', 13:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:53 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-9_uQjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-dxokDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-kVl7Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-3BEJtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-oYSLfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-N_zpvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-_7Dw_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-nAdDwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-93S5Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:54 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-vgcRHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-UCTsOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-EETa7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-45uQYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-FNl_FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-JLedab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-r3KXGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:17:55 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-S47t0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:17:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:17:55 INFO - Running setup.py install for manifestparser 13:17:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:17:55 INFO - Running setup.py install for mozcrash 13:17:56 INFO - Running setup.py install for mozdebug 13:17:56 INFO - Running setup.py install for mozdevice 13:17:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Running setup.py install for mozfile 13:17:56 INFO - Running setup.py install for mozhttpd 13:17:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Running setup.py install for mozinfo 13:17:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Running setup.py install for mozInstall 13:17:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:17:56 INFO - Running setup.py install for mozleak 13:17:57 INFO - Running setup.py install for mozlog 13:17:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Running setup.py install for moznetwork 13:17:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Running setup.py install for mozprocess 13:17:57 INFO - Running setup.py install for mozprofile 13:17:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Running setup.py install for mozrunner 13:17:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:17:57 INFO - Running setup.py install for mozscreenshot 13:17:57 INFO - Running setup.py install for moztest 13:17:58 INFO - Running setup.py install for mozversion 13:17:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:17:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:17:58 INFO - Cleaning up... 13:17:58 INFO - Return code: 0 13:17:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:17:58 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')]} 13:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:58 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')]} 13:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:17:58 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 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:17:58 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 13:17:58 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 13:17:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:17:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:17:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:17:58 INFO - 'HOME': '/Users/cltbld', 13:17:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:17:58 INFO - 'LOGNAME': 'cltbld', 13:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:17:58 INFO - 'MOZ_NO_REMOTE': '1', 13:17:58 INFO - 'NO_EM_RESTART': '1', 13:17:58 INFO - 'PAGER': '/bin/cat', 13:17:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:17:58 INFO - 'PWD': '/builds/slave/test', 13:17:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:17:58 INFO - 'SHELL': '/bin/bash', 13:17:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:17:58 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:17:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:17:58 INFO - 'USER': 'cltbld', 13:17:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:17:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:17:58 INFO - 'XPC_FLAGS': '0x0', 13:17:58 INFO - 'XPC_SERVICE_NAME': '0', 13:17:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:17:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-hAxK1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:17:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-eI_eV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:17:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-s4UCZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:17:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-5_dkyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:17:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:17:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:17:58 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-w7HjIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:17:59 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)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-HeZfCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:17:59 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)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-ssevDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:17:59 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)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-plJ4Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-Xoqmdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-sKdb8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-3daddY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-OwHn_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-UyToox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:17:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:17:59 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-WkJYXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:00 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)) 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-4hjVqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:00 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)) 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-HX1FB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:00 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)) 13:18:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:00 INFO - Running setup.py (path:/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/pip-6Ntjy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:02 INFO - Downloading blessings-1.6.tar.gz 13:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:18:02 INFO - Installing collected packages: blessings 13:18:02 INFO - Running setup.py install for blessings 13:18:02 INFO - Successfully installed blessings 13:18:02 INFO - Cleaning up... 13:18:03 INFO - Return code: 0 13:18:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:03 INFO - Reading from file tmpfile_stdout 13:18:03 INFO - Current package versions: 13:18:03 INFO - blessings == 1.6 13:18:03 INFO - blobuploader == 1.2.4 13:18:03 INFO - docopt == 0.6.1 13:18:03 INFO - manifestparser == 1.1 13:18:03 INFO - mozInstall == 1.12 13:18:03 INFO - mozcrash == 0.17 13:18:03 INFO - mozdebug == 0.1 13:18:03 INFO - mozdevice == 0.48 13:18:03 INFO - mozfile == 1.2 13:18:03 INFO - mozhttpd == 0.7 13:18:03 INFO - mozinfo == 0.9 13:18:03 INFO - mozleak == 0.1 13:18:03 INFO - mozlog == 3.1 13:18:03 INFO - moznetwork == 0.27 13:18:03 INFO - mozprocess == 0.22 13:18:03 INFO - mozprofile == 0.28 13:18:03 INFO - mozrunner == 6.11 13:18:03 INFO - mozscreenshot == 0.1 13:18:03 INFO - mozsystemmonitor == 0.0 13:18:03 INFO - moztest == 0.7 13:18:03 INFO - mozversion == 1.4 13:18:03 INFO - psutil == 3.1.1 13:18:03 INFO - requests == 1.2.3 13:18:03 INFO - wsgiref == 0.1.2 13:18:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:18:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:18:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:03 INFO - 'HOME': '/Users/cltbld', 13:18:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:03 INFO - 'LOGNAME': 'cltbld', 13:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:03 INFO - 'MOZ_NO_REMOTE': '1', 13:18:03 INFO - 'NO_EM_RESTART': '1', 13:18:03 INFO - 'PAGER': '/bin/cat', 13:18:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:03 INFO - 'PWD': '/builds/slave/test', 13:18:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:03 INFO - 'SHELL': '/bin/bash', 13:18:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:18:03 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:18:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:03 INFO - 'USER': 'cltbld', 13:18:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:03 INFO - 'XPC_FLAGS': '0x0', 13:18:03 INFO - 'XPC_SERVICE_NAME': '0', 13:18:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:18:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:18:03 INFO - Cleaning up... 13:18:03 INFO - Return code: 0 13:18:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:18:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:18:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:18:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:03 INFO - 'HOME': '/Users/cltbld', 13:18:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:03 INFO - 'LOGNAME': 'cltbld', 13:18:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:03 INFO - 'MOZ_NO_REMOTE': '1', 13:18:03 INFO - 'NO_EM_RESTART': '1', 13:18:03 INFO - 'PAGER': '/bin/cat', 13:18:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:03 INFO - 'PWD': '/builds/slave/test', 13:18:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:03 INFO - 'SHELL': '/bin/bash', 13:18:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:18:03 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:18:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:03 INFO - 'USER': 'cltbld', 13:18:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:03 INFO - 'XPC_FLAGS': '0x0', 13:18:03 INFO - 'XPC_SERVICE_NAME': '0', 13:18:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:03 INFO - Downloading/unpacking jsonschema 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:06 INFO - Downloading/unpacking functools32 (from jsonschema) 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:06 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:06 INFO - warning: no files found matching '*.txt' 13:18:06 INFO - no previously-included directories found matching 'build' 13:18:06 INFO - no previously-included directories found matching 'dist' 13:18:06 INFO - no previously-included directories found matching '.git*' 13:18:06 INFO - Installing collected packages: jsonschema, functools32 13:18:06 INFO - Running setup.py install for functools32 13:18:06 INFO - warning: no files found matching '*.txt' 13:18:06 INFO - no previously-included directories found matching 'build' 13:18:06 INFO - no previously-included directories found matching 'dist' 13:18:06 INFO - no previously-included directories found matching '.git*' 13:18:06 INFO - Successfully installed jsonschema functools32 13:18:06 INFO - Cleaning up... 13:18:06 INFO - Return code: 0 13:18:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:18:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:18:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:07 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')]} 13:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:07 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 0x10bfb4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bfc4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe183da04c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, '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.NN61ZRbDN0/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.quugX0lupa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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 13:18:07 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 13:18:07 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 13:18:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:18:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:07 INFO - 'HOME': '/Users/cltbld', 13:18:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:07 INFO - 'LOGNAME': 'cltbld', 13:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:07 INFO - 'MOZ_NO_REMOTE': '1', 13:18:07 INFO - 'NO_EM_RESTART': '1', 13:18:07 INFO - 'PAGER': '/bin/cat', 13:18:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:07 INFO - 'PWD': '/builds/slave/test', 13:18:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:07 INFO - 'SHELL': '/bin/bash', 13:18:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:18:07 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:18:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:07 INFO - 'USER': 'cltbld', 13:18:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:07 INFO - 'XPC_FLAGS': '0x0', 13:18:07 INFO - 'XPC_SERVICE_NAME': '0', 13:18:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:07 INFO - Downloading/unpacking flake8 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18: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 13:18:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:18:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:18:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:11 INFO - no previously-included directories found matching 'docs/_build' 13:18:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:18:11 INFO - Running setup.py install for pep8 13:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:18:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:18:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:18:11 INFO - no previously-included directories found matching 'docs/_build' 13:18:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:18:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:18:11 INFO - Cleaning up... 13:18:11 INFO - Return code: 0 13:18:11 INFO - Running post-action listener: _resource_record_post_action 13:18:11 INFO - Running post-action listener: _start_resource_monitoring 13:18:11 INFO - Starting resource monitoring. 13:18:11 INFO - ##### 13:18:11 INFO - ##### Running install step. 13:18:11 INFO - ##### 13:18:11 INFO - Running pre-action listener: _resource_record_pre_action 13:18:11 INFO - Running main action method: install 13:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:11 INFO - Reading from file tmpfile_stdout 13:18:11 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:11 INFO - Reading from file tmpfile_stdout 13:18:11 INFO - Output received: 13:18:11 INFO - Usage: mozinstall [options] installer 13:18:11 INFO - Options: 13:18:11 INFO - -h, --help show this help message and exit 13:18:11 INFO - -d DEST, --destination=DEST 13:18:11 INFO - Directory to install application into. [default: 13:18:11 INFO - "/builds/slave/test"] 13:18:11 INFO - --app=APP Application being installed. [default: firefox] 13:18:11 INFO - mkdir: /builds/slave/test/build/application 13:18:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:18:45 INFO - Reading from file tmpfile_stdout 13:18:45 INFO - Output received: 13:18:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:18:45 INFO - Running post-action listener: _resource_record_post_action 13:18:45 INFO - ##### 13:18:45 INFO - ##### Running run-tests step. 13:18:45 INFO - ##### 13:18:45 INFO - Running pre-action listener: _resource_record_pre_action 13:18:45 INFO - Running main action method: run_tests 13:18:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:45 INFO - 2016-04-20 13:18:45.292 screenresolution[1646:7891] starting screenresolution argv=screenresolution get 13:18:45 INFO - 2016-04-20 13:18:45.295 screenresolution[1646:7891] Display 0: 1600x1200x32@60 13:18:45 INFO - 2016-04-20 13:18:45.301 screenresolution[1647:7893] starting screenresolution argv=screenresolution list 13:18:45 INFO - Available Modes on Display 0 13:18:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:45 INFO - Intel Iris: 13:18:45 INFO - Chipset Model: Intel Iris 13:18:45 INFO - Type: GPU 13:18:45 INFO - Bus: Built-In 13:18:45 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:45 INFO - Vendor: Intel (0x8086) 13:18:45 INFO - Device ID: 0x0a2e 13:18:45 INFO - Revision ID: 0x0009 13:18:45 INFO - Displays: 13:18:45 INFO - Display: 13:18:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:45 INFO - Display Serial Number: 1600x1200 60 13:18:45 INFO - Main Display: Yes 13:18:45 INFO - Mirror: Off 13:18:45 INFO - Online: Yes 13:18:45 INFO - Rotation: Supported 13:18:45 INFO - Return code: 0 13:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:45 INFO - Python 2.7.3 13:18:45 INFO - Return code: 0 13:18:45 INFO - grabbing minidump binary from tooltool 13:18: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')]} 13:18:45 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 0x10be53e00>, '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 0x10bcbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be4eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:45 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 13:18:45 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 13:18:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:45 INFO - Return code: 0 13:18:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:18:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:18:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:18:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:18:46 INFO - Return code: 0 13:18:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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 13:18:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0012 --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 13:18:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NN61ZRbDN0/Render', 13:18:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:46 INFO - 'HOME': '/Users/cltbld', 13:18:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:46 INFO - 'LOGNAME': 'cltbld', 13:18:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:18:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:46 INFO - 'MOZ_NO_REMOTE': '1', 13:18:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:46 INFO - 'NO_EM_RESTART': '1', 13:18:46 INFO - 'PAGER': '/bin/cat', 13:18:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:46 INFO - 'PWD': '/builds/slave/test', 13:18:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:46 INFO - 'SHELL': '/bin/bash', 13:18:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.quugX0lupa/Listeners', 13:18:46 INFO - 'TMPDIR': '/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/', 13:18:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:46 INFO - 'USER': 'cltbld', 13:18:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:46 INFO - 'XPC_FLAGS': '0x0', 13:18:46 INFO - 'XPC_SERVICE_NAME': '0', 13:18:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0012', '--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 13:18:47 INFO - mozversion application_buildid: 20160420110249 13:18:47 INFO - mozversion application_changeset: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc 13:18:47 INFO - mozversion application_display_name: Nightly 13:18:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:47 INFO - mozversion application_name: Firefox 13:18:47 INFO - mozversion application_remotingname: firefox 13:18:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:18:47 INFO - mozversion application_vendor: Mozilla 13:18:47 INFO - mozversion application_version: 48.0a1 13:18:47 INFO - mozversion platform_buildid: 20160420110249 13:18:47 INFO - mozversion platform_changeset: 30c5dbcee7ddeafcaffa50e01429c45d459bb8fc 13:18:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:18:47 INFO - mozversion platform_version: 48.0a1 13:18:47 INFO - using testdate: 1461183527 13:18:47 INFO - actual date: 1461183527 13:18:47 INFO - starting webserver on 'localhost:49277' 13:18:47 INFO - SUITE-START | Running 2 tests 13:18:47 INFO - TEST-START | dromaeo_css 13:18:47 INFO - operating with platform_type : mac_ 13:18:47 INFO - Initialising browser for dromaeo_css test... 13:18:47 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpj1MC9A/profile http://localhost:49277/getInfo.html) 13:18:49 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 13:18:49 INFO - PROCESS | 1665 | colorDepth:24 13:18:49 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 13:18:49 INFO - PROCESS | 1665 | __metrics 13:18:50 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:18:50 INFO - TEST-INFO | 1665: exit 0 13:18:50 INFO - Browser initialized. 13:18:50 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:50 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpj1MC9A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:02 INFO - PROCESS | 1669 | RSS: Main: 247832576 13:19:02 INFO - PROCESS | 1669 | 13:19:52 INFO - PROCESS | 1669 | 1461183592259 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] 13:22:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49277/tests/dromaeo/cssquery-ext.html) 13:22:04 INFO - PROCESS | 1669 | RSS: Main: 261844992 13:22:04 INFO - PROCESS | 1669 | 13:25:06 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-ext.html (next: http://localhost:49277/tests/dromaeo/cssquery-jquery.html) 13:25:07 INFO - PROCESS | 1669 | RSS: Main: 273448960 13:25:07 INFO - PROCESS | 1669 | 13:28:09 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49277/tests/dromaeo/cssquery-mootools.html) 13:28:09 INFO - PROCESS | 1669 | RSS: Main: 275419136 13:28:09 INFO - PROCESS | 1669 | 13:31:11 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49277/tests/dromaeo/cssquery-prototype.html) 13:31:12 INFO - PROCESS | 1669 | RSS: Main: 277000192 13:31:12 INFO - PROCESS | 1669 | 13:34:14 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49277/tests/dromaeo/cssquery-yui.html) 13:34:15 INFO - PROCESS | 1669 | RSS: Main: 279883776 13:34:15 INFO - PROCESS | 1669 | 13:37:17 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49277/tests/dromaeo/cssquery-yui.html (next: http://localhost:49277/tests/dromaeo/cssquery-dojo.html) 13:37:18 INFO - PROCESS | 1669 | RSS: Main: 281157632 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | __start_tp_report 13:37:18 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 13:37:18 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 13:37:18 INFO - PROCESS | 1669 | |i|pagename|runs| 13:37:18 INFO - PROCESS | 1669 | |0;dojo.html;2891.537354023357;3176.7617428692847;3511.929761404772;3536.4164912789392;3565.0196196046086;4652.255639097745;5408.567314614831;5875.9118613220835;5913.467787899088;5957.642541447505;5762.827115186541;5769.932562475945;5845.8830823383505;5896.5282777377815;5901.970490147543;5290.867728306795;5347.278117454152;5379.515843574078;5385.192221166837;5428.348598168225;5274.841754747364;5410.945890541084;5430.511253987141;5479.287692599956;5489.313835770528;4041.4948131483566;5260.710660913648;5320.6275560710765;5345.01117293302;5360.678359298435;4436.733795972252;4469.932951005738;5359.81240656579;5370.301860758076;5376.784928602851;5301.7084060376665;5306.548943339821;5328.866778330573;5342.545883599899;5350.30446042012;5593.720313984325;5632.71836408182;5789.768409263666;5829.213056237396;5840.357560668365;6220.409061139185;6241.0866551645095;6250.624962502265;6297.086922396273;6301.59039662425;5267.236250743659;6213.751449941997;6275.497960163176;6307.621542707407;6315.400036996478;5864.7067646617925;5930.584859059911;5962.880742385215;5967.940320596782;6002.099685047234;6340.461060809883;6368.968155159195;6372.235331760218;6377.202849643794;6390.201224846895;6124.808163753463;6210.968945155245;6305.905411418832;6306.684665766785;6308.463780578611;6213.161223234896;6231.3145553989025;6264.749410023639;6289.496840252768;6302.527310451735;6146.139540464339;6170.660613666201;6229.937700623026;6272.40412160844;6310.274318453345;6131.162586540582;6131.346082861964;6258.874822503615;6268.373162683695;6291.370862913672;4979.3277907482025;5028.823991160365;5031.622628302819;5032.496750324938;5071.771770270347;4496.527864574238;4517.954820451819;4547.249703798836;4551.681382303207;4563.726176429424;4963.8262660806695;5335.866603334947;5979.5515336349945;6036.939630603638;6076.301225359052;6246.875062498724;6249.812505624838;6255.655938923312;6276.9372306276355;6281.309056003836;5960.7019649017375;5971.581989260797;5977.701114944235;5990.28116625999;6027.065804800263;5427.48438898304;5442.619016668875;5501.807436739695;5504.752286147133;5512.91730624041;6451.580647258007;6470.935290647033;6486.999999999905;6490.772822951174;6514.674266286762;6279.1209230708655;6305.180326557702;6314.55798094129;6325.936740632719;6326.33573474797;6302.243730752339;6401.327860574759;6426.518011149089;6488.286288508355;6533.150690410216;6238.095476155841;6280.0893870389455;6280.309165991828;6285.748570057147;6299.842503937438;6266.780662676784;6278.497720182466;6283.905741413791;6284.937150628435;6286.15136956505;6037.792441511803;6094.969525152346;6143.419763699347;6251.812445626639;6277.780277690259;6173.629582225081;6249.125122482765;6249.312575616587;6251.499880009679;6251.749930002749;5443.374011988513;5978.581499295007;6031.668258245839;6132.41742034506;6181.474574661024;6149.631022138686;6220.7511699531515;6242.656653883898;6276.529260305404;6279.058141278845;5719.5138413235345;5888.234529511136;6133.325334213144;6167.753289868355;6172.382761723792 13:37:18 INFO - PROCESS | 1669 | |1;ext.html;506.8276785892797;539.6977692492204;579.3250862744901;589.699253380776;590.5954421221461;32859.835700821524;36140.819295903515;36760.323967603224;36855.81572092139;36873;29275.560866586966;37253;37324.066898327554;37452.81273593635;37534;9225.354225204239;9388;9411.435313881155;9430.481323527203;9455.763605909873;9396.248300136007;9400.717978460658;9456.38533495324;9488.62045518182;9546.856797148048;9488.38325508843;9491.667791627295;9558.904410955905;9564.234861211087;9610.663626773065;8791.604377802982;8865.911340886572;9467.573959171785;9470.384425012386;9512.286578506604;9418.576164072632;9489.288303377274;9545.42727436349;9554.331196816225;9562.665306714232;36861.447078293844;37109.44335834964;37362.87911362664;37386.813065934766;37459.438108428396;2454.5336386086587;2835.376217232206;3024.561438591392;3089.212250876012;3201.9273543363;20225.393238202876;24856.50286994268;25180.370490737696;25436.491270174676;25777.968881244728;2334.6964894563766;2511;2521.231024537515;2557;2749.175247425764;358166;359003;360762;362302;362554.9999999974;34370.96887093391;35422.46866297007;58459;58758.70620646955;59111.271098312034;26829.865850671013;34509.13727156841;34544.30911381758;34826.78106266269;34898.65101348954;12747.61757147287;14731.189784561737;14806.407743690132;15173.317200725995;15214.619634509005;12244.755104897853;12452.128351015343;12612.747745045048;12726.17279876805;12842.67893302675;7843.490173138728;7926.445148839641;8057.033156021198;8074.273315401525;8089.635966381527;3356.590232102523;3389.74576906733;3401.5577974863604;3411.607665118543;3418.7094097001536;999.326128734367;1062.3236473441877;1064.387976913278;1072.2494254022215;1076.4832880217539;29231.123066308046;29369.412611748074;29417.55873661897;30092.84953575262;30165.698343016727;1009.9394036357842;1104.5250542266901;1156.2773266708307;1199.8800119988107;1211.9939400302942;14714.264286785618;14815.111093334435;14930.402783888523;14940.477083302032;14980.026298290577;511119;571921;593420;598486;612196;58971.987381073086;59874.40125598775;59985;59995.100073498936;60150;1201.9843232468725;1403.9400252809269;1427.9500217492339;1488.5608745420127;1489.0842132088687;21940.341789746333;28065.438691225652;28736.712632873405;28861.27846803847;29596.556051658812;50746.74626626991;50871;51410.48589514057;51436.74281628568;51458.742706286226;550461;552320.430387089;553923;556657;563414;25822;26301.73698262993;26310.079147229753;26646.733532664424;26656.533890635426;45252.77373613111;46176.538234618565;46370;47387.52612473969;47723.52276477191;36956.26087478289;37330.25570310791;37703.86888393352;37734.62265377421;38556.80721596374;28349.007784727437;37039.74042984984;37303;37322.813385932895;37915.62084379121;36556.81721591375;36944.445833311984;37013;37316.6268337324;37694.246115078095;32447.837760811046;33355.666443335256;33401.66598334083;33429.66570334363;33504.832475837466;19229.4231173065;20684.17263309511;23151.495152815012;24013.03947842067;25044.123455678964 13:37:18 INFO - PROCESS | 1669 | |2;jquery.html;311.75682967285513;391.58100832109636;393.4098851722416;398.06851966398625;410.6160739708371;19201.423957281288;21304.93475326235;21580.89209553954;21755;21770.129194832207;20763.896180519077;21220.15119395226;21558.676619850714;21561.568768624616;21807;5173.224016397552;5655.236543066685;5841.123831425278;5842.094475356305;5867.266591676041;5704.087346024637;5761.193432919395;5775.971120144393;5808.59339846211;5818.912716309259;5390.51485366317;5623.718814059301;5722.856928576798;5725.227094342252;5727.599068065237;5254.500822421864;5700.258966334371;5707.971460142714;5709.543236541067;5713.74288157034;5481.287432633732;5484.424135465799;5489.670619762787;5490.945090549083;5499.312585926759;10934.398608076554;13079.934600327033;23339.766602334097;24329.63505547418;25216.495670086497;2046.6929960506043;2061.9690704639443;2070.89645517725;2102.6005059038735;2114.3339847947846;8031.357491400674;9252.537373131383;9502.714918552454;11960.86371794678;13873.167609943435;1496.3116966195564;1563.3902777916621;1623.991880040604;1635.0516700313908;1650.3449369598013;114942;115135.84864151335;116129;116819.83180168175;117958;10560.419176945341;10784.352938823695;11807.52769889212;11835.28988260707;11907.76184476323;14828;14980;14980.47568335125;15024.624384390478;15025.323860426308;8288.005439347316;8721.040685524587;8921.776955576162;8927.285817134614;8927.866082008775;6220.813375598739;8813.867791982997;8862.734117976472;8863.601137948808;8904.065073167225;4613.354130421743;4678.719276843401;4681.50844161365;4733.5503127202865;4768.6661933665;1950.1906708716008;1967.5046964306944;2018.5559176981042;2023.2918478532397;2055.845811564139;801.7354273089867;962.9229661627053;964.4213471916934;991.8512223166583;1009.7879445316419;20175.192992280143;20854.478638034172;20939.16243350249;20992.370228893156;21142.78857211408;934.3693007220099;959.8512230604267;981.082687687015;988.5156273426113;1034.7051090439338;10738.97979691928;11072.889271107348;11103.888961110286;11133.220674552866;11176.385298808644;512821;513411;514989;615604;621092.8945355244;113703;122383;122680.38659806644;124230;132823;936.5738588942152;990.3661656539821;1021.8160731068331;1034.6171916390983;1039.6205385034407;13785.310734463035;18132;18147.54631134232;18179.909100454413;18189.45431637053;51384.22923656223;52384.952300953;53496.653040114594;53531.7323413396;53546;55636.72181639066;57912.26263212111;75903.62048189944;77083;77730.2226977723;5941.613795103304;7958.0052493438325;8035;8153.6738530458115;8153.959230203811;8753.343499237455;11394.37330946806;12434.502619895466;12617;12702.618921432371;10483.423411712429;10769.676909692722;10945;10987.230893837355;11133.165012624248;10494.842577361193;10566.524506397076;10672.83990740155;10677.359358438518;11042.33745975244;10165;10677.786444270916;11106.500207490844;11140.554377825121;11542.13433992437;8025.759227223192;8154.551499667338;8202.712905048294;8205.425620206766;8282.893591624743;9877.851832222379;11075.833862491907;11250.606228781953;11318.037966772916;11424.543018279175 13:37:18 INFO - PROCESS | 1669 | |3;mootools.html;1605.2375121817136;1639.83601639836;1893.1764682363173;1959.529712868912;1969.1237399357274;8005.63974621142;8542.95728521358;8552.5296108714;8834.911650883498;8841.425307355017;8537.060923298448;8634.784130396727;8674.522901240429;8697.608607612658;8746.300295976322;2393.282015395379;2420.8547487150827;2421.7457166997474;2425.6240282756203;2434.5982912819454;2387.319613910036;2411.6985376827897;2421.6609674645565;2426.0538390027905;2439.146298795425;2322.198841399714;2331.207389487574;2351.0243249051623;2379.821513386503;2386.0217310902535;2373.169390713254;2384.0940442631777;2388.617821148608;2395.0659242895285;2398.940026499334;2352.306069709423;2357.0689577616745;2361.5867223236037;2382.0709923129994;2387.438951846315;8749.868751968726;8814.074522175208;8883.289336853037;8890.244329232022;8916.375853690244;5137.255098010767;5298.708571028592;5342.332208473941;5369.570434365241;5372.328458942632;2985.85070746464;3321.4021476134285;3330.167458135466;3421.606515250753;3519.225770330523;1011.4538149399316;1023.8617786598788;1029.8506716526138;1039.5737747523556;1043.6242952537082;11594.420278986017;11659.358735269558;11740.236884602473;11742.47158877844;11783.469743861548;4521.0279789845345;4529.433820772403;4710.952890471051;4718.386609740712;4749.1926372516755;9232.215261702697;9244.8613270801;9246.583903724348;9300.348975571645;9300.767480812898;5161.380634323905;5186.144286192812;5266.368035835648;5280.6039547034125;5284.180951952453;4477.32840073985;4759.690620109682;4897.338859253955;4934.4572097069295;4997.875053123628;3194.425003499346;3441.535392722001;3659.908502287464;3872;3897.941530877039;1223.559518573313;1225.7364666596725;1230.317173968456;1244.9439775210137;1245.1097465312346;814.450246083891;893.6336102198197;905.3391024551983;931.9375911460804;941.5292353823088;5694.430556944272;5775.682337471395;5842.620229685057;5922;5986.431289027535;416.4939598387913;440.4472387154101;461.0732427820106;1009.6869970309227;1027.9074883260541;3907.316219661548;3960.524737031517;3963.980180099081;3969.226000929791;4011.6961987354225;10217.74455638615;10535.947320263504;10603.946980265204;10675.679729608124;10685.732856678489;8894.688685896092;10584.735381615521;10633;10635.361878287173;10648.893511064945;7926.207379262143;7939.563324017119;7991.480553764103;8013.998250218722;8108.986376702912;5642.492175704207;5646.774129034792;5664.320281566238;5729.8567535811935;5806.81902592425;9401.670941517013;9778.902210978084;9781.462019588991;9788.608455661693;9987.650432234837;9351;9884.456354900549;9910.851337229804;9993.10062094415;10082.243831712503;6418.390252925965;7039.9296007039275;7074.151101867603;7193.5324203926575;7249.855002900018;7757.573333466714;7760.573168475788;7814.765557033298;7855.450118491651;7867.606619669108;6656.134702488645;6719.227288861648;6720.1599800025;6745.696443660146;6825.624590647363;6566.6388348641285;6569.9343006569325;6587.670616469253;6604.669766511752;6626.0784372531425;6241.095041219089;6307.590006649553;6366.840828979312;6384.138141350858;6386.137871387489;4417.624501917245;4509.954900450954;4613.19269127908;4616.1229366420275;4688.859334219979;4069.8575549855614;4522.615577675802;4523.954760452353;4578.908421831478;4720.716756994591 13:37:18 INFO - PROCESS | 1669 | |4;prototype.html;277.37728798846587;299.0371005362733;302.5054036650078;303.3387215869404;308.81625432867435;5238.711870847102;6205.534584906133;6348.301686814452;6362.5546211765195;6372.522060845432;5000.59995200384;6255.499560035198;6263.342349053352;6267.43593076623;6286.622802631834;4335.718178318407;4454.287314029756;4601.447826260854;4619.55163763206;4622.30665400191;3657.085728567858;4137.482814648169;4267.743935363873;4607.723536587799;4632.4672662643725;4300.806463709125;4535.977320113395;4599.862004139881;4601.861944141681;4625.028743963755;4206.284931561627;4559;4567.65742569307;4589.885252868705;4617.5151609080895;3517.788932664023;3652.721547458368;3875;3904.1020565270146;3911.432842237888;5445.747478080024;5712.428757124296;6017.7592896284095;6053.51571874249;6059.818205453799;4938.419705694179;5017.096922553938;5041.117804384218;5106.183010718304;5328.786848526093;6041.305249896274;6544.541882068257;6583.275839657634;6583.695706502734;6628.536002479828;3693.4829123922673;3766.4915236443003;4183.288840897025;4227.513835908879;4241.34259189826;6919.9966004929;6920.30796920309;6992.160940687099;6994.195667498252;7007.964960175166;3759.5149915783113;4127.215828992482;4172.332426811696;4388.626966707801;4397.494288156903;3666.926661466809;3965.4646622705563;4468.731876087445;4475.843345482893;4483.189289104235;5138.717370544581;5176.844694659167;5198.584113270929;5205.29728486657;5217.452167522356;5692.430756924275;6663.901700454186;6676.833079172962;6687.899681504781;6714.093597364391;1442.5311773673598;1464.633841539615;1477.7340078785708;1482.214426354034;1487.5388629524882;782.4405550031755;875.5709702245854;920.2821798996794;944.1596978688972;946.8201041802035;6121.755129794758;6134.98772702508;6147.784827531015;6151.2618485781995;6158.583525789004;6642.767503137464;6803.217629972518;6824.863502729918;6830.965845170742;6831.590104593641;5079.97460012705;6107.389261073946;6126.724297406538;6131.785387511416;6193.783217587363;3539.7876127432437;3610.29599228148;3616.5117709108936;3617.149969757105;3621.149029977953;6836.624560281424;7130.2869713028285;7205.351518363373;7255.056842610533;7272.96363518179;6252.374762523802;6713.731450741916;6725.9663701681175;7199.676014579357;7203.171635262012;6046.727897244635;6520.858849701283;6974.197967233833;7242.094738157731;7290.4896657233485;6077.787277445268;6700.765473208415;6838.931610684029;6900.896486552806;6910.99162485747;5815.709214539341;6199.008158694587;6636.535442518977;6845.760398386033;6847.733169363484;6315.873682526416;6366.294324911802;7261.419086473175;7270.890936635848;7277.490575659653;4227.957720422879;4261.296886013773;4270.722403043792;4278.550752170977;4292.892677683083;5268.262443258023;6101.572889897665;6346.746130154742;6893.448524118159;6949.652517374212;6153.292371377349;6579.854691544297;6705.8323541909895;6714.294999025032;6734.427573656294;5498.81775418287;5628.915566266591;6007.789727359522;6240.032794916795;6285.842853928689;6134.386561344008;6172.567920245539;6210.5652604317265;6484.157059582224;6615;6038.486728628116;6479.367252414546;6594.670266486753;6687.318876786172;6734.191896972198;5472.644278121909;6379.904301435389;6396.48828093742;6496.350364963466;6514.902276465762 13:37:18 INFO - PROCESS | 1669 | |5;yui.html;538.0906268406391;558.7066789935285;571.1261769492678;579.7014537513181;582.6387639663407;12148.906598406142;12173.878261217385;12244.938775306133;12310.81533776994;12611.936940315309;11351.943240283787;11729.53081876724;11803.350815705133;11861;11929.403529823518;731.4514114414189;749.7525816480576;894.0924961164424;925.4586067150725;927.248928368024;913.3332667152982;920.4155361345561;921.0835218957113;922.40504874356;927.285989787863;963.1476143612917;968.0899954043177;970.1656575345197;970.6554173268494;972.5623469438746;915.8671992561108;916.1388295002677;954.1269738189549;961.0485619236975;966.5119114846992;708.1643660480631;709.3048812164056;724.2106104346235;728.621117019147;730.0618704964096;11771.293722376598;11976.28142311464;12325;12372.566960156351;12405.937970310091;10429.269951103426;10460;10516.789664206673;10785.730356741065;10901.509432075576;9087.818243635156;9091.772705682344;9220.031896650822;9313.674021409219;9418.670346537907;3250.382427338822;3258.7393008559256;3260.250142467246;3265.8530366133346;3358.0765289545325;85392.14607853966;85514.14485855124;87428.5628571853;88847.77880552973;90626;7503.737369192052;7524.661390237453;7618.733344332922;7706.306432421109;7786.454948153688;14139.717205655828;16582.83417165837;16813.15934203285;16976.236069376908;17015.893966892112;6551.1155993941165;6639.767608133789;6640.269570347258;6735.865282694319;6860.216343750561;3797.2215695782297;3855.036240939765;3861.7876016819346;3876.3447038778527;3877.1276462795645;3111.0977816433433;3189.9362012759616;3201.775875688726;3272.9509057364157;3419.418698821157;626.6616027345183;637.1303171171411;647.8348021254644;649.5290914087249;650.7819880340045;517.495441944109;551.8703104770376;580.9941900581025;598.5241732822417;608.6895683201599;6666.266710661824;7135.928640713631;7166.140063192451;7319.560826350436;7443.8883416748795;478.52625900358396;571.5256337240081;573.2261447046537;578.644133857683;599.3317451042057;3331.566896303465;3505.8948231553095;3523.489094081344;3536.840842162109;3678.5401824771902;97950;98336;99591.50204249077;99794;99894.5005274969;84619.30761384738;85134.5743271292;85158;85565.57217213874;87488;57157.714211429506;60603.69698151569;74877.12807179864;75571.62214188893;75979.48041039259;5600.943990560205;6810.284920083518;6832.624205668736;7012.719491220294;7028.50800443964;39533.01167470836;40370.39444408395;41287.1742565153;41567.96080098022;42048.789756051025;60327;62444;62782;62897.68551157398;63923.36076639174;9398.665682686025;9451.858222126537;9479.146876781122;9598.952005240208;9855.35940163887;10526.684199474028;10529.4735263235;10739.516721747385;10836.566537338418;11103;9929.156021738234;9976.551055202388;10134.087932086148;10159.921945807877;10405.427701476492;10097.495125243855;10326.225533085199;10334.844977325196;10358.223133264884;10383.792324153626;9939.950300248453;10005.449700266556;10101.494925253855;10258.43578603184;10264.794704106025;7912.84174316522;8744.213020828156;8817;8960.910390896268;8981;8736.126387361213;8787.121287871161;8817.735467935972;8831.646734130563;8931.687390941286 13:37:18 INFO - PROCESS | 1669 | __end_tp_report 13:37:18 INFO - PROCESS | 1669 | __start_cc_report 13:37:18 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,392 13:37:18 INFO - PROCESS | 1669 | __end_cc_report 13:37:18 INFO - PROCESS | 1669 | __startTimestamp1461184638183__endTimestamp 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | ------- Summary: start ------- 13:37:18 INFO - PROCESS | 1669 | Number of tests: 6 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5806.17 Median:6094.97 stddev:683.07 (11.2%) stddev-sans-first:645.76 13:37:18 INFO - PROCESS | 1669 | Values: 2891.5 3176.8 3511.9 3536.4 3565.0 4652.3 5408.6 5875.9 5913.5 5957.6 5762.8 5769.9 5845.9 5896.5 5902.0 5290.9 5347.3 5379.5 5385.2 5428.3 5274.8 5410.9 5430.5 5479.3 5489.3 4041.5 5260.7 5320.6 5345.0 5360.7 4436.7 4469.9 5359.8 5370.3 5376.8 5301.7 5306.5 5328.9 5342.5 5350.3 5593.7 5632.7 5789.8 5829.2 5840.4 6220.4 6241.1 6250.6 6297.1 6301.6 5267.2 6213.8 6275.5 6307.6 6315.4 5864.7 5930.6 5962.9 5967.9 6002.1 6340.5 6369.0 6372.2 6377.2 6390.2 6124.8 6211.0 6305.9 6306.7 6308.5 6213.2 6231.3 6264.7 6289.5 6302.5 6146.1 6170.7 6229.9 6272.4 6310.3 6131.2 6131.3 6258.9 6268.4 6291.4 4979.3 5028.8 5031.6 5032.5 5071.8 4496.5 4518.0 4547.2 4551.7 4563.7 4963.8 5335.9 5979.6 6036.9 6076.3 6246.9 6249.8 6255.7 6276.9 6281.3 5960.7 5971.6 5977.7 5990.3 6027.1 5427.5 5442.6 5501.8 5504.8 5512.9 6451.6 6470.9 6487.0 6490.8 6514.7 6279.1 6305.2 6314.6 6325.9 6326.3 6302.2 6401.3 6426.5 6488.3 6533.2 6238.1 6280.1 6280.3 6285.7 6299.8 6266.8 6278.5 6283.9 6284.9 6286.2 6037.8 6095.0 6143.4 6251.8 6277.8 6173.6 6249.1 6249.3 6251.5 6251.7 5443.4 5978.6 6031.7 6132.4 6181.5 6149.6 6220.8 6242.7 6276.5 6279.1 5719.5 5888.2 6133.3 6167.8 6172.4 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:61833.29 Median:36658.57 stddev:135906.00 (370.7%) stddev-sans-first:136209.25 13:37:18 INFO - PROCESS | 1669 | Values: 506.8 539.7 579.3 589.7 590.6 32859.8 36140.8 36760.3 36855.8 36873.0 29275.6 37253.0 37324.1 37452.8 37534.0 9225.4 9388.0 9411.4 9430.5 9455.8 9396.2 9400.7 9456.4 9488.6 9546.9 9488.4 9491.7 9558.9 9564.2 9610.7 8791.6 8865.9 9467.6 9470.4 9512.3 9418.6 9489.3 9545.4 9554.3 9562.7 36861.4 37109.4 37362.9 37386.8 37459.4 2454.5 2835.4 3024.6 3089.2 3201.9 20225.4 24856.5 25180.4 25436.5 25778.0 2334.7 2511.0 2521.2 2557.0 2749.2 358166.0 359003.0 360762.0 362302.0 362555.0 34371.0 35422.5 58459.0 58758.7 59111.3 26829.9 34509.1 34544.3 34826.8 34898.7 12747.6 14731.2 14806.4 15173.3 15214.6 12244.8 12452.1 12612.7 12726.2 12842.7 7843.5 7926.4 8057.0 8074.3 8089.6 3356.6 3389.7 3401.6 3411.6 3418.7 999.3 1062.3 1064.4 1072.2 1076.5 29231.1 29369.4 29417.6 30092.8 30165.7 1009.9 1104.5 1156.3 1199.9 1212.0 14714.3 14815.1 14930.4 14940.5 14980.0 511119.0 571921.0 593420.0 598486.0 612196.0 58972.0 59874.4 59985.0 59995.1 60150.0 1202.0 1403.9 1428.0 1488.6 1489.1 21940.3 28065.4 28736.7 28861.3 29596.6 50746.7 50871.0 51410.5 51436.7 51458.7 550461.0 552320.4 553923.0 556657.0 563414.0 25822.0 26301.7 26310.1 26646.7 26656.5 45252.8 46176.5 46370.0 47387.5 47723.5 36956.3 37330.3 37703.9 37734.6 38556.8 28349.0 37039.7 37303.0 37322.8 37915.6 36556.8 36944.4 37013.0 37316.6 37694.2 32447.8 33355.7 33401.7 33429.7 33504.8 19229.4 20684.2 23151.5 24013.0 25044.1 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33178.19 Median:21788.56 stddev:93315.69 (428.3%) stddev-sans-first:93544.84 13:37:18 INFO - PROCESS | 1669 | Values: 311.8 391.6 393.4 398.1 410.6 19201.4 21304.9 21580.9 21755.0 21770.1 20763.9 21220.2 21558.7 21561.6 21807.0 5173.2 5655.2 5841.1 5842.1 5867.3 5704.1 5761.2 5776.0 5808.6 5818.9 5390.5 5623.7 5722.9 5725.2 5727.6 5254.5 5700.3 5708.0 5709.5 5713.7 5481.3 5484.4 5489.7 5490.9 5499.3 10934.4 13079.9 23339.8 24329.6 25216.5 2046.7 2062.0 2070.9 2102.6 2114.3 8031.4 9252.5 9502.7 11960.9 13873.2 1496.3 1563.4 1624.0 1635.1 1650.3 114942.0 115135.8 116129.0 116819.8 117958.0 10560.4 10784.4 11807.5 11835.3 11907.8 14828.0 14980.0 14980.5 15024.6 15025.3 8288.0 8721.0 8921.8 8927.3 8927.9 6220.8 8813.9 8862.7 8863.6 8904.1 4613.4 4678.7 4681.5 4733.6 4768.7 1950.2 1967.5 2018.6 2023.3 2055.8 801.7 962.9 964.4 991.9 1009.8 20175.2 20854.5 20939.2 20992.4 21142.8 934.4 959.9 981.1 988.5 1034.7 10739.0 11072.9 11103.9 11133.2 11176.4 512821.0 513411.0 514989.0 615604.0 621092.9 113703.0 122383.0 122680.4 124230.0 132823.0 936.6 990.4 1021.8 1034.6 1039.6 13785.3 18132.0 18147.5 18179.9 18189.5 51384.2 52385.0 53496.7 53531.7 53546.0 55636.7 57912.3 75903.6 77083.0 77730.2 5941.6 7958.0 8035.0 8153.7 8154.0 8753.3 11394.4 12434.5 12617.0 12702.6 10483.4 10769.7 10945.0 10987.2 11133.2 10494.8 10566.5 10672.8 10677.4 11042.3 10165.0 10677.8 11106.5 11140.6 11542.1 8025.8 8154.6 8202.7 8205.4 8282.9 9877.9 11075.8 11250.6 11318.0 11424.5 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5527.48 Median:4754.44 stddev:3106.47 (65.3%) stddev-sans-first:3101.21 13:37:18 INFO - PROCESS | 1669 | Values: 1605.2 1639.8 1893.2 1959.5 1969.1 8005.6 8543.0 8552.5 8834.9 8841.4 8537.1 8634.8 8674.5 8697.6 8746.3 2393.3 2420.9 2421.7 2425.6 2434.6 2387.3 2411.7 2421.7 2426.1 2439.1 2322.2 2331.2 2351.0 2379.8 2386.0 2373.2 2384.1 2388.6 2395.1 2398.9 2352.3 2357.1 2361.6 2382.1 2387.4 8749.9 8814.1 8883.3 8890.2 8916.4 5137.3 5298.7 5342.3 5369.6 5372.3 2985.9 3321.4 3330.2 3421.6 3519.2 1011.5 1023.9 1029.9 1039.6 1043.6 11594.4 11659.4 11740.2 11742.5 11783.5 4521.0 4529.4 4711.0 4718.4 4749.2 9232.2 9244.9 9246.6 9300.3 9300.8 5161.4 5186.1 5266.4 5280.6 5284.2 4477.3 4759.7 4897.3 4934.5 4997.9 3194.4 3441.5 3659.9 3872.0 3897.9 1223.6 1225.7 1230.3 1244.9 1245.1 814.5 893.6 905.3 931.9 941.5 5694.4 5775.7 5842.6 5922.0 5986.4 416.5 440.4 461.1 1009.7 1027.9 3907.3 3960.5 3964.0 3969.2 4011.7 10217.7 10535.9 10603.9 10675.7 10685.7 8894.7 10584.7 10633.0 10635.4 10648.9 7926.2 7939.6 7991.5 8014.0 8109.0 5642.5 5646.8 5664.3 5729.9 5806.8 9401.7 9778.9 9781.5 9788.6 9987.7 9351.0 9884.5 9910.9 9993.1 10082.2 6418.4 7039.9 7074.2 7193.5 7249.9 7757.6 7760.6 7814.8 7855.5 7867.6 6656.1 6719.2 6720.2 6745.7 6825.6 6566.6 6569.9 6587.7 6604.7 6626.1 6241.1 6307.6 6366.8 6384.1 6386.1 4417.6 4510.0 4613.2 4616.1 4688.9 4069.9 4522.6 4524.0 4578.9 4720.7 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:5286.24 Median:6114.57 stddev:1721.15 (28.1%) stddev-sans-first:1684.41 13:37:18 INFO - PROCESS | 1669 | Values: 277.4 299.0 302.5 303.3 308.8 5238.7 6205.5 6348.3 6362.6 6372.5 5000.6 6255.5 6263.3 6267.4 6286.6 4335.7 4454.3 4601.4 4619.6 4622.3 3657.1 4137.5 4267.7 4607.7 4632.5 4300.8 4536.0 4599.9 4601.9 4625.0 4206.3 4559.0 4567.7 4589.9 4617.5 3517.8 3652.7 3875.0 3904.1 3911.4 5445.7 5712.4 6017.8 6053.5 6059.8 4938.4 5017.1 5041.1 5106.2 5328.8 6041.3 6544.5 6583.3 6583.7 6628.5 3693.5 3766.5 4183.3 4227.5 4241.3 6920.0 6920.3 6992.2 6994.2 7008.0 3759.5 4127.2 4172.3 4388.6 4397.5 3666.9 3965.5 4468.7 4475.8 4483.2 5138.7 5176.8 5198.6 5205.3 5217.5 5692.4 6663.9 6676.8 6687.9 6714.1 1442.5 1464.6 1477.7 1482.2 1487.5 782.4 875.6 920.3 944.2 946.8 6121.8 6135.0 6147.8 6151.3 6158.6 6642.8 6803.2 6824.9 6831.0 6831.6 5080.0 6107.4 6126.7 6131.8 6193.8 3539.8 3610.3 3616.5 3617.1 3621.1 6836.6 7130.3 7205.4 7255.1 7273.0 6252.4 6713.7 6726.0 7199.7 7203.2 6046.7 6520.9 6974.2 7242.1 7290.5 6077.8 6700.8 6838.9 6900.9 6911.0 5815.7 6199.0 6636.5 6845.8 6847.7 6315.9 6366.3 7261.4 7270.9 7277.5 4228.0 4261.3 4270.7 4278.6 4292.9 5268.3 6101.6 6346.7 6893.4 6949.7 6153.3 6579.9 6705.8 6714.3 6734.4 5498.8 5628.9 6007.8 6240.0 6285.8 6134.4 6172.6 6210.6 6484.2 6615.0 6038.5 6479.4 6594.7 6687.3 6734.2 5472.6 6379.9 6396.5 6496.4 6514.9 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:17610.58 Median:32280.25 stddev:26883.00 (83.3%) stddev-sans-first:26927.85 13:37:18 INFO - PROCESS | 1669 | Values: 538.1 558.7 571.1 579.7 582.6 12148.9 12173.9 12244.9 12310.8 12611.9 11351.9 11729.5 11803.4 11861.0 11929.4 731.5 749.8 894.1 925.5 927.2 913.3 920.4 921.1 922.4 927.3 963.1 968.1 970.2 970.7 972.6 915.9 916.1 954.1 961.0 966.5 708.2 709.3 724.2 728.6 730.1 11771.3 11976.3 12325.0 12372.6 12405.9 10429.3 10460.0 10516.8 10785.7 10901.5 9087.8 9091.8 9220.0 9313.7 9418.7 3250.4 3258.7 3260.3 3265.9 3358.1 85392.1 85514.1 87428.6 88847.8 90626.0 7503.7 7524.7 7618.7 7706.3 7786.5 14139.7 16582.8 16813.2 16976.2 17015.9 6551.1 6639.8 6640.3 6735.9 6860.2 3797.2 3855.0 3861.8 3876.3 3877.1 3111.1 3189.9 3201.8 3273.0 3419.4 626.7 637.1 647.8 649.5 650.8 517.5 551.9 581.0 598.5 608.7 6666.3 7135.9 7166.1 7319.6 7443.9 478.5 571.5 573.2 578.6 599.3 3331.6 3505.9 3523.5 3536.8 3678.5 97950.0 98336.0 99591.5 99794.0 99894.5 84619.3 85134.6 85158.0 85565.6 87488.0 57157.7 60603.7 74877.1 75571.6 75979.5 5600.9 6810.3 6832.6 7012.7 7028.5 39533.0 40370.4 41287.2 41568.0 42048.8 60327.0 62444.0 62782.0 62897.7 63923.4 9398.7 9451.9 9479.1 9599.0 9855.4 10526.7 10529.5 10739.5 10836.6 11103.0 9929.2 9976.6 10134.1 10159.9 10405.4 10097.5 10326.2 10334.8 10358.2 10383.8 9940.0 10005.4 10101.5 10258.4 10264.8 7912.8 8744.2 8817.0 8960.9 8981.0 8736.1 8787.1 8817.7 8831.6 8931.7 13:37:18 INFO - PROCESS | 1669 | -------- Summary: end -------- 13:37:18 INFO - PROCESS | 1669 | 13:37:18 INFO - TEST-INFO | 1669: exit 0 13:37:18 INFO - TEST-OK | dromaeo_css | took 1111766ms 13:37:18 INFO - TEST-START | kraken 13:37:18 INFO - operating with platform_type : mac_ 13:37:18 INFO - Initialising browser for kraken test... 13:37:18 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpLnxCxV/profile http://localhost:49277/getInfo.html) 13:37:21 INFO - PROCESS | 1677 | __metrics Screen width/height:1600/1200 13:37:21 INFO - PROCESS | 1677 | colorDepth:24 13:37:21 INFO - PROCESS | 1677 | Browser inner width/height: 1024/689 13:37:21 INFO - PROCESS | 1677 | __metrics 13:37:21 ERROR - PROCESS | 1677 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 13:37:22 INFO - TEST-INFO | 1677: exit 0 13:37:22 INFO - Browser initialized. 13:37:22 INFO - Running cycle 1/1 for kraken test... 13:37:22 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/T/tmpLnxCxV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:34 INFO - PROCESS | 1680 | RSS: Main: 247955456 13:37:34 INFO - PROCESS | 1680 | 13:37:36 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:37 INFO - PROCESS | 1680 | RSS: Main: 260030464 13:37:37 INFO - PROCESS | 1680 | 13:37:40 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-dft) 13:37:40 INFO - PROCESS | 1680 | RSS: Main: 268869632 13:37:40 INFO - PROCESS | 1680 | 13:37:44 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-fft) 13:37:44 INFO - PROCESS | 1680 | RSS: Main: 272166912 13:37:44 INFO - PROCESS | 1680 | 13:37:46 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator) 13:37:47 INFO - PROCESS | 1680 | RSS: Main: 273080320 13:37:47 INFO - PROCESS | 1680 | 13:37:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:37:50 INFO - PROCESS | 1680 | RSS: Main: 273510400 13:37:50 INFO - PROCESS | 1680 | 13:37:53 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom) 13:37:53 INFO - PROCESS | 1680 | RSS: Main: 274153472 13:37:53 INFO - PROCESS | 1680 | 13:37:56 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate) 13:37:57 INFO - PROCESS | 1680 | RSS: Main: 274083840 13:37:57 INFO - PROCESS | 1680 | 13:37:59 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial) 13:38:00 INFO - PROCESS | 1680 | RSS: Main: 274333696 13:38:00 INFO - PROCESS | 1680 | 13:38:02 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:02 INFO - PROCESS | 1680 | RSS: Main: 274784256 13:38:02 INFO - PROCESS | 1680 | 13:38:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:05 INFO - PROCESS | 1680 | RSS: Main: 275480576 13:38:05 INFO - PROCESS | 1680 | 13:38:07 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:08 INFO - PROCESS | 1680 | RSS: Main: 275738624 13:38:08 INFO - PROCESS | 1680 | 13:38:10 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:11 INFO - PROCESS | 1680 | RSS: Main: 275714048 13:38:11 INFO - PROCESS | 1680 | 13:38:14 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:15 INFO - PROCESS | 1680 | RSS: Main: 275542016 13:38:15 INFO - PROCESS | 1680 | 13:38:16 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49277/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49277/tests/kraken/driver.html?testName=ai-astar) 13:38:17 INFO - PROCESS | 1680 | RSS: Main: 277250048 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | __start_tp_report 13:38:17 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 13:38:17 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 13:38:17 INFO - PROCESS | 1680 | |i|pagename|runs| 13:38:17 INFO - PROCESS | 1680 | |0;ai-astar;117;110;117;116;115;127;117;116;117;116 13:38:17 INFO - PROCESS | 1680 | |1;audio-beat-detection;185;156;145;160;124;141;137;124;170;124 13:38:17 INFO - PROCESS | 1680 | |2;audio-dft;201;201;196;210;230;274;275;217;201;196 13:38:17 INFO - PROCESS | 1680 | |3;audio-fft;69;80;73;144;57;56;55;65;125;71 13:38:17 INFO - PROCESS | 1680 | |4;audio-oscillator;80;80;132;77;85;117;124;81;80;118 13:38:17 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;88;88;88;88;94;116;93;122;75;119 13:38:17 INFO - PROCESS | 1680 | |6;imaging-darkroom;94;94;95;95;95;94;94;95;94;109 13:38:17 INFO - PROCESS | 1680 | |7;imaging-desaturate;94;91;90;90;91;90;90;90;91;91 13:38:17 INFO - PROCESS | 1680 | |8;json-parse-financial;60;61;62;60;62;62;62;78;62;61 13:38:17 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;64;71;65;66;75;72;70;66;67;67 13:38:17 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;96;82;84;82;84;82;86;83;85;85 13:38:17 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;140;139;176;150;131;148;155;150;181;141 13:38:17 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;170;170;168;163;175;205;184;172;166;172 13:38:17 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;69;67;71;90;98;93;73;66;69;72 13:38:17 INFO - PROCESS | 1680 | __end_tp_report 13:38:17 INFO - PROCESS | 1680 | __start_cc_report 13:38:17 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1021 13:38:17 INFO - PROCESS | 1680 | __end_cc_report 13:38:17 INFO - PROCESS | 1680 | __startTimestamp1461184697071__endTimestamp 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | ------- Summary: start ------- 13:38:17 INFO - PROCESS | 1680 | Number of tests: 14 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:116.80 Median:117.00 stddev:4.16 (3.6%) stddev-sans-first:4.41 13:38:17 INFO - PROCESS | 1680 | Values: 117.0 110.0 117.0 116.0 115.0 127.0 117.0 116.0 117.0 116.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:146.60 Median:150.50 stddev:20.95 (13.9%) stddev-sans-first:16.99 13:38:17 INFO - PROCESS | 1680 | Values: 185.0 156.0 145.0 160.0 124.0 141.0 137.0 124.0 170.0 124.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:220.10 Median:213.50 stddev:30.52 (14.3%) stddev-sans-first:31.58 13:38:17 INFO - PROCESS | 1680 | Values: 201.0 201.0 196.0 210.0 230.0 274.0 275.0 217.0 201.0 196.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:79.50 Median:67.00 stddev:30.41 (45.4%) stddev-sans-first:32.02 13:38:17 INFO - PROCESS | 1680 | Values: 69.0 80.0 73.0 144.0 57.0 56.0 55.0 65.0 125.0 71.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:80.00 stddev:22.26 (27.8%) stddev-sans-first:22.70 13:38:17 INFO - PROCESS | 1680 | Values: 80.0 80.0 132.0 77.0 85.0 117.0 124.0 81.0 80.0 118.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:97.10 Median:88.00 stddev:16.00 (18.2%) stddev-sans-first:16.62 13:38:17 INFO - PROCESS | 1680 | Values: 88.0 88.0 88.0 88.0 94.0 116.0 93.0 122.0 75.0 119.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:94.50 stddev:4.63 (4.9%) stddev-sans-first:4.86 13:38:17 INFO - PROCESS | 1680 | Values: 94.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 109.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:91.00 stddev:1.23 (1.4%) stddev-sans-first:0.53 13:38:17 INFO - PROCESS | 1680 | Values: 94.0 91.0 90.0 90.0 91.0 90.0 90.0 90.0 91.0 91.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:62.00 stddev:5.33 (8.6%) stddev-sans-first:5.55 13:38:17 INFO - PROCESS | 1680 | Values: 60.0 61.0 62.0 60.0 62.0 62.0 62.0 78.0 62.0 61.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:3.53 (5.2%) stddev-sans-first:3.38 13:38:17 INFO - PROCESS | 1680 | Values: 64.0 71.0 65.0 66.0 75.0 72.0 70.0 66.0 67.0 67.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:4.15 (4.9%) stddev-sans-first:1.50 13:38:17 INFO - PROCESS | 1680 | Values: 96.0 82.0 84.0 82.0 84.0 82.0 86.0 83.0 85.0 85.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:150.00 stddev:16.04 (10.7%) stddev-sans-first:16.51 13:38:17 INFO - PROCESS | 1680 | Values: 140.0 139.0 176.0 150.0 131.0 148.0 155.0 150.0 181.0 141.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:172.00 stddev:12.11 (7.0%) stddev-sans-first:12.74 13:38:17 INFO - PROCESS | 1680 | Values: 170.0 170.0 168.0 163.0 175.0 205.0 184.0 172.0 166.0 172.0 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:72.50 stddev:11.98 (16.5%) stddev-sans-first:12.37 13:38:17 INFO - PROCESS | 1680 | Values: 69.0 67.0 71.0 90.0 98.0 93.0 73.0 66.0 69.0 72.0 13:38:17 INFO - PROCESS | 1680 | -------- Summary: end -------- 13:38:17 INFO - PROCESS | 1680 | 13:38:17 INFO - TEST-INFO | 1680: exit 0 13:38:17 INFO - TEST-OK | kraken | took 59024ms 13:38:17 INFO - SUITE-END | took 1170s 13:38:18 INFO - Completed test suite (00:19:31) 13:38:18 INFO - javascript benchmark 13:38:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2891.537354023357, 3176.7617428692847, 3511.929761404772, 3536.4164912789392, 3565.0196196046086, 4652.255639097745, 5408.567314614831, 5875.9118613220835, 5913.467787899088, 5957.642541447505, 5762.827115186541, 5769.932562475945, 5845.8830823383505, 5896.5282777377815, 5901.970490147543, 5290.867728306795, 5347.278117454152, 5379.515843574078, 5385.192221166837, 5428.348598168225, 5274.841754747364, 5410.945890541084, 5430.511253987141, 5479.287692599956, 5489.313835770528, 4041.4948131483566, 5260.710660913648, 5320.6275560710765, 5345.01117293302, 5360.678359298435, 4436.733795972252, 4469.932951005738, 5359.81240656579, 5370.301860758076, 5376.784928602851, 5301.7084060376665, 5306.548943339821, 5328.866778330573, 5342.545883599899, 5350.30446042012, 5593.720313984325, 5632.71836408182, 5789.768409263666, 5829.213056237396, 5840.357560668365, 6220.409061139185, 6241.0866551645095, 6250.624962502265, 6297.086922396273, 6301.59039662425, 5267.236250743659, 6213.751449941997, 6275.497960163176, 6307.621542707407, 6315.400036996478, 5864.7067646617925, 5930.584859059911, 5962.880742385215, 5967.940320596782, 6002.099685047234, 6340.461060809883, 6368.968155159195, 6372.235331760218, 6377.202849643794, 6390.201224846895, 6124.808163753463, 6210.968945155245, 6305.905411418832, 6306.684665766785, 6308.463780578611, 6213.161223234896, 6231.3145553989025, 6264.749410023639, 6289.496840252768, 6302.527310451735, 6146.139540464339, 6170.660613666201, 6229.937700623026, 6272.40412160844, 6310.274318453345, 6131.162586540582, 6131.346082861964, 6258.874822503615, 6268.373162683695, 6291.370862913672, 4979.3277907482025, 5028.823991160365, 5031.622628302819, 5032.496750324938, 5071.771770270347, 4496.527864574238, 4517.954820451819, 4547.249703798836, 4551.681382303207, 4563.726176429424, 4963.8262660806695, 5335.866603334947, 5979.5515336349945, 6036.939630603638, 6076.301225359052, 6246.875062498724, 6249.812505624838, 6255.655938923312, 6276.9372306276355, 6281.309056003836, 5960.7019649017375, 5971.581989260797, 5977.701114944235, 5990.28116625999, 6027.065804800263, 5427.48438898304, 5442.619016668875, 5501.807436739695, 5504.752286147133, 5512.91730624041, 6451.580647258007, 6470.935290647033, 6486.999999999905, 6490.772822951174, 6514.674266286762, 6279.1209230708655, 6305.180326557702, 6314.55798094129, 6325.936740632719, 6326.33573474797, 6302.243730752339, 6401.327860574759, 6426.518011149089, 6488.286288508355, 6533.150690410216, 6238.095476155841, 6280.0893870389455, 6280.309165991828, 6285.748570057147, 6299.842503937438, 6266.780662676784, 6278.497720182466, 6283.905741413791, 6284.937150628435, 6286.15136956505, 6037.792441511803, 6094.969525152346, 6143.419763699347, 6251.812445626639, 6277.780277690259, 6173.629582225081, 6249.125122482765, 6249.312575616587, 6251.499880009679, 6251.749930002749, 5443.374011988513, 5978.581499295007, 6031.668258245839, 6132.41742034506, 6181.474574661024, 6149.631022138686, 6220.7511699531515, 6242.656653883898, 6276.529260305404, 6279.058141278845, 5719.5138413235345, 5888.234529511136, 6133.325334213144, 6167.753289868355, 6172.382761723792], "value": 5762.331801147201, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.8276785892797, 539.6977692492204, 579.3250862744901, 589.699253380776, 590.5954421221461, 32859.835700821524, 36140.819295903515, 36760.323967603224, 36855.81572092139, 36873.0, 29275.560866586966, 37253.0, 37324.066898327554, 37452.81273593635, 37534.0, 9225.354225204239, 9388.0, 9411.435313881155, 9430.481323527203, 9455.763605909873, 9396.248300136007, 9400.717978460658, 9456.38533495324, 9488.62045518182, 9546.856797148048, 9488.38325508843, 9491.667791627295, 9558.904410955905, 9564.234861211087, 9610.663626773065, 8791.604377802982, 8865.911340886572, 9467.573959171785, 9470.384425012386, 9512.286578506604, 9418.576164072632, 9489.288303377274, 9545.42727436349, 9554.331196816225, 9562.665306714232, 36861.447078293844, 37109.44335834964, 37362.87911362664, 37386.813065934766, 37459.438108428396, 2454.5336386086587, 2835.376217232206, 3024.561438591392, 3089.212250876012, 3201.9273543363, 20225.393238202876, 24856.50286994268, 25180.370490737696, 25436.491270174676, 25777.968881244728, 2334.6964894563766, 2511.0, 2521.231024537515, 2557.0, 2749.175247425764, 358166.0, 359003.0, 360762.0, 362302.0, 362554.9999999974, 34370.96887093391, 35422.46866297007, 58459.0, 58758.70620646955, 59111.271098312034, 26829.865850671013, 34509.13727156841, 34544.30911381758, 34826.78106266269, 34898.65101348954, 12747.61757147287, 14731.189784561737, 14806.407743690132, 15173.317200725995, 15214.619634509005, 12244.755104897853, 12452.128351015343, 12612.747745045048, 12726.17279876805, 12842.67893302675, 7843.490173138728, 7926.445148839641, 8057.033156021198, 8074.273315401525, 8089.635966381527, 3356.590232102523, 3389.74576906733, 3401.5577974863604, 3411.607665118543, 3418.7094097001536, 999.326128734367, 1062.3236473441877, 1064.387976913278, 1072.2494254022215, 1076.4832880217539, 29231.123066308046, 29369.412611748074, 29417.55873661897, 30092.84953575262, 30165.698343016727, 1009.9394036357842, 1104.5250542266901, 1156.2773266708307, 1199.8800119988107, 1211.9939400302942, 14714.264286785618, 14815.111093334435, 14930.402783888523, 14940.477083302032, 14980.026298290577, 511119.0, 571921.0, 593420.0, 598486.0, 612196.0, 58971.987381073086, 59874.40125598775, 59985.0, 59995.100073498936, 60150.0, 1201.9843232468725, 1403.9400252809269, 1427.9500217492339, 1488.5608745420127, 1489.0842132088687, 21940.341789746333, 28065.438691225652, 28736.712632873405, 28861.27846803847, 29596.556051658812, 50746.74626626991, 50871.0, 51410.48589514057, 51436.74281628568, 51458.742706286226, 550461.0, 552320.430387089, 553923.0, 556657.0, 563414.0, 25822.0, 26301.73698262993, 26310.079147229753, 26646.733532664424, 26656.533890635426, 45252.77373613111, 46176.538234618565, 46370.0, 47387.52612473969, 47723.52276477191, 36956.26087478289, 37330.25570310791, 37703.86888393352, 37734.62265377421, 38556.80721596374, 28349.007784727437, 37039.74042984984, 37303.0, 37322.813385932895, 37915.62084379121, 36556.81721591375, 36944.445833311984, 37013.0, 37316.6268337324, 37694.246115078095, 32447.837760811046, 33355.666443335256, 33401.66598334083, 33429.66570334363, 33504.832475837466, 19229.4231173065, 20684.17263309511, 23151.495152815012, 24013.03947842067, 25044.123455678964], "value": 17760.046028263245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [311.75682967285513, 391.58100832109636, 393.4098851722416, 398.06851966398625, 410.6160739708371, 19201.423957281288, 21304.93475326235, 21580.89209553954, 21755.0, 21770.129194832207, 20763.896180519077, 21220.15119395226, 21558.676619850714, 21561.568768624616, 21807.0, 5173.224016397552, 5655.236543066685, 5841.123831425278, 5842.094475356305, 5867.266591676041, 5704.087346024637, 5761.193432919395, 5775.971120144393, 5808.59339846211, 5818.912716309259, 5390.51485366317, 5623.718814059301, 5722.856928576798, 5725.227094342252, 5727.599068065237, 5254.500822421864, 5700.258966334371, 5707.971460142714, 5709.543236541067, 5713.74288157034, 5481.287432633732, 5484.424135465799, 5489.670619762787, 5490.945090549083, 5499.312585926759, 10934.398608076554, 13079.934600327033, 23339.766602334097, 24329.63505547418, 25216.495670086497, 2046.6929960506043, 2061.9690704639443, 2070.89645517725, 2102.6005059038735, 2114.3339847947846, 8031.357491400674, 9252.537373131383, 9502.714918552454, 11960.86371794678, 13873.167609943435, 1496.3116966195564, 1563.3902777916621, 1623.991880040604, 1635.0516700313908, 1650.3449369598013, 114942.0, 115135.84864151335, 116129.0, 116819.83180168175, 117958.0, 10560.419176945341, 10784.352938823695, 11807.52769889212, 11835.28988260707, 11907.76184476323, 14828.0, 14980.0, 14980.47568335125, 15024.624384390478, 15025.323860426308, 8288.005439347316, 8721.040685524587, 8921.776955576162, 8927.285817134614, 8927.866082008775, 6220.813375598739, 8813.867791982997, 8862.734117976472, 8863.601137948808, 8904.065073167225, 4613.354130421743, 4678.719276843401, 4681.50844161365, 4733.5503127202865, 4768.6661933665, 1950.1906708716008, 1967.5046964306944, 2018.5559176981042, 2023.2918478532397, 2055.845811564139, 801.7354273089867, 962.9229661627053, 964.4213471916934, 991.8512223166583, 1009.7879445316419, 20175.192992280143, 20854.478638034172, 20939.16243350249, 20992.370228893156, 21142.78857211408, 934.3693007220099, 959.8512230604267, 981.082687687015, 988.5156273426113, 1034.7051090439338, 10738.97979691928, 11072.889271107348, 11103.888961110286, 11133.220674552866, 11176.385298808644, 512821.0, 513411.0, 514989.0, 615604.0, 621092.8945355244, 113703.0, 122383.0, 122680.38659806644, 124230.0, 132823.0, 936.5738588942152, 990.3661656539821, 1021.8160731068331, 1034.6171916390983, 1039.6205385034407, 13785.310734463035, 18132.0, 18147.54631134232, 18179.909100454413, 18189.45431637053, 51384.22923656223, 52384.952300953, 53496.653040114594, 53531.7323413396, 53546.0, 55636.72181639066, 57912.26263212111, 75903.62048189944, 77083.0, 77730.2226977723, 5941.613795103304, 7958.0052493438325, 8035.0, 8153.6738530458115, 8153.959230203811, 8753.343499237455, 11394.37330946806, 12434.502619895466, 12617.0, 12702.618921432371, 10483.423411712429, 10769.676909692722, 10945.0, 10987.230893837355, 11133.165012624248, 10494.842577361193, 10566.524506397076, 10672.83990740155, 10677.359358438518, 11042.33745975244, 10165.0, 10677.786444270916, 11106.500207490844, 11140.554377825121, 11542.13433992437, 8025.759227223192, 8154.551499667338, 8202.712905048294, 8205.425620206766, 8282.893591624743, 9877.851832222379, 11075.833862491907, 11250.606228781953, 11318.037966772916, 11424.543018279175], "value": 9336.093647204245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.2375121817136, 1639.83601639836, 1893.1764682363173, 1959.529712868912, 1969.1237399357274, 8005.63974621142, 8542.95728521358, 8552.5296108714, 8834.911650883498, 8841.425307355017, 8537.060923298448, 8634.784130396727, 8674.522901240429, 8697.608607612658, 8746.300295976322, 2393.282015395379, 2420.8547487150827, 2421.7457166997474, 2425.6240282756203, 2434.5982912819454, 2387.319613910036, 2411.6985376827897, 2421.6609674645565, 2426.0538390027905, 2439.146298795425, 2322.198841399714, 2331.207389487574, 2351.0243249051623, 2379.821513386503, 2386.0217310902535, 2373.169390713254, 2384.0940442631777, 2388.617821148608, 2395.0659242895285, 2398.940026499334, 2352.306069709423, 2357.0689577616745, 2361.5867223236037, 2382.0709923129994, 2387.438951846315, 8749.868751968726, 8814.074522175208, 8883.289336853037, 8890.244329232022, 8916.375853690244, 5137.255098010767, 5298.708571028592, 5342.332208473941, 5369.570434365241, 5372.328458942632, 2985.85070746464, 3321.4021476134285, 3330.167458135466, 3421.606515250753, 3519.225770330523, 1011.4538149399316, 1023.8617786598788, 1029.8506716526138, 1039.5737747523556, 1043.6242952537082, 11594.420278986017, 11659.358735269558, 11740.236884602473, 11742.47158877844, 11783.469743861548, 4521.0279789845345, 4529.433820772403, 4710.952890471051, 4718.386609740712, 4749.1926372516755, 9232.215261702697, 9244.8613270801, 9246.583903724348, 9300.348975571645, 9300.767480812898, 5161.380634323905, 5186.144286192812, 5266.368035835648, 5280.6039547034125, 5284.180951952453, 4477.32840073985, 4759.690620109682, 4897.338859253955, 4934.4572097069295, 4997.875053123628, 3194.425003499346, 3441.535392722001, 3659.908502287464, 3872.0, 3897.941530877039, 1223.559518573313, 1225.7364666596725, 1230.317173968456, 1244.9439775210137, 1245.1097465312346, 814.450246083891, 893.6336102198197, 905.3391024551983, 931.9375911460804, 941.5292353823088, 5694.430556944272, 5775.682337471395, 5842.620229685057, 5922.0, 5986.431289027535, 416.4939598387913, 440.4472387154101, 461.0732427820106, 1009.6869970309227, 1027.9074883260541, 3907.316219661548, 3960.524737031517, 3963.980180099081, 3969.226000929791, 4011.6961987354225, 10217.74455638615, 10535.947320263504, 10603.946980265204, 10675.679729608124, 10685.732856678489, 8894.688685896092, 10584.735381615521, 10633.0, 10635.361878287173, 10648.893511064945, 7926.207379262143, 7939.563324017119, 7991.480553764103, 8013.998250218722, 8108.986376702912, 5642.492175704207, 5646.774129034792, 5664.320281566238, 5729.8567535811935, 5806.81902592425, 9401.670941517013, 9778.902210978084, 9781.462019588991, 9788.608455661693, 9987.650432234837, 9351.0, 9884.456354900549, 9910.851337229804, 9993.10062094415, 10082.243831712503, 6418.390252925965, 7039.9296007039275, 7074.151101867603, 7193.5324203926575, 7249.855002900018, 7757.573333466714, 7760.573168475788, 7814.765557033298, 7855.450118491651, 7867.606619669108, 6656.134702488645, 6719.227288861648, 6720.1599800025, 6745.696443660146, 6825.624590647363, 6566.6388348641285, 6569.9343006569325, 6587.670616469253, 6604.669766511752, 6626.0784372531425, 6241.095041219089, 6307.590006649553, 6366.840828979312, 6384.138141350858, 6386.137871387489, 4417.624501917245, 4509.954900450954, 4613.19269127908, 4616.1229366420275, 4688.859334219979, 4069.8575549855614, 4522.615577675802, 4523.954760452353, 4578.908421831478, 4720.716756994591], "value": 4437.388042137163, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.37728798846587, 299.0371005362733, 302.5054036650078, 303.3387215869404, 308.81625432867435, 5238.711870847102, 6205.534584906133, 6348.301686814452, 6362.5546211765195, 6372.522060845432, 5000.59995200384, 6255.499560035198, 6263.342349053352, 6267.43593076623, 6286.622802631834, 4335.718178318407, 4454.287314029756, 4601.447826260854, 4619.55163763206, 4622.30665400191, 3657.085728567858, 4137.482814648169, 4267.743935363873, 4607.723536587799, 4632.4672662643725, 4300.806463709125, 4535.977320113395, 4599.862004139881, 4601.861944141681, 4625.028743963755, 4206.284931561627, 4559.0, 4567.65742569307, 4589.885252868705, 4617.5151609080895, 3517.788932664023, 3652.721547458368, 3875.0, 3904.1020565270146, 3911.432842237888, 5445.747478080024, 5712.428757124296, 6017.7592896284095, 6053.51571874249, 6059.818205453799, 4938.419705694179, 5017.096922553938, 5041.117804384218, 5106.183010718304, 5328.786848526093, 6041.305249896274, 6544.541882068257, 6583.275839657634, 6583.695706502734, 6628.536002479828, 3693.4829123922673, 3766.4915236443003, 4183.288840897025, 4227.513835908879, 4241.34259189826, 6919.9966004929, 6920.30796920309, 6992.160940687099, 6994.195667498252, 7007.964960175166, 3759.5149915783113, 4127.215828992482, 4172.332426811696, 4388.626966707801, 4397.494288156903, 3666.926661466809, 3965.4646622705563, 4468.731876087445, 4475.843345482893, 4483.189289104235, 5138.717370544581, 5176.844694659167, 5198.584113270929, 5205.29728486657, 5217.452167522356, 5692.430756924275, 6663.901700454186, 6676.833079172962, 6687.899681504781, 6714.093597364391, 1442.5311773673598, 1464.633841539615, 1477.7340078785708, 1482.214426354034, 1487.5388629524882, 782.4405550031755, 875.5709702245854, 920.2821798996794, 944.1596978688972, 946.8201041802035, 6121.755129794758, 6134.98772702508, 6147.784827531015, 6151.2618485781995, 6158.583525789004, 6642.767503137464, 6803.217629972518, 6824.863502729918, 6830.965845170742, 6831.590104593641, 5079.97460012705, 6107.389261073946, 6126.724297406538, 6131.785387511416, 6193.783217587363, 3539.7876127432437, 3610.29599228148, 3616.5117709108936, 3617.149969757105, 3621.149029977953, 6836.624560281424, 7130.2869713028285, 7205.351518363373, 7255.056842610533, 7272.96363518179, 6252.374762523802, 6713.731450741916, 6725.9663701681175, 7199.676014579357, 7203.171635262012, 6046.727897244635, 6520.858849701283, 6974.197967233833, 7242.094738157731, 7290.4896657233485, 6077.787277445268, 6700.765473208415, 6838.931610684029, 6900.896486552806, 6910.99162485747, 5815.709214539341, 6199.008158694587, 6636.535442518977, 6845.760398386033, 6847.733169363484, 6315.873682526416, 6366.294324911802, 7261.419086473175, 7270.890936635848, 7277.490575659653, 4227.957720422879, 4261.296886013773, 4270.722403043792, 4278.550752170977, 4292.892677683083, 5268.262443258023, 6101.572889897665, 6346.746130154742, 6893.448524118159, 6949.652517374212, 6153.292371377349, 6579.854691544297, 6705.8323541909895, 6714.294999025032, 6734.427573656294, 5498.81775418287, 5628.915566266591, 6007.789727359522, 6240.032794916795, 6285.842853928689, 6134.386561344008, 6172.567920245539, 6210.5652604317265, 6484.157059582224, 6615.0, 6038.486728628116, 6479.367252414546, 6594.670266486753, 6687.318876786172, 6734.191896972198, 5472.644278121909, 6379.904301435389, 6396.48828093742, 6496.350364963466, 6514.902276465762], "value": 4705.369466321847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.0906268406391, 558.7066789935285, 571.1261769492678, 579.7014537513181, 582.6387639663407, 12148.906598406142, 12173.878261217385, 12244.938775306133, 12310.81533776994, 12611.936940315309, 11351.943240283787, 11729.53081876724, 11803.350815705133, 11861.0, 11929.403529823518, 731.4514114414189, 749.7525816480576, 894.0924961164424, 925.4586067150725, 927.248928368024, 913.3332667152982, 920.4155361345561, 921.0835218957113, 922.40504874356, 927.285989787863, 963.1476143612917, 968.0899954043177, 970.1656575345197, 970.6554173268494, 972.5623469438746, 915.8671992561108, 916.1388295002677, 954.1269738189549, 961.0485619236975, 966.5119114846992, 708.1643660480631, 709.3048812164056, 724.2106104346235, 728.621117019147, 730.0618704964096, 11771.293722376598, 11976.28142311464, 12325.0, 12372.566960156351, 12405.937970310091, 10429.269951103426, 10460.0, 10516.789664206673, 10785.730356741065, 10901.509432075576, 9087.818243635156, 9091.772705682344, 9220.031896650822, 9313.674021409219, 9418.670346537907, 3250.382427338822, 3258.7393008559256, 3260.250142467246, 3265.8530366133346, 3358.0765289545325, 85392.14607853966, 85514.14485855124, 87428.5628571853, 88847.77880552973, 90626.0, 7503.737369192052, 7524.661390237453, 7618.733344332922, 7706.306432421109, 7786.454948153688, 14139.717205655828, 16582.83417165837, 16813.15934203285, 16976.236069376908, 17015.893966892112, 6551.1155993941165, 6639.767608133789, 6640.269570347258, 6735.865282694319, 6860.216343750561, 3797.2215695782297, 3855.036240939765, 3861.7876016819346, 3876.3447038778527, 3877.1276462795645, 3111.0977816433433, 3189.9362012759616, 3201.775875688726, 3272.9509057364157, 3419.418698821157, 626.6616027345183, 637.1303171171411, 647.8348021254644, 649.5290914087249, 650.7819880340045, 517.495441944109, 551.8703104770376, 580.9941900581025, 598.5241732822417, 608.6895683201599, 6666.266710661824, 7135.928640713631, 7166.140063192451, 7319.560826350436, 7443.8883416748795, 478.52625900358396, 571.5256337240081, 573.2261447046537, 578.644133857683, 599.3317451042057, 3331.566896303465, 3505.8948231553095, 3523.489094081344, 3536.840842162109, 3678.5401824771902, 97950.0, 98336.0, 99591.50204249077, 99794.0, 99894.5005274969, 84619.30761384738, 85134.5743271292, 85158.0, 85565.57217213874, 87488.0, 57157.714211429506, 60603.69698151569, 74877.12807179864, 75571.62214188893, 75979.48041039259, 5600.943990560205, 6810.284920083518, 6832.624205668736, 7012.719491220294, 7028.50800443964, 39533.01167470836, 40370.39444408395, 41287.1742565153, 41567.96080098022, 42048.789756051025, 60327.0, 62444.0, 62782.0, 62897.68551157398, 63923.36076639174, 9398.665682686025, 9451.858222126537, 9479.146876781122, 9598.952005240208, 9855.35940163887, 10526.684199474028, 10529.4735263235, 10739.516721747385, 10836.566537338418, 11103.0, 9929.156021738234, 9976.551055202388, 10134.087932086148, 10159.921945807877, 10405.427701476492, 10097.495125243855, 10326.225533085199, 10334.844977325196, 10358.223133264884, 10383.792324153626, 9939.950300248453, 10005.449700266556, 10101.494925253855, 10258.43578603184, 10264.794704106025, 7912.84174316522, 8744.213020828156, 8817.0, 8960.910390896268, 8981.0, 8736.126387361213, 8787.121287871161, 8817.735467935972, 8831.646734130563, 8931.687390941286], "value": 6312.110534574132, "unit": "score"}], "name": "dromaeo_css", "value": 7079.839650440127, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 110.0, 117.0, 116.0, 115.0, 127.0, 117.0, 116.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 156.0, 145.0, 160.0, 124.0, 141.0, 137.0, 124.0, 170.0, 124.0], "value": 146.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 201.0, 196.0, 210.0, 230.0, 274.0, 275.0, 217.0, 201.0, 196.0], "value": 220.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 80.0, 73.0, 144.0, 57.0, 56.0, 55.0, 65.0, 125.0, 71.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 132.0, 77.0, 85.0, 117.0, 124.0, 81.0, 80.0, 118.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 94.0, 116.0, 93.0, 122.0, 75.0, 119.0], "value": 97.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 109.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 90.0, 90.0, 91.0, 90.0, 90.0, 90.0, 91.0, 91.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 62.0, 60.0, 62.0, 62.0, 62.0, 78.0, 62.0, 61.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 65.0, 66.0, 75.0, 72.0, 70.0, 66.0, 67.0, 67.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 82.0, 84.0, 82.0, 84.0, 82.0, 86.0, 83.0, 85.0, 85.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 176.0, 150.0, 131.0, 148.0, 155.0, 150.0, 181.0, 141.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 168.0, 163.0, 175.0, 205.0, 184.0, 172.0, 166.0, 172.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 71.0, 90.0, 98.0, 93.0, 73.0, 66.0, 69.0, 72.0], "value": 76.8, "unit": "score"}], "name": "kraken", "value": 1562.8, "alertThreshold": 2.0}]} 13:38:18 INFO - Return code: 0 13:38:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:38:18 ERROR - # TBPL SUCCESS # 13:38:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:18 INFO - 2016-04-20 13:38:18.397 screenresolution[1685:10501] starting screenresolution argv=screenresolution get 13:38:18 INFO - 2016-04-20 13:38:18.400 screenresolution[1685:10501] Display 0: 1600x1200x32@60 13:38:18 INFO - 2016-04-20 13:38:18.406 screenresolution[1686:10504] starting screenresolution argv=screenresolution list 13:38:18 INFO - Available Modes on Display 0 13:38:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:18 INFO - Intel Iris: 13:38:18 INFO - Chipset Model: Intel Iris 13:38:18 INFO - Type: GPU 13:38:18 INFO - Bus: Built-In 13:38:18 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:18 INFO - Vendor: Intel (0x8086) 13:38:18 INFO - Device ID: 0x0a2e 13:38:18 INFO - Revision ID: 0x0009 13:38:18 INFO - Displays: 13:38:18 INFO - Display: 13:38:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:18 INFO - Display Serial Number: 1600x1200 60 13:38:18 INFO - Main Display: Yes 13:38:18 INFO - Mirror: Off 13:38:18 INFO - Online: Yes 13:38:18 INFO - Rotation: Supported 13:38:18 INFO - Return code: 0 13:38:18 INFO - Running post-action listener: _resource_record_post_action 13:38:18 INFO - Running post-run listener: _resource_record_post_run 13:38:19 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 32579072; Write bytes: 696448000; Read time: 325; Write time: 2213 13:38:19 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 375630336; Write bytes: 369715200; Read time: 28069; Write time: 707 13:38:19 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 31657472; Write bytes: 299437056; Read time: 311; Write time: 1453 13:38:19 INFO - Running post-run listener: _upload_blobber_files 13:38:19 INFO - Blob upload gear active. 13:38:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:38:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:38:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:21 INFO - (blobuploader) - INFO - Done attempting. 13:38:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:38:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:38:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:22 INFO - (blobuploader) - INFO - Done attempting. 13:38:22 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:22 INFO - Return code: 0 13:38:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e034333de340293f92480791a1acd04f012a042cf3b653044007d5b1006cd450d02c2fce398b2cf44d2bd428136e6bbb41c094c5a008c8debfd6e471ad91f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641e76737d47fba87d2e1e9e13fe18db410ac0c32521b5c10623448f0626b1506e2d6799d8fe2fa3e415e6c158c8d1d264c6b2d57ee99b2d9d458c1e57a1e4f9"} 13:38:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:22 INFO - Contents: 13:38:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e034333de340293f92480791a1acd04f012a042cf3b653044007d5b1006cd450d02c2fce398b2cf44d2bd428136e6bbb41c094c5a008c8debfd6e471ad91f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641e76737d47fba87d2e1e9e13fe18db410ac0c32521b5c10623448f0626b1506e2d6799d8fe2fa3e415e6c158c8d1d264c6b2d57ee99b2d9d458c1e57a1e4f9"} 13:38:22 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:22 INFO - Copying logs to upload dir... 13:38:22 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1489.518637 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 49 secs) (at 2016-04-20 13:38:22.229159) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 13:38:22.233173) ========= 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.NN61ZRbDN0/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.quugX0lupa/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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/Firefox/sha512/43e034333de340293f92480791a1acd04f012a042cf3b653044007d5b1006cd450d02c2fce398b2cf44d2bd428136e6bbb41c094c5a008c8debfd6e471ad91f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641e76737d47fba87d2e1e9e13fe18db410ac0c32521b5c10623448f0626b1506e2d6799d8fe2fa3e415e6c158c8d1d264c6b2d57ee99b2d9d458c1e57a1e4f9"} build_url:https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010961 build_url: 'https://queue.taskcluster.net/v1/task/Z9eEEw1STji-07o_DmwQXw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43e034333de340293f92480791a1acd04f012a042cf3b653044007d5b1006cd450d02c2fce398b2cf44d2bd428136e6bbb41c094c5a008c8debfd6e471ad91f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641e76737d47fba87d2e1e9e13fe18db410ac0c32521b5c10623448f0626b1506e2d6799d8fe2fa3e415e6c158c8d1d264c6b2d57ee99b2d9d458c1e57a1e4f9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 13:38:22.261583) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 13:38:22.262066) ========= 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.NN61ZRbDN0/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.quugX0lupa/Listeners TMPDIR=/var/folders/s_/41fvm5ld6bb_qpjwgs6r2cd800000w/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.004863 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 13:38:22.310866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 13:38:22.311248) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 13:38:22.311714) ========= ========= Total master_lag: 0.15 =========