builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0151 starttime: 1461197813.39 results: success (0) buildid: 20160420145812 builduid: 0196ae12dcc544b9abb2c818bb34b6f2 revision: a6623a30d98d63a54ac754b28e55e986643e6c93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.391081) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.391518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.391810) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.431573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.431955) ========= 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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-20 17:16:53-- 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% 13.3M=0.001s 2016-04-20 17:16:53 (13.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156759 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.623099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:53.623391) ========= 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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.026141 ========= master_lag: 0.35 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.001378) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.001763) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a6623a30d98d63a54ac754b28e55e986643e6c93 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a6623a30d98d63a54ac754b28e55e986643e6c93 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C5kIMCsmVF/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.OSTJCgFzDK/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-20 17:16:54,039 truncating revision to first 12 chars 2016-04-20 17:16:54,039 Setting DEBUG logging. 2016-04-20 17:16:54,039 attempt 1/10 2016-04-20 17:16:54,039 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a6623a30d98d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 17:16:54,404 unpacking tar archive at: fx-team-a6623a30d98d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.610670 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.739731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.740040) ========= script_repo_revision: a6623a30d98d63a54ac754b28e55e986643e6c93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.740443) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.740727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 17:16:54.756427) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-20 17:16:54.756721) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.C5kIMCsmVF/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.OSTJCgFzDK/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:16:54 INFO - MultiFileLogger online at 20160420 17:16:54 in /builds/slave/test 17:16:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 17:16:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:16:54 INFO - {'append_to_log': False, 17:16:54 INFO - 'base_work_dir': '/builds/slave/test', 17:16:54 INFO - 'blob_upload_branch': 'Fx-Team', 17:16:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:16:54 INFO - 'branch': 'Fx-Team', 17:16:54 INFO - 'buildbot_json_path': 'buildprops.json', 17:16:54 INFO - 'config_files': ('talos/mac_config.py',), 17:16:54 INFO - 'default_actions': ('clobber', 17:16:54 INFO - 'read-buildbot-config', 17:16:54 INFO - 'download-and-extract', 17:16:54 INFO - 'populate-webroot', 17:16:54 INFO - 'create-virtualenv', 17:16:54 INFO - 'install', 17:16:54 INFO - 'run-tests'), 17:16:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:16:54 INFO - 'download_minidump_stackwalk': True, 17:16:54 INFO - 'download_symbols': 'ondemand', 17:16:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:16:54 INFO - 'tooltool.py': '/tools/tooltool.py', 17:16:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:16:54 INFO - '/tools/misc-python/virtualenv.py')}, 17:16:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:16:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:16:54 INFO - 'installer_path': 'installer.exe', 17:16:54 INFO - 'log_level': 'info', 17:16:54 INFO - 'log_name': 'talos', 17:16:54 INFO - 'log_to_console': True, 17:16:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:16:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:16:54 INFO - 'opt_config_files': (), 17:16:54 INFO - 'pip_index': False, 17:16:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:54 INFO - 'cmd': ('bash', 17:16:54 INFO - '-c', 17:16:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:54 INFO - 'enabled': True, 17:16:54 INFO - 'halt_on_failure': False, 17:16:54 INFO - 'name': 'check_screen_resolution'},), 17:16:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:16:54 INFO - 'cmd': ('bash', 17:16:54 INFO - '-c', 17:16:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:16:54 INFO - 'enabled': True, 17:16:54 INFO - 'halt_on_failure': False, 17:16:54 INFO - 'name': 'check_screen_resolution'},), 17:16:54 INFO - 'run_cmd_checks_enabled': True, 17:16:54 INFO - 'sps_profile': False, 17:16:54 INFO - 'sps_profile_interval': 0, 17:16:54 INFO - 'suite': 'dromaeojs', 17:16:54 INFO - 'system_bits': '32', 17:16:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:16:54 INFO - 'title': 't-yosemite-r7-0151', 17:16:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:16:54 INFO - 'use_talos_json': True, 17:16:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:16:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:16:54 INFO - 'work_dir': 'build'} 17:16:54 INFO - ##### 17:16:54 INFO - ##### Running clobber step. 17:16:54 INFO - ##### 17:16:54 INFO - Running pre-action listener: _resource_record_pre_action 17:16:54 INFO - Running main action method: clobber 17:16:54 INFO - rmtree: /builds/slave/test/build 17:16:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - ##### 17:16:56 INFO - ##### Running read-buildbot-config step. 17:16:56 INFO - ##### 17:16:56 INFO - Running pre-action listener: _resource_record_pre_action 17:16:56 INFO - Running main action method: read_buildbot_config 17:16:56 INFO - Using buildbot properties: 17:16:56 INFO - { 17:16:56 INFO - "project": "", 17:16:56 INFO - "product": "firefox", 17:16:56 INFO - "script_repo_revision": "production", 17:16:56 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 17:16:56 INFO - "repository": "", 17:16:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 17:16:56 INFO - "buildid": "20160420145812", 17:16:56 INFO - "pgo_build": "False", 17:16:56 INFO - "basedir": "/builds/slave/test", 17:16:56 INFO - "buildnumber": 680, 17:16:56 INFO - "slavename": "t-yosemite-r7-0151", 17:16:56 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 17:16:56 INFO - "platform": "yosemite_r7", 17:16:56 INFO - "scheduler": "tests-fx-team-macosx64-talos", 17:16:56 INFO - "branch": "fx-team", 17:16:56 INFO - "repo_path": "integration/fx-team", 17:16:56 INFO - "revision": "a6623a30d98d63a54ac754b28e55e986643e6c93", 17:16:56 INFO - "stage_platform": "macosx64", 17:16:56 INFO - "builduid": "0196ae12dcc544b9abb2c818bb34b6f2", 17:16:56 INFO - "slavebuilddir": "test" 17:16:56 INFO - } 17:16:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:16:56 INFO - Running post-action listener: _resource_record_post_action 17:16:56 INFO - ##### 17:16:56 INFO - ##### Running download-and-extract step. 17:16:56 INFO - ##### 17:16:56 INFO - Running pre-action listener: _resource_record_pre_action 17:16:56 INFO - Running main action method: download_and_extract 17:16:56 INFO - mkdir: /builds/slave/test/build/tests 17:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:16:56 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:16:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:16:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:16:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:16:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 17:16:58 INFO - Downloaded 1199 bytes. 17:16:58 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:16:58 INFO - Using the following test package requirements: 17:16:58 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:16:58 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:16:58 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:16:58 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'jsshell-mac.zip'], 17:16:58 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:16:58 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:16:58 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:16:58 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:16:58 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:16:58 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:16:58 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:16:58 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:16: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')]} 17:16:58 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:16:59 INFO - Downloaded 18099652 bytes. 17:16:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:16:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:17:02 INFO - Return code: 0 17:17:02 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:17:02 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')]} 17:17:02 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:17:03 INFO - Downloaded 18099652 bytes. 17:17:03 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:03 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 17:17:07 INFO - Return code: 0 17:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:07 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:17:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:17:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:17:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:17:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:17:08 INFO - Downloaded 10845952 bytes. 17:17:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 17:17:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 17:17:08 INFO - Return code: 0 17:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:08 INFO - https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:17:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:17:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:17:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 17:17:11 INFO - Downloaded 110036674 bytes. 17:17:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:17:11 INFO - mkdir: /builds/slave/test/properties 17:17:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:17:11 INFO - Writing to file /builds/slave/test/properties/build_url 17:17:11 INFO - Contents: 17:17:11 INFO - build_url:https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:17:12 INFO - Running post-action listener: _resource_record_post_action 17:17:12 INFO - Running post-action listener: set_extra_try_arguments 17:17:12 INFO - ##### 17:17:12 INFO - ##### Running populate-webroot step. 17:17:12 INFO - ##### 17:17:12 INFO - Running pre-action listener: _resource_record_pre_action 17:17:12 INFO - Running main action method: populate_webroot 17:17:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:17:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:17:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:17:12 INFO - '--tppagecycles', 17:17:12 INFO - '7'], 17:17:12 INFO - 'tests': ['tsvgm']}}, 17:17:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:17:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:17:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:17:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:17:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:17:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['damp', 'tps']}, 17:17:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'tests': ['damp', 'tps']}, 17:17:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['dromaeo_dom']}, 17:17:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:17:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['a11yr', 17:17:12 INFO - 'ts_paint', 17:17:12 INFO - 'tpaint', 17:17:12 INFO - 'sessionrestore', 17:17:12 INFO - 'sessionrestore_no_auto_restore', 17:17:12 INFO - 'tabpaint']}, 17:17:12 INFO - 'other-e10s': {'tests': ['a11yr', 17:17:12 INFO - 'ts_paint', 17:17:12 INFO - 'tpaint', 17:17:12 INFO - 'sessionrestore', 17:17:12 INFO - 'sessionrestore_no_auto_restore', 17:17:12 INFO - 'tabpaint']}, 17:17:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:17:12 INFO - 'ts_paint', 17:17:12 INFO - 'tpaint', 17:17:12 INFO - 'sessionrestore', 17:17:12 INFO - 'sessionrestore_no_auto_restore', 17:17:12 INFO - 'tabpaint']}, 17:17:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:17:12 INFO - 'ts_paint', 17:17:12 INFO - 'tpaint', 17:17:12 INFO - 'sessionrestore', 17:17:12 INFO - 'sessionrestore_no_auto_restore', 17:17:12 INFO - 'tabpaint']}, 17:17:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['a11yr', 17:17:12 INFO - 'ts_paint', 17:17:12 INFO - 'tpaint', 17:17:12 INFO - 'sessionrestore', 17:17:12 INFO - 'sessionrestore_no_auto_restore', 17:17:12 INFO - 'tabpaint']}, 17:17:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['a11yr', 17:17:12 INFO - 'ts_paint', 17:17:12 INFO - 'tpaint', 17:17:12 INFO - 'sessionrestore', 17:17:12 INFO - 'sessionrestore_no_auto_restore', 17:17:12 INFO - 'tabpaint']}, 17:17:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['tsvgx', 17:17:12 INFO - 'tsvgr_opacity', 17:17:12 INFO - 'tart', 17:17:12 INFO - 'tscrollx', 17:17:12 INFO - 'cart']}, 17:17:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:17:12 INFO - 'tsvgr_opacity', 17:17:12 INFO - 'tart', 17:17:12 INFO - 'tscrollx', 17:17:12 INFO - 'cart']}, 17:17:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'talos_options': ['--disable-e10s'], 17:17:12 INFO - 'tests': ['tp5o']}, 17:17:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'tests': ['tp5o']}, 17:17:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'talos_options': ['--disable-e10s', 17:17:12 INFO - '--xperf_path', 17:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:12 INFO - 'tests': ['tp5n']}, 17:17:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:17:12 INFO - 'talos_options': ['--xperf_path', 17:17:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:17:12 INFO - 'tests': ['tp5n']}}, 17:17:12 INFO - 'talos.zip': {'path': '', 17:17:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:17:12 INFO - Running post-action listener: _resource_record_post_action 17:17:12 INFO - ##### 17:17:12 INFO - ##### Running create-virtualenv step. 17:17:12 INFO - ##### 17:17:12 INFO - Running pre-action listener: _resource_record_pre_action 17:17:12 INFO - Running main action method: create_virtualenv 17:17:12 INFO - Creating virtualenv /builds/slave/test/build/venv 17:17:12 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 17:17:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:17:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:17:12 INFO - Using real prefix '/tools/python27' 17:17:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:17:13 INFO - Installing distribute.............................................................................................................................................................................................done. 17:17:16 INFO - Installing pip.................done. 17:17:16 INFO - Return code: 0 17:17:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:16 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:16 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 17:17:16 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 17:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:16 INFO - 'HOME': '/Users/cltbld', 17:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:16 INFO - 'LOGNAME': 'cltbld', 17:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:16 INFO - 'MOZ_NO_REMOTE': '1', 17:17:16 INFO - 'NO_EM_RESTART': '1', 17:17:16 INFO - 'PAGER': '/bin/cat', 17:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:16 INFO - 'PWD': '/builds/slave/test', 17:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:16 INFO - 'SHELL': '/bin/bash', 17:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:16 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:16 INFO - 'USER': 'cltbld', 17:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:16 INFO - 'XPC_FLAGS': '0x0', 17:17:16 INFO - 'XPC_SERVICE_NAME': '0', 17:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:16 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 17:17:16 INFO - Cleaning up... 17:17:16 INFO - Return code: 0 17:17:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:16 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:16 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 17:17:16 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 17:17:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:16 INFO - 'HOME': '/Users/cltbld', 17:17:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:16 INFO - 'LOGNAME': 'cltbld', 17:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:16 INFO - 'MOZ_NO_REMOTE': '1', 17:17:16 INFO - 'NO_EM_RESTART': '1', 17:17:16 INFO - 'PAGER': '/bin/cat', 17:17:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:16 INFO - 'PWD': '/builds/slave/test', 17:17:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:16 INFO - 'SHELL': '/bin/bash', 17:17:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:16 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:16 INFO - 'USER': 'cltbld', 17:17:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:16 INFO - 'XPC_FLAGS': '0x0', 17:17:16 INFO - 'XPC_SERVICE_NAME': '0', 17:17:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:16 INFO - Downloading/unpacking psutil>=0.7.1 17:17:16 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 17:17:16 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 17:17:16 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 17:17:16 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 17:17:16 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 17:17:16 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 17:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:17:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:19 INFO - Installing collected packages: psutil 17:17:19 INFO - Running setup.py install for psutil 17:17:20 INFO - building 'psutil._psutil_osx' extension 17:17:20 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 17:17:20 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 17:17:20 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 17:17:20 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 17:17:20 INFO - building 'psutil._psutil_posix' extension 17:17:20 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 17:17:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:17:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:17:20 INFO - ^ 17:17:20 INFO - 1 warning generated. 17:17:20 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 17:17:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:17:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:17:21 INFO - Successfully installed psutil 17:17:21 INFO - Cleaning up... 17:17:21 INFO - Return code: 0 17:17:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:21 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:21 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 17:17:21 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 17:17:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:21 INFO - 'HOME': '/Users/cltbld', 17:17:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:21 INFO - 'LOGNAME': 'cltbld', 17:17:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:21 INFO - 'MOZ_NO_REMOTE': '1', 17:17:21 INFO - 'NO_EM_RESTART': '1', 17:17:21 INFO - 'PAGER': '/bin/cat', 17:17:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:21 INFO - 'PWD': '/builds/slave/test', 17:17:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:21 INFO - 'SHELL': '/bin/bash', 17:17:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:21 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:21 INFO - 'USER': 'cltbld', 17:17:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:21 INFO - 'XPC_FLAGS': '0x0', 17:17:21 INFO - 'XPC_SERVICE_NAME': '0', 17:17:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:17:21 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 17:17:21 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 17:17:21 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 17:17:21 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 17:17:21 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 17:17:21 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 17:17:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:17:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:17:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:17:24 INFO - Installing collected packages: mozsystemmonitor 17:17:24 INFO - Running setup.py install for mozsystemmonitor 17:17:24 INFO - Successfully installed mozsystemmonitor 17:17:24 INFO - Cleaning up... 17:17:24 INFO - Return code: 0 17:17:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:17:24 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')]} 17:17:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 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')]} 17:17:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:24 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:24 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 17:17:24 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 17:17:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:24 INFO - 'HOME': '/Users/cltbld', 17:17:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:24 INFO - 'LOGNAME': 'cltbld', 17:17:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:24 INFO - 'MOZ_NO_REMOTE': '1', 17:17:24 INFO - 'NO_EM_RESTART': '1', 17:17:24 INFO - 'PAGER': '/bin/cat', 17:17:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:24 INFO - 'PWD': '/builds/slave/test', 17:17:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:24 INFO - 'SHELL': '/bin/bash', 17:17:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:24 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:24 INFO - 'USER': 'cltbld', 17:17:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:24 INFO - 'XPC_FLAGS': '0x0', 17:17:24 INFO - 'XPC_SERVICE_NAME': '0', 17:17:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:24 INFO - Downloading/unpacking blobuploader==1.2.4 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:24 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 17:17:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:17:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:17:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17: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 17:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:17:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:17:27 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 17:17:27 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 17:17:27 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 17:17:27 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 17:17:27 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 17:17:27 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 17:17:28 INFO - Downloading docopt-0.6.1.tar.gz 17:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:17:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:17:28 INFO - Running setup.py install for blobuploader 17:17:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:17:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:17:28 INFO - Running setup.py install for requests 17:17:28 INFO - Running setup.py install for docopt 17:17:28 INFO - Successfully installed blobuploader requests docopt 17:17:28 INFO - Cleaning up... 17:17:28 INFO - Return code: 0 17:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:28 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:28 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 17:17:28 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 17:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:29 INFO - 'HOME': '/Users/cltbld', 17:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:29 INFO - 'LOGNAME': 'cltbld', 17:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:29 INFO - 'MOZ_NO_REMOTE': '1', 17:17:29 INFO - 'NO_EM_RESTART': '1', 17:17:29 INFO - 'PAGER': '/bin/cat', 17:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:29 INFO - 'PWD': '/builds/slave/test', 17:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:29 INFO - 'SHELL': '/bin/bash', 17:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:29 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:29 INFO - 'USER': 'cltbld', 17:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:29 INFO - 'XPC_FLAGS': '0x0', 17:17:29 INFO - 'XPC_SERVICE_NAME': '0', 17:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-WwQYfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-akrjho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-JWHLIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-W0m2Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-PQeo84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-f5457P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Ly58Yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:29 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-D5cSMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-PcXdsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-t03UJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-MHLWOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-OXO7ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-w0lyJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-g78rq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-G1slbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-YNYP4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:30 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-9s6QRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:17:31 INFO - Running setup.py install for manifestparser 17:17:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:17:31 INFO - Running setup.py install for mozcrash 17:17:31 INFO - Running setup.py install for mozdebug 17:17:31 INFO - Running setup.py install for mozdevice 17:17:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:17:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:17:31 INFO - Running setup.py install for mozfile 17:17:31 INFO - Running setup.py install for mozhttpd 17:17:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:17:31 INFO - Running setup.py install for mozinfo 17:17:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Running setup.py install for mozInstall 17:17:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Running setup.py install for mozleak 17:17:32 INFO - Running setup.py install for mozlog 17:17:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Running setup.py install for moznetwork 17:17:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Running setup.py install for mozprocess 17:17:32 INFO - Running setup.py install for mozprofile 17:17:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:17:32 INFO - Running setup.py install for mozrunner 17:17:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:17:33 INFO - Running setup.py install for mozscreenshot 17:17:33 INFO - Running setup.py install for moztest 17:17:33 INFO - Running setup.py install for mozversion 17:17:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:17:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:17:33 INFO - Cleaning up... 17:17:33 INFO - Return code: 0 17:17:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:33 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:33 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 17:17:33 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 17:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:33 INFO - 'HOME': '/Users/cltbld', 17:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:33 INFO - 'LOGNAME': 'cltbld', 17:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:33 INFO - 'MOZ_NO_REMOTE': '1', 17:17:33 INFO - 'NO_EM_RESTART': '1', 17:17:33 INFO - 'PAGER': '/bin/cat', 17:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:33 INFO - 'PWD': '/builds/slave/test', 17:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:33 INFO - 'SHELL': '/bin/bash', 17:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:33 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:33 INFO - 'USER': 'cltbld', 17:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:33 INFO - 'XPC_FLAGS': '0x0', 17:17:33 INFO - 'XPC_SERVICE_NAME': '0', 17:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:17:33 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uSsMYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:17:33 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)) 17:17:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:17:33 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-znkjkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ln55ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-C7wviK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-L2aFVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-aH1cJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-02uYkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-uwxUi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-n_8qm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-hx4_VU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:17:34 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)) 17:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:17:34 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-fZWPSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:17:35 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)) 17:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:17:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-SuQVLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:17:35 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)) 17:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:17:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-zq4yA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:17:35 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)) 17:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:17:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-yqaND1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:17:35 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)) 17:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-GltPyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:17:35 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)) 17:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:17:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-5Q7iMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:17:35 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)) 17:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:17:35 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-T6C7rZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:17:35 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)) 17:17:35 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)) 17:17:35 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)) 17:17:35 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)) 17:17:35 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)) 17:17:35 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)) 17:17:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:38 INFO - Downloading blessings-1.6.tar.gz 17:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:17:38 INFO - Installing collected packages: blessings 17:17:38 INFO - Running setup.py install for blessings 17:17:38 INFO - Successfully installed blessings 17:17:38 INFO - Cleaning up... 17:17:38 INFO - Return code: 0 17:17:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:38 INFO - Reading from file tmpfile_stdout 17:17:38 INFO - Current package versions: 17:17:38 INFO - blessings == 1.6 17:17:38 INFO - blobuploader == 1.2.4 17:17:38 INFO - docopt == 0.6.1 17:17:38 INFO - manifestparser == 1.1 17:17:38 INFO - mozInstall == 1.12 17:17:38 INFO - mozcrash == 0.17 17:17:38 INFO - mozdebug == 0.1 17:17:38 INFO - mozdevice == 0.48 17:17:38 INFO - mozfile == 1.2 17:17:38 INFO - mozhttpd == 0.7 17:17:38 INFO - mozinfo == 0.9 17:17:38 INFO - mozleak == 0.1 17:17:38 INFO - mozlog == 3.1 17:17:38 INFO - moznetwork == 0.27 17:17:38 INFO - mozprocess == 0.22 17:17:38 INFO - mozprofile == 0.28 17:17:38 INFO - mozrunner == 6.11 17:17:38 INFO - mozscreenshot == 0.1 17:17:38 INFO - mozsystemmonitor == 0.0 17:17:38 INFO - moztest == 0.7 17:17:38 INFO - mozversion == 1.4 17:17:38 INFO - psutil == 3.1.1 17:17:38 INFO - requests == 1.2.3 17:17:38 INFO - wsgiref == 0.1.2 17:17:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:38 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 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:38 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 17:17:38 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 17:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:38 INFO - 'HOME': '/Users/cltbld', 17:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:38 INFO - 'LOGNAME': 'cltbld', 17:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:38 INFO - 'MOZ_NO_REMOTE': '1', 17:17:38 INFO - 'NO_EM_RESTART': '1', 17:17:38 INFO - 'PAGER': '/bin/cat', 17:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:38 INFO - 'PWD': '/builds/slave/test', 17:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:38 INFO - 'SHELL': '/bin/bash', 17:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:38 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:38 INFO - 'USER': 'cltbld', 17:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:38 INFO - 'XPC_FLAGS': '0x0', 17:17:38 INFO - 'XPC_SERVICE_NAME': '0', 17:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 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)) 17:17:38 INFO - Cleaning up... 17:17:38 INFO - Return code: 0 17:17:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:17:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:38 INFO - 'HOME': '/Users/cltbld', 17:17:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:38 INFO - 'LOGNAME': 'cltbld', 17:17:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:38 INFO - 'MOZ_NO_REMOTE': '1', 17:17:38 INFO - 'NO_EM_RESTART': '1', 17:17:38 INFO - 'PAGER': '/bin/cat', 17:17:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:38 INFO - 'PWD': '/builds/slave/test', 17:17:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:38 INFO - 'SHELL': '/bin/bash', 17:17:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:38 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:38 INFO - 'USER': 'cltbld', 17:17:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:38 INFO - 'XPC_FLAGS': '0x0', 17:17:38 INFO - 'XPC_SERVICE_NAME': '0', 17:17:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:39 INFO - Downloading/unpacking jsonschema 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:17:41 INFO - Downloading/unpacking functools32 (from jsonschema) 17:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:41 INFO - Downloading functools32-3.2.3-2.tar.gz 17:17:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:17:42 INFO - warning: no files found matching '*.txt' 17:17:42 INFO - no previously-included directories found matching 'build' 17:17:42 INFO - no previously-included directories found matching 'dist' 17:17:42 INFO - no previously-included directories found matching '.git*' 17:17:42 INFO - Installing collected packages: jsonschema, functools32 17:17:42 INFO - Running setup.py install for functools32 17:17:42 INFO - warning: no files found matching '*.txt' 17:17:42 INFO - no previously-included directories found matching 'build' 17:17:42 INFO - no previously-included directories found matching 'dist' 17:17:42 INFO - no previously-included directories found matching '.git*' 17:17:42 INFO - Successfully installed jsonschema functools32 17:17:42 INFO - Cleaning up... 17:17:42 INFO - Return code: 0 17:17:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:17: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')]} 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17: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')]} 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:17:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d125a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d135420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92b94ab760>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, '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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:17:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:17:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:17:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:17:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:17:42 INFO - 'HOME': '/Users/cltbld', 17:17:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:17:42 INFO - 'LOGNAME': 'cltbld', 17:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:17:42 INFO - 'MOZ_NO_REMOTE': '1', 17:17:42 INFO - 'NO_EM_RESTART': '1', 17:17:42 INFO - 'PAGER': '/bin/cat', 17:17:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:17:42 INFO - 'PWD': '/builds/slave/test', 17:17:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:17:42 INFO - 'SHELL': '/bin/bash', 17:17:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:17:42 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:17:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:17:42 INFO - 'USER': 'cltbld', 17:17:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:17:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:17:42 INFO - 'XPC_FLAGS': '0x0', 17:17:42 INFO - 'XPC_SERVICE_NAME': '0', 17:17:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:17:42 INFO - Downloading/unpacking flake8 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:17:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:17:46 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:17:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:17:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:47 INFO - no previously-included directories found matching 'docs/_build' 17:17:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:17:47 INFO - Running setup.py install for pep8 17:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:17:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:17:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:17:47 INFO - no previously-included directories found matching 'docs/_build' 17:17:47 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:17:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:17:47 INFO - Cleaning up... 17:17:47 INFO - Return code: 0 17:17:47 INFO - Running post-action listener: _resource_record_post_action 17:17:47 INFO - Running post-action listener: _start_resource_monitoring 17:17:47 INFO - Starting resource monitoring. 17:17:47 INFO - ##### 17:17:47 INFO - ##### Running install step. 17:17:47 INFO - ##### 17:17:47 INFO - Running pre-action listener: _resource_record_pre_action 17:17:47 INFO - Running main action method: install 17:17:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:17:48 INFO - Reading from file tmpfile_stdout 17:17:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:17:48 INFO - Reading from file tmpfile_stdout 17:17:48 INFO - Output received: 17:17:48 INFO - Usage: mozinstall [options] installer 17:17:48 INFO - Options: 17:17:48 INFO - -h, --help show this help message and exit 17:17:48 INFO - -d DEST, --destination=DEST 17:17:48 INFO - Directory to install application into. [default: 17:17:48 INFO - "/builds/slave/test"] 17:17:48 INFO - --app=APP Application being installed. [default: firefox] 17:17:48 INFO - mkdir: /builds/slave/test/build/application 17:17:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:18:21 INFO - Reading from file tmpfile_stdout 17:18:21 INFO - Output received: 17:18:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:18:21 INFO - Running post-action listener: _resource_record_post_action 17:18:21 INFO - ##### 17:18:21 INFO - ##### Running run-tests step. 17:18:21 INFO - ##### 17:18:21 INFO - Running pre-action listener: _resource_record_pre_action 17:18:21 INFO - Running main action method: run_tests 17:18:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:21 INFO - 2016-04-20 17:18:21.399 screenresolution[1647:7785] starting screenresolution argv=screenresolution get 17:18:21 INFO - 2016-04-20 17:18:21.401 screenresolution[1647:7785] Display 0: 1600x1200x32@60 17:18:21 INFO - 2016-04-20 17:18:21.408 screenresolution[1648:7788] starting screenresolution argv=screenresolution list 17:18:21 INFO - Available Modes on Display 0 17:18:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:21 INFO - Intel Iris: 17:18:21 INFO - Chipset Model: Intel Iris 17:18:21 INFO - Type: GPU 17:18:21 INFO - Bus: Built-In 17:18:21 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:21 INFO - Vendor: Intel (0x8086) 17:18:21 INFO - Device ID: 0x0a2e 17:18:21 INFO - Revision ID: 0x0009 17:18:21 INFO - Displays: 17:18:21 INFO - Display: 17:18:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:21 INFO - Display Serial Number: 1600x1200 60 17:18:21 INFO - Main Display: Yes 17:18:21 INFO - Mirror: Off 17:18:21 INFO - Online: Yes 17:18:21 INFO - Rotation: Supported 17:18:21 INFO - Return code: 0 17:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:18:21 INFO - Python 2.7.3 17:18:21 INFO - Return code: 0 17:18:21 INFO - grabbing minidump binary from tooltool 17:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:18:21 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 0x10cfc4e00>, '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 0x10cdeddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cfbfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:18:21 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 17:18:21 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 17:18:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:18:21 INFO - Return code: 0 17:18:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:18:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:18:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:18:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:18:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:18:23 INFO - Return code: 0 17:18:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:18:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.C5kIMCsmVF/Render', 17:18:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:18:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:18:23 INFO - 'HOME': '/Users/cltbld', 17:18:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:18:23 INFO - 'LOGNAME': 'cltbld', 17:18:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:18:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:18:23 INFO - 'MOZ_NO_REMOTE': '1', 17:18:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:18:23 INFO - 'NO_EM_RESTART': '1', 17:18:23 INFO - 'PAGER': '/bin/cat', 17:18:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:18:23 INFO - 'PWD': '/builds/slave/test', 17:18:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:18:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:18:23 INFO - 'SHELL': '/bin/bash', 17:18:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.OSTJCgFzDK/Listeners', 17:18:23 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:18:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:18:23 INFO - 'USER': 'cltbld', 17:18:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:18:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:18:23 INFO - 'XPC_FLAGS': '0x0', 17:18:23 INFO - 'XPC_SERVICE_NAME': '0', 17:18:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:18:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:18:23 INFO - mozversion application_buildid: 20160420145812 17:18:23 INFO - mozversion application_changeset: a6623a30d98d63a54ac754b28e55e986643e6c93 17:18:23 INFO - mozversion application_display_name: Nightly 17:18:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:18:23 INFO - mozversion application_name: Firefox 17:18:23 INFO - mozversion application_remotingname: firefox 17:18:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:18:23 INFO - mozversion application_vendor: Mozilla 17:18:23 INFO - mozversion application_version: 48.0a1 17:18:23 INFO - mozversion platform_buildid: 20160420145812 17:18:23 INFO - mozversion platform_changeset: a6623a30d98d63a54ac754b28e55e986643e6c93 17:18:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:18:23 INFO - mozversion platform_version: 48.0a1 17:18:23 INFO - using testdate: 1461197903 17:18:23 INFO - actual date: 1461197903 17:18:23 INFO - starting webserver on 'localhost:49276' 17:18:23 INFO - SUITE-START | Running 2 tests 17:18:23 INFO - TEST-START | dromaeo_css 17:18:23 INFO - operating with platform_type : mac_ 17:18:23 INFO - Initialising browser for dromaeo_css test... 17:18:23 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpLbPD3o/profile http://localhost:49276/getInfo.html) 17:18:25 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 17:18:25 INFO - PROCESS | 1666 | colorDepth:24 17:18:25 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 17:18:25 INFO - PROCESS | 1666 | __metrics 17:18:25 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:18:25 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:18:26 INFO - TEST-INFO | 1666: exit 0 17:18:26 INFO - Browser initialized. 17:18:26 INFO - Running cycle 1/1 for dromaeo_css test... 17:18:26 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpLbPD3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:18:38 INFO - PROCESS | 1668 | RSS: Main: 237789184 17:18:38 INFO - PROCESS | 1668 | 17:19:30 INFO - PROCESS | 1668 | 1461197970286 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] 17:21:40 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 17:21:42 INFO - PROCESS | 1668 | RSS: Main: 375767040 17:21:42 INFO - PROCESS | 1668 | 17:24:44 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 17:24:45 INFO - PROCESS | 1668 | RSS: Main: 380489728 17:24:45 INFO - PROCESS | 1668 | 17:27:47 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 17:27:48 INFO - PROCESS | 1668 | RSS: Main: 375062528 17:27:48 INFO - PROCESS | 1668 | 17:30:50 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 17:30:51 INFO - PROCESS | 1668 | RSS: Main: 375156736 17:30:51 INFO - PROCESS | 1668 | 17:33:54 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 17:33:55 INFO - PROCESS | 1668 | RSS: Main: 341528576 17:33:55 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 17:36:58 INFO - PROCESS | 1668 | RSS: Main: 382681088 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | __start_tp_report 17:36:58 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 17:36:58 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 17:36:58 INFO - PROCESS | 1668 | |i|pagename|runs| 17:36:58 INFO - PROCESS | 1668 | |0;dojo.html;3403.2512847173625;3447.8276086195683;3470.6702863227993;3484.773489723166;3509.6139424663284;5625.915611265835;5697.515711164551;5712.171735098408;5718.857028574283;5732.9999999999945;5690;5721.828345149642;5752.913706294409;5832.270966129234;5837.09525023621;5143.09995750744;5148.948510514893;5188.299579556769;5192.909489007313;5305.628605997563;5269.920951185735;5275.525202731754;5314.627976041678;5322.0686379883555;5364.946350536484;4651.860444186646;4887.729190410483;5147.742612869341;5255.973720131413;5280.735963201863;5214.139666954948;5229.032628963654;5229.921551176735;5248.475152484759;5310.389305229871;4188.895277618053;5141.794328226903;5211.583073354161;5227.79088836446;5263.920896216267;5555.138953462219;5622.971885140589;5643.887122257532;5661.320641523002;5671.7731290748325;6219.378062193789;6230.96884515579;6244.594101383395;6245.094461303131;6262.091996660504;6210.068489726532;6273.780417685405;6280.214973128359;6286.277078135981;6287.434130928238;5672.290963629587;5697.230873832063;5771.336296325892;5781.988152073371;5814.622049566807;6233.065040244;6259.843503912439;6265.937340626535;6268.310485846553;6269.5611307208055;6146.938530614726;6171.753129874754;6173.41352571505;6177.7837775677635;6188.752449902044;6073.210482637229;6202.844928876814;6211.9068213976825;6230.283517395467;6254.718537665816;5993.70031498432;6048.092786082035;6049.0926361046195;6051.031834906482;6104.641056839945;6220.284667263232;6248.656323902229;6267.4045965633195;6273.121762953099;6288.025356069817;4909.2881532177635;4943.431505376856;4944.134776414113;4955.950440495621;4984.22744474607;4329.350597410414;4449.154660614473;4496.820127194941;4511.413516242867;4543.636509079266;5664.54683625309;5675.091985282417;5679.233303503974;5681.914771278434;5686.061799802987;6087.46898570244;6191.938080619227;6204.100405441186;6225.470834978987;6261.906071408933;5648.717564121777;5681;5695.629784064023;5698.886022279531;5711.286089238845;5394.78420863161;5401.891962160735;5404.540614047772;5409.404965453797;5410.48600382963;6182.938170618237;6270.153529273581;6339.207599050119;6349.0476428536085;6372.522060845363;6249.78125765596;6271.404216599416;6273.592216505913;6276.246850377984;6297.55917085818;6151.98492248774;6215.720292586754;6329.430351268408;6344.936550634435;6360.045993101072;6113.388661133851;6144.986077297196;6190.690465476799;6202.193714817045;6240.906386404116;5157.716325602128;6224.37756224374;6228.564000520101;6238.033104868571;6252.9062064069985;5899.528037756883;6044.697765111639;6072.787452439144;6094.847628809138;6098.847528811815;6069.45374916242;6083.878322433438;6091.786787462417;6094.14681944537;6135.07973803933;4859.712176273361;5623.493885550321;5842.38654941225;5856.180134781049;5936.851578710567;5827.358990510956;6052.273727152769;6085.908711369421;6090;6109.602875813236;5907.379725128972;5928.79249226275;5932.644041357532;5933.465988061095;5942.762289508371 17:36:58 INFO - PROCESS | 1668 | |1;ext.html;496.9464734762304;516.0401652925559;524.8320537428025;525.7108590275348;569.9484451187558;28241;31146.53280200796;31165.84417077917;31263.531047034285;38609.806950965205;42116.157676846444;42940;42986.57013429865;43013.7849310753;43027.35458968118;9469.195118414926;9727.854082188773;9758.121769040785;9758.609655613767;9768.072033156874;9590.76023099421;9688.903110968871;9689.854652180187;9694.612215511372;9721.979192184825;9637.277204209713;9722.173615242713;9724.805503889918;9725.173360264385;9727.319087663831;9643.324967252294;9694.806103877918;9704.563294651758;9704.75738106546;9717.951410242975;9475.431474111507;9575.952120239424;9584.90415095854;9586.328956973015;9589.472579008221;41515.7924210377;41541;41550.792246038574;41667.41658417571;41826.790866045776;3125.3905488429764;3295.7198638115788;3535.4520049392386;3691.1141326081815;3709.8145092745253;28005.579916301067;29492;30097;30270.54594181089;30293.394132117453;2732.6584176977876;2736.2475319287155;2829.5472724364004;2863.627728395316;2873.181143374149;381910;450667;455134;456105;456292.7185364085;35247.82376088155;36148.45777313342;36250.8187459061;36266.91199264026;36295.63704362975;35524.822375887954;35654.465183021755;35715.285694285965;35748.463773043426;35786.46320305197;14318.284085795669;14459.204743738985;14472.565823025327;14497.20265385414;14508.274586270856;12456.75086498265;12523.185992910432;12544.059195560369;12773.552925647558;12775.808362874564;6745.3591908768585;8150.7147249845975;8208.46644968075;8259.21537453941;8269.338452923752;3344.816035118043;3397.21863971288;3403.7447191460737;3411.7270618350967;3435.1068722131927;821.515305969469;969.3941286695815;1071.4856868702911;1092.4537731134433;1100.0924237504091;29859.552106718416;30031.099067028023;30681.232969175504;30882.84558577238;30968.380632387227;1039.0856046678873;1047.8421344414464;1110.2894147745449;1166.049669519339;1218.451696736472;15620.453284135001;15667.451639192574;15681.68636627261;15798;16044.839551604568;635805;637683;648629;649106;650202;60162;61154.38845611576;61156.38843611596;61215.38784612186;61248.693756530934;1417.681021770114;1418.3475601223347;1485.7474229381248;1495.5961890289561;1505.284989629917;24834.751652483243;26945.0569230076;29411.264718381357;30227.307839903173;30376.240593985327;50031;50552.24171637502;51168.48831511786;51194.48805511897;51424.74287628687;348229;353592;353947;354469;354552;23871;26576.335591610365;27190.184294471197;27522.724772752015;27622.861885690443;43001;43597;45816.54183458123;46235;47247.76376118098;36115.097122572144;37644;37710.81144594259;38529;38546;36423.453648194765;36811.07972300714;36816.07959801026;37373.06567335838;37802.810985945995;36878.63121368859;37213.81393093017;37640.87077387683;37969.152313576036;38238.42642360422;30976.84511577428;32673.509897352033;32749.836250818593;32840;32944;24238.515229694956;24473.265802025966;24505.50988980246;25096.49807003813;25240.368990775376 17:36:58 INFO - PROCESS | 1668 | |2;jquery.html;375.3843696338006;391.4793324877913;402.71809733186774;403.7799399327366;407.9163771426858;19031.619367612657;19051.809481905177;20033.499162520944;20069.698954515694;20080.29718959837;14859.851401486008;19445.222191112338;19874.205031798745;21265.255716049942;21265.68101478479;5739.569532285085;5815.360310365856;5859.79490717825;5866.589338746289;5875.943419803078;5339.946600533984;5787.276590426197;5825.7378417971295;5832.941670583304;5833.649981001154;5498.5876059295515;5796.8260952171295;5801.767929282823;5812.9827280226;5818.156367326735;5692.089265717465;5737.741801618917;5783.913241301342;5785.566082543805;5793.594448388636;5008.574271186953;5063.2531776537035;5093.541581257705;5099.413567439755;5105.514976077304;24370.756292437203;24422.633660495107;25659.615105773428;25982.87008564945;26333;2153.095699806085;2189.638709612912;2453.362125847275;2454.312792418126;2749.2989287731502;13849.307534623229;14430;14664.120152790867;14746.926265368711;15045.322960466805;1713.837185467391;1720.7504911787846;1723.5949551855304;1749.3090229359332;1769.8672599555084;111078;113432.43283783611;113569.86430135675;113606;116212;10532.684019479428;10848.891511084947;10968.945155274172;11024.834627480594;11177.552897884156;13819;13841.51554695601;13862.306884655727;13887.722245555033;13891;8341.624626891804;8545.359098067669;8551.529665868436;8634.956825215833;8675.39272250949;8529.360297977677;8551.828963420698;8557.187067228604;8651.870221946676;8658.307335413152;5426.484483974095;6502.772402965874;6625.602463852184;6646.202455705346;6724.9327506725285;1600.8559229669386;1634.9346026159058;1674.372110458578;1885.1422602715732;1912.6079153773444;898.3262553085186;898.9437411042;916.812053529025;924.3437159616748;1019.9337043092175;20164.29424970119;20327.390178294674;21315.36053918385;21348.78651213499;21474.892625537086;856.7601071699934;933.4679232837218;947.3463310315998;961.33667769239;966.8301355360093;9983.901770805205;10641.787164256672;10839.512221950032;10859.782804344028;10970.835437468444;484613;493050;494046;537490;640822;95169;129211;130796.69203308036;137556.62443375637;140752;1017.3133135133755;1027.3476342522551;1036.6734478639205;1083.3229231730168;1088.5591335509132;17537.56156096108;18078.367257145936;18164.636707265516;18170.182341794385;18295.72556411628;50832.491675082776;51501.227481588554;51728;51840.74079629578;52086.69783255449;74812;75859.48281034238;77283.22716772986;77478.6126069366;78562;6665.50008749336;7674.4823461988;7839.490433121829;7940.086890007492;8056.919430805617;8964.273762966994;10532.736681582715;12092.637220883387;12184.817227741769;12341.938290308492;6220.377962203744;9640;10377.844332335171;10625.893741062491;10748.408837514013;8356.707515236938;9660.32377733552;10399.92001599668;10630.468476576294;10885.496335842643;9425.952870235606;9923.801523969336;10610.628627998292;10963;11188.272762270426;7560.697572097055;7899.960500197692;7988.3609311253795;8045.034595848536;8236.917630823855;10489.685309440729;10781.568737250422;11051.83422248683;11055.834162487408;11069.169812263952 17:36:58 INFO - PROCESS | 1668 | |3;mootools.html;1438.0221449414394;1625.4392234679035;1630.7146249406355;1921.8654694171414;2039.388183544937;7914.010748656418;8548.743537693872;8779.912200877989;8781.38530302879;8799.516026618534;8406.159384061591;8627.094155113717;8637.481751094938;8654.004789449215;8660;1954.8631595788302;2165.2854557995825;2441.4506735984396;2451.3748994006505;2480.962785558218;2472.196536125757;2498.1256560203965;2498.950020999579;2502.6120951252583;2504.1485894795765;2412.300432874464;2443.218170185541;2444.327809852287;2445.4742230420457;2446.241665083821;2123.9044243009025;2361.8700971446565;2370.8696021718797;2444.2300675287406;2447.6940382452194;2113.7674855765854;2359.622460406327;2365.775251351119;2370.928872133839;2373.6439534069855;8532.744017679479;8600.741977740678;8603.225709686158;8607.225349718556;8615.913840861574;5112.744362781846;5272.6836389816735;5276.182191760283;5288.497592728685;5291.994521041029;3276.770626056177;3333;3436.347094052122;3455.913602159966;3459.809710465923;984.6898227058454;984.7735020945223;997.2470784557685;997.5860018092483;1008.6973907827696;11543.249688770204;11611.361375124365;11620.302781833032;11642.068634509218;11672.708182295426;4648.767561621906;4655.743934083658;4853.49038350968;4898.632602554822;4907.7300748458465;9824.852627210597;9873.160781333667;9883;9889.307748457539;9902.257330700226;5362.249285100089;5364.865878353073;5375.973120134374;5396.730163491809;5405.081136206854;4398.8020539075815;4566.383538222364;4765.999140180532;4913.0173965207105;4931.3835770528685;3902.492675952165;3939.2318497892634;4012.9799351003057;4029.1538776857187;4057.4522439470293;1247.3015111537568;1354.4717560151548;1363.9386227619782;1364.836219653648;1385.1342910680823;811.7767613906223;829.4649950781712;883.9823203535893;932.5616960028775;951.414879848888;5659.518940889988;5698.6580805151825;5720.971395142998;5806.187133801272;5983.19226904371;984.9261305402124;986.9654562090292;999.1756800639502;1002.7392877851811;1036.4506811389974;3641.326354624403;3785.886423407302;3870.864519741852;3898.434726964631;3913.943235326503;10403.115735162595;10653.254272200871;10705.304155229886;10857.782844343068;10908.34549926991;8619.655213791379;10620.893791062144;10788.676339709822;10793.40636265013;10815.67552973412;7760;8029.353982433587;8128.065272493621;8154.510729356258;8170.7957301067945;5563.499285064364;5681.176229446624;5701.372848986525;5771.711414429178;5893;9239.029901860207;9643.98738132486;9753.31726779147;9754.268429867647;9755.170810481188;9368.953155234452;9879.456629885139;9973.401595904268;9998.400095994264;10010.949945250228;6798.456123510206;7053.365197132282;7184.928150718635;7186.856262874818;7329.706811727471;8048.839023219386;8053.798655033671;8154.429189956646;8163.061247956323;8181.263686268265;7138.821529461805;7250.927490725026;7297.379722723628;7367.079115110611;7419.703211871681;7022.578645281095;7195.064641596559;7233.421326293989;7246.927530724625;7283.817904552428;6588.670566471753;6670.966645166744;6693.497987651043;6696.497762667722;6700.49746269022;4634.374359461564;4710.81156753726;4744.074905393415;4813.446453657734;4941.481144479778;4811.27830825365;4813.590844778233;4843.128236917389;4847.248676455155;4909.803607855646 17:36:58 INFO - PROCESS | 1668 | |4;prototype.html;315.52513467231825;318.8182735840571;329.6258746322923;333.4098645397646;333.6380027669978;5628.677260843699;5846.4445877641665;5847.4152584741505;5913.73388197531;5929.229200203973;5528.9723551382285;5679.261695979517;5822.283950000503;5846.181534585151;5915.940840591604;4401.185780630578;4427.468703755554;4447.888802779924;4466.062126953344;4480.103979204156;3645.8333333333344;3827.5598306194865;4258.999135203225;4344.283193273106;4481.753503557303;3988.840446382141;4397.582229688174;4418.425604671388;4419.337099435078;4433.224185767478;3638.6543278388513;4412.911741765162;4421.867343979702;4453.79747468185;4454.754988475633;3082.6917308269217;3363.015820665819;3833.313342129454;3843.5195600549932;3845.6731177849915;5595.21666966625;5612.15817627355;5618.213450116987;5619.241402410663;5643.153526970947;4402.427684401007;4691.507391723854;5029.547340739351;5045.672031317989;5063.772130254148;4982;6151.815445536597;6206.410391012847;6244.500439964837;6260.561760676755;3564.6078931317534;3736.663700266989;3846.9230615387814;3996.9408106851706;4183.707140500166;5791.507721843691;6126.632402055891;6275.403836635513;6553.14809074822;6649.833754156137;3947.013246688328;3963.286608410456;4052.756834589934;4215.725977811432;4238.9826441654395;3973.4834671316094;4223.408722778813;4262.657262962157;4281.785910704452;4293.97853010733;4980.03687805755;5016.924746128811;5033.672811267256;5053.747312634354;5059.392872855281;5727.885442291131;5730.856728581735;5780.335261444903;6191.628502289877;6300.338464461257;1236.8126598465574;1411.484808045056;1475.4614565683662;1478.9852101478848;1482.4737218287353;842.3050982938977;885.7997413504609;907.756373767929;953.1612181280428;960.7614258777032;4729.12511185425;4897.510248975145;5664.461876121762;5732.656040637575;5736.627119237236;5316.973415132977;5350.839474815762;5599.356074051536;6422.646754428458;6450.580712253689;4815.422149342031;5403.756830942617;5745;5754.510866576388;5757.85605359861;2978.7914845960577;3378.300760667066;3388.7627866049634;3404;3410.60778010527;5556.555475562026;5797.188393624896;5891.970540147272;6742.696578653972;6743.52795304324;5687.687177205211;5891.293044834647;6586.7035983380865;6617.705835331812;6667.533272670964;5800.883982320414;6393.616383016941;6682.129003878922;6724.562903411263;6731.697073631698;6216.285127210429;6302.332759187263;6410.73052743095;6417.807465776034;6442.967785161044;5183.533481986488;6255.15472935476;6293.527985401205;6293.96853015732;6337.9366206337345;6297.52768542352;6587.110740050032;6618.801435956929;6698.7224343723365;6724.966375168288;3369.7809642373168;4060.7563546187325;4098.118904435561;4130.876073717794;4197.5172855122055;6401.783661104375;6411.551191416556;6425.518086143465;6432.517561182836;6436.549441539048;6115.388461153849;6166.304266326796;6236.688165591611;6241.843953901007;6264.780732674334;5186.403563590085;6160.613861881041;6213.720382582705;6217.222847144107;6232.5637205397;6030.517558595389;6084.847878802888;6090.969545152246;6106.511479081574;6114;4795.688280261772;5962.940370596239;6237.438630523275;6325.462335701517;6337.271213810286;6143.477804386677;6168.444839964424;6175.073738939195;6183.907241391293;6192.659403732838 17:36:58 INFO - PROCESS | 1668 | |5;yui.html;651.9869602607947;729.6862349189846;738.6971341749884;760.1030783675261;790.9169537198594;14443.92778036111;14521.636959076028;14880.925595372035;14920.253987300646;14923.626909327273;14025.228612426312;14118.858811411883;14127.858721412782;14133.363998620061;14140.292985350743;616.3405156482565;765.1048273519967;903.783092057908;912.406935491929;935.1490143968989;948.9667861624845;949.4872768704926;949.6913503111482;951.291287990448;955.1737746848995;985.5515740338165;989.3124278626358;992.270681049428;992.5483904823288;993.991099034477;749.3368368993453;943.7404713703786;974.7368210583173;975.395254941937;980.3137803537481;734.5042096584784;737.395335824624;740.6185814305637;741.9591922444264;742.6583771465079;14611.488597899022;14647.487337943121;14648.267586620734;14661.853381466155;14671.119732816065;12171;12242.326672033034;12356.382180891009;12575.245485270912;12576.559820406334;9399.483028433433;9414.764630884283;9556.23550115989;9869.013098690146;10340.586376544928;4036.6770658347264;4056.9797151014054;4172.70791044627;4193.370994350841;4205.158968206371;84495.577522112;86708.56645716794;86864.69702954461;88141;88476;9299;9460.337776355589;9474.05259474061;9705.514724263758;9841.950790246146;20638.793612063986;20709.482262943548;20943;21223.893880530806;21241;7454.804995158539;7617.581033043236;7750.92249077502;7992.280694737501;7993.640286187136;4075.7350772200307;4163.375493675972;4202.789860506962;4229.259879521133;4241.660667146621;3591.6947059500235;3685.686716629063;3686.557613086447;3689.557253129588;3692.6861216796337;678.8302924268933;705.9047028651066;714.1358955663706;716.6166101135867;726.0307489501574;541.1855157987204;566.8526183192317;587.4507335641189;594.215635361319;596.5943158652071;7457.366123879422;7629.809254768676;7758.650860711282;7807.609619519001;8123.918760812435;508.7456271864068;517.873121085329;519.7158488443271;536.7504110588595;557.4954666027252;3520.542329497149;3764.7552909060823;3815.809209539512;3864.381698928158;3982.984338993596;93364;93773;93944.53027734955;94809.52595236979;97331.64294128167;76669;77162.61418692983;77294;78554.82167767487;79170.60414698005;70150;70284.6485767568;70470.2952970474;70876.64561677158;71190.64404678046;6301;7109;7463.626818659154;7733.304002639565;8202.712905048294;35001.824990874884;38150.90170040674;40252.3962140574;42904.14191716211;43005;62264.688676556325;64342.678286608265;65160;65502;65803;10278.17774578017;10422.426766527913;10648.627298044532;10754.73113172177;10860.782784344427;11610;11666.183367164556;11848.28910265387;11937.343446110548;12247.510099595916;10785.62250321235;10823.134149267882;10849.837252441377;11013.889861101607;11266.830997535208;10988.066014388867;11063.889361106609;11076.667699969013;11327.618857769492;11453.942730286295;10854.565817367216;10870.076043536072;11169.273997190157;11217.943910280397;11221.55113795439;9086.772830679021;9093.909060909305;9139.360244782802;9257.629694812133;9389.953050234704;8643.697470588499;8653.134686531297;9128.315376346667;9547;9679.818322477377 17:36:58 INFO - PROCESS | 1668 | __end_tp_report 17:36:58 INFO - PROCESS | 1668 | __start_cc_report 17:36:58 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1280 17:36:58 INFO - PROCESS | 1668 | __end_cc_report 17:36:58 INFO - PROCESS | 1668 | __startTimestamp1461199018317__endTimestamp 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | ------- Summary: start ------- 17:36:58 INFO - PROCESS | 1668 | Number of tests: 6 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | [#0] dojo.html Cycles:165 Average:5718.38 Median:5907.38 stddev:634.71 (10.7%) stddev-sans-first:610.12 17:36:58 INFO - PROCESS | 1668 | Values: 3403.3 3447.8 3470.7 3484.8 3509.6 5625.9 5697.5 5712.2 5718.9 5733.0 5690.0 5721.8 5752.9 5832.3 5837.1 5143.1 5148.9 5188.3 5192.9 5305.6 5269.9 5275.5 5314.6 5322.1 5364.9 4651.9 4887.7 5147.7 5256.0 5280.7 5214.1 5229.0 5229.9 5248.5 5310.4 4188.9 5141.8 5211.6 5227.8 5263.9 5555.1 5623.0 5643.9 5661.3 5671.8 6219.4 6231.0 6244.6 6245.1 6262.1 6210.1 6273.8 6280.2 6286.3 6287.4 5672.3 5697.2 5771.3 5782.0 5814.6 6233.1 6259.8 6265.9 6268.3 6269.6 6146.9 6171.8 6173.4 6177.8 6188.8 6073.2 6202.8 6211.9 6230.3 6254.7 5993.7 6048.1 6049.1 6051.0 6104.6 6220.3 6248.7 6267.4 6273.1 6288.0 4909.3 4943.4 4944.1 4956.0 4984.2 4329.4 4449.2 4496.8 4511.4 4543.6 5664.5 5675.1 5679.2 5681.9 5686.1 6087.5 6191.9 6204.1 6225.5 6261.9 5648.7 5681.0 5695.6 5698.9 5711.3 5394.8 5401.9 5404.5 5409.4 5410.5 6182.9 6270.2 6339.2 6349.0 6372.5 6249.8 6271.4 6273.6 6276.2 6297.6 6152.0 6215.7 6329.4 6344.9 6360.0 6113.4 6145.0 6190.7 6202.2 6240.9 5157.7 6224.4 6228.6 6238.0 6252.9 5899.5 6044.7 6072.8 6094.8 6098.8 6069.5 6083.9 6091.8 6094.1 6135.1 4859.7 5623.5 5842.4 5856.2 5936.9 5827.4 6052.3 6085.9 6090.0 6109.6 5907.4 5928.8 5932.6 5933.5 5942.8 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | [#1] ext.html Cycles:180 Average:60554.58 Median:36359.55 stddev:132456.21 (364.3%) stddev-sans-first:132751.03 17:36:58 INFO - PROCESS | 1668 | Values: 496.9 516.0 524.8 525.7 569.9 28241.0 31146.5 31165.8 31263.5 38609.8 42116.2 42940.0 42986.6 43013.8 43027.4 9469.2 9727.9 9758.1 9758.6 9768.1 9590.8 9688.9 9689.9 9694.6 9722.0 9637.3 9722.2 9724.8 9725.2 9727.3 9643.3 9694.8 9704.6 9704.8 9718.0 9475.4 9576.0 9584.9 9586.3 9589.5 41515.8 41541.0 41550.8 41667.4 41826.8 3125.4 3295.7 3535.5 3691.1 3709.8 28005.6 29492.0 30097.0 30270.5 30293.4 2732.7 2736.2 2829.5 2863.6 2873.2 381910.0 450667.0 455134.0 456105.0 456292.7 35247.8 36148.5 36250.8 36266.9 36295.6 35524.8 35654.5 35715.3 35748.5 35786.5 14318.3 14459.2 14472.6 14497.2 14508.3 12456.8 12523.2 12544.1 12773.6 12775.8 6745.4 8150.7 8208.5 8259.2 8269.3 3344.8 3397.2 3403.7 3411.7 3435.1 821.5 969.4 1071.5 1092.5 1100.1 29859.6 30031.1 30681.2 30882.8 30968.4 1039.1 1047.8 1110.3 1166.0 1218.5 15620.5 15667.5 15681.7 15798.0 16044.8 635805.0 637683.0 648629.0 649106.0 650202.0 60162.0 61154.4 61156.4 61215.4 61248.7 1417.7 1418.3 1485.7 1495.6 1505.3 24834.8 26945.1 29411.3 30227.3 30376.2 50031.0 50552.2 51168.5 51194.5 51424.7 348229.0 353592.0 353947.0 354469.0 354552.0 23871.0 26576.3 27190.2 27522.7 27622.9 43001.0 43597.0 45816.5 46235.0 47247.8 36115.1 37644.0 37710.8 38529.0 38546.0 36423.5 36811.1 36816.1 37373.1 37802.8 36878.6 37213.8 37640.9 37969.2 38238.4 30976.8 32673.5 32749.8 32840.0 32944.0 24238.5 24473.3 24505.5 25096.5 25240.4 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | [#2] jquery.html Cycles:180 Average:32790.35 Median:14541.15 stddev:89573.05 (616.0%) stddev-sans-first:89791.26 17:36:58 INFO - PROCESS | 1668 | Values: 375.4 391.5 402.7 403.8 407.9 19031.6 19051.8 20033.5 20069.7 20080.3 14859.9 19445.2 19874.2 21265.3 21265.7 5739.6 5815.4 5859.8 5866.6 5875.9 5339.9 5787.3 5825.7 5832.9 5833.6 5498.6 5796.8 5801.8 5813.0 5818.2 5692.1 5737.7 5783.9 5785.6 5793.6 5008.6 5063.3 5093.5 5099.4 5105.5 24370.8 24422.6 25659.6 25982.9 26333.0 2153.1 2189.6 2453.4 2454.3 2749.3 13849.3 14430.0 14664.1 14746.9 15045.3 1713.8 1720.8 1723.6 1749.3 1769.9 111078.0 113432.4 113569.9 113606.0 116212.0 10532.7 10848.9 10968.9 11024.8 11177.6 13819.0 13841.5 13862.3 13887.7 13891.0 8341.6 8545.4 8551.5 8635.0 8675.4 8529.4 8551.8 8557.2 8651.9 8658.3 5426.5 6502.8 6625.6 6646.2 6724.9 1600.9 1634.9 1674.4 1885.1 1912.6 898.3 898.9 916.8 924.3 1019.9 20164.3 20327.4 21315.4 21348.8 21474.9 856.8 933.5 947.3 961.3 966.8 9983.9 10641.8 10839.5 10859.8 10970.8 484613.0 493050.0 494046.0 537490.0 640822.0 95169.0 129211.0 130796.7 137556.6 140752.0 1017.3 1027.3 1036.7 1083.3 1088.6 17537.6 18078.4 18164.6 18170.2 18295.7 50832.5 51501.2 51728.0 51840.7 52086.7 74812.0 75859.5 77283.2 77478.6 78562.0 6665.5 7674.5 7839.5 7940.1 8056.9 8964.3 10532.7 12092.6 12184.8 12341.9 6220.4 9640.0 10377.8 10625.9 10748.4 8356.7 9660.3 10399.9 10630.5 10885.5 9426.0 9923.8 10610.6 10963.0 11188.3 7560.7 7900.0 7988.4 8045.0 8236.9 10489.7 10781.6 11051.8 11055.8 11069.2 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | [#3] mootools.html Cycles:180 Average:5624.91 Median:5282.34 stddev:3124.49 (59.1%) stddev-sans-first:3117.41 17:36:58 INFO - PROCESS | 1668 | Values: 1438.0 1625.4 1630.7 1921.9 2039.4 7914.0 8548.7 8779.9 8781.4 8799.5 8406.2 8627.1 8637.5 8654.0 8660.0 1954.9 2165.3 2441.5 2451.4 2481.0 2472.2 2498.1 2499.0 2502.6 2504.1 2412.3 2443.2 2444.3 2445.5 2446.2 2123.9 2361.9 2370.9 2444.2 2447.7 2113.8 2359.6 2365.8 2370.9 2373.6 8532.7 8600.7 8603.2 8607.2 8615.9 5112.7 5272.7 5276.2 5288.5 5292.0 3276.8 3333.0 3436.3 3455.9 3459.8 984.7 984.8 997.2 997.6 1008.7 11543.2 11611.4 11620.3 11642.1 11672.7 4648.8 4655.7 4853.5 4898.6 4907.7 9824.9 9873.2 9883.0 9889.3 9902.3 5362.2 5364.9 5376.0 5396.7 5405.1 4398.8 4566.4 4766.0 4913.0 4931.4 3902.5 3939.2 4013.0 4029.2 4057.5 1247.3 1354.5 1363.9 1364.8 1385.1 811.8 829.5 884.0 932.6 951.4 5659.5 5698.7 5721.0 5806.2 5983.2 984.9 987.0 999.2 1002.7 1036.5 3641.3 3785.9 3870.9 3898.4 3913.9 10403.1 10653.3 10705.3 10857.8 10908.3 8619.7 10620.9 10788.7 10793.4 10815.7 7760.0 8029.4 8128.1 8154.5 8170.8 5563.5 5681.2 5701.4 5771.7 5893.0 9239.0 9644.0 9753.3 9754.3 9755.2 9369.0 9879.5 9973.4 9998.4 10010.9 6798.5 7053.4 7184.9 7186.9 7329.7 8048.8 8053.8 8154.4 8163.1 8181.3 7138.8 7250.9 7297.4 7367.1 7419.7 7022.6 7195.1 7233.4 7246.9 7283.8 6588.7 6671.0 6693.5 6696.5 6700.5 4634.4 4710.8 4744.1 4813.4 4941.5 4811.3 4813.6 4843.1 4847.2 4909.8 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | [#4] prototype.html Cycles:180 Average:4987.32 Median:5683.47 stddev:1583.50 (27.9%) stddev-sans-first:1548.63 17:36:58 INFO - PROCESS | 1668 | Values: 315.5 318.8 329.6 333.4 333.6 5628.7 5846.4 5847.4 5913.7 5929.2 5529.0 5679.3 5822.3 5846.2 5915.9 4401.2 4427.5 4447.9 4466.1 4480.1 3645.8 3827.6 4259.0 4344.3 4481.8 3988.8 4397.6 4418.4 4419.3 4433.2 3638.7 4412.9 4421.9 4453.8 4454.8 3082.7 3363.0 3833.3 3843.5 3845.7 5595.2 5612.2 5618.2 5619.2 5643.2 4402.4 4691.5 5029.5 5045.7 5063.8 4982.0 6151.8 6206.4 6244.5 6260.6 3564.6 3736.7 3846.9 3996.9 4183.7 5791.5 6126.6 6275.4 6553.1 6649.8 3947.0 3963.3 4052.8 4215.7 4239.0 3973.5 4223.4 4262.7 4281.8 4294.0 4980.0 5016.9 5033.7 5053.7 5059.4 5727.9 5730.9 5780.3 6191.6 6300.3 1236.8 1411.5 1475.5 1479.0 1482.5 842.3 885.8 907.8 953.2 960.8 4729.1 4897.5 5664.5 5732.7 5736.6 5317.0 5350.8 5599.4 6422.6 6450.6 4815.4 5403.8 5745.0 5754.5 5757.9 2978.8 3378.3 3388.8 3404.0 3410.6 5556.6 5797.2 5892.0 6742.7 6743.5 5687.7 5891.3 6586.7 6617.7 6667.5 5800.9 6393.6 6682.1 6724.6 6731.7 6216.3 6302.3 6410.7 6417.8 6443.0 5183.5 6255.2 6293.5 6294.0 6337.9 6297.5 6587.1 6618.8 6698.7 6725.0 3369.8 4060.8 4098.1 4130.9 4197.5 6401.8 6411.6 6425.5 6432.5 6436.5 6115.4 6166.3 6236.7 6241.8 6264.8 5186.4 6160.6 6213.7 6217.2 6232.6 6030.5 6084.8 6091.0 6106.5 6114.0 4795.7 5962.9 6237.4 6325.5 6337.3 6143.5 6168.4 6175.1 6183.9 6192.7 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - PROCESS | 1668 | [#5] yui.html Cycles:180 Average:18059.33 Median:32905.99 stddev:25906.59 (78.7%) stddev-sans-first:25946.29 17:36:58 INFO - PROCESS | 1668 | Values: 652.0 729.7 738.7 760.1 790.9 14443.9 14521.6 14880.9 14920.3 14923.6 14025.2 14118.9 14127.9 14133.4 14140.3 616.3 765.1 903.8 912.4 935.1 949.0 949.5 949.7 951.3 955.2 985.6 989.3 992.3 992.5 994.0 749.3 943.7 974.7 975.4 980.3 734.5 737.4 740.6 742.0 742.7 14611.5 14647.5 14648.3 14661.9 14671.1 12171.0 12242.3 12356.4 12575.2 12576.6 9399.5 9414.8 9556.2 9869.0 10340.6 4036.7 4057.0 4172.7 4193.4 4205.2 84495.6 86708.6 86864.7 88141.0 88476.0 9299.0 9460.3 9474.1 9705.5 9842.0 20638.8 20709.5 20943.0 21223.9 21241.0 7454.8 7617.6 7750.9 7992.3 7993.6 4075.7 4163.4 4202.8 4229.3 4241.7 3591.7 3685.7 3686.6 3689.6 3692.7 678.8 705.9 714.1 716.6 726.0 541.2 566.9 587.5 594.2 596.6 7457.4 7629.8 7758.7 7807.6 8123.9 508.7 517.9 519.7 536.8 557.5 3520.5 3764.8 3815.8 3864.4 3983.0 93364.0 93773.0 93944.5 94809.5 97331.6 76669.0 77162.6 77294.0 78554.8 79170.6 70150.0 70284.6 70470.3 70876.6 71190.6 6301.0 7109.0 7463.6 7733.3 8202.7 35001.8 38150.9 40252.4 42904.1 43005.0 62264.7 64342.7 65160.0 65502.0 65803.0 10278.2 10422.4 10648.6 10754.7 10860.8 11610.0 11666.2 11848.3 11937.3 12247.5 10785.6 10823.1 10849.8 11013.9 11266.8 10988.1 11063.9 11076.7 11327.6 11453.9 10854.6 10870.1 11169.3 11217.9 11221.6 9086.8 9093.9 9139.4 9257.6 9390.0 8643.7 8653.1 9128.3 9547.0 9679.8 17:36:58 INFO - PROCESS | 1668 | -------- Summary: end -------- 17:36:58 INFO - PROCESS | 1668 | 17:36:58 INFO - TEST-INFO | 1668: exit 0 17:36:58 INFO - TEST-OK | dromaeo_css | took 1115448ms 17:36:58 INFO - TEST-START | kraken 17:36:58 INFO - operating with platform_type : mac_ 17:36:58 INFO - Initialising browser for kraken test... 17:36:58 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp9yKLSU/profile http://localhost:49276/getInfo.html) 17:37:00 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 17:37:00 INFO - PROCESS | 1675 | colorDepth:24 17:37:00 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 17:37:00 INFO - PROCESS | 1675 | __metrics 17:37:01 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:37:01 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:37:01 INFO - TEST-INFO | 1675: exit 0 17:37:01 INFO - Browser initialized. 17:37:01 INFO - Running cycle 1/1 for kraken test... 17:37:01 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmp9yKLSU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:13 INFO - PROCESS | 1677 | RSS: Main: 239124480 17:37:13 INFO - PROCESS | 1677 | 17:37:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 17:37:16 INFO - PROCESS | 1677 | RSS: Main: 286560256 17:37:16 INFO - PROCESS | 1677 | 17:37:19 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 17:37:20 INFO - PROCESS | 1677 | RSS: Main: 299188224 17:37:20 INFO - PROCESS | 1677 | 17:37:23 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 17:37:24 INFO - PROCESS | 1677 | RSS: Main: 386351104 17:37:24 INFO - PROCESS | 1677 | 17:37:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 17:37:26 INFO - PROCESS | 1677 | RSS: Main: 287571968 17:37:26 INFO - PROCESS | 1677 | 17:37:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:37:29 INFO - PROCESS | 1677 | RSS: Main: 291667968 17:37:29 INFO - PROCESS | 1677 | 17:37:32 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 17:37:33 INFO - PROCESS | 1677 | RSS: Main: 331558912 17:37:33 INFO - PROCESS | 1677 | 17:37:35 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 17:37:36 INFO - PROCESS | 1677 | RSS: Main: 331575296 17:37:36 INFO - PROCESS | 1677 | 17:37:39 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 17:37:39 INFO - PROCESS | 1677 | RSS: Main: 327344128 17:37:39 INFO - PROCESS | 1677 | 17:37:41 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:37:42 INFO - PROCESS | 1677 | RSS: Main: 320065536 17:37:42 INFO - PROCESS | 1677 | 17:37:43 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:37:44 INFO - PROCESS | 1677 | RSS: Main: 327254016 17:37:44 INFO - PROCESS | 1677 | 17:37:46 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:37:47 INFO - PROCESS | 1677 | RSS: Main: 330035200 17:37:47 INFO - PROCESS | 1677 | 17:37:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:37:50 INFO - PROCESS | 1677 | RSS: Main: 335212544 17:37:50 INFO - PROCESS | 1677 | 17:37:53 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:37:54 INFO - PROCESS | 1677 | RSS: Main: 332210176 17:37:54 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 17:37:56 INFO - PROCESS | 1677 | RSS: Main: 396611584 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | __start_tp_report 17:37:56 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 17:37:56 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 17:37:56 INFO - PROCESS | 1677 | |i|pagename|runs| 17:37:56 INFO - PROCESS | 1677 | |0;ai-astar;112;108;113;112;113;112;120;111;111;112 17:37:56 INFO - PROCESS | 1677 | |1;audio-beat-detection;160;122;145;164;123;146;141;123;172;110 17:37:56 INFO - PROCESS | 1677 | |2;audio-dft;187;185;187;183;185;186;180;183;186;185 17:37:56 INFO - PROCESS | 1677 | |3;audio-fft;75;73;85;91;55;59;58;79;83;60 17:37:56 INFO - PROCESS | 1677 | |4;audio-oscillator;89;103;170;115;108;77;127;76;76;127 17:37:56 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;86;87;87;83;88;83;77;129;132;83 17:37:56 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;92;93;92;93;92;93;92;97;92 17:37:56 INFO - PROCESS | 1677 | |7;imaging-desaturate;86;85;86;87;85;83;83;85;80;84 17:37:56 INFO - PROCESS | 1677 | |8;json-parse-financial;60;60;59;57;60;58;60;77;61;57 17:37:56 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;66;68;80;74;73;69;69;68;68;71 17:37:56 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;83;81;81;81;80;79;80;92;108;106 17:37:56 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;138;140;140;139;134;139;135;140;184;171 17:37:56 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;170;170;175;165;228;172;174;223;202;168 17:37:56 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;70;67;70;68;68;69;67;71;68;67 17:37:56 INFO - PROCESS | 1677 | __end_tp_report 17:37:56 INFO - PROCESS | 1677 | __start_cc_report 17:37:56 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1932 17:37:56 INFO - PROCESS | 1677 | __end_cc_report 17:37:56 INFO - PROCESS | 1677 | __startTimestamp1461199076471__endTimestamp 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | ------- Summary: start ------- 17:37:56 INFO - PROCESS | 1677 | Number of tests: 14 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:3.03 (2.7%) stddev-sans-first:3.21 17:37:56 INFO - PROCESS | 1677 | Values: 112.0 108.0 113.0 112.0 113.0 112.0 120.0 111.0 111.0 112.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:145.50 stddev:20.71 (14.2%) stddev-sans-first:20.74 17:37:56 INFO - PROCESS | 1677 | Values: 160.0 122.0 145.0 164.0 123.0 146.0 141.0 123.0 172.0 110.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:2.16 (1.2%) stddev-sans-first:2.13 17:37:56 INFO - PROCESS | 1677 | Values: 187.0 185.0 187.0 183.0 185.0 186.0 180.0 183.0 186.0 185.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:71.80 Median:77.00 stddev:12.94 (16.8%) stddev-sans-first:13.68 17:37:56 INFO - PROCESS | 1677 | Values: 75.0 73.0 85.0 91.0 55.0 59.0 58.0 79.0 83.0 60.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:106.80 Median:123.00 stddev:29.81 (24.2%) stddev-sans-first:30.91 17:37:56 INFO - PROCESS | 1677 | Values: 89.0 103.0 170.0 115.0 108.0 77.0 127.0 76.0 76.0 127.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:84.50 stddev:19.77 (23.4%) stddev-sans-first:20.78 17:37:56 INFO - PROCESS | 1677 | Values: 86.0 87.0 87.0 83.0 88.0 83.0 77.0 129.0 132.0 83.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 17:37:56 INFO - PROCESS | 1677 | Values: 93.0 92.0 93.0 92.0 93.0 92.0 93.0 92.0 97.0 92.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:2.01 (2.4%) stddev-sans-first:2.05 17:37:56 INFO - PROCESS | 1677 | Values: 86.0 85.0 86.0 87.0 85.0 83.0 83.0 85.0 80.0 84.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:60.00 stddev:5.82 (9.7%) stddev-sans-first:6.16 17:37:56 INFO - PROCESS | 1677 | Values: 60.0 60.0 59.0 57.0 60.0 58.0 60.0 77.0 61.0 57.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:70.00 stddev:4.12 (5.9%) stddev-sans-first:4.01 17:37:56 INFO - PROCESS | 1677 | Values: 66.0 68.0 80.0 74.0 73.0 69.0 69.0 68.0 68.0 71.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:81.00 stddev:11.12 (13.7%) stddev-sans-first:11.70 17:37:56 INFO - PROCESS | 1677 | Values: 83.0 81.0 81.0 81.0 80.0 79.0 80.0 92.0 108.0 106.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:140.00 stddev:17.01 (12.1%) stddev-sans-first:17.79 17:37:56 INFO - PROCESS | 1677 | Values: 138.0 140.0 140.0 139.0 134.0 139.0 135.0 140.0 184.0 171.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:174.50 stddev:23.83 (13.7%) stddev-sans-first:24.67 17:37:56 INFO - PROCESS | 1677 | Values: 170.0 170.0 175.0 165.0 228.0 172.0 174.0 223.0 202.0 168.0 17:37:56 INFO - PROCESS | 1677 | 17:37:56 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.43 (2.1%) stddev-sans-first:1.41 17:37:56 INFO - PROCESS | 1677 | Values: 70.0 67.0 70.0 68.0 68.0 69.0 67.0 71.0 68.0 67.0 17:37:56 INFO - PROCESS | 1677 | -------- Summary: end -------- 17:37:56 INFO - PROCESS | 1677 | 17:37:57 INFO - TEST-INFO | 1677: exit 0 17:37:57 INFO - TEST-OK | kraken | took 58394ms 17:37:57 INFO - SUITE-END | took 1173s 17:37:57 INFO - Completed test suite (00:19:34) 17:37:57 INFO - javascript benchmark 17:37:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3403.2512847173625, 3447.8276086195683, 3470.6702863227993, 3484.773489723166, 3509.6139424663284, 5625.915611265835, 5697.515711164551, 5712.171735098408, 5718.857028574283, 5732.9999999999945, 5690.0, 5721.828345149642, 5752.913706294409, 5832.270966129234, 5837.09525023621, 5143.09995750744, 5148.948510514893, 5188.299579556769, 5192.909489007313, 5305.628605997563, 5269.920951185735, 5275.525202731754, 5314.627976041678, 5322.0686379883555, 5364.946350536484, 4651.860444186646, 4887.729190410483, 5147.742612869341, 5255.973720131413, 5280.735963201863, 5214.139666954948, 5229.032628963654, 5229.921551176735, 5248.475152484759, 5310.389305229871, 4188.895277618053, 5141.794328226903, 5211.583073354161, 5227.79088836446, 5263.920896216267, 5555.138953462219, 5622.971885140589, 5643.887122257532, 5661.320641523002, 5671.7731290748325, 6219.378062193789, 6230.96884515579, 6244.594101383395, 6245.094461303131, 6262.091996660504, 6210.068489726532, 6273.780417685405, 6280.214973128359, 6286.277078135981, 6287.434130928238, 5672.290963629587, 5697.230873832063, 5771.336296325892, 5781.988152073371, 5814.622049566807, 6233.065040244, 6259.843503912439, 6265.937340626535, 6268.310485846553, 6269.5611307208055, 6146.938530614726, 6171.753129874754, 6173.41352571505, 6177.7837775677635, 6188.752449902044, 6073.210482637229, 6202.844928876814, 6211.9068213976825, 6230.283517395467, 6254.718537665816, 5993.70031498432, 6048.092786082035, 6049.0926361046195, 6051.031834906482, 6104.641056839945, 6220.284667263232, 6248.656323902229, 6267.4045965633195, 6273.121762953099, 6288.025356069817, 4909.2881532177635, 4943.431505376856, 4944.134776414113, 4955.950440495621, 4984.22744474607, 4329.350597410414, 4449.154660614473, 4496.820127194941, 4511.413516242867, 4543.636509079266, 5664.54683625309, 5675.091985282417, 5679.233303503974, 5681.914771278434, 5686.061799802987, 6087.46898570244, 6191.938080619227, 6204.100405441186, 6225.470834978987, 6261.906071408933, 5648.717564121777, 5681.0, 5695.629784064023, 5698.886022279531, 5711.286089238845, 5394.78420863161, 5401.891962160735, 5404.540614047772, 5409.404965453797, 5410.48600382963, 6182.938170618237, 6270.153529273581, 6339.207599050119, 6349.0476428536085, 6372.522060845363, 6249.78125765596, 6271.404216599416, 6273.592216505913, 6276.246850377984, 6297.55917085818, 6151.98492248774, 6215.720292586754, 6329.430351268408, 6344.936550634435, 6360.045993101072, 6113.388661133851, 6144.986077297196, 6190.690465476799, 6202.193714817045, 6240.906386404116, 5157.716325602128, 6224.37756224374, 6228.564000520101, 6238.033104868571, 6252.9062064069985, 5899.528037756883, 6044.697765111639, 6072.787452439144, 6094.847628809138, 6098.847528811815, 6069.45374916242, 6083.878322433438, 6091.786787462417, 6094.14681944537, 6135.07973803933, 4859.712176273361, 5623.493885550321, 5842.38654941225, 5856.180134781049, 5936.851578710567, 5827.358990510956, 6052.273727152769, 6085.908711369421, 6090.0, 6109.602875813236, 5907.379725128972, 5928.79249226275, 5932.644041357532, 5933.465988061095, 5942.762289508371], "value": 5679.389831510911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.9464734762304, 516.0401652925559, 524.8320537428025, 525.7108590275348, 569.9484451187558, 28241.0, 31146.53280200796, 31165.84417077917, 31263.531047034285, 38609.806950965205, 42116.157676846444, 42940.0, 42986.57013429865, 43013.7849310753, 43027.35458968118, 9469.195118414926, 9727.854082188773, 9758.121769040785, 9758.609655613767, 9768.072033156874, 9590.76023099421, 9688.903110968871, 9689.854652180187, 9694.612215511372, 9721.979192184825, 9637.277204209713, 9722.173615242713, 9724.805503889918, 9725.173360264385, 9727.319087663831, 9643.324967252294, 9694.806103877918, 9704.563294651758, 9704.75738106546, 9717.951410242975, 9475.431474111507, 9575.952120239424, 9584.90415095854, 9586.328956973015, 9589.472579008221, 41515.7924210377, 41541.0, 41550.792246038574, 41667.41658417571, 41826.790866045776, 3125.3905488429764, 3295.7198638115788, 3535.4520049392386, 3691.1141326081815, 3709.8145092745253, 28005.579916301067, 29492.0, 30097.0, 30270.54594181089, 30293.394132117453, 2732.6584176977876, 2736.2475319287155, 2829.5472724364004, 2863.627728395316, 2873.181143374149, 381910.0, 450667.0, 455134.0, 456105.0, 456292.7185364085, 35247.82376088155, 36148.45777313342, 36250.8187459061, 36266.91199264026, 36295.63704362975, 35524.822375887954, 35654.465183021755, 35715.285694285965, 35748.463773043426, 35786.46320305197, 14318.284085795669, 14459.204743738985, 14472.565823025327, 14497.20265385414, 14508.274586270856, 12456.75086498265, 12523.185992910432, 12544.059195560369, 12773.552925647558, 12775.808362874564, 6745.3591908768585, 8150.7147249845975, 8208.46644968075, 8259.21537453941, 8269.338452923752, 3344.816035118043, 3397.21863971288, 3403.7447191460737, 3411.7270618350967, 3435.1068722131927, 821.515305969469, 969.3941286695815, 1071.4856868702911, 1092.4537731134433, 1100.0924237504091, 29859.552106718416, 30031.099067028023, 30681.232969175504, 30882.84558577238, 30968.380632387227, 1039.0856046678873, 1047.8421344414464, 1110.2894147745449, 1166.049669519339, 1218.451696736472, 15620.453284135001, 15667.451639192574, 15681.68636627261, 15798.0, 16044.839551604568, 635805.0, 637683.0, 648629.0, 649106.0, 650202.0, 60162.0, 61154.38845611576, 61156.38843611596, 61215.38784612186, 61248.693756530934, 1417.681021770114, 1418.3475601223347, 1485.7474229381248, 1495.5961890289561, 1505.284989629917, 24834.751652483243, 26945.0569230076, 29411.264718381357, 30227.307839903173, 30376.240593985327, 50031.0, 50552.24171637502, 51168.48831511786, 51194.48805511897, 51424.74287628687, 348229.0, 353592.0, 353947.0, 354469.0, 354552.0, 23871.0, 26576.335591610365, 27190.184294471197, 27522.724772752015, 27622.861885690443, 43001.0, 43597.0, 45816.54183458123, 46235.0, 47247.76376118098, 36115.097122572144, 37644.0, 37710.81144594259, 38529.0, 38546.0, 36423.453648194765, 36811.07972300714, 36816.07959801026, 37373.06567335838, 37802.810985945995, 36878.63121368859, 37213.81393093017, 37640.87077387683, 37969.152313576036, 38238.42642360422, 30976.84511577428, 32673.509897352033, 32749.836250818593, 32840.0, 32944.0, 24238.515229694956, 24473.265802025966, 24505.50988980246, 25096.49807003813, 25240.368990775376], "value": 18030.45730588256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.3843696338006, 391.4793324877913, 402.71809733186774, 403.7799399327366, 407.9163771426858, 19031.619367612657, 19051.809481905177, 20033.499162520944, 20069.698954515694, 20080.29718959837, 14859.851401486008, 19445.222191112338, 19874.205031798745, 21265.255716049942, 21265.68101478479, 5739.569532285085, 5815.360310365856, 5859.79490717825, 5866.589338746289, 5875.943419803078, 5339.946600533984, 5787.276590426197, 5825.7378417971295, 5832.941670583304, 5833.649981001154, 5498.5876059295515, 5796.8260952171295, 5801.767929282823, 5812.9827280226, 5818.156367326735, 5692.089265717465, 5737.741801618917, 5783.913241301342, 5785.566082543805, 5793.594448388636, 5008.574271186953, 5063.2531776537035, 5093.541581257705, 5099.413567439755, 5105.514976077304, 24370.756292437203, 24422.633660495107, 25659.615105773428, 25982.87008564945, 26333.0, 2153.095699806085, 2189.638709612912, 2453.362125847275, 2454.312792418126, 2749.2989287731502, 13849.307534623229, 14430.0, 14664.120152790867, 14746.926265368711, 15045.322960466805, 1713.837185467391, 1720.7504911787846, 1723.5949551855304, 1749.3090229359332, 1769.8672599555084, 111078.0, 113432.43283783611, 113569.86430135675, 113606.0, 116212.0, 10532.684019479428, 10848.891511084947, 10968.945155274172, 11024.834627480594, 11177.552897884156, 13819.0, 13841.51554695601, 13862.306884655727, 13887.722245555033, 13891.0, 8341.624626891804, 8545.359098067669, 8551.529665868436, 8634.956825215833, 8675.39272250949, 8529.360297977677, 8551.828963420698, 8557.187067228604, 8651.870221946676, 8658.307335413152, 5426.484483974095, 6502.772402965874, 6625.602463852184, 6646.202455705346, 6724.9327506725285, 1600.8559229669386, 1634.9346026159058, 1674.372110458578, 1885.1422602715732, 1912.6079153773444, 898.3262553085186, 898.9437411042, 916.812053529025, 924.3437159616748, 1019.9337043092175, 20164.29424970119, 20327.390178294674, 21315.36053918385, 21348.78651213499, 21474.892625537086, 856.7601071699934, 933.4679232837218, 947.3463310315998, 961.33667769239, 966.8301355360093, 9983.901770805205, 10641.787164256672, 10839.512221950032, 10859.782804344028, 10970.835437468444, 484613.0, 493050.0, 494046.0, 537490.0, 640822.0, 95169.0, 129211.0, 130796.69203308036, 137556.62443375637, 140752.0, 1017.3133135133755, 1027.3476342522551, 1036.6734478639205, 1083.3229231730168, 1088.5591335509132, 17537.56156096108, 18078.367257145936, 18164.636707265516, 18170.182341794385, 18295.72556411628, 50832.491675082776, 51501.227481588554, 51728.0, 51840.74079629578, 52086.69783255449, 74812.0, 75859.48281034238, 77283.22716772986, 77478.6126069366, 78562.0, 6665.50008749336, 7674.4823461988, 7839.490433121829, 7940.086890007492, 8056.919430805617, 8964.273762966994, 10532.736681582715, 12092.637220883387, 12184.817227741769, 12341.938290308492, 6220.377962203744, 9640.0, 10377.844332335171, 10625.893741062491, 10748.408837514013, 8356.707515236938, 9660.32377733552, 10399.92001599668, 10630.468476576294, 10885.496335842643, 9425.952870235606, 9923.801523969336, 10610.628627998292, 10963.0, 11188.272762270426, 7560.697572097055, 7899.960500197692, 7988.3609311253795, 8045.034595848536, 8236.917630823855, 10489.685309440729, 10781.568737250422, 11051.83422248683, 11055.834162487408, 11069.169812263952], "value": 9452.236763792487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1438.0221449414394, 1625.4392234679035, 1630.7146249406355, 1921.8654694171414, 2039.388183544937, 7914.010748656418, 8548.743537693872, 8779.912200877989, 8781.38530302879, 8799.516026618534, 8406.159384061591, 8627.094155113717, 8637.481751094938, 8654.004789449215, 8660.0, 1954.8631595788302, 2165.2854557995825, 2441.4506735984396, 2451.3748994006505, 2480.962785558218, 2472.196536125757, 2498.1256560203965, 2498.950020999579, 2502.6120951252583, 2504.1485894795765, 2412.300432874464, 2443.218170185541, 2444.327809852287, 2445.4742230420457, 2446.241665083821, 2123.9044243009025, 2361.8700971446565, 2370.8696021718797, 2444.2300675287406, 2447.6940382452194, 2113.7674855765854, 2359.622460406327, 2365.775251351119, 2370.928872133839, 2373.6439534069855, 8532.744017679479, 8600.741977740678, 8603.225709686158, 8607.225349718556, 8615.913840861574, 5112.744362781846, 5272.6836389816735, 5276.182191760283, 5288.497592728685, 5291.994521041029, 3276.770626056177, 3333.0, 3436.347094052122, 3455.913602159966, 3459.809710465923, 984.6898227058454, 984.7735020945223, 997.2470784557685, 997.5860018092483, 1008.6973907827696, 11543.249688770204, 11611.361375124365, 11620.302781833032, 11642.068634509218, 11672.708182295426, 4648.767561621906, 4655.743934083658, 4853.49038350968, 4898.632602554822, 4907.7300748458465, 9824.852627210597, 9873.160781333667, 9883.0, 9889.307748457539, 9902.257330700226, 5362.249285100089, 5364.865878353073, 5375.973120134374, 5396.730163491809, 5405.081136206854, 4398.8020539075815, 4566.383538222364, 4765.999140180532, 4913.0173965207105, 4931.3835770528685, 3902.492675952165, 3939.2318497892634, 4012.9799351003057, 4029.1538776857187, 4057.4522439470293, 1247.3015111537568, 1354.4717560151548, 1363.9386227619782, 1364.836219653648, 1385.1342910680823, 811.7767613906223, 829.4649950781712, 883.9823203535893, 932.5616960028775, 951.414879848888, 5659.518940889988, 5698.6580805151825, 5720.971395142998, 5806.187133801272, 5983.19226904371, 984.9261305402124, 986.9654562090292, 999.1756800639502, 1002.7392877851811, 1036.4506811389974, 3641.326354624403, 3785.886423407302, 3870.864519741852, 3898.434726964631, 3913.943235326503, 10403.115735162595, 10653.254272200871, 10705.304155229886, 10857.782844343068, 10908.34549926991, 8619.655213791379, 10620.893791062144, 10788.676339709822, 10793.40636265013, 10815.67552973412, 7760.0, 8029.353982433587, 8128.065272493621, 8154.510729356258, 8170.7957301067945, 5563.499285064364, 5681.176229446624, 5701.372848986525, 5771.711414429178, 5893.0, 9239.029901860207, 9643.98738132486, 9753.31726779147, 9754.268429867647, 9755.170810481188, 9368.953155234452, 9879.456629885139, 9973.401595904268, 9998.400095994264, 10010.949945250228, 6798.456123510206, 7053.365197132282, 7184.928150718635, 7186.856262874818, 7329.706811727471, 8048.839023219386, 8053.798655033671, 8154.429189956646, 8163.061247956323, 8181.263686268265, 7138.821529461805, 7250.927490725026, 7297.379722723628, 7367.079115110611, 7419.703211871681, 7022.578645281095, 7195.064641596559, 7233.421326293989, 7246.927530724625, 7283.817904552428, 6588.670566471753, 6670.966645166744, 6693.497987651043, 6696.497762667722, 6700.49746269022, 4634.374359461564, 4710.81156753726, 4744.074905393415, 4813.446453657734, 4941.481144479778, 4811.27830825365, 4813.590844778233, 4843.128236917389, 4847.248676455155, 4909.803607855646], "value": 4549.635488132733, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.52513467231825, 318.8182735840571, 329.6258746322923, 333.4098645397646, 333.6380027669978, 5628.677260843699, 5846.4445877641665, 5847.4152584741505, 5913.73388197531, 5929.229200203973, 5528.9723551382285, 5679.261695979517, 5822.283950000503, 5846.181534585151, 5915.940840591604, 4401.185780630578, 4427.468703755554, 4447.888802779924, 4466.062126953344, 4480.103979204156, 3645.8333333333344, 3827.5598306194865, 4258.999135203225, 4344.283193273106, 4481.753503557303, 3988.840446382141, 4397.582229688174, 4418.425604671388, 4419.337099435078, 4433.224185767478, 3638.6543278388513, 4412.911741765162, 4421.867343979702, 4453.79747468185, 4454.754988475633, 3082.6917308269217, 3363.015820665819, 3833.313342129454, 3843.5195600549932, 3845.6731177849915, 5595.21666966625, 5612.15817627355, 5618.213450116987, 5619.241402410663, 5643.153526970947, 4402.427684401007, 4691.507391723854, 5029.547340739351, 5045.672031317989, 5063.772130254148, 4982.0, 6151.815445536597, 6206.410391012847, 6244.500439964837, 6260.561760676755, 3564.6078931317534, 3736.663700266989, 3846.9230615387814, 3996.9408106851706, 4183.707140500166, 5791.507721843691, 6126.632402055891, 6275.403836635513, 6553.14809074822, 6649.833754156137, 3947.013246688328, 3963.286608410456, 4052.756834589934, 4215.725977811432, 4238.9826441654395, 3973.4834671316094, 4223.408722778813, 4262.657262962157, 4281.785910704452, 4293.97853010733, 4980.03687805755, 5016.924746128811, 5033.672811267256, 5053.747312634354, 5059.392872855281, 5727.885442291131, 5730.856728581735, 5780.335261444903, 6191.628502289877, 6300.338464461257, 1236.8126598465574, 1411.484808045056, 1475.4614565683662, 1478.9852101478848, 1482.4737218287353, 842.3050982938977, 885.7997413504609, 907.756373767929, 953.1612181280428, 960.7614258777032, 4729.12511185425, 4897.510248975145, 5664.461876121762, 5732.656040637575, 5736.627119237236, 5316.973415132977, 5350.839474815762, 5599.356074051536, 6422.646754428458, 6450.580712253689, 4815.422149342031, 5403.756830942617, 5745.0, 5754.510866576388, 5757.85605359861, 2978.7914845960577, 3378.300760667066, 3388.7627866049634, 3404.0, 3410.60778010527, 5556.555475562026, 5797.188393624896, 5891.970540147272, 6742.696578653972, 6743.52795304324, 5687.687177205211, 5891.293044834647, 6586.7035983380865, 6617.705835331812, 6667.533272670964, 5800.883982320414, 6393.616383016941, 6682.129003878922, 6724.562903411263, 6731.697073631698, 6216.285127210429, 6302.332759187263, 6410.73052743095, 6417.807465776034, 6442.967785161044, 5183.533481986488, 6255.15472935476, 6293.527985401205, 6293.96853015732, 6337.9366206337345, 6297.52768542352, 6587.110740050032, 6618.801435956929, 6698.7224343723365, 6724.966375168288, 3369.7809642373168, 4060.7563546187325, 4098.118904435561, 4130.876073717794, 4197.5172855122055, 6401.783661104375, 6411.551191416556, 6425.518086143465, 6432.517561182836, 6436.549441539048, 6115.388461153849, 6166.304266326796, 6236.688165591611, 6241.843953901007, 6264.780732674334, 5186.403563590085, 6160.613861881041, 6213.720382582705, 6217.222847144107, 6232.5637205397, 6030.517558595389, 6084.847878802888, 6090.969545152246, 6106.511479081574, 6114.0, 4795.688280261772, 5962.940370596239, 6237.438630523275, 6325.462335701517, 6337.271213810286, 6143.477804386677, 6168.444839964424, 6175.073738939195, 6183.907241391293, 6192.659403732838], "value": 4474.36490538439, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.9869602607947, 729.6862349189846, 738.6971341749884, 760.1030783675261, 790.9169537198594, 14443.92778036111, 14521.636959076028, 14880.925595372035, 14920.253987300646, 14923.626909327273, 14025.228612426312, 14118.858811411883, 14127.858721412782, 14133.363998620061, 14140.292985350743, 616.3405156482565, 765.1048273519967, 903.783092057908, 912.406935491929, 935.1490143968989, 948.9667861624845, 949.4872768704926, 949.6913503111482, 951.291287990448, 955.1737746848995, 985.5515740338165, 989.3124278626358, 992.270681049428, 992.5483904823288, 993.991099034477, 749.3368368993453, 943.7404713703786, 974.7368210583173, 975.395254941937, 980.3137803537481, 734.5042096584784, 737.395335824624, 740.6185814305637, 741.9591922444264, 742.6583771465079, 14611.488597899022, 14647.487337943121, 14648.267586620734, 14661.853381466155, 14671.119732816065, 12171.0, 12242.326672033034, 12356.382180891009, 12575.245485270912, 12576.559820406334, 9399.483028433433, 9414.764630884283, 9556.23550115989, 9869.013098690146, 10340.586376544928, 4036.6770658347264, 4056.9797151014054, 4172.70791044627, 4193.370994350841, 4205.158968206371, 84495.577522112, 86708.56645716794, 86864.69702954461, 88141.0, 88476.0, 9299.0, 9460.337776355589, 9474.05259474061, 9705.514724263758, 9841.950790246146, 20638.793612063986, 20709.482262943548, 20943.0, 21223.893880530806, 21241.0, 7454.804995158539, 7617.581033043236, 7750.92249077502, 7992.280694737501, 7993.640286187136, 4075.7350772200307, 4163.375493675972, 4202.789860506962, 4229.259879521133, 4241.660667146621, 3591.6947059500235, 3685.686716629063, 3686.557613086447, 3689.557253129588, 3692.6861216796337, 678.8302924268933, 705.9047028651066, 714.1358955663706, 716.6166101135867, 726.0307489501574, 541.1855157987204, 566.8526183192317, 587.4507335641189, 594.215635361319, 596.5943158652071, 7457.366123879422, 7629.809254768676, 7758.650860711282, 7807.609619519001, 8123.918760812435, 508.7456271864068, 517.873121085329, 519.7158488443271, 536.7504110588595, 557.4954666027252, 3520.542329497149, 3764.7552909060823, 3815.809209539512, 3864.381698928158, 3982.984338993596, 93364.0, 93773.0, 93944.53027734955, 94809.52595236979, 97331.64294128167, 76669.0, 77162.61418692983, 77294.0, 78554.82167767487, 79170.60414698005, 70150.0, 70284.6485767568, 70470.2952970474, 70876.64561677158, 71190.64404678046, 6301.0, 7109.0, 7463.626818659154, 7733.304002639565, 8202.712905048294, 35001.824990874884, 38150.90170040674, 40252.3962140574, 42904.14191716211, 43005.0, 62264.688676556325, 64342.678286608265, 65160.0, 65502.0, 65803.0, 10278.17774578017, 10422.426766527913, 10648.627298044532, 10754.73113172177, 10860.782784344427, 11610.0, 11666.183367164556, 11848.28910265387, 11937.343446110548, 12247.510099595916, 10785.62250321235, 10823.134149267882, 10849.837252441377, 11013.889861101607, 11266.830997535208, 10988.066014388867, 11063.889361106609, 11076.667699969013, 11327.618857769492, 11453.942730286295, 10854.565817367216, 10870.076043536072, 11169.273997190157, 11217.943910280397, 11221.55113795439, 9086.772830679021, 9093.909060909305, 9139.360244782802, 9257.629694812133, 9389.953050234704, 8643.697470588499, 8653.134686531297, 9128.315376346667, 9547.0, 9679.818322477377], "value": 6832.301651220339, "unit": "score"}], "name": "dromaeo_css", "value": 7159.116683377517, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 112.0, 113.0, 112.0, 120.0, 111.0, 111.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 145.0, 164.0, 123.0, 146.0, 141.0, 123.0, 172.0, 110.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 185.0, 187.0, 183.0, 185.0, 186.0, 180.0, 183.0, 186.0, 185.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 85.0, 91.0, 55.0, 59.0, 58.0, 79.0, 83.0, 60.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 103.0, 170.0, 115.0, 108.0, 77.0, 127.0, 76.0, 76.0, 127.0], "value": 106.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 83.0, 88.0, 83.0, 77.0, 129.0, 132.0, 83.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 92.0, 93.0, 92.0, 93.0, 92.0, 97.0, 92.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 87.0, 85.0, 83.0, 83.0, 85.0, 80.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 57.0, 60.0, 58.0, 60.0, 77.0, 61.0, 57.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 80.0, 74.0, 73.0, 69.0, 69.0, 68.0, 68.0, 71.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 81.0, 80.0, 79.0, 80.0, 92.0, 108.0, 106.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 140.0, 140.0, 139.0, 134.0, 139.0, 135.0, 140.0, 184.0, 171.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 175.0, 165.0, 228.0, 172.0, 174.0, 223.0, 202.0, 168.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 70.0, 68.0, 68.0, 69.0, 67.0, 71.0, 68.0, 67.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1504.8999999999999, "alertThreshold": 2.0}]} 17:37:57 INFO - Return code: 0 17:37:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:37:57 ERROR - # TBPL SUCCESS # 17:37:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:37:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:37:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:37:57 INFO - 2016-04-20 17:37:57.807 screenresolution[1681:9994] starting screenresolution argv=screenresolution get 17:37:57 INFO - 2016-04-20 17:37:57.810 screenresolution[1681:9994] Display 0: 1600x1200x32@60 17:37:57 INFO - 2016-04-20 17:37:57.816 screenresolution[1682:9997] starting screenresolution argv=screenresolution list 17:37:57 INFO - Available Modes on Display 0 17:37:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:37:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:37:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:37:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:37:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:37:58 INFO - Intel Iris: 17:37:58 INFO - Chipset Model: Intel Iris 17:37:58 INFO - Type: GPU 17:37:58 INFO - Bus: Built-In 17:37:58 INFO - VRAM (Dynamic, Max): 1536 MB 17:37:58 INFO - Vendor: Intel (0x8086) 17:37:58 INFO - Device ID: 0x0a2e 17:37:58 INFO - Revision ID: 0x0009 17:37:58 INFO - Displays: 17:37:58 INFO - Display: 17:37:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:37:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:37:58 INFO - Display Serial Number: 1600x1200 60 17:37:58 INFO - Main Display: Yes 17:37:58 INFO - Mirror: Off 17:37:58 INFO - Online: Yes 17:37:58 INFO - Rotation: Supported 17:37:58 INFO - Return code: 0 17:37:58 INFO - Running post-action listener: _resource_record_post_action 17:37:58 INFO - Running post-run listener: _resource_record_post_run 17:37:59 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 32415232; Write bytes: 694876160; Read time: 324; Write time: 2140 17:37:59 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384147968; Write bytes: 379217920; Read time: 28455; Write time: 800 17:37:59 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30629376; Write bytes: 295911424; Read time: 304; Write time: 1294 17:37:59 INFO - Running post-run listener: _upload_blobber_files 17:37:59 INFO - Blob upload gear active. 17:37:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:37:59 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 17:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:37:59 INFO - (blobuploader) - INFO - Open directory for files ... 17:37:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:37:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:37:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:38:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:00 INFO - (blobuploader) - INFO - Done attempting. 17:38:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:38:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:38:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:38:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:38:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:38:01 INFO - (blobuploader) - INFO - Done attempting. 17:38:01 INFO - (blobuploader) - INFO - Iteration through files over. 17:38:01 INFO - Return code: 0 17:38:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:38:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:38:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aefa17a0cd27fb9a716bab059f5c875b6cb1c97728f30e541fa5aa1e8b931613982db421e56e043bc397c4862a63b09268665eb4304e76089af3c16c2105d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79a6460474de5dad2587cca6e24a176a229ddd8f6b9040e88124db967757c269af430dbb4d0df6c5c62c85b8b62b3c0332fff50588dfd84dc84191fb428f4fbe"} 17:38:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:38:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:38:01 INFO - Contents: 17:38:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aefa17a0cd27fb9a716bab059f5c875b6cb1c97728f30e541fa5aa1e8b931613982db421e56e043bc397c4862a63b09268665eb4304e76089af3c16c2105d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79a6460474de5dad2587cca6e24a176a229ddd8f6b9040e88124db967757c269af430dbb4d0df6c5c62c85b8b62b3c0332fff50588dfd84dc84191fb428f4fbe"} 17:38:01 INFO - Running post-run listener: copy_logs_to_upload_dir 17:38:01 INFO - Copying logs to upload dir... 17:38:01 INFO - mkdir: /builds/slave/test/build/upload/logs 17:38:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.250818 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-04-20 17:38:02.062716) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 17:38:02.066171) ========= 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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aefa17a0cd27fb9a716bab059f5c875b6cb1c97728f30e541fa5aa1e8b931613982db421e56e043bc397c4862a63b09268665eb4304e76089af3c16c2105d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79a6460474de5dad2587cca6e24a176a229ddd8f6b9040e88124db967757c269af430dbb4d0df6c5c62c85b8b62b3c0332fff50588dfd84dc84191fb428f4fbe"} build_url:https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010807 build_url: 'https://queue.taskcluster.net/v1/task/RqAtR-Y7SA-HU3YZl3M7kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/64aefa17a0cd27fb9a716bab059f5c875b6cb1c97728f30e541fa5aa1e8b931613982db421e56e043bc397c4862a63b09268665eb4304e76089af3c16c2105d5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/79a6460474de5dad2587cca6e24a176a229ddd8f6b9040e88124db967757c269af430dbb4d0df6c5c62c85b8b62b3c0332fff50588dfd84dc84191fb428f4fbe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 17:38:02.093788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:38:02.094163) ========= 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.C5kIMCsmVF/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.OSTJCgFzDK/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.004988 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 17:38:02.143113) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 17:38:02.143469) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 17:38:02.143928) ========= ========= Total master_lag: 0.63 =========