builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0082 starttime: 1462018128.55 results: success (0) buildid: 20160430030223 builduid: 3777a79ad3e2458a883827273402b3a9 revision: 2b7c421063ad7e30b6491d62ed8480ca333b628a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:48.548811) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:48.549540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:48.549899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:48.886008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:48.886491) ========= 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.sDGOib7Kq1/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.qylSut6823/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-30 05:08:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.41M=0.001s 2016-04-30 05:08:49 (8.41 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.516355 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:49.441470) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:49.441882) ========= 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.sDGOib7Kq1/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.qylSut6823/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.020217 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:49.515030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:49.515340) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2b7c421063ad7e30b6491d62ed8480ca333b628a --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 2b7c421063ad7e30b6491d62ed8480ca333b628a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sDGOib7Kq1/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.qylSut6823/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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-30 05:08:49,594 truncating revision to first 12 chars 2016-04-30 05:08:49,594 Setting DEBUG logging. 2016-04-30 05:08:49,594 attempt 1/10 2016-04-30 05:08:49,594 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2b7c421063ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-30 05:08:50,298 unpacking tar archive at: mozilla-central-2b7c421063ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.952915 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:50.491891) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:50.492192) ========= script_repo_revision: 2b7c421063ad7e30b6491d62ed8480ca333b628a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:50.492568) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:50.492855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-30 05:08:50.506818) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-30 05:08:50.507392) ========= /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.sDGOib7Kq1/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.qylSut6823/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:08:50 INFO - MultiFileLogger online at 20160430 05:08:50 in /builds/slave/test 05:08:50 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 05:08:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:50 INFO - {'append_to_log': False, 05:08:50 INFO - 'base_work_dir': '/builds/slave/test', 05:08:50 INFO - 'blob_upload_branch': 'Firefox', 05:08:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:50 INFO - 'branch': 'Firefox', 05:08:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:50 INFO - 'config_files': ('talos/mac_config.py',), 05:08:50 INFO - 'default_actions': ('clobber', 05:08:50 INFO - 'read-buildbot-config', 05:08:50 INFO - 'download-and-extract', 05:08:50 INFO - 'populate-webroot', 05:08:50 INFO - 'create-virtualenv', 05:08:50 INFO - 'install', 05:08:50 INFO - 'run-tests'), 05:08:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:50 INFO - 'download_minidump_stackwalk': True, 05:08:50 INFO - 'download_symbols': 'ondemand', 05:08:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:50 INFO - 'installer_path': 'installer.exe', 05:08:50 INFO - 'log_level': 'info', 05:08:50 INFO - 'log_name': 'talos', 05:08:50 INFO - 'log_to_console': True, 05:08:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:08:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:08:50 INFO - 'opt_config_files': (), 05:08:50 INFO - 'pip_index': False, 05:08:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:50 INFO - 'cmd': ('bash', 05:08:50 INFO - '-c', 05:08:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:50 INFO - 'enabled': True, 05:08:50 INFO - 'halt_on_failure': False, 05:08:50 INFO - 'name': 'check_screen_resolution'},), 05:08:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:08:50 INFO - 'cmd': ('bash', 05:08:50 INFO - '-c', 05:08:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:08:50 INFO - 'enabled': True, 05:08:50 INFO - 'halt_on_failure': False, 05:08:50 INFO - 'name': 'check_screen_resolution'},), 05:08:50 INFO - 'run_cmd_checks_enabled': True, 05:08:50 INFO - 'sps_profile': False, 05:08:50 INFO - 'sps_profile_interval': 0, 05:08:50 INFO - 'suite': 'dromaeojs-e10s', 05:08:50 INFO - 'system_bits': '32', 05:08:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:50 INFO - 'title': 't-yosemite-r7-0082', 05:08:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:50 INFO - 'use_talos_json': True, 05:08:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:50 INFO - 'work_dir': 'build'} 05:08:50 INFO - ##### 05:08:50 INFO - ##### Running clobber step. 05:08:50 INFO - ##### 05:08:50 INFO - Running pre-action listener: _resource_record_pre_action 05:08:50 INFO - Running main action method: clobber 05:08:50 INFO - rmtree: /builds/slave/test/build 05:08:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:52 INFO - Running post-action listener: _resource_record_post_action 05:08:52 INFO - ##### 05:08:52 INFO - ##### Running read-buildbot-config step. 05:08:52 INFO - ##### 05:08:52 INFO - Running pre-action listener: _resource_record_pre_action 05:08:52 INFO - Running main action method: read_buildbot_config 05:08:52 INFO - Using buildbot properties: 05:08:52 INFO - { 05:08:52 INFO - "project": "", 05:08:52 INFO - "product": "firefox", 05:08:52 INFO - "script_repo_revision": "production", 05:08:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:08:52 INFO - "repository": "", 05:08:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:08:52 INFO - "buildid": "20160430030223", 05:08:52 INFO - "stage_platform": "macosx64", 05:08:52 INFO - "basedir": "/builds/slave/test", 05:08:52 INFO - "nightly_build": "True", 05:08:52 INFO - "buildnumber": 218, 05:08:52 INFO - "slavename": "t-yosemite-r7-0082", 05:08:52 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:08:52 INFO - "platform": "yosemite_r7", 05:08:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:08:52 INFO - "branch": "mozilla-central", 05:08:52 INFO - "repo_path": "mozilla-central", 05:08:52 INFO - "revision": "2b7c421063ad7e30b6491d62ed8480ca333b628a", 05:08:52 INFO - "pgo_build": "False", 05:08:52 INFO - "builduid": "3777a79ad3e2458a883827273402b3a9", 05:08:52 INFO - "slavebuilddir": "test" 05:08:52 INFO - } 05:08:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 05:08:52 INFO - Running post-action listener: _resource_record_post_action 05:08:52 INFO - ##### 05:08:52 INFO - ##### Running download-and-extract step. 05:08:52 INFO - ##### 05:08:52 INFO - Running pre-action listener: _resource_record_pre_action 05:08:52 INFO - Running main action method: download_and_extract 05:08:52 INFO - mkdir: /builds/slave/test/build/tests 05:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:52 INFO - https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 05:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 05:08:58 INFO - Downloaded 1199 bytes. 05:08:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 05:08:58 INFO - Using the following test package requirements: 05:08:58 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:08:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 05:08:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'jsshell-mac.zip'], 05:08:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 05:08:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 05:08:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 05:08:58 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 05:08:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 05:08:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 05:08:58 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08: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')]} 05:08:58 INFO - https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:08:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:08:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:08:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:08:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:01 INFO - Downloaded 18127938 bytes. 05:09:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:09:04 INFO - Return code: 0 05:09:04 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:04 INFO - https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 05:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:09:13 INFO - Downloaded 18127938 bytes. 05:09:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:09:16 INFO - Return code: 0 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:16 INFO - https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 05:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:09:17 INFO - Downloaded 10840152 bytes. 05:09:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:09:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:09:18 INFO - Return code: 0 05:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:18 INFO - https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 05:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 05:09:20 INFO - Downloaded 110649810 bytes. 05:09:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:09:20 INFO - mkdir: /builds/slave/test/properties 05:09:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:20 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:20 INFO - Contents: 05:09:20 INFO - build_url:https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 05:09:22 INFO - Running post-action listener: _resource_record_post_action 05:09:22 INFO - Running post-action listener: set_extra_try_arguments 05:09:22 INFO - ##### 05:09:22 INFO - ##### Running populate-webroot step. 05:09:22 INFO - ##### 05:09:22 INFO - Running pre-action listener: _resource_record_pre_action 05:09:22 INFO - Running main action method: populate_webroot 05:09:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:09:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:09:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:09:22 INFO - '--tppagecycles', 05:09:22 INFO - '7'], 05:09:22 INFO - 'tests': ['tsvgm']}}, 05:09:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:09:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:09:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['damp', 'tps']}, 05:09:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'tests': ['damp', 'tps']}, 05:09:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['dromaeo_dom']}, 05:09:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['a11yr', 05:09:22 INFO - 'ts_paint', 05:09:22 INFO - 'tpaint', 05:09:22 INFO - 'sessionrestore', 05:09:22 INFO - 'sessionrestore_no_auto_restore', 05:09:22 INFO - 'tabpaint']}, 05:09:22 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:22 INFO - 'ts_paint', 05:09:22 INFO - 'tpaint', 05:09:22 INFO - 'sessionrestore', 05:09:22 INFO - 'sessionrestore_no_auto_restore', 05:09:22 INFO - 'tabpaint']}, 05:09:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:09:22 INFO - 'ts_paint', 05:09:22 INFO - 'tpaint', 05:09:22 INFO - 'sessionrestore', 05:09:22 INFO - 'sessionrestore_no_auto_restore', 05:09:22 INFO - 'tabpaint']}, 05:09:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:09:22 INFO - 'ts_paint', 05:09:22 INFO - 'tpaint', 05:09:22 INFO - 'sessionrestore', 05:09:22 INFO - 'sessionrestore_no_auto_restore', 05:09:22 INFO - 'tabpaint']}, 05:09:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['a11yr', 05:09:22 INFO - 'ts_paint', 05:09:22 INFO - 'tpaint', 05:09:22 INFO - 'sessionrestore', 05:09:22 INFO - 'sessionrestore_no_auto_restore', 05:09:22 INFO - 'tabpaint']}, 05:09:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['a11yr', 05:09:22 INFO - 'ts_paint', 05:09:22 INFO - 'tpaint', 05:09:22 INFO - 'sessionrestore', 05:09:22 INFO - 'sessionrestore_no_auto_restore', 05:09:22 INFO - 'tabpaint']}, 05:09:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['tsvgx', 05:09:22 INFO - 'tsvgr_opacity', 05:09:22 INFO - 'tart', 05:09:22 INFO - 'tscrollx', 05:09:22 INFO - 'cart']}, 05:09:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:22 INFO - 'tsvgr_opacity', 05:09:22 INFO - 'tart', 05:09:22 INFO - 'tscrollx', 05:09:22 INFO - 'cart']}, 05:09:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'talos_options': ['--disable-e10s'], 05:09:22 INFO - 'tests': ['tp5o']}, 05:09:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'tests': ['tp5o']}, 05:09:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'talos_options': ['--disable-e10s', 05:09:22 INFO - '--xperf_path', 05:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:22 INFO - 'tests': ['tp5n']}, 05:09:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:09:22 INFO - 'talos_options': ['--xperf_path', 05:09:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:22 INFO - 'tests': ['tp5n']}}, 05:09:22 INFO - 'talos.zip': {'path': '', 05:09:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:09:22 INFO - Running post-action listener: _resource_record_post_action 05:09:22 INFO - ##### 05:09:22 INFO - ##### Running create-virtualenv step. 05:09:22 INFO - ##### 05:09:22 INFO - Running pre-action listener: _resource_record_pre_action 05:09:22 INFO - Running main action method: create_virtualenv 05:09:22 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:09:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:22 INFO - Using real prefix '/tools/python27' 05:09:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:25 INFO - Installing pip.................done. 05:09:25 INFO - Return code: 0 05:09:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:25 INFO - 'HOME': '/Users/cltbld', 05:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:25 INFO - 'LOGNAME': 'cltbld', 05:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:25 INFO - 'MOZ_NO_REMOTE': '1', 05:09:25 INFO - 'NO_EM_RESTART': '1', 05:09:25 INFO - 'PAGER': '/bin/cat', 05:09:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:25 INFO - 'PWD': '/builds/slave/test', 05:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:25 INFO - 'SHELL': '/bin/bash', 05:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:25 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:25 INFO - 'USER': 'cltbld', 05:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:25 INFO - 'XPC_FLAGS': '0x0', 05:09:25 INFO - 'XPC_SERVICE_NAME': '0', 05:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:09:25 INFO - Cleaning up... 05:09:25 INFO - Return code: 0 05:09:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:25 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:09:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:25 INFO - 'HOME': '/Users/cltbld', 05:09:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:25 INFO - 'LOGNAME': 'cltbld', 05:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:25 INFO - 'MOZ_NO_REMOTE': '1', 05:09:25 INFO - 'NO_EM_RESTART': '1', 05:09:25 INFO - 'PAGER': '/bin/cat', 05:09:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:25 INFO - 'PWD': '/builds/slave/test', 05:09:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:25 INFO - 'SHELL': '/bin/bash', 05:09:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:25 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:25 INFO - 'USER': 'cltbld', 05:09:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:25 INFO - 'XPC_FLAGS': '0x0', 05:09:25 INFO - 'XPC_SERVICE_NAME': '0', 05:09:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:26 INFO - Downloading/unpacking psutil>=0.7.1 05:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:29 INFO - Installing collected packages: psutil 05:09:29 INFO - Running setup.py install for psutil 05:09:29 INFO - building 'psutil._psutil_osx' extension 05:09:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:09:29 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:09:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:09:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:09:30 INFO - building 'psutil._psutil_posix' extension 05:09:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:09:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:09:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:09:30 INFO - ^ 05:09:30 INFO - 1 warning generated. 05:09:30 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:09:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:30 INFO - Successfully installed psutil 05:09:30 INFO - Cleaning up... 05:09:30 INFO - Return code: 0 05:09:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:09:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:30 INFO - 'HOME': '/Users/cltbld', 05:09:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:30 INFO - 'LOGNAME': 'cltbld', 05:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:30 INFO - 'MOZ_NO_REMOTE': '1', 05:09:30 INFO - 'NO_EM_RESTART': '1', 05:09:30 INFO - 'PAGER': '/bin/cat', 05:09:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:30 INFO - 'PWD': '/builds/slave/test', 05:09:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:30 INFO - 'SHELL': '/bin/bash', 05:09:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:30 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:30 INFO - 'USER': 'cltbld', 05:09:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:30 INFO - 'XPC_FLAGS': '0x0', 05:09:30 INFO - 'XPC_SERVICE_NAME': '0', 05:09:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:09:33 INFO - Installing collected packages: mozsystemmonitor 05:09:33 INFO - Running setup.py install for mozsystemmonitor 05:09:33 INFO - Successfully installed mozsystemmonitor 05:09:33 INFO - Cleaning up... 05:09:33 INFO - Return code: 0 05:09:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:33 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:09:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:33 INFO - 'HOME': '/Users/cltbld', 05:09:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:33 INFO - 'LOGNAME': 'cltbld', 05:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:33 INFO - 'MOZ_NO_REMOTE': '1', 05:09:33 INFO - 'NO_EM_RESTART': '1', 05:09:33 INFO - 'PAGER': '/bin/cat', 05:09:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:33 INFO - 'PWD': '/builds/slave/test', 05:09:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:33 INFO - 'SHELL': '/bin/bash', 05:09:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:33 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:33 INFO - 'USER': 'cltbld', 05:09:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:33 INFO - 'XPC_FLAGS': '0x0', 05:09:33 INFO - 'XPC_SERVICE_NAME': '0', 05:09:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:37 INFO - Downloading docopt-0.6.1.tar.gz 05:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:37 INFO - Running setup.py install for blobuploader 05:09:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:37 INFO - Running setup.py install for requests 05:09:37 INFO - Running setup.py install for docopt 05:09:38 INFO - Successfully installed blobuploader requests docopt 05:09:38 INFO - Cleaning up... 05:09:38 INFO - Return code: 0 05:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:38 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:38 INFO - 'HOME': '/Users/cltbld', 05:09:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:38 INFO - 'LOGNAME': 'cltbld', 05:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:38 INFO - 'MOZ_NO_REMOTE': '1', 05:09:38 INFO - 'NO_EM_RESTART': '1', 05:09:38 INFO - 'PAGER': '/bin/cat', 05:09:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:38 INFO - 'PWD': '/builds/slave/test', 05:09:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:38 INFO - 'SHELL': '/bin/bash', 05:09:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:38 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:38 INFO - 'USER': 'cltbld', 05:09:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:38 INFO - 'XPC_FLAGS': '0x0', 05:09:38 INFO - 'XPC_SERVICE_NAME': '0', 05:09:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-nSveOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-cX76VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-QyhfYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-LM9eu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0dQQfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:38 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-mWVR7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-zMY_kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Ke7Fjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-fv_g4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-t4J4Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-9HcZch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-SbOize-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ytmPwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-dYY4vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-c2Wmqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:39 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Q2saQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:40 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-y3UMKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:40 INFO - Running setup.py install for manifestparser 05:09:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:40 INFO - Running setup.py install for mozcrash 05:09:40 INFO - Running setup.py install for mozdebug 05:09:40 INFO - Running setup.py install for mozdevice 05:09:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:09:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:40 INFO - Running setup.py install for mozfile 05:09:40 INFO - Running setup.py install for mozhttpd 05:09:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozinfo 05:09:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozInstall 05:09:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozleak 05:09:41 INFO - Running setup.py install for mozlog 05:09:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for moznetwork 05:09:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:41 INFO - Running setup.py install for mozprocess 05:09:41 INFO - Running setup.py install for mozprofile 05:09:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:42 INFO - Running setup.py install for mozrunner 05:09:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:42 INFO - Running setup.py install for mozscreenshot 05:09:42 INFO - Running setup.py install for moztest 05:09:42 INFO - Running setup.py install for mozversion 05:09:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:42 INFO - Cleaning up... 05:09:42 INFO - Return code: 0 05:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:42 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:42 INFO - 'HOME': '/Users/cltbld', 05:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:42 INFO - 'LOGNAME': 'cltbld', 05:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:42 INFO - 'MOZ_NO_REMOTE': '1', 05:09:42 INFO - 'NO_EM_RESTART': '1', 05:09:42 INFO - 'PAGER': '/bin/cat', 05:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:42 INFO - 'PWD': '/builds/slave/test', 05:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:42 INFO - 'SHELL': '/bin/bash', 05:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:42 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:42 INFO - 'USER': 'cltbld', 05:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:42 INFO - 'XPC_FLAGS': '0x0', 05:09:42 INFO - 'XPC_SERVICE_NAME': '0', 05:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-5NfQmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-F9ePny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-2306wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0sKR4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-ZRNY6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-IcYRJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-nxzv5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-MhKQVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TAiCN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:43 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-u2FwjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-K6Q0sC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-n5ELaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qgWRhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-WQhFSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-qVZ36_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TqUyFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:44 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TQL6G4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:09:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:47 INFO - Downloading blessings-1.6.tar.gz 05:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:47 INFO - Installing collected packages: blessings 05:09:47 INFO - Running setup.py install for blessings 05:09:47 INFO - Successfully installed blessings 05:09:47 INFO - Cleaning up... 05:09:47 INFO - Return code: 0 05:09:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:47 INFO - Reading from file tmpfile_stdout 05:09:47 INFO - Current package versions: 05:09:47 INFO - blessings == 1.6 05:09:47 INFO - blobuploader == 1.2.4 05:09:47 INFO - docopt == 0.6.1 05:09:47 INFO - manifestparser == 1.1 05:09:47 INFO - mozInstall == 1.12 05:09:47 INFO - mozcrash == 0.17 05:09:47 INFO - mozdebug == 0.1 05:09:47 INFO - mozdevice == 0.48 05:09:47 INFO - mozfile == 1.2 05:09:47 INFO - mozhttpd == 0.7 05:09:47 INFO - mozinfo == 0.9 05:09:47 INFO - mozleak == 0.1 05:09:47 INFO - mozlog == 3.1 05:09:47 INFO - moznetwork == 0.27 05:09:47 INFO - mozprocess == 0.22 05:09:47 INFO - mozprofile == 0.28 05:09:47 INFO - mozrunner == 6.11 05:09:47 INFO - mozscreenshot == 0.1 05:09:47 INFO - mozsystemmonitor == 0.0 05:09:47 INFO - moztest == 0.7 05:09:47 INFO - mozversion == 1.4 05:09:47 INFO - psutil == 3.1.1 05:09:47 INFO - requests == 1.2.3 05:09:47 INFO - wsgiref == 0.1.2 05:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:47 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:47 INFO - 'HOME': '/Users/cltbld', 05:09:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:47 INFO - 'LOGNAME': 'cltbld', 05:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:47 INFO - 'MOZ_NO_REMOTE': '1', 05:09:47 INFO - 'NO_EM_RESTART': '1', 05:09:47 INFO - 'PAGER': '/bin/cat', 05:09:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:47 INFO - 'PWD': '/builds/slave/test', 05:09:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:47 INFO - 'SHELL': '/bin/bash', 05:09:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:47 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:47 INFO - 'USER': 'cltbld', 05:09:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:47 INFO - 'XPC_FLAGS': '0x0', 05:09:47 INFO - 'XPC_SERVICE_NAME': '0', 05:09:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:09:48 INFO - Cleaning up... 05:09:48 INFO - Return code: 0 05:09:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09: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', 'jsonschema'] in /builds/slave/test/build 05:09: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 jsonschema 05:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:48 INFO - 'HOME': '/Users/cltbld', 05:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:48 INFO - 'LOGNAME': 'cltbld', 05:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:48 INFO - 'MOZ_NO_REMOTE': '1', 05:09:48 INFO - 'NO_EM_RESTART': '1', 05:09:48 INFO - 'PAGER': '/bin/cat', 05:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:48 INFO - 'PWD': '/builds/slave/test', 05:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:48 INFO - 'SHELL': '/bin/bash', 05:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:48 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:48 INFO - 'USER': 'cltbld', 05:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:48 INFO - 'XPC_FLAGS': '0x0', 05:09:48 INFO - 'XPC_SERVICE_NAME': '0', 05:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:48 INFO - Downloading/unpacking jsonschema 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:50 INFO - Downloading/unpacking functools32 (from jsonschema) 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:51 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:51 INFO - warning: no files found matching '*.txt' 05:09:51 INFO - no previously-included directories found matching 'build' 05:09:51 INFO - no previously-included directories found matching 'dist' 05:09:51 INFO - no previously-included directories found matching '.git*' 05:09:51 INFO - Installing collected packages: jsonschema, functools32 05:09:51 INFO - Running setup.py install for functools32 05:09:51 INFO - warning: no files found matching '*.txt' 05:09:51 INFO - no previously-included directories found matching 'build' 05:09:51 INFO - no previously-included directories found matching 'dist' 05:09:51 INFO - no previously-included directories found matching '.git*' 05:09:51 INFO - Successfully installed jsonschema functools32 05:09:51 INFO - Cleaning up... 05:09:51 INFO - Return code: 0 05:09:51 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09:51 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 0x10b4eca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b4fc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1c25c45b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, '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.sDGOib7Kq1/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.qylSut6823/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:09:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:09:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:09:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:51 INFO - 'HOME': '/Users/cltbld', 05:09:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:51 INFO - 'LOGNAME': 'cltbld', 05:09:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:51 INFO - 'MOZ_NO_REMOTE': '1', 05:09:51 INFO - 'NO_EM_RESTART': '1', 05:09:51 INFO - 'PAGER': '/bin/cat', 05:09:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:51 INFO - 'PWD': '/builds/slave/test', 05:09:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:51 INFO - 'SHELL': '/bin/bash', 05:09:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:09:51 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:09:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:51 INFO - 'USER': 'cltbld', 05:09:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:51 INFO - 'XPC_FLAGS': '0x0', 05:09:51 INFO - 'XPC_SERVICE_NAME': '0', 05:09:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:51 INFO - Downloading/unpacking flake8 05:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:09:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:09:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:09:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:55 INFO - no previously-included directories found matching 'docs/_build' 05:09:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:09:55 INFO - Running setup.py install for pep8 05:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:09:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:09:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:09:56 INFO - no previously-included directories found matching 'docs/_build' 05:09:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:09:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:09:56 INFO - Cleaning up... 05:09:56 INFO - Return code: 0 05:09:56 INFO - Running post-action listener: _resource_record_post_action 05:09:56 INFO - Running post-action listener: _start_resource_monitoring 05:09:56 INFO - Starting resource monitoring. 05:09:56 INFO - ##### 05:09:56 INFO - ##### Running install step. 05:09:56 INFO - ##### 05:09:56 INFO - Running pre-action listener: _resource_record_pre_action 05:09:56 INFO - Running main action method: install 05:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:56 INFO - Reading from file tmpfile_stdout 05:09:56 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:56 INFO - Reading from file tmpfile_stdout 05:09:56 INFO - Output received: 05:09:56 INFO - Usage: mozinstall [options] installer 05:09:56 INFO - Options: 05:09:56 INFO - -h, --help show this help message and exit 05:09:56 INFO - -d DEST, --destination=DEST 05:09:56 INFO - Directory to install application into. [default: 05:09:56 INFO - "/builds/slave/test"] 05:09:56 INFO - --app=APP Application being installed. [default: firefox] 05:09:56 INFO - mkdir: /builds/slave/test/build/application 05:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:10:30 INFO - Reading from file tmpfile_stdout 05:10:30 INFO - Output received: 05:10:30 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:10:30 INFO - Running post-action listener: _resource_record_post_action 05:10:30 INFO - ##### 05:10:30 INFO - ##### Running run-tests step. 05:10:30 INFO - ##### 05:10:30 INFO - Running pre-action listener: _resource_record_pre_action 05:10:30 INFO - Running main action method: run_tests 05:10:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:30 INFO - 2016-04-30 05:10:30.937 screenresolution[1981:16147] starting screenresolution argv=screenresolution get 05:10:30 INFO - 2016-04-30 05:10:30.940 screenresolution[1981:16147] Display 0: 1600x1200x32@60 05:10:30 INFO - 2016-04-30 05:10:30.945 screenresolution[1982:16149] starting screenresolution argv=screenresolution list 05:10:30 INFO - Available Modes on Display 0 05:10:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:31 INFO - Intel Iris: 05:10:31 INFO - Chipset Model: Intel Iris 05:10:31 INFO - Type: GPU 05:10:31 INFO - Bus: Built-In 05:10:31 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:31 INFO - Vendor: Intel (0x8086) 05:10:31 INFO - Device ID: 0x0a2e 05:10:31 INFO - Revision ID: 0x0009 05:10:31 INFO - Displays: 05:10:31 INFO - Display: 05:10:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:31 INFO - Display Serial Number: 1600x1200 60 05:10:31 INFO - Main Display: Yes 05:10:31 INFO - Mirror: Off 05:10:31 INFO - Online: Yes 05:10:31 INFO - Rotation: Supported 05:10:31 INFO - Return code: 0 05:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:10:31 INFO - Python 2.7.3 05:10:31 INFO - Return code: 0 05:10:31 INFO - grabbing minidump binary from tooltool 05:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:31 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 0x10b38be00>, '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 0x10b1f4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b386b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:10:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:10:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:10:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:31 INFO - Return code: 0 05:10:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:10:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:10:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:10:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:10:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:10:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:10:32 INFO - Return code: 0 05:10:32 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:10:32 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:10:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sDGOib7Kq1/Render', 05:10:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:10:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:10:32 INFO - 'HOME': '/Users/cltbld', 05:10:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:10:32 INFO - 'LOGNAME': 'cltbld', 05:10:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:10:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:32 INFO - 'MOZ_NO_REMOTE': '1', 05:10:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:10:32 INFO - 'NO_EM_RESTART': '1', 05:10:32 INFO - 'PAGER': '/bin/cat', 05:10:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:10:32 INFO - 'PWD': '/builds/slave/test', 05:10:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:10:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:10:32 INFO - 'SHELL': '/bin/bash', 05:10:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.qylSut6823/Listeners', 05:10:32 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 05:10:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:10:32 INFO - 'USER': 'cltbld', 05:10:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:10:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:32 INFO - 'XPC_FLAGS': '0x0', 05:10:32 INFO - 'XPC_SERVICE_NAME': '0', 05:10:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:10:32 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:10:32 INFO - mozversion application_buildid: 20160430030223 05:10:32 INFO - mozversion application_changeset: 2b7c421063ad7e30b6491d62ed8480ca333b628a 05:10:32 INFO - mozversion application_display_name: Nightly 05:10:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:32 INFO - mozversion application_name: Firefox 05:10:32 INFO - mozversion application_remotingname: firefox 05:10:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:10:32 INFO - mozversion application_vendor: Mozilla 05:10:32 INFO - mozversion application_version: 49.0a1 05:10:32 INFO - mozversion platform_buildid: 20160430030223 05:10:32 INFO - mozversion platform_changeset: 2b7c421063ad7e30b6491d62ed8480ca333b628a 05:10:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:10:32 INFO - mozversion platform_version: 49.0a1 05:10:32 INFO - using testdate: 1462018232 05:10:32 INFO - actual date: 1462018232 05:10:32 INFO - starting webserver on 'localhost:49850' 05:10:32 INFO - SUITE-START | Running 2 tests 05:10:32 INFO - TEST-START | dromaeo_css 05:10:32 INFO - operating with platform_type : mac_ 05:10:32 INFO - Initialising browser for dromaeo_css test... 05:10:32 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpPor0LY/profile http://localhost:49850/getInfo.html) 05:10:35 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 05:10:35 INFO - PROCESS | 2000 | colorDepth:24 05:10:35 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 05:10:35 INFO - PROCESS | 2000 | __metrics 05:10:35 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:10:36 INFO - TEST-INFO | 2000: exit 0 05:10:36 INFO - Browser initialized. 05:10:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:10:36 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpPor0LY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:10:48 INFO - PROCESS | 2004 | RSS: Main: 250150912 05:10:48 INFO - PROCESS | 2004 | 05:11:38 INFO - PROCESS | 2004 | 1462018298211 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:13:48 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49850/tests/dromaeo/cssquery-ext.html) 05:13:50 INFO - PROCESS | 2004 | RSS: Main: 262328320 05:13:50 INFO - PROCESS | 2004 | 05:16:52 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-ext.html (next: http://localhost:49850/tests/dromaeo/cssquery-jquery.html) 05:16:53 INFO - PROCESS | 2004 | RSS: Main: 274014208 05:16:53 INFO - PROCESS | 2004 | 05:19:54 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49850/tests/dromaeo/cssquery-mootools.html) 05:19:55 INFO - PROCESS | 2004 | RSS: Main: 276705280 05:19:55 INFO - PROCESS | 2004 | 05:22:57 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49850/tests/dromaeo/cssquery-prototype.html) 05:22:57 INFO - PROCESS | 2004 | RSS: Main: 277524480 05:22:57 INFO - PROCESS | 2004 | 05:26:00 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49850/tests/dromaeo/cssquery-yui.html) 05:26:01 INFO - PROCESS | 2004 | RSS: Main: 280440832 05:26:01 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | Cycle 1(1): loaded http://localhost:49850/tests/dromaeo/cssquery-yui.html (next: http://localhost:49850/tests/dromaeo/cssquery-dojo.html) 05:29:03 INFO - PROCESS | 2004 | RSS: Main: 281612288 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | __start_tp_report 05:29:03 INFO - PROCESS | 2004 | _x_x_mozilla_page_load 05:29:03 INFO - PROCESS | 2004 | _x_x_mozilla_page_load_details 05:29:03 INFO - PROCESS | 2004 | |i|pagename|runs| 05:29:03 INFO - PROCESS | 2004 | |0;dojo.html;3461.8269086545674;3462.948055779163;3511.6137224905274;3517.859285628575;3521.6830485256305;4990;5018.447970723218;5716.742746576404;5731.541476681866;5737.512311453526;5620.381758006616;5686.402927692595;5735.541156707463;5785.2189954356145;5851.765929362831;5036.194208926572;5148.974255128719;5181.507756763121;5200.453952335007;5247.2653828464045;56.548395811297794;5166.819161329354;5196.532312091911;5217.217417387385;5272.182811664179;5138.511841375063;5183.067047931371;5184.948150518484;5199.168133098724;5201.453847346012;5119.2321151827155;5229.08491014071;5271.973640131813;5298.92051619226;5308.124159513714;4490.50604433512;5129.0767661820855;5142.588592912558;5194.610404219661;5218.765155568009;5551.805686800983;5615.9157612635845;5631.521320687746;5643.407442218549;5698.309014113957;6063.060225665029;6176.073588961647;6256.937430625681;6285.685715714196;6312.779052733178;5282.811367442333;5852.76588936442;6200.81397558074;6255.530835187334;6288.339724328971;4838.879028024292;5877.911831322576;5883.941160588425;5886.823395298148;5894.911576326359;5750.654960702372;6105.065535583899;6261.24865016201;6282.717277722513;6294.276158241769;4943.28322393251;6179.969100154471;6187.16473276111;6188.350223226586;6237.937620623827;5704.258446401941;6304.369563043659;6321.873562528724;6323.177986861679;6329.303776584572;6101.938980610137;6210.968945155245;6232.376762323822;6278.874422511524;6282.905756413657;6100.005955098508;6136.447719705248;6165.753369865245;6283.717232724538;6292.276388215414;4935.975320123376;4959.628027897922;4979.651424400257;4990.326305948651;4991.201407774811;4411.602955733935;4433.445819272591;4486.5962063414445;4513.684042117086;4559.316102584573;5134.768935397916;5748.856278593069;5840.503557197686;5872.765089396462;5888.852778680567;6244.625322480666;6246.250449946036;6253.74985000604;6261.092141639437;6261.217347831521;5689.971550142222;5775.971120144456;5881.911771323434;5890.440408161217;5894.911576326359;5404.162354835007;5425.891482170335;5427.99582077317;5434.293541839615;5436.456354364532;6208.2239720034995;6307.148534947815;6307.5269354798575;6313.526485513605;6320.399562041599;6182.783602573888;6217.316095229611;6254.749810007549;6276.9372306276355;6288.11966324724;6313.210848643919;6321;6325.493960483058;6332.715027823851;6334.144890439732;6031.487323577545;6167.506599471942;6239.1577137085915;6244.406781355764;6249.937500624936;6190.473809726223;6250.468710159687;6264.843378915563;6265.122882796321;6281;6157.84605384869;6160.876782464236;6168.784092556739;6181.690915454119;6186.628802271878;6001.549883758648;6118.143459915705;6122.367660829284;6170.10533472653;6176.845578860564;5861.710423706778;5905.586608937333;5921.792737254175;5987.670678112746;6102.694865256808;6126.23422072241;6128.080787881853;6157.4458298753325;6186.752529898934;6192.318844927145;5891.823245302648;5997.400259973968;6050.667213303311;6094.3600921904335;6103.084537319438 05:29:03 INFO - PROCESS | 2004 | |1;ext.html;459.9310103484475;492.4828929623895;509.80627361602586;522.6028218553898;553.1978630985072;38303.80848095759;39193.60806391935;39240.60759392412;39244.607553924456;39261.01847453808;40748.77753667387;41560.54538091167;41577.96055098624;41648.54230101939;41749.7912510437;9357.812843743139;9607.27945404094;9627.374220675669;9638.710838674851;9643.421394716304;9397.389169703947;9449.291303152257;9468.242540596735;9541.2367010639;9581.377210481296;9432.717018489457;9492.288078394147;9515.476648784314;9521.523923803818;9632.373895696757;8135.227153420416;8144.6742130314715;9468.952655236713;9625.374350667254;9625.663101791404;9296.721098366992;9425.434473931586;9432.717018489457;9438.00900905402;9458.14876661097;39047;39229.21541569181;39267.8036609818;39600.00999975024;39745.40381894274;2665.333666583354;2774.389634280455;2994.970278920906;3095.746222779778;3359.378514974713;26726;26826.463470730672;26834.329141771417;27082.187534374;27231.319217019733;2661.175035738908;2674.7993900457545;2703.445793612305;2815.6761972373233;2836.0073974109105;349109.50890491024;350542;351321.2433937839;352008;353590;56203.43796562064;60004.399955999885;60111.69944150251;60196.69901650464;60232.39767602355;62154;62691.686541567;63521;63691.36308636855;63857.36142638607;16665.916670416813;16790;16853.241604127845;16894.57763555921;16992;12555.623331300076;12970.156939799072;12976.805347919788;13005.934970325088;13009;18914.621707565773;19592.70610940837;19602.039796020283;19803.702944455843;20207.898960505103;7355.485116041933;7709.383249340151;8504.617292221741;8578.323826239624;8609.053004169537;972.8200282947536;974.8537719342014;995.581855620641;1059.3643813711865;1133.5975728616222;28739.13782586526;29584.704152958195;29706.257343566584;30182.623519589535;30339.544906826417;1065.7495488560182;1072.3137192197;1109.8612673415823;1121.302259985212;1136.023020202625;12988.740225195632;15186;15426.84573154254;15554.22228888551;15653.452129175424;523028;622675;630279;641399.793001032;641715;59896.401035989955;60408;60418.39581604128;60420;60533;1439.417036100381;1455.0905683947533;1463.151372204119;1467.2443691498886;1474.1449959023741;24792.876035619705;26619.866900665373;29279.85360073186;29447.85276073606;29604.703952960193;52411.73794131005;52509.21236181537;52809.73595132;52825;52963.205551915984;480545;495150;500291;565419;567416;26400;26797.330066748487;26826.463470730865;26862.791174396807;26869.462610747283;45203;46213.76893115513;46371;46494;46877.531224687315;37878;37912.05219869525;38259.80870095632;38608.06555446289;39077.41383879187;28452.43095138127;30326;37150.256994860494;37577.62422375741;38066.619333807415;30349.393012139193;34917.650823491436;35087.824560878056;35612.46581301335;36203.81898090493;30831.766729330575;30867.69132308648;31668.36663266768;31783.682163178997;32864.1783955403;24660.876695616407;24811.00755969741;25052;25258.49483010293;25329.620055699546 05:29:03 INFO - PROCESS | 2004 | |2;jquery.html;386.35671606774724;391.40506430226037;394.8736404350608;397.4455634390026;406.4857954687319;20095.799042009574;20125.899370503146;20802.167913283487;20872.686909696367;20990.26534071308;17209;19867.60264794703;20201.090950907208;20950;21053.789462105375;4869.975650121744;5576.832695019136;5864.354920958691;5935.169076329317;5948.613340132899;5625.874825034989;5651.886962260753;5687.829365119053;5853.5317174625925;5896.437444077323;5138.7944482220855;5323.307969963918;6085.969570152143;6090.908636370458;6146.139540464339;5747.310322761275;5926.288845338544;6074.878502429949;6075.605085669439;6081.452669259744;5859.531237501033;5882.323532793741;5889.617174883619;5894.3810899855325;5924.58527903047;12809.487620495169;13555.118917270345;13586;13606.319684015858;13613.319334033358;2046.4270004398643;2067.1111422088497;2075.7509098908076;2089.9268525601533;2139.711138996231;8960.23837973773;9596.42421454708;9851.62497704131;9988.550515226832;10215.642452514201;1701.174930158872;1806.683830329687;1809.2491615979484;1824.1517694272227;1834.7981722010702;124538.75461245362;133219.6678033217;133529;134698;135273.64726352808;11288.2662626929;11417.42912854354;11666.416679166008;11669.72440374119;11847.466863990969;14945.953783235287;15049.322780474906;15053.698926021418;15067.698646027018;15076.396944122112;8629.13708629132;8770.166834150745;8867.955660221787;8902.643894244287;8903.685041889155;8753.868691969625;8800.33997450181;8820.2061814437;8840.115988401109;8938.659201119885;4525.208088584484;4567.58891699742;4637.976810115995;4662.487126416091;4737.2183589708;1924.7786504551875;1969.7833238343771;1983.8313743331978;1987.0859404673722;2001.419588319371;878.6090189865577;900.5407242306339;928.874601928731;949.4303417949313;967.1778987860403;19160.90419547893;19608.509787255432;19782;20036.198552057755;20041.29855455052;840.1892174051947;907.8093600344001;930.2929773372285;943;988.4069558264983;10356.275060745675;10487.580496780043;10563.94718026405;10566.630167944086;10596.523156457977;607600;615193;618740;627315;627413;129077;133784;135496.3225183868;136186.31906840403;136385.63614363928;936.1013427109915;970.6554173268529;1031.118393773328;1061.0662616897082;1062.123747907979;17438.82561174372;17923.73114403259;17958.91020544889;17998.73001904999;18305.26778928828;50379.98480060903;52569;53170;53631.39105826832;54033.72983135059;64334.67832660807;72979;77493.2250677486;79169;80050;6450.741970321134;7715.3441957432005;7792.103908050647;8106.959465202636;8274.544900030556;11639;12016.63950081499;12278;12321.322327271728;12535.24788512692;8019.83960320802;10112.292139550162;10201.897981020094;10328.328658637465;10567.365958042543;9270.675526356545;10488.790224195625;10586.629467968583;10787.298825576312;10843.512041958289;10738.677839664822;10993.560257589927;11131.443427828739;11216.719582010515;11429.171332586746;7925.28672419485;7992.480488768211;8067.0722866871065;8080.474769139987;8176.7546973588505;7987.440879138405;9847.458389788344;10929.453527323443;11096.61161859331;11193.216474846682 05:29:03 INFO - PROCESS | 2004 | |3;mootools.html;1596.5130635156277;1624.0905093147835;1887.745154404156;1944.64996300666;1956.3641816409652;7983.441159118864;8454.408191426603;8593.914060859404;8818.77953051174;8822.206001459866;6627.469802415807;8536.567078382663;8606.397552171351;8670.826583468326;8698;2332.813374930006;2346.835721499496;2367.562001029806;2368.822338324624;2389.7371289158264;2337.91817286395;2353.1293421434093;2381.785639292463;2392.461696118377;2402.7356990731005;2337.3922780077132;2350.8119350452007;2361.657559653849;2371.893264803088;2380.0479808076734;2320.535892821434;2329.091654254842;2330.1378489958656;2336.3224664847176;2351.659009443621;2333.49829786595;2334.8015418689433;2336.7663233676667;2345.0971376020184;2354.399628094842;8789.956050219773;8846.159614836644;8868.403687336277;8893.866592001124;8917.108289171096;5144.971005798818;5353.892922141575;5364.061289274361;5401.864953376158;5452.809151679672;2995.281132528199;3454.3436747018236;3488.4244099723514;3546.095745584885;3576.856925722968;1004.678502879079;1014.2899970020941;1019.8521214423942;1032.5049706742655;1041.4116024446164;8729.476231426135;11095.72260693481;11283.153763467692;11462.197646164772;11467.426628668532;4038.5557588665224;4714.81140754366;4746.8101275948575;4753.548412900769;4780.593649539758;10263.435511046815;10264.692059238234;10268;10289.588416463408;10314.535845886952;5362.91955620666;5458.918116228259;5471.699056551848;5482.533984611353;5494.313210848644;4434.600885920283;4745.6440766942615;4909.975450122726;4919.3358896549225;4926.950730492721;3949.4668219790533;3957.56466788653;4034.152827906114;4061.878143655695;4153.3769934510065;1317.6442360562594;1334.4328660319325;1335.419092694681;1342.2818791946263;1348.8516263211038;824.1428913929566;884.752269364579;906.8639704044446;907.3059109781022;909.7088931541975;5015.3730783652045;5679.119736440858;5774.191613174159;5817.301923769175;5861.238039054895;428.85418957554583;446.7855429393909;447.70004097254264;448.4528874772772;892.6474042753076;3854.5952674969285;3965.3457179565626;4074.022234663719;4133.42132101506;4136.73111247768;10294.124999374988;10575.312604680672;10632.41521716313;10654.467276636136;10659.040686338267;10303.072723454776;10443.268971171945;10527.105196058421;10621.2034097443;10673.519691613896;7721.884171737428;7998.840023199504;8160.836783264302;8175.632096555551;8187.345012398994;5745.425457454388;5886;5956.404359564009;5975.34271230173;6061.484773794277;9016.729498115066;9317.906820931705;9641.807163856543;9691.2731545133;9768.36505627132;9755;9774.560144793644;9836.45899475507;9836.557354918903;9860.06329398706;7378.852422951618;7411.4070874328845;7481.364084052916;7519.834425664031;7528.623568821427;8179.509229446252;8239.176082391712;8253.463524870864;8300.501969881827;8323.6670533178;7285.599292038989;7322.707091716485;7550.886736698844;7576.3181313682035;7615.048118985127;6766.323367663194;7136.85726285461;7167.820804479929;7207.063081799332;7255;6729.495287853529;6742.988551717085;6788.4569234462115;6820.181578210647;6873.965630172017;4239.236937351307;4797.904041919072;4804.903901921872;4899.6570240084275;5097.311862898609;4984.825531106394;5024.472430394756;5035.320231768665;5099.464556221544;5247.527722504993 05:29:03 INFO - PROCESS | 2004 | |4;prototype.html;257.1526819130962;308.86101254435494;309.7599360495616;314.71518275960256;315.5109580150766;5049.444561098281;5227.372715274168;5451.5366193873515;5511.283533140696;5570.498655121039;4938.7036777793355;5042.924356134661;5398.78404863805;5429.2083612407905;5437.8368648940595;3271.8854840080603;3898.551666558347;4089.243489954353;4100.138970816132;4138.4413104231;3242.67573242675;3521.806300653463;4107.445494858201;4122.484689413824;4154.189932963073;3588.623194564559;3735.514383130203;4099.180163967204;4104.630583247507;4105.486814148231;3294.6046474423224;4089.7137200395837;4115.54728979812;4139.2135494256;4146.579072265393;3559.9110022249392;3570.8750193743094;3581.925422373278;3606.9278614427826;3608.2422691234874;4401.823927042915;5230.764615592308;5237.16205407133;5248.895022099537;5250.553702935255;4518.570735780096;4681.95318046822;4771.28430735389;4787.305840653085;4790.4969978152485;5121.923171152435;5765.077587585966;5788.913166302509;5835.161923993928;5850.736716847752;3523.365794157051;4014.979925100385;4025.3156963316305;4033.495813023372;4047.170330082326;5285.682859028432;5356.794721187741;5819.912701309484;5842.182094506772;6089.451949324538;3496.9125771855906;4027.8791636250958;4078.5513593504693;4095.5801905409317;4107.568705285962;3682.0610744260043;4160.564605211197;4164.146349998243;4180.979095104505;4188.434561334242;4200.663946884242;4617.976910115428;4790.604697651174;4857.125717370836;4857.514248575185;4933.728644924492;5619.229942568078;5850.3564607893095;5853.595137167049;5892.499137573354;1498.4980031689506;1520.7794869743825;1527.7479215929247;1530.530690537097;1533.6242620558035;888.706726780161;978.5058545434653;997.3467378866853;1008.2488546033105;1019.4189312092185;5164.690118592896;5381.354237491526;5464.617476776588;5511.862203444946;5515.338159420815;5081.136206844772;5095.0638757272;5247.658902171423;5249.194334107741;5704.543636509069;5130.743462826844;5403.945960540423;5420.864478387993;5506.724663766796;5585.301837270341;3457;3475.1833319169973;3483.7038851697384;3485.215826439031;3489.1102768793794;5342.545883599938;6910.861782764317;6918.965405173042;6931.514793964475;6934.202566704793;5022.874428139253;5483.616146869761;6074.149619053336;6190.535709821781;6276.372362763687;5428.240046393508;5818.912716309174;6344.365563443711;6347.270063942613;6415.647139407378;5077.669951453144;5308.362996440452;5731.684757338387;6094.7257373417415;6110.716749482481;6003.339632640494;6008.969955150371;6014.127951447103;6014.398560143951;6026.192142357363;5477.945220547744;5551.500364967173;6056.63660180373;6277.686115694106;6349.365063493614;3904.9219015620097;3906.68746500285;3933.763974161445;3936.9370270027507;3937.370020796773;4484.282514797616;4911.484294149206;4932.950670493249;5761.567882408753;5937.7921772737745;5411.269478620336;5541;5851.707414629337;5868.501177399798;5881.500072493886;5779.774786707232;5840.430210707275;5850.54277203567;5852.531797456279;5857.414258574108;4432.667549933833;5257.869558044886;5434.402215756343;5631.943680563142;5640.266765320646;4767.332573439652;5146.408163061295;5665.830025099253;5857.26784151981;5876.324222714272;5457.863553411196;5583.561068950113;5664.903985525382;5752.353917198136;5779.306483222041 05:29:03 INFO - PROCESS | 2004 | |5;yui.html;674.1707699529582;704.2253521126758;727.9126504819421;734.7758933525273;735.6321839080458;14328.068675536097;14453.783193252084;14851.40594376225;14962.551123466286;15153.015054021482;13806.654833629163;13836.654083647914;13853.653658658539;13907.930460347709;13940.860591394083;724.1816747075824;875.7285241575132;910.5037754423838;928.0626567167142;931.8881734191906;919;924.0620769918538;927.6289484206304;928.4150984879517;934.3879758758025;952.2144231009445;968.5689868008739;972.5817898303727;972.8151651186251;974.9317547771659;917.6237742525533;930.6324002019232;939.642935684439;951.7382719752054;969.1277849935044;677.1501765284586;677.6103740349319;691.512483698991;709.5139829217003;715.9248278930689;13155.736885262337;13431.9926005549;14247.857521424758;14766.70466590673;14770;12254.019678425704;12437.75124497505;12501.624951251386;12713.745725085539;12777;9936.602535898628;10087.747806304827;10113.797724045478;10430.16558675304;10494.370337779681;3413.7269018478464;3454.844531996066;3555.2000799820094;3573.76770509916;3582.982085089558;79936.60031699862;79993.20006799916;82037;83435;84058.57970710169;9370.39092458988;9387.718368448957;9428.952855235817;9540.189083927944;9677.758056048655;21985.23051693183;22080.337589872328;22111.668324975137;22126;22244.666330005064;7005.229424763272;7018.473614478935;7165.426765858719;7214.314640109181;7265.8546829063125;3280.868765249363;4025.1748391579654;4029.2747305485295;4030.5767894371256;4032.475778148822;2953.4388466191353;3494.405950988338;3573.5890372606964;3589.2642008388216;3593.317269718745;622.1569772957578;633.2654121219364;633.7369991453495;638.125767698247;638.3189612449239;528.231423279128;546.573672535423;561.166667498764;599.1671576508656;599.7810799058312;7606.771796846104;7991.600419978978;8093.878591821127;8192.54940978252;8197.79505512355;522.3314157877923;565.5871214013711;568.4656422962485;592.8280798568367;598.8712426828253;3781.9243615128094;3822.50307460034;3830.578636349999;3838.3091043612417;3911.843526258918;93090;93303.53348233216;94518;95770.56344154844;95843.52078239564;73978.63010684912;78788.3635709172;80788.59605701934;81135.59432202802;81944.59027704824;70048.94926576105;72674;72975.54048918992;73032.63483682547;73805;7492;7621.161672215941;7679.923200768144;7760.495567788075;7956.562389068657;45145;45563.54436455593;45578;46109.769451152526;46381.53618463772;62063.6896815513;65611.67194163999;66270.66864665646;66273.0059049105;66882.33117668956;9483.30386712811;10174.898251017692;10200.23345604754;10392.42841643717;10785.676429707122;10258.38449692991;10672.039516443558;10868.565257389615;10869.565217391215;10937.398443085707;10038;10202.905463145382;10314.845277320996;10376.858545559831;10448.164146868081;10451.16390688728;10520.15838732915;10646.414447205478;10737.89262107369;10742;8265.421420500506;8857.734267971971;8956.955215223883;10016.198704103508;10492.94753526258;8612.951378661208;8615.138486151334;8778.341624378325;9101.681441149529;9249.167574918021;8682.696105636525;8728.956355218183;8766.868496972424;8837.867431988398;8900.73297801067 05:29:03 INFO - PROCESS | 2004 | __end_tp_report 05:29:03 INFO - PROCESS | 2004 | __start_cc_report 05:29:03 INFO - PROCESS | 2004 | _x_x_mozilla_cycle_collect,413 05:29:03 INFO - PROCESS | 2004 | __end_cc_report 05:29:03 INFO - PROCESS | 2004 | __startTimestamp1462019343801__endTimestamp 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | ------- Summary: start ------- 05:29:03 INFO - PROCESS | 2004 | Number of tests: 6 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | [#0] dojo.html Cycles:165 Average:5698.77 Median:5905.59 stddev:778.36 (13.2%) stddev-sans-first:760.71 05:29:03 INFO - PROCESS | 2004 | Values: 3461.8 3462.9 3511.6 3517.9 3521.7 4990.0 5018.4 5716.7 5731.5 5737.5 5620.4 5686.4 5735.5 5785.2 5851.8 5036.2 5149.0 5181.5 5200.5 5247.3 56.5 5166.8 5196.5 5217.2 5272.2 5138.5 5183.1 5184.9 5199.2 5201.5 5119.2 5229.1 5272.0 5298.9 5308.1 4490.5 5129.1 5142.6 5194.6 5218.8 5551.8 5615.9 5631.5 5643.4 5698.3 6063.1 6176.1 6256.9 6285.7 6312.8 5282.8 5852.8 6200.8 6255.5 6288.3 4838.9 5877.9 5883.9 5886.8 5894.9 5750.7 6105.1 6261.2 6282.7 6294.3 4943.3 6180.0 6187.2 6188.4 6237.9 5704.3 6304.4 6321.9 6323.2 6329.3 6101.9 6211.0 6232.4 6278.9 6282.9 6100.0 6136.4 6165.8 6283.7 6292.3 4936.0 4959.6 4979.7 4990.3 4991.2 4411.6 4433.4 4486.6 4513.7 4559.3 5134.8 5748.9 5840.5 5872.8 5888.9 6244.6 6246.3 6253.7 6261.1 6261.2 5690.0 5776.0 5881.9 5890.4 5894.9 5404.2 5425.9 5428.0 5434.3 5436.5 6208.2 6307.1 6307.5 6313.5 6320.4 6182.8 6217.3 6254.7 6276.9 6288.1 6313.2 6321.0 6325.5 6332.7 6334.1 6031.5 6167.5 6239.2 6244.4 6249.9 6190.5 6250.5 6264.8 6265.1 6281.0 6157.8 6160.9 6168.8 6181.7 6186.6 6001.5 6118.1 6122.4 6170.1 6176.8 5861.7 5905.6 5921.8 5987.7 6102.7 6126.2 6128.1 6157.4 6186.8 6192.3 5891.8 5997.4 6050.7 6094.4 6103.1 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | [#1] ext.html Cycles:180 Average:63637.24 Median:38455.94 stddev:135638.08 (352.7%) stddev-sans-first:135935.63 05:29:03 INFO - PROCESS | 2004 | Values: 459.9 492.5 509.8 522.6 553.2 38303.8 39193.6 39240.6 39244.6 39261.0 40748.8 41560.5 41578.0 41648.5 41749.8 9357.8 9607.3 9627.4 9638.7 9643.4 9397.4 9449.3 9468.2 9541.2 9581.4 9432.7 9492.3 9515.5 9521.5 9632.4 8135.2 8144.7 9469.0 9625.4 9625.7 9296.7 9425.4 9432.7 9438.0 9458.1 39047.0 39229.2 39267.8 39600.0 39745.4 2665.3 2774.4 2995.0 3095.7 3359.4 26726.0 26826.5 26834.3 27082.2 27231.3 2661.2 2674.8 2703.4 2815.7 2836.0 349109.5 350542.0 351321.2 352008.0 353590.0 56203.4 60004.4 60111.7 60196.7 60232.4 62154.0 62691.7 63521.0 63691.4 63857.4 16665.9 16790.0 16853.2 16894.6 16992.0 12555.6 12970.2 12976.8 13005.9 13009.0 18914.6 19592.7 19602.0 19803.7 20207.9 7355.5 7709.4 8504.6 8578.3 8609.1 972.8 974.9 995.6 1059.4 1133.6 28739.1 29584.7 29706.3 30182.6 30339.5 1065.7 1072.3 1109.9 1121.3 1136.0 12988.7 15186.0 15426.8 15554.2 15653.5 523028.0 622675.0 630279.0 641399.8 641715.0 59896.4 60408.0 60418.4 60420.0 60533.0 1439.4 1455.1 1463.2 1467.2 1474.1 24792.9 26619.9 29279.9 29447.9 29604.7 52411.7 52509.2 52809.7 52825.0 52963.2 480545.0 495150.0 500291.0 565419.0 567416.0 26400.0 26797.3 26826.5 26862.8 26869.5 45203.0 46213.8 46371.0 46494.0 46877.5 37878.0 37912.1 38259.8 38608.1 39077.4 28452.4 30326.0 37150.3 37577.6 38066.6 30349.4 34917.7 35087.8 35612.5 36203.8 30831.8 30867.7 31668.4 31783.7 32864.2 24660.9 24811.0 25052.0 25258.5 25329.6 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | [#2] jquery.html Cycles:180 Average:35595.57 Median:388.88 stddev:103728.49 (26673.6%) stddev-sans-first:103985.78 05:29:03 INFO - PROCESS | 2004 | Values: 386.4 391.4 394.9 397.4 406.5 20095.8 20125.9 20802.2 20872.7 20990.3 17209.0 19867.6 20201.1 20950.0 21053.8 4870.0 5576.8 5864.4 5935.2 5948.6 5625.9 5651.9 5687.8 5853.5 5896.4 5138.8 5323.3 6086.0 6090.9 6146.1 5747.3 5926.3 6074.9 6075.6 6081.5 5859.5 5882.3 5889.6 5894.4 5924.6 12809.5 13555.1 13586.0 13606.3 13613.3 2046.4 2067.1 2075.8 2089.9 2139.7 8960.2 9596.4 9851.6 9988.6 10215.6 1701.2 1806.7 1809.2 1824.2 1834.8 124538.8 133219.7 133529.0 134698.0 135273.6 11288.3 11417.4 11666.4 11669.7 11847.5 14946.0 15049.3 15053.7 15067.7 15076.4 8629.1 8770.2 8868.0 8902.6 8903.7 8753.9 8800.3 8820.2 8840.1 8938.7 4525.2 4567.6 4638.0 4662.5 4737.2 1924.8 1969.8 1983.8 1987.1 2001.4 878.6 900.5 928.9 949.4 967.2 19160.9 19608.5 19782.0 20036.2 20041.3 840.2 907.8 930.3 943.0 988.4 10356.3 10487.6 10563.9 10566.6 10596.5 607600.0 615193.0 618740.0 627315.0 627413.0 129077.0 133784.0 135496.3 136186.3 136385.6 936.1 970.7 1031.1 1061.1 1062.1 17438.8 17923.7 17958.9 17998.7 18305.3 50380.0 52569.0 53170.0 53631.4 54033.7 64334.7 72979.0 77493.2 79169.0 80050.0 6450.7 7715.3 7792.1 8107.0 8274.5 11639.0 12016.6 12278.0 12321.3 12535.2 8019.8 10112.3 10201.9 10328.3 10567.4 9270.7 10488.8 10586.6 10787.3 10843.5 10738.7 10993.6 11131.4 11216.7 11429.2 7925.3 7992.5 8067.1 8080.5 8176.8 7987.4 9847.5 10929.5 11096.6 11193.2 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | [#3] mootools.html Cycles:180 Average:5629.09 Median:4923.14 stddev:3125.25 (63.5%) stddev-sans-first:3119.32 05:29:03 INFO - PROCESS | 2004 | Values: 1596.5 1624.1 1887.7 1944.6 1956.4 7983.4 8454.4 8593.9 8818.8 8822.2 6627.5 8536.6 8606.4 8670.8 8698.0 2332.8 2346.8 2367.6 2368.8 2389.7 2337.9 2353.1 2381.8 2392.5 2402.7 2337.4 2350.8 2361.7 2371.9 2380.0 2320.5 2329.1 2330.1 2336.3 2351.7 2333.5 2334.8 2336.8 2345.1 2354.4 8790.0 8846.2 8868.4 8893.9 8917.1 5145.0 5353.9 5364.1 5401.9 5452.8 2995.3 3454.3 3488.4 3546.1 3576.9 1004.7 1014.3 1019.9 1032.5 1041.4 8729.5 11095.7 11283.2 11462.2 11467.4 4038.6 4714.8 4746.8 4753.5 4780.6 10263.4 10264.7 10268.0 10289.6 10314.5 5362.9 5458.9 5471.7 5482.5 5494.3 4434.6 4745.6 4910.0 4919.3 4927.0 3949.5 3957.6 4034.2 4061.9 4153.4 1317.6 1334.4 1335.4 1342.3 1348.9 824.1 884.8 906.9 907.3 909.7 5015.4 5679.1 5774.2 5817.3 5861.2 428.9 446.8 447.7 448.5 892.6 3854.6 3965.3 4074.0 4133.4 4136.7 10294.1 10575.3 10632.4 10654.5 10659.0 10303.1 10443.3 10527.1 10621.2 10673.5 7721.9 7998.8 8160.8 8175.6 8187.3 5745.4 5886.0 5956.4 5975.3 6061.5 9016.7 9317.9 9641.8 9691.3 9768.4 9755.0 9774.6 9836.5 9836.6 9860.1 7378.9 7411.4 7481.4 7519.8 7528.6 8179.5 8239.2 8253.5 8300.5 8323.7 7285.6 7322.7 7550.9 7576.3 7615.0 6766.3 7136.9 7167.8 7207.1 7255.0 6729.5 6743.0 6788.5 6820.2 6874.0 4239.2 4797.9 4804.9 4899.7 5097.3 4984.8 5024.5 5035.3 5099.5 5247.5 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | [#4] prototype.html Cycles:180 Average:4687.57 Median:5229.07 stddev:1438.35 (27.5%) stddev-sans-first:1403.42 05:29:03 INFO - PROCESS | 2004 | Values: 257.2 308.9 309.8 314.7 315.5 5049.4 5227.4 5451.5 5511.3 5570.5 4938.7 5042.9 5398.8 5429.2 5437.8 3271.9 3898.6 4089.2 4100.1 4138.4 3242.7 3521.8 4107.4 4122.5 4154.2 3588.6 3735.5 4099.2 4104.6 4105.5 3294.6 4089.7 4115.5 4139.2 4146.6 3559.9 3570.9 3581.9 3606.9 3608.2 4401.8 5230.8 5237.2 5248.9 5250.6 4518.6 4682.0 4771.3 4787.3 4790.5 5121.9 5765.1 5788.9 5835.2 5850.7 3523.4 4015.0 4025.3 4033.5 4047.2 5285.7 5356.8 5819.9 5842.2 6089.5 3496.9 4027.9 4078.6 4095.6 4107.6 3682.1 4160.6 4164.1 4181.0 4188.4 4200.7 4618.0 4790.6 4857.1 4857.5 4933.7 5619.2 5850.4 5853.6 5892.5 1498.5 1520.8 1527.7 1530.5 1533.6 888.7 978.5 997.3 1008.2 1019.4 5164.7 5381.4 5464.6 5511.9 5515.3 5081.1 5095.1 5247.7 5249.2 5704.5 5130.7 5403.9 5420.9 5506.7 5585.3 3457.0 3475.2 3483.7 3485.2 3489.1 5342.5 6910.9 6919.0 6931.5 6934.2 5022.9 5483.6 6074.1 6190.5 6276.4 5428.2 5818.9 6344.4 6347.3 6415.6 5077.7 5308.4 5731.7 6094.7 6110.7 6003.3 6009.0 6014.1 6014.4 6026.2 5477.9 5551.5 6056.6 6277.7 6349.4 3904.9 3906.7 3933.8 3936.9 3937.4 4484.3 4911.5 4933.0 5761.6 5937.8 5411.3 5541.0 5851.7 5868.5 5881.5 5779.8 5840.4 5850.5 5852.5 5857.4 4432.7 5257.9 5434.4 5631.9 5640.3 4767.3 5146.4 5665.8 5857.3 5876.3 5457.9 5583.6 5664.9 5752.4 5779.3 05:29:03 INFO - PROCESS | 2004 | 05:29:03 INFO - PROCESS | 2004 | [#5] yui.html Cycles:180 Average:18045.94 Median:33125.00 stddev:26009.74 (78.5%) stddev-sans-first:26050.00 05:29:03 INFO - PROCESS | 2004 | Values: 674.2 704.2 727.9 734.8 735.6 14328.1 14453.8 14851.4 14962.6 15153.0 13806.7 13836.7 13853.7 13907.9 13940.9 724.2 875.7 910.5 928.1 931.9 919.0 924.1 927.6 928.4 934.4 952.2 968.6 972.6 972.8 974.9 917.6 930.6 939.6 951.7 969.1 677.2 677.6 691.5 709.5 715.9 13155.7 13432.0 14247.9 14766.7 14770.0 12254.0 12437.8 12501.6 12713.7 12777.0 9936.6 10087.7 10113.8 10430.2 10494.4 3413.7 3454.8 3555.2 3573.8 3583.0 79936.6 79993.2 82037.0 83435.0 84058.6 9370.4 9387.7 9429.0 9540.2 9677.8 21985.2 22080.3 22111.7 22126.0 22244.7 7005.2 7018.5 7165.4 7214.3 7265.9 3280.9 4025.2 4029.3 4030.6 4032.5 2953.4 3494.4 3573.6 3589.3 3593.3 622.2 633.3 633.7 638.1 638.3 528.2 546.6 561.2 599.2 599.8 7606.8 7991.6 8093.9 8192.5 8197.8 522.3 565.6 568.5 592.8 598.9 3781.9 3822.5 3830.6 3838.3 3911.8 93090.0 93303.5 94518.0 95770.6 95843.5 73978.6 78788.4 80788.6 81135.6 81944.6 70048.9 72674.0 72975.5 73032.6 73805.0 7492.0 7621.2 7679.9 7760.5 7956.6 45145.0 45563.5 45578.0 46109.8 46381.5 62063.7 65611.7 66270.7 66273.0 66882.3 9483.3 10174.9 10200.2 10392.4 10785.7 10258.4 10672.0 10868.6 10869.6 10937.4 10038.0 10202.9 10314.8 10376.9 10448.2 10451.2 10520.2 10646.4 10737.9 10742.0 8265.4 8857.7 8957.0 10016.2 10492.9 8613.0 8615.1 8778.3 9101.7 9249.2 8682.7 8729.0 8766.9 8837.9 8900.7 05:29:03 INFO - PROCESS | 2004 | -------- Summary: end -------- 05:29:03 INFO - PROCESS | 2004 | 05:29:04 INFO - TEST-INFO | 2004: exit 0 05:29:04 INFO - TEST-OK | dromaeo_css | took 1111757ms 05:29:04 INFO - TEST-START | kraken 05:29:04 INFO - operating with platform_type : mac_ 05:29:04 INFO - Initialising browser for kraken test... 05:29:04 INFO - TEST-INFO | started process 2009 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmptfxQwB/profile http://localhost:49850/getInfo.html) 05:29:07 INFO - PROCESS | 2009 | __metrics Screen width/height:1600/1200 05:29:07 INFO - PROCESS | 2009 | colorDepth:24 05:29:07 INFO - PROCESS | 2009 | Browser inner width/height: 1024/689 05:29:07 INFO - PROCESS | 2009 | __metrics 05:29:07 ERROR - PROCESS | 2009 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:29:07 INFO - TEST-INFO | 2009: exit 0 05:29:07 INFO - Browser initialized. 05:29:07 INFO - Running cycle 1/1 for kraken test... 05:29:07 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmptfxQwB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:19 INFO - PROCESS | 2013 | RSS: Main: 250490880 05:29:19 INFO - PROCESS | 2013 | 05:29:22 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:23 INFO - PROCESS | 2013 | RSS: Main: 262631424 05:29:23 INFO - PROCESS | 2013 | 05:29:26 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-dft) 05:29:26 INFO - PROCESS | 2013 | RSS: Main: 267780096 05:29:26 INFO - PROCESS | 2013 | 05:29:30 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-fft) 05:29:31 INFO - PROCESS | 2013 | RSS: Main: 267542528 05:29:31 INFO - PROCESS | 2013 | 05:29:33 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49850/tests/kraken/driver.html?testName=audio-oscillator) 05:29:33 INFO - PROCESS | 2013 | RSS: Main: 268173312 05:29:33 INFO - PROCESS | 2013 | 05:29:36 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:36 INFO - PROCESS | 2013 | RSS: Main: 268709888 05:29:36 INFO - PROCESS | 2013 | 05:29:39 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49850/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:40 INFO - PROCESS | 2013 | RSS: Main: 269467648 05:29:40 INFO - PROCESS | 2013 | 05:29:43 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49850/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:43 INFO - PROCESS | 2013 | RSS: Main: 269545472 05:29:43 INFO - PROCESS | 2013 | 05:29:46 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49850/tests/kraken/driver.html?testName=json-parse-financial) 05:29:47 INFO - PROCESS | 2013 | RSS: Main: 269639680 05:29:47 INFO - PROCESS | 2013 | 05:29:49 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:49 INFO - PROCESS | 2013 | RSS: Main: 268787712 05:29:49 INFO - PROCESS | 2013 | 05:29:51 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:52 INFO - PROCESS | 2013 | RSS: Main: 268828672 05:29:52 INFO - PROCESS | 2013 | 05:29:54 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:55 INFO - PROCESS | 2013 | RSS: Main: 268910592 05:29:55 INFO - PROCESS | 2013 | 05:29:57 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:58 INFO - PROCESS | 2013 | RSS: Main: 268926976 05:29:58 INFO - PROCESS | 2013 | 05:30:01 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:02 INFO - PROCESS | 2013 | RSS: Main: 268898304 05:30:02 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | Cycle 1(1): loaded http://localhost:49850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49850/tests/kraken/driver.html?testName=ai-astar) 05:30:03 INFO - PROCESS | 2013 | RSS: Main: 270548992 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | __start_tp_report 05:30:03 INFO - PROCESS | 2013 | _x_x_mozilla_page_load 05:30:03 INFO - PROCESS | 2013 | _x_x_mozilla_page_load_details 05:30:03 INFO - PROCESS | 2013 | |i|pagename|runs| 05:30:03 INFO - PROCESS | 2013 | |0;ai-astar;115;110;117;115;115;129;117;115;117;117 05:30:03 INFO - PROCESS | 2013 | |1;audio-beat-detection;156;123;149;171;126;143;140;123;209;152 05:30:03 INFO - PROCESS | 2013 | |2;audio-dft;194;193;207;269;256;205;265;282;199;198 05:30:03 INFO - PROCESS | 2013 | |3;audio-fft;73;86;79;173;73;58;60;61;130;51 05:30:03 INFO - PROCESS | 2013 | |4;audio-oscillator;97;132;176;116;79;117;168;120;106;165 05:30:03 INFO - PROCESS | 2013 | |5;imaging-gaussian-blur;89;87;93;87;137;77;136;130;89;103 05:30:03 INFO - PROCESS | 2013 | |6;imaging-darkroom;95;95;96;95;106;152;95;95;94;94 05:30:03 INFO - PROCESS | 2013 | |7;imaging-desaturate;109;149;104;146;132;91;98;90;116;91 05:30:03 INFO - PROCESS | 2013 | |8;json-parse-financial;56;63;60;61;59;56;54;75;85;77 05:30:03 INFO - PROCESS | 2013 | |9;json-stringify-tinderbox;66;69;76;77;75;75;68;70;71;70 05:30:03 INFO - PROCESS | 2013 | |10;stanford-crypto-aes;88;86;85;86;85;84;86;85;86;87 05:30:03 INFO - PROCESS | 2013 | |11;stanford-crypto-ccm;142;130;177;161;137;140;144;146;176;139 05:30:03 INFO - PROCESS | 2013 | |12;stanford-crypto-pbkdf2;172;174;174;171;171;172;171;171;171;172 05:30:03 INFO - PROCESS | 2013 | |13;stanford-crypto-sha256-iterative;70;71;70;69;68;71;69;71;71;72 05:30:03 INFO - PROCESS | 2013 | __end_tp_report 05:30:03 INFO - PROCESS | 2013 | __start_cc_report 05:30:03 INFO - PROCESS | 2013 | _x_x_mozilla_cycle_collect,1078 05:30:03 INFO - PROCESS | 2013 | __end_cc_report 05:30:03 INFO - PROCESS | 2013 | __startTimestamp1462019403961__endTimestamp 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | ------- Summary: start ------- 05:30:03 INFO - PROCESS | 2013 | Number of tests: 14 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#0] ai-astar Cycles:10 Average:116.70 Median:117.00 stddev:4.81 (4.1%) stddev-sans-first:5.06 05:30:03 INFO - PROCESS | 2013 | Values: 115.0 110.0 117.0 115.0 115.0 129.0 117.0 115.0 117.0 117.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:150.50 stddev:26.12 (17.4%) stddev-sans-first:27.59 05:30:03 INFO - PROCESS | 2013 | Values: 156.0 123.0 149.0 171.0 126.0 143.0 140.0 123.0 209.0 152.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#2] audio-dft Cycles:10 Average:226.80 Median:231.50 stddev:36.25 (15.7%) stddev-sans-first:36.46 05:30:03 INFO - PROCESS | 2013 | Values: 194.0 193.0 207.0 269.0 256.0 205.0 265.0 282.0 199.0 198.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#3] audio-fft Cycles:10 Average:84.40 Median:67.00 stddev:38.26 (57.1%) stddev-sans-first:40.36 05:30:03 INFO - PROCESS | 2013 | Values: 73.0 86.0 79.0 173.0 73.0 58.0 60.0 61.0 130.0 51.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#4] audio-oscillator Cycles:10 Average:127.60 Median:166.50 stddev:32.42 (19.5%) stddev-sans-first:32.45 05:30:03 INFO - PROCESS | 2013 | Values: 97.0 132.0 176.0 116.0 79.0 117.0 168.0 120.0 106.0 165.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#5] imaging-gaussian-blur Cycles:10 Average:102.80 Median:87.00 stddev:22.74 (26.1%) stddev-sans-first:23.56 05:30:03 INFO - PROCESS | 2013 | Values: 89.0 87.0 93.0 87.0 137.0 77.0 136.0 130.0 89.0 103.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#6] imaging-darkroom Cycles:10 Average:101.70 Median:95.00 stddev:18.02 (19.0%) stddev-sans-first:18.95 05:30:03 INFO - PROCESS | 2013 | Values: 95.0 95.0 96.0 95.0 106.0 152.0 95.0 95.0 94.0 94.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:119.50 stddev:22.54 (18.9%) stddev-sans-first:23.87 05:30:03 INFO - PROCESS | 2013 | Values: 109.0 149.0 104.0 146.0 132.0 91.0 98.0 90.0 116.0 91.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:62.00 stddev:10.57 (17.1%) stddev-sans-first:10.75 05:30:03 INFO - PROCESS | 2013 | Values: 56.0 63.0 60.0 61.0 59.0 56.0 54.0 75.0 85.0 77.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:73.00 stddev:3.77 (5.2%) stddev-sans-first:3.39 05:30:03 INFO - PROCESS | 2013 | Values: 66.0 69.0 76.0 77.0 75.0 75.0 68.0 70.0 71.0 70.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:0.88 05:30:03 INFO - PROCESS | 2013 | Values: 88.0 86.0 85.0 86.0 85.0 84.0 86.0 85.0 86.0 87.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:145.00 stddev:16.42 (11.3%) stddev-sans-first:17.20 05:30:03 INFO - PROCESS | 2013 | Values: 142.0 130.0 177.0 161.0 137.0 140.0 144.0 146.0 176.0 139.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.90 Median:172.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 05:30:03 INFO - PROCESS | 2013 | Values: 172.0 174.0 174.0 171.0 171.0 172.0 171.0 171.0 171.0 172.0 05:30:03 INFO - PROCESS | 2013 | 05:30:03 INFO - PROCESS | 2013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:71.00 stddev:1.23 (1.7%) stddev-sans-first:1.30 05:30:03 INFO - PROCESS | 2013 | Values: 70.0 71.0 70.0 69.0 68.0 71.0 69.0 71.0 71.0 72.0 05:30:03 INFO - PROCESS | 2013 | -------- Summary: end -------- 05:30:03 INFO - PROCESS | 2013 | 05:30:04 INFO - TEST-INFO | 2013: exit 0 05:30:04 INFO - TEST-OK | kraken | took 60378ms 05:30:04 INFO - SUITE-END | took 1172s 05:30:05 INFO - Completed test suite (00:19:32) 05:30:05 INFO - javascript benchmark 05:30:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3461.8269086545674, 3462.948055779163, 3511.6137224905274, 3517.859285628575, 3521.6830485256305, 4990.0, 5018.447970723218, 5716.742746576404, 5731.541476681866, 5737.512311453526, 5620.381758006616, 5686.402927692595, 5735.541156707463, 5785.2189954356145, 5851.765929362831, 5036.194208926572, 5148.974255128719, 5181.507756763121, 5200.453952335007, 5247.2653828464045, 56.548395811297794, 5166.819161329354, 5196.532312091911, 5217.217417387385, 5272.182811664179, 5138.511841375063, 5183.067047931371, 5184.948150518484, 5199.168133098724, 5201.453847346012, 5119.2321151827155, 5229.08491014071, 5271.973640131813, 5298.92051619226, 5308.124159513714, 4490.50604433512, 5129.0767661820855, 5142.588592912558, 5194.610404219661, 5218.765155568009, 5551.805686800983, 5615.9157612635845, 5631.521320687746, 5643.407442218549, 5698.309014113957, 6063.060225665029, 6176.073588961647, 6256.937430625681, 6285.685715714196, 6312.779052733178, 5282.811367442333, 5852.76588936442, 6200.81397558074, 6255.530835187334, 6288.339724328971, 4838.879028024292, 5877.911831322576, 5883.941160588425, 5886.823395298148, 5894.911576326359, 5750.654960702372, 6105.065535583899, 6261.24865016201, 6282.717277722513, 6294.276158241769, 4943.28322393251, 6179.969100154471, 6187.16473276111, 6188.350223226586, 6237.937620623827, 5704.258446401941, 6304.369563043659, 6321.873562528724, 6323.177986861679, 6329.303776584572, 6101.938980610137, 6210.968945155245, 6232.376762323822, 6278.874422511524, 6282.905756413657, 6100.005955098508, 6136.447719705248, 6165.753369865245, 6283.717232724538, 6292.276388215414, 4935.975320123376, 4959.628027897922, 4979.651424400257, 4990.326305948651, 4991.201407774811, 4411.602955733935, 4433.445819272591, 4486.5962063414445, 4513.684042117086, 4559.316102584573, 5134.768935397916, 5748.856278593069, 5840.503557197686, 5872.765089396462, 5888.852778680567, 6244.625322480666, 6246.250449946036, 6253.74985000604, 6261.092141639437, 6261.217347831521, 5689.971550142222, 5775.971120144456, 5881.911771323434, 5890.440408161217, 5894.911576326359, 5404.162354835007, 5425.891482170335, 5427.99582077317, 5434.293541839615, 5436.456354364532, 6208.2239720034995, 6307.148534947815, 6307.5269354798575, 6313.526485513605, 6320.399562041599, 6182.783602573888, 6217.316095229611, 6254.749810007549, 6276.9372306276355, 6288.11966324724, 6313.210848643919, 6321.0, 6325.493960483058, 6332.715027823851, 6334.144890439732, 6031.487323577545, 6167.506599471942, 6239.1577137085915, 6244.406781355764, 6249.937500624936, 6190.473809726223, 6250.468710159687, 6264.843378915563, 6265.122882796321, 6281.0, 6157.84605384869, 6160.876782464236, 6168.784092556739, 6181.690915454119, 6186.628802271878, 6001.549883758648, 6118.143459915705, 6122.367660829284, 6170.10533472653, 6176.845578860564, 5861.710423706778, 5905.586608937333, 5921.792737254175, 5987.670678112746, 6102.694865256808, 6126.23422072241, 6128.080787881853, 6157.4458298753325, 6186.752529898934, 6192.318844927145, 5891.823245302648, 5997.400259973968, 6050.667213303311, 6094.3600921904335, 6103.084537319438], "value": 5653.646805233391, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.9310103484475, 492.4828929623895, 509.80627361602586, 522.6028218553898, 553.1978630985072, 38303.80848095759, 39193.60806391935, 39240.60759392412, 39244.607553924456, 39261.01847453808, 40748.77753667387, 41560.54538091167, 41577.96055098624, 41648.54230101939, 41749.7912510437, 9357.812843743139, 9607.27945404094, 9627.374220675669, 9638.710838674851, 9643.421394716304, 9397.389169703947, 9449.291303152257, 9468.242540596735, 9541.2367010639, 9581.377210481296, 9432.717018489457, 9492.288078394147, 9515.476648784314, 9521.523923803818, 9632.373895696757, 8135.227153420416, 8144.6742130314715, 9468.952655236713, 9625.374350667254, 9625.663101791404, 9296.721098366992, 9425.434473931586, 9432.717018489457, 9438.00900905402, 9458.14876661097, 39047.0, 39229.21541569181, 39267.8036609818, 39600.00999975024, 39745.40381894274, 2665.333666583354, 2774.389634280455, 2994.970278920906, 3095.746222779778, 3359.378514974713, 26726.0, 26826.463470730672, 26834.329141771417, 27082.187534374, 27231.319217019733, 2661.175035738908, 2674.7993900457545, 2703.445793612305, 2815.6761972373233, 2836.0073974109105, 349109.50890491024, 350542.0, 351321.2433937839, 352008.0, 353590.0, 56203.43796562064, 60004.399955999885, 60111.69944150251, 60196.69901650464, 60232.39767602355, 62154.0, 62691.686541567, 63521.0, 63691.36308636855, 63857.36142638607, 16665.916670416813, 16790.0, 16853.241604127845, 16894.57763555921, 16992.0, 12555.623331300076, 12970.156939799072, 12976.805347919788, 13005.934970325088, 13009.0, 18914.621707565773, 19592.70610940837, 19602.039796020283, 19803.702944455843, 20207.898960505103, 7355.485116041933, 7709.383249340151, 8504.617292221741, 8578.323826239624, 8609.053004169537, 972.8200282947536, 974.8537719342014, 995.581855620641, 1059.3643813711865, 1133.5975728616222, 28739.13782586526, 29584.704152958195, 29706.257343566584, 30182.623519589535, 30339.544906826417, 1065.7495488560182, 1072.3137192197, 1109.8612673415823, 1121.302259985212, 1136.023020202625, 12988.740225195632, 15186.0, 15426.84573154254, 15554.22228888551, 15653.452129175424, 523028.0, 622675.0, 630279.0, 641399.793001032, 641715.0, 59896.401035989955, 60408.0, 60418.39581604128, 60420.0, 60533.0, 1439.417036100381, 1455.0905683947533, 1463.151372204119, 1467.2443691498886, 1474.1449959023741, 24792.876035619705, 26619.866900665373, 29279.85360073186, 29447.85276073606, 29604.703952960193, 52411.73794131005, 52509.21236181537, 52809.73595132, 52825.0, 52963.205551915984, 480545.0, 495150.0, 500291.0, 565419.0, 567416.0, 26400.0, 26797.330066748487, 26826.463470730865, 26862.791174396807, 26869.462610747283, 45203.0, 46213.76893115513, 46371.0, 46494.0, 46877.531224687315, 37878.0, 37912.05219869525, 38259.80870095632, 38608.06555446289, 39077.41383879187, 28452.43095138127, 30326.0, 37150.256994860494, 37577.62422375741, 38066.619333807415, 30349.393012139193, 34917.650823491436, 35087.824560878056, 35612.46581301335, 36203.81898090493, 30831.766729330575, 30867.69132308648, 31668.36663266768, 31783.682163178997, 32864.1783955403, 24660.876695616407, 24811.00755969741, 25052.0, 25258.49483010293, 25329.620055699546], "value": 19379.59415773232, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.35671606774724, 391.40506430226037, 394.8736404350608, 397.4455634390026, 406.4857954687319, 20095.799042009574, 20125.899370503146, 20802.167913283487, 20872.686909696367, 20990.26534071308, 17209.0, 19867.60264794703, 20201.090950907208, 20950.0, 21053.789462105375, 4869.975650121744, 5576.832695019136, 5864.354920958691, 5935.169076329317, 5948.613340132899, 5625.874825034989, 5651.886962260753, 5687.829365119053, 5853.5317174625925, 5896.437444077323, 5138.7944482220855, 5323.307969963918, 6085.969570152143, 6090.908636370458, 6146.139540464339, 5747.310322761275, 5926.288845338544, 6074.878502429949, 6075.605085669439, 6081.452669259744, 5859.531237501033, 5882.323532793741, 5889.617174883619, 5894.3810899855325, 5924.58527903047, 12809.487620495169, 13555.118917270345, 13586.0, 13606.319684015858, 13613.319334033358, 2046.4270004398643, 2067.1111422088497, 2075.7509098908076, 2089.9268525601533, 2139.711138996231, 8960.23837973773, 9596.42421454708, 9851.62497704131, 9988.550515226832, 10215.642452514201, 1701.174930158872, 1806.683830329687, 1809.2491615979484, 1824.1517694272227, 1834.7981722010702, 124538.75461245362, 133219.6678033217, 133529.0, 134698.0, 135273.64726352808, 11288.2662626929, 11417.42912854354, 11666.416679166008, 11669.72440374119, 11847.466863990969, 14945.953783235287, 15049.322780474906, 15053.698926021418, 15067.698646027018, 15076.396944122112, 8629.13708629132, 8770.166834150745, 8867.955660221787, 8902.643894244287, 8903.685041889155, 8753.868691969625, 8800.33997450181, 8820.2061814437, 8840.115988401109, 8938.659201119885, 4525.208088584484, 4567.58891699742, 4637.976810115995, 4662.487126416091, 4737.2183589708, 1924.7786504551875, 1969.7833238343771, 1983.8313743331978, 1987.0859404673722, 2001.419588319371, 878.6090189865577, 900.5407242306339, 928.874601928731, 949.4303417949313, 967.1778987860403, 19160.90419547893, 19608.509787255432, 19782.0, 20036.198552057755, 20041.29855455052, 840.1892174051947, 907.8093600344001, 930.2929773372285, 943.0, 988.4069558264983, 10356.275060745675, 10487.580496780043, 10563.94718026405, 10566.630167944086, 10596.523156457977, 607600.0, 615193.0, 618740.0, 627315.0, 627413.0, 129077.0, 133784.0, 135496.3225183868, 136186.31906840403, 136385.63614363928, 936.1013427109915, 970.6554173268529, 1031.118393773328, 1061.0662616897082, 1062.123747907979, 17438.82561174372, 17923.73114403259, 17958.91020544889, 17998.73001904999, 18305.26778928828, 50379.98480060903, 52569.0, 53170.0, 53631.39105826832, 54033.72983135059, 64334.67832660807, 72979.0, 77493.2250677486, 79169.0, 80050.0, 6450.741970321134, 7715.3441957432005, 7792.103908050647, 8106.959465202636, 8274.544900030556, 11639.0, 12016.63950081499, 12278.0, 12321.322327271728, 12535.24788512692, 8019.83960320802, 10112.292139550162, 10201.897981020094, 10328.328658637465, 10567.365958042543, 9270.675526356545, 10488.790224195625, 10586.629467968583, 10787.298825576312, 10843.512041958289, 10738.677839664822, 10993.560257589927, 11131.443427828739, 11216.719582010515, 11429.171332586746, 7925.28672419485, 7992.480488768211, 8067.0722866871065, 8080.474769139987, 8176.7546973588505, 7987.440879138405, 9847.458389788344, 10929.453527323443, 11096.61161859331, 11193.216474846682], "value": 9316.486491589589, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1596.5130635156277, 1624.0905093147835, 1887.745154404156, 1944.64996300666, 1956.3641816409652, 7983.441159118864, 8454.408191426603, 8593.914060859404, 8818.77953051174, 8822.206001459866, 6627.469802415807, 8536.567078382663, 8606.397552171351, 8670.826583468326, 8698.0, 2332.813374930006, 2346.835721499496, 2367.562001029806, 2368.822338324624, 2389.7371289158264, 2337.91817286395, 2353.1293421434093, 2381.785639292463, 2392.461696118377, 2402.7356990731005, 2337.3922780077132, 2350.8119350452007, 2361.657559653849, 2371.893264803088, 2380.0479808076734, 2320.535892821434, 2329.091654254842, 2330.1378489958656, 2336.3224664847176, 2351.659009443621, 2333.49829786595, 2334.8015418689433, 2336.7663233676667, 2345.0971376020184, 2354.399628094842, 8789.956050219773, 8846.159614836644, 8868.403687336277, 8893.866592001124, 8917.108289171096, 5144.971005798818, 5353.892922141575, 5364.061289274361, 5401.864953376158, 5452.809151679672, 2995.281132528199, 3454.3436747018236, 3488.4244099723514, 3546.095745584885, 3576.856925722968, 1004.678502879079, 1014.2899970020941, 1019.8521214423942, 1032.5049706742655, 1041.4116024446164, 8729.476231426135, 11095.72260693481, 11283.153763467692, 11462.197646164772, 11467.426628668532, 4038.5557588665224, 4714.81140754366, 4746.8101275948575, 4753.548412900769, 4780.593649539758, 10263.435511046815, 10264.692059238234, 10268.0, 10289.588416463408, 10314.535845886952, 5362.91955620666, 5458.918116228259, 5471.699056551848, 5482.533984611353, 5494.313210848644, 4434.600885920283, 4745.6440766942615, 4909.975450122726, 4919.3358896549225, 4926.950730492721, 3949.4668219790533, 3957.56466788653, 4034.152827906114, 4061.878143655695, 4153.3769934510065, 1317.6442360562594, 1334.4328660319325, 1335.419092694681, 1342.2818791946263, 1348.8516263211038, 824.1428913929566, 884.752269364579, 906.8639704044446, 907.3059109781022, 909.7088931541975, 5015.3730783652045, 5679.119736440858, 5774.191613174159, 5817.301923769175, 5861.238039054895, 428.85418957554583, 446.7855429393909, 447.70004097254264, 448.4528874772772, 892.6474042753076, 3854.5952674969285, 3965.3457179565626, 4074.022234663719, 4133.42132101506, 4136.73111247768, 10294.124999374988, 10575.312604680672, 10632.41521716313, 10654.467276636136, 10659.040686338267, 10303.072723454776, 10443.268971171945, 10527.105196058421, 10621.2034097443, 10673.519691613896, 7721.884171737428, 7998.840023199504, 8160.836783264302, 8175.632096555551, 8187.345012398994, 5745.425457454388, 5886.0, 5956.404359564009, 5975.34271230173, 6061.484773794277, 9016.729498115066, 9317.906820931705, 9641.807163856543, 9691.2731545133, 9768.36505627132, 9755.0, 9774.560144793644, 9836.45899475507, 9836.557354918903, 9860.06329398706, 7378.852422951618, 7411.4070874328845, 7481.364084052916, 7519.834425664031, 7528.623568821427, 8179.509229446252, 8239.176082391712, 8253.463524870864, 8300.501969881827, 8323.6670533178, 7285.599292038989, 7322.707091716485, 7550.886736698844, 7576.3181313682035, 7615.048118985127, 6766.323367663194, 7136.85726285461, 7167.820804479929, 7207.063081799332, 7255.0, 6729.495287853529, 6742.988551717085, 6788.4569234462115, 6820.181578210647, 6873.965630172017, 4239.236937351307, 4797.904041919072, 4804.903901921872, 4899.6570240084275, 5097.311862898609, 4984.825531106394, 5024.472430394756, 5035.320231768665, 5099.464556221544, 5247.527722504993], "value": 4493.20471134942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.1526819130962, 308.86101254435494, 309.7599360495616, 314.71518275960256, 315.5109580150766, 5049.444561098281, 5227.372715274168, 5451.5366193873515, 5511.283533140696, 5570.498655121039, 4938.7036777793355, 5042.924356134661, 5398.78404863805, 5429.2083612407905, 5437.8368648940595, 3271.8854840080603, 3898.551666558347, 4089.243489954353, 4100.138970816132, 4138.4413104231, 3242.67573242675, 3521.806300653463, 4107.445494858201, 4122.484689413824, 4154.189932963073, 3588.623194564559, 3735.514383130203, 4099.180163967204, 4104.630583247507, 4105.486814148231, 3294.6046474423224, 4089.7137200395837, 4115.54728979812, 4139.2135494256, 4146.579072265393, 3559.9110022249392, 3570.8750193743094, 3581.925422373278, 3606.9278614427826, 3608.2422691234874, 4401.823927042915, 5230.764615592308, 5237.16205407133, 5248.895022099537, 5250.553702935255, 4518.570735780096, 4681.95318046822, 4771.28430735389, 4787.305840653085, 4790.4969978152485, 5121.923171152435, 5765.077587585966, 5788.913166302509, 5835.161923993928, 5850.736716847752, 3523.365794157051, 4014.979925100385, 4025.3156963316305, 4033.495813023372, 4047.170330082326, 5285.682859028432, 5356.794721187741, 5819.912701309484, 5842.182094506772, 6089.451949324538, 3496.9125771855906, 4027.8791636250958, 4078.5513593504693, 4095.5801905409317, 4107.568705285962, 3682.0610744260043, 4160.564605211197, 4164.146349998243, 4180.979095104505, 4188.434561334242, 4200.663946884242, 4617.976910115428, 4790.604697651174, 4857.125717370836, 4857.514248575185, 4933.728644924492, 5619.229942568078, 5850.3564607893095, 5853.595137167049, 5892.499137573354, 1498.4980031689506, 1520.7794869743825, 1527.7479215929247, 1530.530690537097, 1533.6242620558035, 888.706726780161, 978.5058545434653, 997.3467378866853, 1008.2488546033105, 1019.4189312092185, 5164.690118592896, 5381.354237491526, 5464.617476776588, 5511.862203444946, 5515.338159420815, 5081.136206844772, 5095.0638757272, 5247.658902171423, 5249.194334107741, 5704.543636509069, 5130.743462826844, 5403.945960540423, 5420.864478387993, 5506.724663766796, 5585.301837270341, 3457.0, 3475.1833319169973, 3483.7038851697384, 3485.215826439031, 3489.1102768793794, 5342.545883599938, 6910.861782764317, 6918.965405173042, 6931.514793964475, 6934.202566704793, 5022.874428139253, 5483.616146869761, 6074.149619053336, 6190.535709821781, 6276.372362763687, 5428.240046393508, 5818.912716309174, 6344.365563443711, 6347.270063942613, 6415.647139407378, 5077.669951453144, 5308.362996440452, 5731.684757338387, 6094.7257373417415, 6110.716749482481, 6003.339632640494, 6008.969955150371, 6014.127951447103, 6014.398560143951, 6026.192142357363, 5477.945220547744, 5551.500364967173, 6056.63660180373, 6277.686115694106, 6349.365063493614, 3904.9219015620097, 3906.68746500285, 3933.763974161445, 3936.9370270027507, 3937.370020796773, 4484.282514797616, 4911.484294149206, 4932.950670493249, 5761.567882408753, 5937.7921772737745, 5411.269478620336, 5541.0, 5851.707414629337, 5868.501177399798, 5881.500072493886, 5779.774786707232, 5840.430210707275, 5850.54277203567, 5852.531797456279, 5857.414258574108, 4432.667549933833, 5257.869558044886, 5434.402215756343, 5631.943680563142, 5640.266765320646, 4767.332573439652, 5146.408163061295, 5665.830025099253, 5857.26784151981, 5876.324222714272, 5457.863553411196, 5583.561068950113, 5664.903985525382, 5752.353917198136, 5779.306483222041], "value": 4238.380310619891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [674.1707699529582, 704.2253521126758, 727.9126504819421, 734.7758933525273, 735.6321839080458, 14328.068675536097, 14453.783193252084, 14851.40594376225, 14962.551123466286, 15153.015054021482, 13806.654833629163, 13836.654083647914, 13853.653658658539, 13907.930460347709, 13940.860591394083, 724.1816747075824, 875.7285241575132, 910.5037754423838, 928.0626567167142, 931.8881734191906, 919.0, 924.0620769918538, 927.6289484206304, 928.4150984879517, 934.3879758758025, 952.2144231009445, 968.5689868008739, 972.5817898303727, 972.8151651186251, 974.9317547771659, 917.6237742525533, 930.6324002019232, 939.642935684439, 951.7382719752054, 969.1277849935044, 677.1501765284586, 677.6103740349319, 691.512483698991, 709.5139829217003, 715.9248278930689, 13155.736885262337, 13431.9926005549, 14247.857521424758, 14766.70466590673, 14770.0, 12254.019678425704, 12437.75124497505, 12501.624951251386, 12713.745725085539, 12777.0, 9936.602535898628, 10087.747806304827, 10113.797724045478, 10430.16558675304, 10494.370337779681, 3413.7269018478464, 3454.844531996066, 3555.2000799820094, 3573.76770509916, 3582.982085089558, 79936.60031699862, 79993.20006799916, 82037.0, 83435.0, 84058.57970710169, 9370.39092458988, 9387.718368448957, 9428.952855235817, 9540.189083927944, 9677.758056048655, 21985.23051693183, 22080.337589872328, 22111.668324975137, 22126.0, 22244.666330005064, 7005.229424763272, 7018.473614478935, 7165.426765858719, 7214.314640109181, 7265.8546829063125, 3280.868765249363, 4025.1748391579654, 4029.2747305485295, 4030.5767894371256, 4032.475778148822, 2953.4388466191353, 3494.405950988338, 3573.5890372606964, 3589.2642008388216, 3593.317269718745, 622.1569772957578, 633.2654121219364, 633.7369991453495, 638.125767698247, 638.3189612449239, 528.231423279128, 546.573672535423, 561.166667498764, 599.1671576508656, 599.7810799058312, 7606.771796846104, 7991.600419978978, 8093.878591821127, 8192.54940978252, 8197.79505512355, 522.3314157877923, 565.5871214013711, 568.4656422962485, 592.8280798568367, 598.8712426828253, 3781.9243615128094, 3822.50307460034, 3830.578636349999, 3838.3091043612417, 3911.843526258918, 93090.0, 93303.53348233216, 94518.0, 95770.56344154844, 95843.52078239564, 73978.63010684912, 78788.3635709172, 80788.59605701934, 81135.59432202802, 81944.59027704824, 70048.94926576105, 72674.0, 72975.54048918992, 73032.63483682547, 73805.0, 7492.0, 7621.161672215941, 7679.923200768144, 7760.495567788075, 7956.562389068657, 45145.0, 45563.54436455593, 45578.0, 46109.769451152526, 46381.53618463772, 62063.6896815513, 65611.67194163999, 66270.66864665646, 66273.0059049105, 66882.33117668956, 9483.30386712811, 10174.898251017692, 10200.23345604754, 10392.42841643717, 10785.676429707122, 10258.38449692991, 10672.039516443558, 10868.565257389615, 10869.565217391215, 10937.398443085707, 10038.0, 10202.905463145382, 10314.845277320996, 10376.858545559831, 10448.164146868081, 10451.16390688728, 10520.15838732915, 10646.414447205478, 10737.89262107369, 10742.0, 8265.421420500506, 8857.734267971971, 8956.955215223883, 10016.198704103508, 10492.94753526258, 8612.951378661208, 8615.138486151334, 8778.341624378325, 9101.681441149529, 9249.167574918021, 8682.696105636525, 8728.956355218183, 8766.868496972424, 8837.867431988398, 8900.73297801067], "value": 6696.066515183756, "unit": "score"}], "name": "dromaeo_css", "value": 7119.085312481843, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 110.0, 117.0, 115.0, 115.0, 129.0, 117.0, 115.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 123.0, 149.0, 171.0, 126.0, 143.0, 140.0, 123.0, 209.0, 152.0], "value": 149.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 193.0, 207.0, 269.0, 256.0, 205.0, 265.0, 282.0, 199.0, 198.0], "value": 226.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 86.0, 79.0, 173.0, 73.0, 58.0, 60.0, 61.0, 130.0, 51.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 132.0, 176.0, 116.0, 79.0, 117.0, 168.0, 120.0, 106.0, 165.0], "value": 127.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 93.0, 87.0, 137.0, 77.0, 136.0, 130.0, 89.0, 103.0], "value": 102.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 106.0, 152.0, 95.0, 95.0, 94.0, 94.0], "value": 101.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 149.0, 104.0, 146.0, 132.0, 91.0, 98.0, 90.0, 116.0, 91.0], "value": 112.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 63.0, 60.0, 61.0, 59.0, 56.0, 54.0, 75.0, 85.0, 77.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 76.0, 77.0, 75.0, 75.0, 68.0, 70.0, 71.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 86.0, 85.0, 84.0, 86.0, 85.0, 86.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 130.0, 177.0, 161.0, 137.0, 140.0, 144.0, 146.0, 176.0, 139.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 174.0, 174.0, 171.0, 171.0, 172.0, 171.0, 171.0, 171.0, 172.0], "value": 171.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 70.0, 69.0, 68.0, 71.0, 69.0, 71.0, 71.0, 72.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1635.2000000000003, "alertThreshold": 2.0}]} 05:30:05 INFO - Return code: 0 05:30:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:30:05 ERROR - # TBPL SUCCESS # 05:30:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:30:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:30:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:30:05 INFO - 2016-04-30 05:30:05.283 screenresolution[2019:18718] starting screenresolution argv=screenresolution get 05:30:05 INFO - 2016-04-30 05:30:05.286 screenresolution[2019:18718] Display 0: 1600x1200x32@60 05:30:05 INFO - 2016-04-30 05:30:05.291 screenresolution[2020:18721] starting screenresolution argv=screenresolution list 05:30:05 INFO - Available Modes on Display 0 05:30:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:30:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:30:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:30:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:30:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:30:05 INFO - Intel Iris: 05:30:05 INFO - Chipset Model: Intel Iris 05:30:05 INFO - Type: GPU 05:30:05 INFO - Bus: Built-In 05:30:05 INFO - VRAM (Dynamic, Max): 1536 MB 05:30:05 INFO - Vendor: Intel (0x8086) 05:30:05 INFO - Device ID: 0x0a2e 05:30:05 INFO - Revision ID: 0x0009 05:30:05 INFO - Displays: 05:30:05 INFO - Display: 05:30:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:30:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:30:05 INFO - Display Serial Number: 1600x1200 60 05:30:05 INFO - Main Display: Yes 05:30:05 INFO - Mirror: Off 05:30:05 INFO - Online: Yes 05:30:05 INFO - Rotation: Supported 05:30:05 INFO - Return code: 0 05:30:05 INFO - Running post-action listener: _resource_record_post_action 05:30:05 INFO - Running post-run listener: _resource_record_post_run 05:30:06 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 827392; Write bytes: 700635136; Read time: 9; Write time: 1828 05:30:06 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 383134208; Write bytes: 378861568; Read time: 29452; Write time: 716 05:30:06 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 827392; Write bytes: 298676224; Read time: 9; Write time: 1068 05:30:06 INFO - Running post-run listener: _upload_blobber_files 05:30:06 INFO - Blob upload gear active. 05:30:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:30:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:30:06 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'] 05:30:06 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 05:30:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:30:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:30:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:08 INFO - (blobuploader) - INFO - Done attempting. 05:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:30:09 INFO - (blobuploader) - INFO - Done attempting. 05:30:09 INFO - (blobuploader) - INFO - Iteration through files over. 05:30:09 INFO - Return code: 0 05:30:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:30:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:30:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e50399e236b07b2eef0789f654d81700d2092ca6191cacd0e5c3aff2f7674b5035eb6d6d57b96be2a2b9da4d33778678cc70aa8264b60a317d2a12157ba916e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04d21d35a476b4791793ba373e023b24cdd1bc221afd19d496a75d81bd1fb4e27da8ef88a539fd65103123e062266acb9df6a648ddbe09b9e6bf8e4e7d9cf85"} 05:30:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:30:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:30:09 INFO - Contents: 05:30:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e50399e236b07b2eef0789f654d81700d2092ca6191cacd0e5c3aff2f7674b5035eb6d6d57b96be2a2b9da4d33778678cc70aa8264b60a317d2a12157ba916e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04d21d35a476b4791793ba373e023b24cdd1bc221afd19d496a75d81bd1fb4e27da8ef88a539fd65103123e062266acb9df6a648ddbe09b9e6bf8e4e7d9cf85"} 05:30:09 INFO - Running post-run listener: copy_logs_to_upload_dir 05:30:09 INFO - Copying logs to upload dir... 05:30:09 INFO - mkdir: /builds/slave/test/build/upload/logs 05:30:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.555904 ========= master_lag: 0.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-04-30 05:30:09.791780) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 05:30:09.793290) ========= 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.sDGOib7Kq1/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.qylSut6823/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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/8e50399e236b07b2eef0789f654d81700d2092ca6191cacd0e5c3aff2f7674b5035eb6d6d57b96be2a2b9da4d33778678cc70aa8264b60a317d2a12157ba916e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04d21d35a476b4791793ba373e023b24cdd1bc221afd19d496a75d81bd1fb4e27da8ef88a539fd65103123e062266acb9df6a648ddbe09b9e6bf8e4e7d9cf85"} build_url:https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009999 build_url: 'https://queue.taskcluster.net/v1/task/H0PBKJKoTFyXQQ_5yIqK6g/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e50399e236b07b2eef0789f654d81700d2092ca6191cacd0e5c3aff2f7674b5035eb6d6d57b96be2a2b9da4d33778678cc70aa8264b60a317d2a12157ba916e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e04d21d35a476b4791793ba373e023b24cdd1bc221afd19d496a75d81bd1fb4e27da8ef88a539fd65103123e062266acb9df6a648ddbe09b9e6bf8e4e7d9cf85"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-30 05:30:09.830454) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:30:09.834259) ========= 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.sDGOib7Kq1/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.qylSut6823/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.004838 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-30 05:30:09.895160) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 05:30:09.895472) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-30 05:30:09.895877) ========= ========= Total master_lag: 0.93 =========