builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0040 starttime: 1460713324.67 results: success (0) buildid: 20160415014851 builduid: 82c794c2d287426992de7fc4aec04e81 revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.665344) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.665764) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.666426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.685545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.688943) ========= 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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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-15 02:42:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.0M=0.001s 2016-04-15 02:42:04 (13.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.787289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.787605) ========= 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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.020078 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.836473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:04.836829) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 529cff9c5663a3581dfb5e690727144f07e8e23c --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 529cff9c5663a3581dfb5e690727144f07e8e23c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CgDVeWTLA8/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.6oW4X6QdFg/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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-15 02:42:04,905 truncating revision to first 12 chars 2016-04-15 02:42:04,905 Setting DEBUG logging. 2016-04-15 02:42:04,906 attempt 1/10 2016-04-15 02:42:04,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/529cff9c5663?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-15 02:42:05,517 unpacking tar archive at: fx-team-529cff9c5663/testing/mozharness/ program finished with exit code 0 elapsedTime=0.857024 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:05.714365) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:05.714750) ========= script_repo_revision: 529cff9c5663a3581dfb5e690727144f07e8e23c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:05.715147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:05.715415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-15 02:42:05.733793) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-15 02:42:05.734125) ========= /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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:05 INFO - MultiFileLogger online at 20160415 02:42:05 in /builds/slave/test 02:42:05 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 02:42:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:42:05 INFO - {'append_to_log': False, 02:42:05 INFO - 'base_work_dir': '/builds/slave/test', 02:42:05 INFO - 'blob_upload_branch': 'Fx-Team', 02:42:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:42:05 INFO - 'branch': 'Fx-Team', 02:42:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:42:05 INFO - 'config_files': ('talos/mac_config.py',), 02:42:05 INFO - 'default_actions': ('clobber', 02:42:05 INFO - 'read-buildbot-config', 02:42:05 INFO - 'download-and-extract', 02:42:05 INFO - 'populate-webroot', 02:42:05 INFO - 'create-virtualenv', 02:42:05 INFO - 'install', 02:42:05 INFO - 'run-tests'), 02:42:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:42:05 INFO - 'download_minidump_stackwalk': True, 02:42:05 INFO - 'download_symbols': 'ondemand', 02:42:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:42:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:42:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:42:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:42:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:42:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:42:05 INFO - 'installer_path': 'installer.exe', 02:42:05 INFO - 'log_level': 'info', 02:42:05 INFO - 'log_name': 'talos', 02:42:05 INFO - 'log_to_console': True, 02:42:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:42:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:42:05 INFO - 'opt_config_files': (), 02:42:05 INFO - 'pip_index': False, 02:42:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:42:05 INFO - 'cmd': ('bash', 02:42:05 INFO - '-c', 02:42:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:42:05 INFO - 'enabled': True, 02:42:05 INFO - 'halt_on_failure': False, 02:42:05 INFO - 'name': 'check_screen_resolution'},), 02:42:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:42:05 INFO - 'cmd': ('bash', 02:42:05 INFO - '-c', 02:42:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:42:05 INFO - 'enabled': True, 02:42:05 INFO - 'halt_on_failure': False, 02:42:05 INFO - 'name': 'check_screen_resolution'},), 02:42:05 INFO - 'run_cmd_checks_enabled': True, 02:42:05 INFO - 'sps_profile': False, 02:42:05 INFO - 'sps_profile_interval': 0, 02:42:05 INFO - 'suite': 'dromaeojs', 02:42:05 INFO - 'system_bits': '32', 02:42:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:42:05 INFO - 'title': 't-yosemite-r7-0040', 02:42:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:42:05 INFO - 'use_talos_json': True, 02:42:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:42:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:42:05 INFO - 'work_dir': 'build'} 02:42:05 INFO - ##### 02:42:05 INFO - ##### Running clobber step. 02:42:05 INFO - ##### 02:42:05 INFO - Running pre-action listener: _resource_record_pre_action 02:42:05 INFO - Running main action method: clobber 02:42:05 INFO - rmtree: /builds/slave/test/build 02:42:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:42:06 INFO - Running post-action listener: _resource_record_post_action 02:42:06 INFO - ##### 02:42:06 INFO - ##### Running read-buildbot-config step. 02:42:06 INFO - ##### 02:42:06 INFO - Running pre-action listener: _resource_record_pre_action 02:42:06 INFO - Running main action method: read_buildbot_config 02:42:06 INFO - Using buildbot properties: 02:42:06 INFO - { 02:42:06 INFO - "project": "", 02:42:06 INFO - "product": "firefox", 02:42:06 INFO - "script_repo_revision": "production", 02:42:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 02:42:06 INFO - "repository": "", 02:42:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 02:42:06 INFO - "buildid": "20160415014851", 02:42:06 INFO - "pgo_build": "False", 02:42:06 INFO - "basedir": "/builds/slave/test", 02:42:06 INFO - "buildnumber": 662, 02:42:06 INFO - "slavename": "t-yosemite-r7-0040", 02:42:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 02:42:06 INFO - "platform": "yosemite_r7", 02:42:06 INFO - "scheduler": "tests-fx-team-macosx64-talos", 02:42:06 INFO - "branch": "fx-team", 02:42:06 INFO - "repo_path": "integration/fx-team", 02:42:06 INFO - "revision": "529cff9c5663a3581dfb5e690727144f07e8e23c", 02:42:06 INFO - "stage_platform": "macosx64", 02:42:06 INFO - "builduid": "82c794c2d287426992de7fc4aec04e81", 02:42:06 INFO - "slavebuilddir": "test" 02:42:06 INFO - } 02:42:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 02:42:06 INFO - Running post-action listener: _resource_record_post_action 02:42:06 INFO - ##### 02:42:06 INFO - ##### Running download-and-extract step. 02:42:06 INFO - ##### 02:42:06 INFO - Running pre-action listener: _resource_record_pre_action 02:42:06 INFO - Running main action method: download_and_extract 02:42:06 INFO - mkdir: /builds/slave/test/build/tests 02:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:06 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:42:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:42:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:42:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:07 INFO - Downloaded 1199 bytes. 02:42:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:42:07 INFO - Using the following test package requirements: 02:42:07 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:42:07 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 02:42:07 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 02:42:07 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'jsshell-mac.zip'], 02:42:07 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 02:42:07 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:42:07 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 02:42:07 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 02:42:07 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 02:42:07 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:42:07 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 02:42:07 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:42: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')]} 02:42:07 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:42:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:42:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:42:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:08 INFO - Downloaded 18031138 bytes. 02:42:08 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'] 02:42:08 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 02:42:11 INFO - Return code: 0 02:42:11 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 02:42:11 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')]} 02:42:11 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:42:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:42:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:42:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:12 INFO - Downloaded 18031138 bytes. 02:42:12 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'] 02:42:12 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 02:42:16 INFO - Return code: 0 02:42: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')]} 02:42:16 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:17 INFO - Downloaded 10841076 bytes. 02:42:17 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'] 02:42:17 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 02:42:17 INFO - Return code: 0 02:42:17 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')]} 02:42:17 INFO - https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:42:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:42:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:42:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 02:42:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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 02:42:20 INFO - Downloaded 109830505 bytes. 02:42:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:42:20 INFO - mkdir: /builds/slave/test/properties 02:42:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:42:20 INFO - Writing to file /builds/slave/test/properties/build_url 02:42:20 INFO - Contents: 02:42:20 INFO - build_url:https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:42:21 INFO - Running post-action listener: _resource_record_post_action 02:42:21 INFO - Running post-action listener: set_extra_try_arguments 02:42:21 INFO - ##### 02:42:21 INFO - ##### Running populate-webroot step. 02:42:21 INFO - ##### 02:42:21 INFO - Running pre-action listener: _resource_record_pre_action 02:42:21 INFO - Running main action method: populate_webroot 02:42:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:42:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:42:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:42:21 INFO - '--tppagecycles', 02:42:21 INFO - '7'], 02:42:21 INFO - 'tests': ['tsvgm']}}, 02:42:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:42:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:42:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:42:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:42:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:42:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['damp', 'tps']}, 02:42:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'tests': ['damp', 'tps']}, 02:42:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['dromaeo_dom']}, 02:42:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:42:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['a11yr', 02:42:21 INFO - 'ts_paint', 02:42:21 INFO - 'tpaint', 02:42:21 INFO - 'sessionrestore', 02:42:21 INFO - 'sessionrestore_no_auto_restore', 02:42:21 INFO - 'tabpaint']}, 02:42:21 INFO - 'other-e10s': {'tests': ['a11yr', 02:42:21 INFO - 'ts_paint', 02:42:21 INFO - 'tpaint', 02:42:21 INFO - 'sessionrestore', 02:42:21 INFO - 'sessionrestore_no_auto_restore', 02:42:21 INFO - 'tabpaint']}, 02:42:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:42:21 INFO - 'ts_paint', 02:42:21 INFO - 'tpaint', 02:42:21 INFO - 'sessionrestore', 02:42:21 INFO - 'sessionrestore_no_auto_restore', 02:42:21 INFO - 'tabpaint']}, 02:42:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:42:21 INFO - 'ts_paint', 02:42:21 INFO - 'tpaint', 02:42:21 INFO - 'sessionrestore', 02:42:21 INFO - 'sessionrestore_no_auto_restore', 02:42:21 INFO - 'tabpaint']}, 02:42:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['a11yr', 02:42:21 INFO - 'ts_paint', 02:42:21 INFO - 'tpaint', 02:42:21 INFO - 'sessionrestore', 02:42:21 INFO - 'sessionrestore_no_auto_restore', 02:42:21 INFO - 'tabpaint']}, 02:42:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['a11yr', 02:42:21 INFO - 'ts_paint', 02:42:21 INFO - 'tpaint', 02:42:21 INFO - 'sessionrestore', 02:42:21 INFO - 'sessionrestore_no_auto_restore', 02:42:21 INFO - 'tabpaint']}, 02:42:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['tsvgx', 02:42:21 INFO - 'tsvgr_opacity', 02:42:21 INFO - 'tart', 02:42:21 INFO - 'tscrollx', 02:42:21 INFO - 'cart']}, 02:42:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:42:21 INFO - 'tsvgr_opacity', 02:42:21 INFO - 'tart', 02:42:21 INFO - 'tscrollx', 02:42:21 INFO - 'cart']}, 02:42:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'talos_options': ['--disable-e10s'], 02:42:21 INFO - 'tests': ['tp5o']}, 02:42:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'tests': ['tp5o']}, 02:42:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'talos_options': ['--disable-e10s', 02:42:21 INFO - '--xperf_path', 02:42:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:21 INFO - 'tests': ['tp5n']}, 02:42:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:42:21 INFO - 'talos_options': ['--xperf_path', 02:42:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:42:21 INFO - 'tests': ['tp5n']}}, 02:42:21 INFO - 'talos.zip': {'path': '', 02:42:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:42:21 INFO - Running post-action listener: _resource_record_post_action 02:42:21 INFO - ##### 02:42:21 INFO - ##### Running create-virtualenv step. 02:42:21 INFO - ##### 02:42:21 INFO - Running pre-action listener: _resource_record_pre_action 02:42:21 INFO - Running main action method: create_virtualenv 02:42:21 INFO - Creating virtualenv /builds/slave/test/build/venv 02:42:21 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 02:42:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:42:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:42:21 INFO - Using real prefix '/tools/python27' 02:42:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:42:22 INFO - Installing distribute.............................................................................................................................................................................................done. 02:42:25 INFO - Installing pip.................done. 02:42:25 INFO - Return code: 0 02:42:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:25 INFO - 'HOME': '/Users/cltbld', 02:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:25 INFO - 'LOGNAME': 'cltbld', 02:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:25 INFO - 'MOZ_NO_REMOTE': '1', 02:42:25 INFO - 'NO_EM_RESTART': '1', 02:42:25 INFO - 'PAGER': '/bin/cat', 02:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:25 INFO - 'PWD': '/builds/slave/test', 02:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:25 INFO - 'SHELL': '/bin/bash', 02:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:25 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:25 INFO - 'USER': 'cltbld', 02:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:25 INFO - 'XPC_FLAGS': '0x0', 02:42:25 INFO - 'XPC_SERVICE_NAME': '0', 02:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:42:25 INFO - Cleaning up... 02:42:25 INFO - Return code: 0 02:42:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:42:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:42:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:25 INFO - 'HOME': '/Users/cltbld', 02:42:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:25 INFO - 'LOGNAME': 'cltbld', 02:42:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:25 INFO - 'MOZ_NO_REMOTE': '1', 02:42:25 INFO - 'NO_EM_RESTART': '1', 02:42:25 INFO - 'PAGER': '/bin/cat', 02:42:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:25 INFO - 'PWD': '/builds/slave/test', 02:42:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:25 INFO - 'SHELL': '/bin/bash', 02:42:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:25 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:25 INFO - 'USER': 'cltbld', 02:42:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:25 INFO - 'XPC_FLAGS': '0x0', 02:42:25 INFO - 'XPC_SERVICE_NAME': '0', 02:42:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:25 INFO - Downloading/unpacking psutil>=0.7.1 02:42:25 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 02:42:25 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 02:42:25 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 02:42:25 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 02:42:25 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 02:42:25 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 02:42:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:42:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:28 INFO - Installing collected packages: psutil 02:42:28 INFO - Running setup.py install for psutil 02:42:28 INFO - building 'psutil._psutil_osx' extension 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 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 02:42:28 INFO - building 'psutil._psutil_posix' extension 02:42:28 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 02:42:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:42:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:42:29 INFO - ^ 02:42:29 INFO - 1 warning generated. 02:42:29 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 02:42:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:42:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:42:29 INFO - Successfully installed psutil 02:42:29 INFO - Cleaning up... 02:42:29 INFO - Return code: 0 02:42:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:29 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 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:29 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 02:42:29 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 02:42:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:29 INFO - 'HOME': '/Users/cltbld', 02:42:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:29 INFO - 'LOGNAME': 'cltbld', 02:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:29 INFO - 'MOZ_NO_REMOTE': '1', 02:42:29 INFO - 'NO_EM_RESTART': '1', 02:42:29 INFO - 'PAGER': '/bin/cat', 02:42:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:29 INFO - 'PWD': '/builds/slave/test', 02:42:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:29 INFO - 'SHELL': '/bin/bash', 02:42:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:29 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:29 INFO - 'USER': 'cltbld', 02:42:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:29 INFO - 'XPC_FLAGS': '0x0', 02:42:29 INFO - 'XPC_SERVICE_NAME': '0', 02:42:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:42:29 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 02:42:29 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 02:42:29 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 02:42:29 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 02:42:29 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 02:42:29 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 02:42:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:42:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:42:31 INFO - Installing collected packages: mozsystemmonitor 02:42:31 INFO - Running setup.py install for mozsystemmonitor 02:42:32 INFO - Successfully installed mozsystemmonitor 02:42:32 INFO - Cleaning up... 02:42:32 INFO - Return code: 0 02:42:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:32 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 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:32 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 02:42:32 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 02:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:32 INFO - 'HOME': '/Users/cltbld', 02:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:32 INFO - 'LOGNAME': 'cltbld', 02:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:32 INFO - 'MOZ_NO_REMOTE': '1', 02:42:32 INFO - 'NO_EM_RESTART': '1', 02:42:32 INFO - 'PAGER': '/bin/cat', 02:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:32 INFO - 'PWD': '/builds/slave/test', 02:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:32 INFO - 'SHELL': '/bin/bash', 02:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:32 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:32 INFO - 'USER': 'cltbld', 02:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:32 INFO - 'XPC_FLAGS': '0x0', 02:42:32 INFO - 'XPC_SERVICE_NAME': '0', 02:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:32 INFO - Downloading/unpacking blobuploader==1.2.4 02:42:32 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 02:42:32 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 02:42:32 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 02:42:32 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 02:42:32 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 02:42:32 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 02:42:34 INFO - Downloading blobuploader-1.2.4.tar.gz 02:42:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:42:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:42:34 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 02:42:34 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 02:42:34 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 02:42:34 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 02:42:34 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 02:42:34 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 02:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:42:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42: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 02:42:36 INFO - Downloading docopt-0.6.1.tar.gz 02:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:42:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:42:36 INFO - Running setup.py install for blobuploader 02:42:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:42:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:42:36 INFO - Running setup.py install for requests 02:42:36 INFO - Running setup.py install for docopt 02:42:36 INFO - Successfully installed blobuploader requests docopt 02:42:36 INFO - Cleaning up... 02:42:37 INFO - Return code: 0 02:42:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:37 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')]} 02:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:37 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')]} 02:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:37 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 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:37 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 02:42:37 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 02:42:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:37 INFO - 'HOME': '/Users/cltbld', 02:42:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:37 INFO - 'LOGNAME': 'cltbld', 02:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:37 INFO - 'MOZ_NO_REMOTE': '1', 02:42:37 INFO - 'NO_EM_RESTART': '1', 02:42:37 INFO - 'PAGER': '/bin/cat', 02:42:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:37 INFO - 'PWD': '/builds/slave/test', 02:42:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:37 INFO - 'SHELL': '/bin/bash', 02:42:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:37 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:37 INFO - 'USER': 'cltbld', 02:42:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:37 INFO - 'XPC_FLAGS': '0x0', 02:42:37 INFO - 'XPC_SERVICE_NAME': '0', 02:42:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-y7xJy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-nOqSzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-bb8aP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-ShKtM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-GGAX8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-kYAzza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-haZYmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:37 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-cI3ntq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Fd9y8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-UsyJZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-0lnOMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-m3IhqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-jZMh22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Md9oSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-kxU3Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-8twEON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:38 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Gl0Br8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:42:39 INFO - Running setup.py install for manifestparser 02:42:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:42:39 INFO - Running setup.py install for mozcrash 02:42:39 INFO - Running setup.py install for mozdebug 02:42:39 INFO - Running setup.py install for mozdevice 02:42:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:42:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:42:39 INFO - Running setup.py install for mozfile 02:42:39 INFO - Running setup.py install for mozhttpd 02:42:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:42:39 INFO - Running setup.py install for mozinfo 02:42:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Running setup.py install for mozInstall 02:42:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Running setup.py install for mozleak 02:42:40 INFO - Running setup.py install for mozlog 02:42:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Running setup.py install for moznetwork 02:42:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Running setup.py install for mozprocess 02:42:40 INFO - Running setup.py install for mozprofile 02:42:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:42:40 INFO - Running setup.py install for mozrunner 02:42:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:42:41 INFO - Running setup.py install for mozscreenshot 02:42:41 INFO - Running setup.py install for moztest 02:42:41 INFO - Running setup.py install for mozversion 02:42:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:42:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:42:41 INFO - Cleaning up... 02:42:41 INFO - Return code: 0 02:42:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:41 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 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:41 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 02:42:41 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 02:42:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:41 INFO - 'HOME': '/Users/cltbld', 02:42:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:41 INFO - 'LOGNAME': 'cltbld', 02:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:41 INFO - 'MOZ_NO_REMOTE': '1', 02:42:41 INFO - 'NO_EM_RESTART': '1', 02:42:41 INFO - 'PAGER': '/bin/cat', 02:42:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:41 INFO - 'PWD': '/builds/slave/test', 02:42:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:41 INFO - 'SHELL': '/bin/bash', 02:42:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:41 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:41 INFO - 'USER': 'cltbld', 02:42:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:41 INFO - 'XPC_FLAGS': '0x0', 02:42:41 INFO - 'XPC_SERVICE_NAME': '0', 02:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:42:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-qvsuvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:42:41 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)) 02:42:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:42:41 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-6kI1XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-7M8Wh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-2mlCB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Wfshof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-BVTwPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-zm4sfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-PBPCkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-SQFenp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-PREkwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:42:42 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-I6r1ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:42:42 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)) 02:42:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:42:43 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-tMatP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:42:43 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)) 02:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:42:43 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-Uz9H3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:42:43 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)) 02:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:42:43 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-ntLBnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:42:43 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)) 02:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:43 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-6pmmx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:42:43 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)) 02:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:42:43 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-SNmeae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:42:43 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)) 02:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:42:43 INFO - Running setup.py (path:/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/pip-_Qmqlk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:42:43 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)) 02:42:43 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)) 02:42:43 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)) 02:42:43 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)) 02:42:43 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)) 02:42:43 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)) 02:42:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:42:43 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 02:42:43 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 02:42:43 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 02:42:43 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 02:42:43 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 02:42:43 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 02:42:46 INFO - Downloading blessings-1.6.tar.gz 02:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:42:46 INFO - Installing collected packages: blessings 02:42:46 INFO - Running setup.py install for blessings 02:42:46 INFO - Successfully installed blessings 02:42:46 INFO - Cleaning up... 02:42:46 INFO - Return code: 0 02:42:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:42:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:46 INFO - Reading from file tmpfile_stdout 02:42:46 INFO - Current package versions: 02:42:46 INFO - blessings == 1.6 02:42:46 INFO - blobuploader == 1.2.4 02:42:46 INFO - docopt == 0.6.1 02:42:46 INFO - manifestparser == 1.1 02:42:46 INFO - mozInstall == 1.12 02:42:46 INFO - mozcrash == 0.17 02:42:46 INFO - mozdebug == 0.1 02:42:46 INFO - mozdevice == 0.48 02:42:46 INFO - mozfile == 1.2 02:42:46 INFO - mozhttpd == 0.7 02:42:46 INFO - mozinfo == 0.9 02:42:46 INFO - mozleak == 0.1 02:42:46 INFO - mozlog == 3.1 02:42:46 INFO - moznetwork == 0.27 02:42:46 INFO - mozprocess == 0.22 02:42:46 INFO - mozprofile == 0.28 02:42:46 INFO - mozrunner == 6.11 02:42:46 INFO - mozscreenshot == 0.1 02:42:46 INFO - mozsystemmonitor == 0.0 02:42:46 INFO - moztest == 0.7 02:42:46 INFO - mozversion == 1.4 02:42:46 INFO - psutil == 3.1.1 02:42:46 INFO - requests == 1.2.3 02:42:46 INFO - wsgiref == 0.1.2 02:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:46 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 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:46 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 02:42:46 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 02:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:46 INFO - 'HOME': '/Users/cltbld', 02:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:46 INFO - 'LOGNAME': 'cltbld', 02:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:46 INFO - 'MOZ_NO_REMOTE': '1', 02:42:46 INFO - 'NO_EM_RESTART': '1', 02:42:46 INFO - 'PAGER': '/bin/cat', 02:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:46 INFO - 'PWD': '/builds/slave/test', 02:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:46 INFO - 'SHELL': '/bin/bash', 02:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:46 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:46 INFO - 'USER': 'cltbld', 02:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:46 INFO - 'XPC_FLAGS': '0x0', 02:42:46 INFO - 'XPC_SERVICE_NAME': '0', 02:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 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)) 02:42:46 INFO - Cleaning up... 02:42:46 INFO - Return code: 0 02:42:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:42:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:46 INFO - 'HOME': '/Users/cltbld', 02:42:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:46 INFO - 'LOGNAME': 'cltbld', 02:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:46 INFO - 'MOZ_NO_REMOTE': '1', 02:42:46 INFO - 'NO_EM_RESTART': '1', 02:42:46 INFO - 'PAGER': '/bin/cat', 02:42:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:46 INFO - 'PWD': '/builds/slave/test', 02:42:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:46 INFO - 'SHELL': '/bin/bash', 02:42:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:46 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:46 INFO - 'USER': 'cltbld', 02:42:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:46 INFO - 'XPC_FLAGS': '0x0', 02:42:46 INFO - 'XPC_SERVICE_NAME': '0', 02:42:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:47 INFO - Downloading/unpacking jsonschema 02:42:47 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 02:42:47 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 02:42:47 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 02:42:47 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 02:42:47 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 02:42:47 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 02:42:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:42:49 INFO - Downloading/unpacking functools32 (from jsonschema) 02:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:50 INFO - Downloading functools32-3.2.3-2.tar.gz 02:42:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:42:50 INFO - warning: no files found matching '*.txt' 02:42:50 INFO - no previously-included directories found matching 'build' 02:42:50 INFO - no previously-included directories found matching 'dist' 02:42:50 INFO - no previously-included directories found matching '.git*' 02:42:50 INFO - Installing collected packages: jsonschema, functools32 02:42:50 INFO - Running setup.py install for functools32 02:42:50 INFO - warning: no files found matching '*.txt' 02:42:50 INFO - no previously-included directories found matching 'build' 02:42:50 INFO - no previously-included directories found matching 'dist' 02:42:50 INFO - no previously-included directories found matching '.git*' 02:42:50 INFO - Successfully installed jsonschema functools32 02:42:50 INFO - Cleaning up... 02:42:50 INFO - Return code: 0 02:42:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:42:50 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 0x10c32aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c33a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8089dc8eb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, '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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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 02:42:50 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 02:42:50 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 02:42:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:42:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:42:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:42:50 INFO - 'HOME': '/Users/cltbld', 02:42:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:42:50 INFO - 'LOGNAME': 'cltbld', 02:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:42:50 INFO - 'MOZ_NO_REMOTE': '1', 02:42:50 INFO - 'NO_EM_RESTART': '1', 02:42:50 INFO - 'PAGER': '/bin/cat', 02:42:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:42:50 INFO - 'PWD': '/builds/slave/test', 02:42:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:42:50 INFO - 'SHELL': '/bin/bash', 02:42:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:42:50 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:42:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:42:50 INFO - 'USER': 'cltbld', 02:42:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:42:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:42:50 INFO - 'XPC_FLAGS': '0x0', 02:42:50 INFO - 'XPC_SERVICE_NAME': '0', 02:42:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:42:50 INFO - Downloading/unpacking flake8 02:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:42:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:42:53 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:42:53 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:42:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:53 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 02:42:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:42:54 INFO - no previously-included directories found matching 'docs/_build' 02:42:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:42:54 INFO - Running setup.py install for pep8 02:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:42:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:42:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:42:54 INFO - no previously-included directories found matching 'docs/_build' 02:42:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:42:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:42:54 INFO - Cleaning up... 02:42:54 INFO - Return code: 0 02:42:54 INFO - Running post-action listener: _resource_record_post_action 02:42:54 INFO - Running post-action listener: _start_resource_monitoring 02:42:54 INFO - Starting resource monitoring. 02:42:54 INFO - ##### 02:42:54 INFO - ##### Running install step. 02:42:54 INFO - ##### 02:42:54 INFO - Running pre-action listener: _resource_record_pre_action 02:42:54 INFO - Running main action method: install 02:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:42:54 INFO - Reading from file tmpfile_stdout 02:42:54 INFO - Detecting whether we're running mozinstall >=1.0... 02:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:42:55 INFO - Reading from file tmpfile_stdout 02:42:55 INFO - Output received: 02:42:55 INFO - Usage: mozinstall [options] installer 02:42:55 INFO - Options: 02:42:55 INFO - -h, --help show this help message and exit 02:42:55 INFO - -d DEST, --destination=DEST 02:42:55 INFO - Directory to install application into. [default: 02:42:55 INFO - "/builds/slave/test"] 02:42:55 INFO - --app=APP Application being installed. [default: firefox] 02:42:55 INFO - mkdir: /builds/slave/test/build/application 02:42:55 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'] 02:42:55 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 02:43:28 INFO - Reading from file tmpfile_stdout 02:43:28 INFO - Output received: 02:43:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:43:28 INFO - Running post-action listener: _resource_record_post_action 02:43:28 INFO - ##### 02:43:28 INFO - ##### Running run-tests step. 02:43:28 INFO - ##### 02:43:28 INFO - Running pre-action listener: _resource_record_pre_action 02:43:28 INFO - Running main action method: run_tests 02:43:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:43:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:43:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:43:28 INFO - 2016-04-15 02:43:28.667 screenresolution[1910:9163] starting screenresolution argv=screenresolution get 02:43:28 INFO - 2016-04-15 02:43:28.669 screenresolution[1910:9163] Display 0: 1600x1200x32@60 02:43:28 INFO - 2016-04-15 02:43:28.674 screenresolution[1911:9165] starting screenresolution argv=screenresolution list 02:43:28 INFO - Available Modes on Display 0 02:43:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:43:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:43:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:43:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:43:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:43:28 INFO - Intel Iris: 02:43:28 INFO - Chipset Model: Intel Iris 02:43:28 INFO - Type: GPU 02:43:28 INFO - Bus: Built-In 02:43:28 INFO - VRAM (Dynamic, Max): 1536 MB 02:43:28 INFO - Vendor: Intel (0x8086) 02:43:28 INFO - Device ID: 0x0a2e 02:43:28 INFO - Revision ID: 0x0009 02:43:28 INFO - Displays: 02:43:28 INFO - Display: 02:43:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:43:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:43:28 INFO - Display Serial Number: 1600x1200 60 02:43:28 INFO - Main Display: Yes 02:43:28 INFO - Mirror: Off 02:43:28 INFO - Online: Yes 02:43:28 INFO - Rotation: Supported 02:43:28 INFO - Return code: 0 02:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:43:28 INFO - Python 2.7.3 02:43:28 INFO - Return code: 0 02:43:28 INFO - grabbing minidump binary from tooltool 02:43: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')]} 02:43:28 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 0x10c1c9e00>, '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 0x10bff2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c1c4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:43:28 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 02:43:28 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 02:43:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:43:28 INFO - Return code: 0 02:43:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:43:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:43:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:43:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:43:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:43:30 INFO - Return code: 0 02:43:30 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/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--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 02:43:30 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/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0040 --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 02:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CgDVeWTLA8/Render', 02:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:43:30 INFO - 'HOME': '/Users/cltbld', 02:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:43:30 INFO - 'LOGNAME': 'cltbld', 02:43:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:43:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:43:30 INFO - 'MOZ_NO_REMOTE': '1', 02:43:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:43:30 INFO - 'NO_EM_RESTART': '1', 02:43:30 INFO - 'PAGER': '/bin/cat', 02:43:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:43:30 INFO - 'PWD': '/builds/slave/test', 02:43:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:43:30 INFO - 'SHELL': '/bin/bash', 02:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6oW4X6QdFg/Listeners', 02:43:30 INFO - 'TMPDIR': '/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/', 02:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:43:30 INFO - 'USER': 'cltbld', 02:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:43:30 INFO - 'XPC_FLAGS': '0x0', 02:43:30 INFO - 'XPC_SERVICE_NAME': '0', 02:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:43:30 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/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0040', '--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 02:43:30 INFO - mozversion application_buildid: 20160415014851 02:43:30 INFO - mozversion application_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 02:43:30 INFO - mozversion application_display_name: Nightly 02:43:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:43:30 INFO - mozversion application_name: Firefox 02:43:30 INFO - mozversion application_remotingname: firefox 02:43:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:43:30 INFO - mozversion application_vendor: Mozilla 02:43:30 INFO - mozversion application_version: 48.0a1 02:43:30 INFO - mozversion platform_buildid: 20160415014851 02:43:30 INFO - mozversion platform_changeset: 529cff9c5663a3581dfb5e690727144f07e8e23c 02:43:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:43:30 INFO - mozversion platform_version: 48.0a1 02:43:30 INFO - using testdate: 1460713410 02:43:30 INFO - actual date: 1460713410 02:43:30 INFO - starting webserver on 'localhost:49452' 02:43:30 INFO - SUITE-START | Running 2 tests 02:43:30 INFO - TEST-START | dromaeo_css 02:43:30 INFO - operating with platform_type : mac_ 02:43:30 INFO - Initialising browser for dromaeo_css test... 02:43:30 INFO - TEST-INFO | started process 1929 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmphRrZIU/profile http://localhost:49452/getInfo.html) 02:43:32 INFO - PROCESS | 1929 | __metrics Screen width/height:1600/1200 02:43:32 INFO - PROCESS | 1929 | colorDepth:24 02:43:32 INFO - PROCESS | 1929 | Browser inner width/height: 1024/689 02:43:32 INFO - PROCESS | 1929 | __metrics 02:43:32 INFO - PROCESS | 1929 | 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" 02:43:32 ERROR - PROCESS | 1929 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:43:33 INFO - TEST-INFO | 1929: exit 0 02:43:33 INFO - Browser initialized. 02:43:33 INFO - Running cycle 1/1 for dromaeo_css test... 02:43:33 INFO - TEST-INFO | started process 1931 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmphRrZIU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:43:45 INFO - PROCESS | 1931 | RSS: Main: 237477888 02:43:45 INFO - PROCESS | 1931 | 02:44:36 INFO - PROCESS | 1931 | 1460713476917 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] 02:46:47 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49452/tests/dromaeo/cssquery-ext.html) 02:46:48 INFO - PROCESS | 1931 | RSS: Main: 362057728 02:46:48 INFO - PROCESS | 1931 | 02:49:51 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-ext.html (next: http://localhost:49452/tests/dromaeo/cssquery-jquery.html) 02:49:52 INFO - PROCESS | 1931 | RSS: Main: 383070208 02:49:52 INFO - PROCESS | 1931 | 02:52:54 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49452/tests/dromaeo/cssquery-mootools.html) 02:52:54 INFO - PROCESS | 1931 | RSS: Main: 378748928 02:52:54 INFO - PROCESS | 1931 | 02:55:56 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49452/tests/dromaeo/cssquery-prototype.html) 02:55:57 INFO - PROCESS | 1931 | RSS: Main: 378859520 02:55:57 INFO - PROCESS | 1931 | 02:59:00 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49452/tests/dromaeo/cssquery-yui.html) 02:59:01 INFO - PROCESS | 1931 | RSS: Main: 347373568 02:59:01 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | Cycle 1(1): loaded http://localhost:49452/tests/dromaeo/cssquery-yui.html (next: http://localhost:49452/tests/dromaeo/cssquery-dojo.html) 03:02:03 INFO - PROCESS | 1931 | RSS: Main: 409874432 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | __start_tp_report 03:02:03 INFO - PROCESS | 1931 | _x_x_mozilla_page_load 03:02:03 INFO - PROCESS | 1931 | _x_x_mozilla_page_load_details 03:02:03 INFO - PROCESS | 1931 | |i|pagename|runs| 03:02:03 INFO - PROCESS | 1931 | |0;dojo.html;3159.1628218522096;3414.8804791832276;3454.6545345465443;3455.740819438542;3483.1466290758754;5545.667259964395;5618.381977982419;5637.408072152426;5651.37834838168;5672.914906276409;5627.465390787868;5683.687397193153;5697.287839020122;5698.230738850254;5701.315842098944;5125.359330083739;5126.231065340192;5159.071367153911;5169.793208271664;5214.634975551713;4309.353596960465;5143;5225.712585807779;5236.005159019793;5242.8165014224505;5115.769790359443;5165.01864645718;5170.146925757245;5175.378954525462;5254.57963362932;5175.508326708957;5212;5223.686578805284;5227.294315267428;5269.156934890438;5052.747362631853;5071.340725705634;5086.720230387327;5147.974260128713;5153.56194723449;5553.361363443175;5596.692181929992;5608.46719561641;5612.831615051555;5647.237622920894;6173.506119510474;6228.439440450381;6229.501639868845;6231.034189700558;6240.687965601747;6118.223266370672;6208.81373558794;6285.622862628211;6317.873642527124;6355.142055822497;5735.799247026334;5748.051571490657;5764.020116580234;5769.653820770767;5790.10253410722;6301.054841773679;6320.336364681734;6345.206849143857;6351.777687780906;6367;5981.162637230791;6069.969650151809;6076.787312444043;6084.586213254555;6104.913929256043;6264.937350626436;6281.120643109968;6283.937160628335;6290.433860952537;6300.338464461165;6152.630842149485;6181.629102253879;6202.503799696014;6205.5345849060595;6218.036204388327;6110.847228819315;6146.815595532141;6148.815535533941;6158.599691020159;6204.689765511706;4074.7758873261664;4887.266909963463;4900.411950565955;4903.411590609078;4908.9263661045115;3528.8941331759574;4366.628836548865;4396.670249731283;4399.5820397062225;4449.087936972913;5610.971945140248;5629.211910332557;5634.014047541664;5643.40744221859;5646.350669672958;6090.147379366892;6175.104609831549;6193.504519638418;6194.473469755031;6295.937040629627;5610.186522954149;5669.43305669438;5679.204911312419;5703.914441283384;5709.486146246858;5323;5325.7337133143965;5330.946690533123;5345.465453454701;5349.144136938071;6223.253209614694;6287.1512345832725;6324.367563243639;6327.493800495858;6349.619022858736;6114.113453549299;6146.432659671755;6186.845328866814;6204.720787564661;6208.658523781235;6337.683115844282;6345.397187267202;6346.07981842621;6346.587471814318;6358.872822543431;6066.939330606638;6126.884121540821;6131.816045518642;6143.600665956698;6166.075088736726;6192.071189321638;6192.442680158807;6215.627062376091;6224.284207316216;6228.56400051992;5983.581149319506;6000.789972350947;6020.187274718032;6026.548008899263;6047.334793172836;5950.821475355746;5987.670678112746;6022.45797878193;6046.334903160561;6089.238845144357;5893.086571581412;5920.851978700567;5925.466707996301;5935.2877654681715;5950.434708702666;6033.336333003278;6041;6051.697415129314;6116.816495505142;6117.663528505975;5769.68266745333;5853.882922341614;5872.618279811799;5898.616589921641;5905.261842269716 03:02:03 INFO - PROCESS | 1931 | |1;ext.html;494.34746135101665;510.2219115848331;527.3671594087097;527.7387693091918;578.5892016668165;23145.537089258225;30119.84940075302;30131.69868301319;37509.81245093771;38547;42060.57939420605;42151.78924105375;42156.367654485206;42370.57629423705;42408;9433.103855133768;9711.174550163245;9713.660021899235;9713.95143024284;9715.125638692516;8402.831943361129;8690.478571285743;9480;11367.658970230865;11708.121890858178;11395.202335836495;11517.654470365902;11529.711757206094;11540.769184616303;11547.191696581243;8408.285295749869;11199.496022678999;11328.207025508218;11353.659390218265;11358;8488;8622.827543449159;8643.178898004742;11114.499847506882;11491.42542872853;37842.43236351457;38119;38322.233555328734;38323.041923951845;38332;3050.527168288919;3254.7233485153793;3484.362349695639;3504.2465869838106;3896.875959852183;27618.37512058783;27833.304167395774;27950.44099118006;28048.719512804815;28066.15801525937;2642.3129986203535;2694.5553983592686;2700.6354142190944;2708.3906121122786;2710.186943916817;479678;479855;480146;480469;483838;59684;61022.694886525285;61103.69448152731;61118;61162.38837611567;64018.67990660017;64313.03530447047;64411.67794160999;64429.67785161044;64441;16060.839391605934;16588.75116873248;16592.336306547844;16612.750808737877;16613.58466038359;11678.708032299091;12008.979236764973;12900.548480803127;12993;13003.544875929298;14121.152730835976;14326.49857254991;14352.842374677553;16032.438864639915;16675.166241687868;6845.623490708059;6958;6964.930350696428;6999.930000700029;7028.929710702828;848.3001523742813;960.8174446855076;964.8118616869643;1028.7073009366766;1053.757635743783;29021.56467652987;29097.418051639273;29157.7084229155;29774.851125744666;30110.247243819078;1082.4154956323498;1091.0671375973586;1130.6099395708468;1190.7261329894172;1200.783858905388;14894.255287235595;15049.097054176784;15485.535433937;15541.611459713371;15696.450624228097;598610;602988;606929;607054;607520;59380.109298360556;59710.20869373926;59730;59735;59813.40186598165;1451.586297905092;1491.179851081879;1503.098141115322;1503.8571335723088;1609.7102521546235;28896;29334.85332573409;29338;30138.397232055675;30474.695253047186;49581.752091239316;49921.500784993135;50466.73833154201;50523.74738126286;50611;546833;550092.2495387497;550130;551437;551447;22477.43806404853;23816.285511434686;24212.636810447504;24624.753752462246;25620.103296384535;40815.48990886192;41069.794651026554;41139.588604113575;41869.581304187785;42382.1523569533;29898.85050574733;34228.82885585556;34331.4850277251;35012.82493587516;35488.29023419569;35405.937821864354;35666;35937.640623594474;35950.10124746902;36349.818250908575;35620.753273635295;35847;36085.27829443344;36409.54361825603;36601;29274.41451170922;29820;31229.843850780602;31237.8438107808;31245.843770781;23670.408239793454;23731.43196672636;23799.64300535528;24096;24175.63736543918 03:02:03 INFO - PROCESS | 1931 | |2;jquery.html;344.38871003967955;387.9127196380814;388.4910766895367;395.8970667626418;408.14697282679197;18239.361622343222;19708.014599270016;20276.188952441902;20284.594308113847;20362.287319943804;17921.731174032368;19112.61774764504;20045.498862528446;20434.591308173865;20440.875751833642;5357.892842143175;5621.650803807098;5669.09294512877;5866.266716660418;5867.325257595388;5846.269216347957;5859.384764599719;5895.469407753301;5895.793647222348;5899.380565040673;5586;5815.796447124351;5830.300363956331;5843.298804143508;5857.121431785245;4877.463479017305;5788.942110578903;5819.418058194189;5821.6507009579345;5824.563157763142;4832.613390928717;5093.770780314895;5100.515451032183;5107.668001579923;5108.846734597968;22335.7715325657;22747.886260568757;25597.360065998313;25920.481590368276;26004.609930851053;1856.118343786704;2006.9764420145684;2151.806337429623;2159.6220661384195;2344.6365813298967;9840.753981150458;9919.90080099197;9970.451625160613;10048.497575121288;10142.89857101427;1630.3886042733975;1746.7030604797087;1755.0961254953709;1768.071762324777;1777.2091419318408;106825;110188.449057755;110316.89683103147;111140;111538;11385.544578216945;11518.308901465938;11527.827082593767;11534.269859521139;11654.53381864716;14657.04729192599;14749.77875331871;14810.629734256514;14811.111333320036;14824.925875370554;8352.206540378655;8372.037215720271;8390.412671112963;8446.746597602081;8505.489670619783;6757.68225196082;8182.672693092329;8202.58987050645;8289.41974061822;8329.416940814084;4404.11917616478;4520.706154099973;4527.954720452819;4572.497025327211;4576.0161565263625;1561.8754496762313;1878.5303674081479;1945.085809669453;1953.326102494637;1986.3246496191364;853.6329378367237;869.6738722978882;913.6665117232162;917.6971599372191;981.1709105805583;20085.39743807688;20755.169793208104;20855.724576461787;21163.78836211649;22303.55392892133;415.87939497545375;434.1815677448033;989.6833013435776;990.7968866382374;999.4558407260799;5634.887302253932;5927.170196172539;5936.079907614327;5973.641581505123;6004.39956004396;523152;525291;534794;536541.634583657;539062;122301.38849305696;123263.38368308102;124307;124711.3764431172;126226.73773262149;464.4867421499262;465.5553945981647;471.24835886760565;471.48137049245554;472.07473352230016;10750.0324970753;10839.078678312431;10966.177536684621;10986.945065274622;11019.393933333744;45452;46710.53289467062;47311.45164112636;47457.762711186224;49282;63381;64576.70846583136;66380.66809665921;71374.6431267861;71759.64120179365;7749.535027898344;7944.205579442009;8184.918150818416;8306.501609903426;8514;11803.586874459354;12505.749885002067;12513.061520385825;12624.810627840407;12647.810282845949;10523.263371563917;11031.779364412827;11327.773444531229;11362.204645674723;11438.741738408935;8398.916010839814;10777.62278320255;10994.890051099386;11060.557577696802;11180.608678696206;11242.718932026764;11497.1377146716;11569.421528923689;11617.593384231512;11652.184347095623;8127.431079824592;8188.181181881764;8217.342612591097;8278.296344810758;8526.445781024213;10354.896451035393;10483.633072842415;10727.570897164025;11026.228164028442;11033.282836615594 03:02:03 INFO - PROCESS | 1931 | |3;mootools.html;1417.18511855683;1591.363454618153;1610.3719549375742;1849.5838436351823;1983.722278880957;7883.526988380701;8432.156784321565;8709;8709.651613935435;8710.259627931626;8227.09501954786;8566.657333706644;8598.22615964563;8600.483970961746;8602.956985215082;2341.8126549876056;2392.473655795731;2393.2461274698503;2395.760423957599;2395.784379405853;2373.5608912351186;2379.9762002380016;2419.020296779807;2425.0542288507495;2429.4898071405028;2396.269137912936;2405.987970060156;2421.636754486832;2433.3794882305074;2439.7438268981678;2357.1867705641525;2381.761823817622;2388.940276493084;2396.9161079362225;2398.6162214045844;2306.688597039395;2329.94175145621;2330.673705681206;2337.6960995070704;2356.7996720278798;7721.691132354699;7976.960115199387;8573.271271941892;8653.956730216309;8689.26141277992;4263.637590804754;5285.709285989269;5286.497782710675;5310.36275646921;5315.255864179018;3357.61387440445;3401.200717831308;3455.7235421166497;3468.618451970281;3475.51342812004;989.1246247071322;1003.5333569890037;1011.6610935336671;1015.0103648942296;1019.7246743379246;10853.294535855144;11093.1125509959;11120.332780033143;11246.49390777417;11252.831207531894;4550.522195169459;4624.306354046853;4639.698419602782;4687.601553867959;4832.540908613676;8900.753894454781;9539;10004.49977501122;10026.147777438999;10027.598896044077;5312;5340.118880384771;5341.359036915595;5344;5344.156266088194;3758.511393518825;4692.835750748707;4824.0110777291275;4835.588974937099;4840.177169881129;3317.452620317669;3725.733250694777;3758.285925674113;3861.189150278417;3885.1258466845297;1150.3960420779158;1260.7541529401678;1284.1652925598248;1290.6386211860695;1296.0603562417173;825.9304201059642;882.7837179890968;891.6611687558816;932.7807965128189;941.096547314572;4432.977835110868;5419.430959749248;5632.098864181711;5850.12248162779;5991.820245392645;935.5581931159668;968.2157452463528;977.3842479238176;980.9313348065567;982.0866594067586;3783.697304215656;3840.0975770693863;3911.84380566522;3916.549596796348;3985.9636494511055;10295.897041029644;10764.515596798163;10764.784704306026;10777;10777.191710621579;10620;10723.517441715141;10731.463426828628;10734.57061717538;10751.40867252293;7807.531548107132;8008.27925486709;8141.755747327471;8174.959125204336;8252.298554622925;5584.776608935759;5663.292088488939;5715.714214289185;5770.653760774367;5862.12068189775;9723.65967191145;9856.753581160528;9869.901300987185;9871.111599956039;10015.248856335658;8192.877106843283;9294.442333460014;10065.949670251603;10111.24165687591;10188.235882308709;6823.727050917908;6881.483888708267;6895.586264824126;6902.447804175755;7070.0808894845395;8020.759377218693;8099.271065604124;8126.55303958288;8127.2279133482225;8150.9184908150155;7198.6400679964745;7320.414366850746;7331.900214967797;7436.293552112541;7493.662785174789;6979.267176946348;7208.35124838767;7217.025701530226;7227.927720722725;7284.089488813898;6843.897341539781;6936.7918962429185;6938.722451101899;6951.826204344932;6961.721531138698;4108.548059713489;4622.653301002371;4684.414448193976;4729.196036673842;4913.557779799835;4380.189664912002;4521.389612402284;4530.25250833622;4560.977195114003;4632.3977882875015 03:02:03 INFO - PROCESS | 1931 | |4;prototype.html;281.38657726156976;305.17298122089136;323.37911210475875;327.09884268839346;328.0372107863421;5265.842024739254;5830.300363956326;5851.552819856918;5863.296404431463;5951.613145145568;5624.425160954929;5789.710514474281;5812.738426770795;5880.735366908489;5884.205632239647;3715.7956312402875;3859.7069981556074;4197.286461301571;4461.196984542781;4465.776711164445;4164.97917510412;4411.294192929132;4472.038511719979;4494.123645889053;4515.983903621692;3472.861085556587;4133.689973252003;4328.718633288842;4349.086691794727;4361.433013708213;3820;3985.864028751792;4328.740275583444;4347.63045141165;4390.802413891351;3306.702396784277;3580.695640870529;3750.5686846012513;3751.7748935063983;3765.604611515806;5664.2636457260705;5676.574256930747;5680.659160450345;5695.943040569583;5733.913991290134;4391.956080439187;4926.236433352836;4955.727434991074;4975.626827987915;4991.475895031006;5243.292155558989;5793.304803423616;6168.074788781719;6184.474319682832;6231.600833679066;3448.413769659139;3646.398344273192;4083.632473077437;4116.58834116589;4131.194417088669;5394.757235924393;5732.197492351074;5756.338021127582;5859.626851125301;6354.740580528176;3482.89551313461;4024.959750402517;4183.477065366829;4199.454070970754;4213.346931225665;3809.657130858236;4056.371262454324;4213.6839737019845;4262.87211383659;4275.615194632498;4750.382450281441;4973.925391119136;4984.975075124601;4987.4015118185325;5019.347484826949;5378.408375078739;5929.911051334234;5982.341942386334;6156.569040167235;6251.6561589112125;1422.9217393043482;1463.7072585482947;1467.4570408948757;1476.8449312822213;1483.3473271760606;938.4702934217319;950.2777888804559;959.1463597398182;966.2221911361421;974.2449601558849;4562.749048802348;5664.150377443334;5678.488935995781;5694.4590263924865;5702.45826646468;5338.626296159232;6105.603135796159;6305.306416294204;6326.936730632727;6384.265809431975;5166.870828229249;5227.503387178212;5700.572457065737;5715.199552219383;5919.3192782829665;2982.8508574571183;3315.6850099240532;3415.9829200853837;3458.4466485362723;3461.2731326421736;5645.98372292983;5986.623076692385;6359.427651511293;6493.104137517546;6772.661366931634;5669.149627555899;6321.55749097568;6571.4085732283365;6697.430718388894;6702.865942681119;6783.4573234142135;6801.353871382211;6812.4550035997;6827.6244806536115;6849.554778939452;6067.24159480065;6162.26052873658;6243.910238793597;6495.675216239264;6587.934120658732;5351.411344751997;5798.362180160263;6265.27949285838;6398.93601064002;6415.743370265137;5445.047116754631;6033.728482218223;6449.935500644933;6722.193336799615;6860.3139686031;3488.5464889564196;4126.360414135814;4187.97906010468;4212;4221.53563108064;4824.951750482591;5057.898842023213;6416.967915160394;6534.738610455719;6587.858945842716;6187.938120618736;6285.340039295808;6350.7459701611415;6356.396142366468;6388.584741991755;5556.666600004012;5995.95070862606;6246.968765156145;6312.684365781784;6338.746450141943;5673.149027645886;6190.50475961931;6208.130861679459;6224.190855188796;6235.563510554399;5545.694986775605;6303.9684801575695;6322.114903913363;6323.620582765049;6341.365863413622;5413.079776437936;5929.946077770038;5959.433853783884;6193.1329613853195;6211.689415529115 03:02:03 INFO - PROCESS | 1931 | |5;yui.html;706.2972342519195;721.051816860828;743.1528058013862;752.0974830203756;790.182161462886;11916.82124768128;15031.248437578119;16984.98090114594;17819.37632182874;17882.463526094205;16363.754543681824;16460.917695411506;16532.25604847782;16534.007959522438;16543.338266469356;701.5475018612991;902.1790170944425;904.0642934562729;904.615538396179;904.6833608237097;737.2516895351223;740.0157790139102;740.7185269597545;743.1750756660103;874.8162885793959;936.4053825820619;940.8823897012874;942.034414724909;942.5051847779902;943.0333907744582;931.0363773494435;937.6765016069479;948.8197242523898;949.1125797379403;949.6771097826703;550.3148580017863;565.064817726663;570.2586637371442;710.8294009437698;716.3517017099533;12438.19151755142;14845.628859278604;15021.098734075991;15275.694486110215;15293.6176595586;12215.450304736309;12319.199252048587;12372.1958072725;12767.936160319232;12822.615321540368;10010.299279050469;10156.339837910513;10195.745106372326;10236.129928956048;10573.365598064142;3431.4681224410256;3513.402721537345;3528;3588.8923332300074;3604.6215147409407;78389.21610783876;79224;79910.80133797998;79998.40003199961;80029;9301.488418136933;9354.064593540592;9500.95249523748;10104.898951010542;10109.545070471846;20521.17915283372;20884.164633414795;20893;20928.895355523124;20941.790582094287;7516.173220945691;7612.8477430452185;7647.541147531166;7693.615319234016;7866.252705992922;4138.255114079434;4148.702594810379;4193.454850869368;4198.076423186955;4450.488193857683;2962.407518496266;3378.543896573931;3426.2633533790354;3461.6192218855904;3471.409860323751;646.809191288571;677.2448719677524;678.1387637700192;689.6172624193521;692.5740669488229;446.47316166923343;482.08163448630415;485.1074023796232;519.4805194805194;540.351578106274;7389.81525461857;7575.356094731899;7808.7657370278985;7825.726099586601;7879.527228366202;528.7911275046336;543.1852221667499;551.5256879083985;560.2716468590816;569.829051284613;3417.1969587147;3720.6837418819705;3726.4410338448906;3775.0751065989007;3906.8632597858937;87669.56165219261;89260.21479570372;92498.07501925029;92538;92760;64012.039819402744;67467.32532674709;69892.30107698959;75271;77219.61390193013;60120.69939650361;60565.394346056855;60646.69676651677;61182.63495507701;63102.053469198;5789.797357092481;7555.962220188864;7723.995880535719;7784.377249820114;7868.72459463916;42001;42334.36498452587;42721.78639106784;43324;43510;57060.714696427916;59087.40912590991;59666.40333596608;59687;59823.401765981784;10041.196704263788;10103.797924041624;10215.846762298721;10251.897481025095;10402.219833512365;10979.121670266519;11105.944470277596;11164.832527512257;11604.593839215588;12368.75262494763;10572.312799667998;10798.67603971882;10856;10924.403288895946;11036.227464077438;10308.12380947628;10440.42577658236;10445.485241259086;10514.631987880388;11358.204925655455;10332.70841144857;10402.219833512365;10466.110380617429;10500.527476263434;10770.569177233136;7280.817979550554;7945.721899733481;8770.517621530877;9151.496667683341;9205.309601780027;8567.443116197428;8637.827243455222;8706.306593483261;9068.138526839939;9174.128457796498 03:02:03 INFO - PROCESS | 1931 | __end_tp_report 03:02:03 INFO - PROCESS | 1931 | __start_cc_report 03:02:03 INFO - PROCESS | 1931 | _x_x_mozilla_cycle_collect,1129 03:02:03 INFO - PROCESS | 1931 | __end_cc_report 03:02:03 INFO - PROCESS | 1931 | __startTimestamp1460714523971__endTimestamp 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | ------- Summary: start ------- 03:02:03 INFO - PROCESS | 1931 | Number of tests: 6 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | [#0] dojo.html Cycles:165 Average:5700.33 Median:5925.47 stddev:667.26 (11.3%) stddev-sans-first:638.84 03:02:03 INFO - PROCESS | 1931 | Values: 3159.2 3414.9 3454.7 3455.7 3483.1 5545.7 5618.4 5637.4 5651.4 5672.9 5627.5 5683.7 5697.3 5698.2 5701.3 5125.4 5126.2 5159.1 5169.8 5214.6 4309.4 5143.0 5225.7 5236.0 5242.8 5115.8 5165.0 5170.1 5175.4 5254.6 5175.5 5212.0 5223.7 5227.3 5269.2 5052.7 5071.3 5086.7 5148.0 5153.6 5553.4 5596.7 5608.5 5612.8 5647.2 6173.5 6228.4 6229.5 6231.0 6240.7 6118.2 6208.8 6285.6 6317.9 6355.1 5735.8 5748.1 5764.0 5769.7 5790.1 6301.1 6320.3 6345.2 6351.8 6367.0 5981.2 6070.0 6076.8 6084.6 6104.9 6264.9 6281.1 6283.9 6290.4 6300.3 6152.6 6181.6 6202.5 6205.5 6218.0 6110.8 6146.8 6148.8 6158.6 6204.7 4074.8 4887.3 4900.4 4903.4 4908.9 3528.9 4366.6 4396.7 4399.6 4449.1 5611.0 5629.2 5634.0 5643.4 5646.4 6090.1 6175.1 6193.5 6194.5 6295.9 5610.2 5669.4 5679.2 5703.9 5709.5 5323.0 5325.7 5330.9 5345.5 5349.1 6223.3 6287.2 6324.4 6327.5 6349.6 6114.1 6146.4 6186.8 6204.7 6208.7 6337.7 6345.4 6346.1 6346.6 6358.9 6066.9 6126.9 6131.8 6143.6 6166.1 6192.1 6192.4 6215.6 6224.3 6228.6 5983.6 6000.8 6020.2 6026.5 6047.3 5950.8 5987.7 6022.5 6046.3 6089.2 5893.1 5920.9 5925.5 5935.3 5950.4 6033.3 6041.0 6051.7 6116.8 6117.7 5769.7 5853.9 5872.6 5898.6 5905.3 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | [#1] ext.html Cycles:180 Average:67325.80 Median:19455.09 stddev:146260.53 (751.8%) stddev-sans-first:146584.75 03:02:03 INFO - PROCESS | 1931 | Values: 494.3 510.2 527.4 527.7 578.6 23145.5 30119.8 30131.7 37509.8 38547.0 42060.6 42151.8 42156.4 42370.6 42408.0 9433.1 9711.2 9713.7 9714.0 9715.1 8402.8 8690.5 9480.0 11367.7 11708.1 11395.2 11517.7 11529.7 11540.8 11547.2 8408.3 11199.5 11328.2 11353.7 11358.0 8488.0 8622.8 8643.2 11114.5 11491.4 37842.4 38119.0 38322.2 38323.0 38332.0 3050.5 3254.7 3484.4 3504.2 3896.9 27618.4 27833.3 27950.4 28048.7 28066.2 2642.3 2694.6 2700.6 2708.4 2710.2 479678.0 479855.0 480146.0 480469.0 483838.0 59684.0 61022.7 61103.7 61118.0 61162.4 64018.7 64313.0 64411.7 64429.7 64441.0 16060.8 16588.8 16592.3 16612.8 16613.6 11678.7 12009.0 12900.5 12993.0 13003.5 14121.2 14326.5 14352.8 16032.4 16675.2 6845.6 6958.0 6964.9 6999.9 7028.9 848.3 960.8 964.8 1028.7 1053.8 29021.6 29097.4 29157.7 29774.9 30110.2 1082.4 1091.1 1130.6 1190.7 1200.8 14894.3 15049.1 15485.5 15541.6 15696.5 598610.0 602988.0 606929.0 607054.0 607520.0 59380.1 59710.2 59730.0 59735.0 59813.4 1451.6 1491.2 1503.1 1503.9 1609.7 28896.0 29334.9 29338.0 30138.4 30474.7 49581.8 49921.5 50466.7 50523.7 50611.0 546833.0 550092.2 550130.0 551437.0 551447.0 22477.4 23816.3 24212.6 24624.8 25620.1 40815.5 41069.8 41139.6 41869.6 42382.2 29898.9 34228.8 34331.5 35012.8 35488.3 35405.9 35666.0 35937.6 35950.1 36349.8 35620.8 35847.0 36085.3 36409.5 36601.0 29274.4 29820.0 31229.8 31237.8 31245.8 23670.4 23731.4 23799.6 24096.0 24175.6 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | [#2] jquery.html Cycles:180 Average:31902.68 Median:412.01 stddev:89071.01 (21618.5%) stddev-sans-first:89289.36 03:02:03 INFO - PROCESS | 1931 | Values: 344.4 387.9 388.5 395.9 408.1 18239.4 19708.0 20276.2 20284.6 20362.3 17921.7 19112.6 20045.5 20434.6 20440.9 5357.9 5621.7 5669.1 5866.3 5867.3 5846.3 5859.4 5895.5 5895.8 5899.4 5586.0 5815.8 5830.3 5843.3 5857.1 4877.5 5788.9 5819.4 5821.7 5824.6 4832.6 5093.8 5100.5 5107.7 5108.8 22335.8 22747.9 25597.4 25920.5 26004.6 1856.1 2007.0 2151.8 2159.6 2344.6 9840.8 9919.9 9970.5 10048.5 10142.9 1630.4 1746.7 1755.1 1768.1 1777.2 106825.0 110188.4 110316.9 111140.0 111538.0 11385.5 11518.3 11527.8 11534.3 11654.5 14657.0 14749.8 14810.6 14811.1 14824.9 8352.2 8372.0 8390.4 8446.7 8505.5 6757.7 8182.7 8202.6 8289.4 8329.4 4404.1 4520.7 4528.0 4572.5 4576.0 1561.9 1878.5 1945.1 1953.3 1986.3 853.6 869.7 913.7 917.7 981.2 20085.4 20755.2 20855.7 21163.8 22303.6 415.9 434.2 989.7 990.8 999.5 5634.9 5927.2 5936.1 5973.6 6004.4 523152.0 525291.0 534794.0 536541.6 539062.0 122301.4 123263.4 124307.0 124711.4 126226.7 464.5 465.6 471.2 471.5 472.1 10750.0 10839.1 10966.2 10986.9 11019.4 45452.0 46710.5 47311.5 47457.8 49282.0 63381.0 64576.7 66380.7 71374.6 71759.6 7749.5 7944.2 8184.9 8306.5 8514.0 11803.6 12505.7 12513.1 12624.8 12647.8 10523.3 11031.8 11327.8 11362.2 11438.7 8398.9 10777.6 10994.9 11060.6 11180.6 11242.7 11497.1 11569.4 11617.6 11652.2 8127.4 8188.2 8217.3 8278.3 8526.4 10354.9 10483.6 10727.6 11026.2 11033.3 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | [#3] mootools.html Cycles:180 Average:5564.24 Median:4690.22 stddev:3112.97 (66.4%) stddev-sans-first:3106.10 03:02:03 INFO - PROCESS | 1931 | Values: 1417.2 1591.4 1610.4 1849.6 1983.7 7883.5 8432.2 8709.0 8709.7 8710.3 8227.1 8566.7 8598.2 8600.5 8603.0 2341.8 2392.5 2393.2 2395.8 2395.8 2373.6 2380.0 2419.0 2425.1 2429.5 2396.3 2406.0 2421.6 2433.4 2439.7 2357.2 2381.8 2388.9 2396.9 2398.6 2306.7 2329.9 2330.7 2337.7 2356.8 7721.7 7977.0 8573.3 8654.0 8689.3 4263.6 5285.7 5286.5 5310.4 5315.3 3357.6 3401.2 3455.7 3468.6 3475.5 989.1 1003.5 1011.7 1015.0 1019.7 10853.3 11093.1 11120.3 11246.5 11252.8 4550.5 4624.3 4639.7 4687.6 4832.5 8900.8 9539.0 10004.5 10026.1 10027.6 5312.0 5340.1 5341.4 5344.0 5344.2 3758.5 4692.8 4824.0 4835.6 4840.2 3317.5 3725.7 3758.3 3861.2 3885.1 1150.4 1260.8 1284.2 1290.6 1296.1 825.9 882.8 891.7 932.8 941.1 4433.0 5419.4 5632.1 5850.1 5991.8 935.6 968.2 977.4 980.9 982.1 3783.7 3840.1 3911.8 3916.5 3986.0 10295.9 10764.5 10764.8 10777.0 10777.2 10620.0 10723.5 10731.5 10734.6 10751.4 7807.5 8008.3 8141.8 8175.0 8252.3 5584.8 5663.3 5715.7 5770.7 5862.1 9723.7 9856.8 9869.9 9871.1 10015.2 8192.9 9294.4 10065.9 10111.2 10188.2 6823.7 6881.5 6895.6 6902.4 7070.1 8020.8 8099.3 8126.6 8127.2 8150.9 7198.6 7320.4 7331.9 7436.3 7493.7 6979.3 7208.4 7217.0 7227.9 7284.1 6843.9 6936.8 6938.7 6951.8 6961.7 4108.5 4622.7 4684.4 4729.2 4913.6 4380.2 4521.4 4530.3 4561.0 4632.4 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | [#4] prototype.html Cycles:180 Average:4973.90 Median:5674.86 stddev:1580.05 (27.8%) stddev-sans-first:1544.73 03:02:03 INFO - PROCESS | 1931 | Values: 281.4 305.2 323.4 327.1 328.0 5265.8 5830.3 5851.6 5863.3 5951.6 5624.4 5789.7 5812.7 5880.7 5884.2 3715.8 3859.7 4197.3 4461.2 4465.8 4165.0 4411.3 4472.0 4494.1 4516.0 3472.9 4133.7 4328.7 4349.1 4361.4 3820.0 3985.9 4328.7 4347.6 4390.8 3306.7 3580.7 3750.6 3751.8 3765.6 5664.3 5676.6 5680.7 5695.9 5733.9 4392.0 4926.2 4955.7 4975.6 4991.5 5243.3 5793.3 6168.1 6184.5 6231.6 3448.4 3646.4 4083.6 4116.6 4131.2 5394.8 5732.2 5756.3 5859.6 6354.7 3482.9 4025.0 4183.5 4199.5 4213.3 3809.7 4056.4 4213.7 4262.9 4275.6 4750.4 4973.9 4985.0 4987.4 5019.3 5378.4 5929.9 5982.3 6156.6 6251.7 1422.9 1463.7 1467.5 1476.8 1483.3 938.5 950.3 959.1 966.2 974.2 4562.7 5664.2 5678.5 5694.5 5702.5 5338.6 6105.6 6305.3 6326.9 6384.3 5166.9 5227.5 5700.6 5715.2 5919.3 2982.9 3315.7 3416.0 3458.4 3461.3 5646.0 5986.6 6359.4 6493.1 6772.7 5669.1 6321.6 6571.4 6697.4 6702.9 6783.5 6801.4 6812.5 6827.6 6849.6 6067.2 6162.3 6243.9 6495.7 6587.9 5351.4 5798.4 6265.3 6398.9 6415.7 5445.0 6033.7 6449.9 6722.2 6860.3 3488.5 4126.4 4188.0 4212.0 4221.5 4825.0 5057.9 6417.0 6534.7 6587.9 6187.9 6285.3 6350.7 6356.4 6388.6 5556.7 5996.0 6247.0 6312.7 6338.7 5673.1 6190.5 6208.1 6224.2 6235.6 5545.7 6304.0 6322.1 6323.6 6341.4 5413.1 5929.9 5959.4 6193.1 6211.7 03:02:03 INFO - PROCESS | 1931 | 03:02:03 INFO - PROCESS | 1931 | [#5] yui.html Cycles:180 Average:17206.61 Median:555.90 stddev:23941.99 (4306.9%) stddev-sans-first:23977.09 03:02:03 INFO - PROCESS | 1931 | Values: 706.3 721.1 743.2 752.1 790.2 11916.8 15031.2 16985.0 17819.4 17882.5 16363.8 16460.9 16532.3 16534.0 16543.3 701.5 902.2 904.1 904.6 904.7 737.3 740.0 740.7 743.2 874.8 936.4 940.9 942.0 942.5 943.0 931.0 937.7 948.8 949.1 949.7 550.3 565.1 570.3 710.8 716.4 12438.2 14845.6 15021.1 15275.7 15293.6 12215.5 12319.2 12372.2 12767.9 12822.6 10010.3 10156.3 10195.7 10236.1 10573.4 3431.5 3513.4 3528.0 3588.9 3604.6 78389.2 79224.0 79910.8 79998.4 80029.0 9301.5 9354.1 9501.0 10104.9 10109.5 20521.2 20884.2 20893.0 20928.9 20941.8 7516.2 7612.8 7647.5 7693.6 7866.3 4138.3 4148.7 4193.5 4198.1 4450.5 2962.4 3378.5 3426.3 3461.6 3471.4 646.8 677.2 678.1 689.6 692.6 446.5 482.1 485.1 519.5 540.4 7389.8 7575.4 7808.8 7825.7 7879.5 528.8 543.2 551.5 560.3 569.8 3417.2 3720.7 3726.4 3775.1 3906.9 87669.6 89260.2 92498.1 92538.0 92760.0 64012.0 67467.3 69892.3 75271.0 77219.6 60120.7 60565.4 60646.7 61182.6 63102.1 5789.8 7556.0 7724.0 7784.4 7868.7 42001.0 42334.4 42721.8 43324.0 43510.0 57060.7 59087.4 59666.4 59687.0 59823.4 10041.2 10103.8 10215.8 10251.9 10402.2 10979.1 11105.9 11164.8 11604.6 12368.8 10572.3 10798.7 10856.0 10924.4 11036.2 10308.1 10440.4 10445.5 10514.6 11358.2 10332.7 10402.2 10466.1 10500.5 10770.6 7280.8 7945.7 8770.5 9151.5 9205.3 8567.4 8637.8 8706.3 9068.1 9174.1 03:02:03 INFO - PROCESS | 1931 | -------- Summary: end -------- 03:02:03 INFO - PROCESS | 1931 | 03:02:04 INFO - TEST-INFO | 1931: exit 0 03:02:04 INFO - TEST-OK | dromaeo_css | took 1114099ms 03:02:04 INFO - TEST-START | kraken 03:02:04 INFO - operating with platform_type : mac_ 03:02:04 INFO - Initialising browser for kraken test... 03:02:04 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpRrzzHo/profile http://localhost:49452/getInfo.html) 03:02:06 INFO - PROCESS | 1937 | __metrics Screen width/height:1600/1200 03:02:06 INFO - PROCESS | 1937 | colorDepth:24 03:02:06 INFO - PROCESS | 1937 | Browser inner width/height: 1024/689 03:02:06 INFO - PROCESS | 1937 | __metrics 03:02:06 INFO - PROCESS | 1937 | 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" 03:02:06 ERROR - PROCESS | 1937 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:02:07 INFO - TEST-INFO | 1937: exit 0 03:02:07 INFO - Browser initialized. 03:02:07 INFO - Running cycle 1/1 for kraken test... 03:02:07 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/T/tmpRrzzHo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:02:19 INFO - PROCESS | 1939 | RSS: Main: 237740032 03:02:19 INFO - PROCESS | 1939 | 03:02:21 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-beat-detection) 03:02:22 INFO - PROCESS | 1939 | RSS: Main: 285892608 03:02:22 INFO - PROCESS | 1939 | 03:02:25 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-dft) 03:02:26 INFO - PROCESS | 1939 | RSS: Main: 299499520 03:02:26 INFO - PROCESS | 1939 | 03:02:29 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-fft) 03:02:30 INFO - PROCESS | 1939 | RSS: Main: 387936256 03:02:30 INFO - PROCESS | 1939 | 03:02:32 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49452/tests/kraken/driver.html?testName=audio-oscillator) 03:02:32 INFO - PROCESS | 1939 | RSS: Main: 286687232 03:02:32 INFO - PROCESS | 1939 | 03:02:35 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:02:35 INFO - PROCESS | 1939 | RSS: Main: 291811328 03:02:35 INFO - PROCESS | 1939 | 03:02:38 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-darkroom) 03:02:39 INFO - PROCESS | 1939 | RSS: Main: 329785344 03:02:39 INFO - PROCESS | 1939 | 03:02:41 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49452/tests/kraken/driver.html?testName=imaging-desaturate) 03:02:42 INFO - PROCESS | 1939 | RSS: Main: 330899456 03:02:42 INFO - PROCESS | 1939 | 03:02:45 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49452/tests/kraken/driver.html?testName=json-parse-financial) 03:02:45 INFO - PROCESS | 1939 | RSS: Main: 328519680 03:02:45 INFO - PROCESS | 1939 | 03:02:47 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49452/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:02:48 INFO - PROCESS | 1939 | RSS: Main: 320094208 03:02:48 INFO - PROCESS | 1939 | 03:02:49 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:02:50 INFO - PROCESS | 1939 | RSS: Main: 326770688 03:02:50 INFO - PROCESS | 1939 | 03:02:52 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:02:53 INFO - PROCESS | 1939 | RSS: Main: 329789440 03:02:53 INFO - PROCESS | 1939 | 03:02:56 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:02:57 INFO - PROCESS | 1939 | RSS: Main: 334753792 03:02:57 INFO - PROCESS | 1939 | 03:02:59 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:03:00 INFO - PROCESS | 1939 | RSS: Main: 332480512 03:03:00 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | Cycle 1(1): loaded http://localhost:49452/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49452/tests/kraken/driver.html?testName=ai-astar) 03:03:02 INFO - PROCESS | 1939 | RSS: Main: 397004800 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | __start_tp_report 03:03:02 INFO - PROCESS | 1939 | _x_x_mozilla_page_load 03:03:02 INFO - PROCESS | 1939 | _x_x_mozilla_page_load_details 03:03:02 INFO - PROCESS | 1939 | |i|pagename|runs| 03:03:02 INFO - PROCESS | 1939 | |0;ai-astar;112;110;113;111;114;114;118;113;113;113 03:03:02 INFO - PROCESS | 1939 | |1;audio-beat-detection;156;121;142;169;139;176;180;118;170;119 03:03:02 INFO - PROCESS | 1939 | |2;audio-dft;188;186;189;187;183;182;182;185;184;196 03:03:02 INFO - PROCESS | 1939 | |3;audio-fft;77;73;85;95;73;85;84;106;87;55 03:03:02 INFO - PROCESS | 1939 | |4;audio-oscillator;93;92;129;76;78;84;124;79;76;125 03:03:02 INFO - PROCESS | 1939 | |5;imaging-gaussian-blur;90;85;89;86;88;85;90;129;87;86 03:03:02 INFO - PROCESS | 1939 | |6;imaging-darkroom;94;94;95;94;94;94;94;95;92;94 03:03:02 INFO - PROCESS | 1939 | |7;imaging-desaturate;128;136;85;85;85;87;88;85;85;85 03:03:02 INFO - PROCESS | 1939 | |8;json-parse-financial;59;61;60;58;60;60;59;78;59;57 03:03:02 INFO - PROCESS | 1939 | |9;json-stringify-tinderbox;64;64;73;86;74;71;67;68;67;69 03:03:02 INFO - PROCESS | 1939 | |10;stanford-crypto-aes;84;86;83;84;85;84;87;87;73;99 03:03:02 INFO - PROCESS | 1939 | |11;stanford-crypto-ccm;144;145;145;138;142;124;162;149;175;178 03:03:02 INFO - PROCESS | 1939 | |12;stanford-crypto-pbkdf2;171;179;167;169;170;172;169;170;168;168 03:03:02 INFO - PROCESS | 1939 | |13;stanford-crypto-sha256-iterative;70;67;69;68;69;70;70;69;67;67 03:03:02 INFO - PROCESS | 1939 | __end_tp_report 03:03:02 INFO - PROCESS | 1939 | __start_cc_report 03:03:02 INFO - PROCESS | 1939 | _x_x_mozilla_cycle_collect,1996 03:03:02 INFO - PROCESS | 1939 | __end_cc_report 03:03:02 INFO - PROCESS | 1939 | __startTimestamp1460714582560__endTimestamp 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | ------- Summary: start ------- 03:03:02 INFO - PROCESS | 1939 | Number of tests: 14 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:2.13 (1.9%) stddev-sans-first:2.22 03:03:02 INFO - PROCESS | 1939 | Values: 112.0 110.0 113.0 111.0 114.0 114.0 118.0 113.0 113.0 113.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:162.50 stddev:24.44 (15.0%) stddev-sans-first:25.79 03:03:02 INFO - PROCESS | 1939 | Values: 156.0 121.0 142.0 169.0 139.0 176.0 180.0 118.0 170.0 119.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#2] audio-dft Cycles:10 Average:186.20 Median:186.50 stddev:4.21 (2.3%) stddev-sans-first:4.42 03:03:02 INFO - PROCESS | 1939 | Values: 188.0 186.0 189.0 187.0 183.0 182.0 182.0 185.0 184.0 196.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#3] audio-fft Cycles:10 Average:82.00 Median:84.50 stddev:13.78 (16.3%) stddev-sans-first:14.49 03:03:02 INFO - PROCESS | 1939 | Values: 77.0 73.0 85.0 95.0 73.0 85.0 84.0 106.0 87.0 55.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:78.50 stddev:21.84 (27.8%) stddev-sans-first:23.15 03:03:02 INFO - PROCESS | 1939 | Values: 93.0 92.0 129.0 76.0 78.0 84.0 124.0 79.0 76.0 125.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:87.50 stddev:13.31 (15.2%) stddev-sans-first:14.11 03:03:02 INFO - PROCESS | 1939 | Values: 90.0 85.0 89.0 86.0 88.0 85.0 90.0 129.0 87.0 86.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 03:03:02 INFO - PROCESS | 1939 | Values: 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 92.0 94.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:85.00 stddev:19.67 (23.1%) stddev-sans-first:16.83 03:03:02 INFO - PROCESS | 1939 | Values: 128.0 136.0 85.0 85.0 85.0 87.0 88.0 85.0 85.0 85.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.00 stddev:6.05 (10.1%) stddev-sans-first:6.36 03:03:02 INFO - PROCESS | 1939 | Values: 59.0 61.0 60.0 58.0 60.0 60.0 59.0 78.0 59.0 57.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:6.46 (9.2%) stddev-sans-first:6.44 03:03:02 INFO - PROCESS | 1939 | Values: 64.0 64.0 73.0 86.0 74.0 71.0 67.0 68.0 67.0 69.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:85.50 stddev:6.29 (7.4%) stddev-sans-first:6.65 03:03:02 INFO - PROCESS | 1939 | Values: 84.0 86.0 83.0 84.0 85.0 84.0 87.0 87.0 73.0 99.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#11] stanford-crypto-ccm Cycles:10 Average:150.20 Median:147.00 stddev:16.75 (11.4%) stddev-sans-first:17.61 03:03:02 INFO - PROCESS | 1939 | Values: 144.0 145.0 145.0 138.0 142.0 124.0 162.0 149.0 175.0 178.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.30 Median:170.00 stddev:3.40 (2.0%) stddev-sans-first:3.60 03:03:02 INFO - PROCESS | 1939 | Values: 171.0 179.0 167.0 169.0 170.0 172.0 169.0 170.0 168.0 168.0 03:03:02 INFO - PROCESS | 1939 | 03:03:02 INFO - PROCESS | 1939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:1.24 03:03:02 INFO - PROCESS | 1939 | Values: 70.0 67.0 69.0 68.0 69.0 70.0 70.0 69.0 67.0 67.0 03:03:02 INFO - PROCESS | 1939 | -------- Summary: end -------- 03:03:02 INFO - PROCESS | 1939 | 03:03:03 INFO - TEST-INFO | 1939: exit 0 03:03:03 INFO - TEST-OK | kraken | took 58835ms 03:03:03 INFO - SUITE-END | took 1172s 03:03:03 INFO - Completed test suite (00:19:33) 03:03:03 INFO - javascript benchmark 03:03:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.1628218522096, 3414.8804791832276, 3454.6545345465443, 3455.740819438542, 3483.1466290758754, 5545.667259964395, 5618.381977982419, 5637.408072152426, 5651.37834838168, 5672.914906276409, 5627.465390787868, 5683.687397193153, 5697.287839020122, 5698.230738850254, 5701.315842098944, 5125.359330083739, 5126.231065340192, 5159.071367153911, 5169.793208271664, 5214.634975551713, 4309.353596960465, 5143.0, 5225.712585807779, 5236.005159019793, 5242.8165014224505, 5115.769790359443, 5165.01864645718, 5170.146925757245, 5175.378954525462, 5254.57963362932, 5175.508326708957, 5212.0, 5223.686578805284, 5227.294315267428, 5269.156934890438, 5052.747362631853, 5071.340725705634, 5086.720230387327, 5147.974260128713, 5153.56194723449, 5553.361363443175, 5596.692181929992, 5608.46719561641, 5612.831615051555, 5647.237622920894, 6173.506119510474, 6228.439440450381, 6229.501639868845, 6231.034189700558, 6240.687965601747, 6118.223266370672, 6208.81373558794, 6285.622862628211, 6317.873642527124, 6355.142055822497, 5735.799247026334, 5748.051571490657, 5764.020116580234, 5769.653820770767, 5790.10253410722, 6301.054841773679, 6320.336364681734, 6345.206849143857, 6351.777687780906, 6367.0, 5981.162637230791, 6069.969650151809, 6076.787312444043, 6084.586213254555, 6104.913929256043, 6264.937350626436, 6281.120643109968, 6283.937160628335, 6290.433860952537, 6300.338464461165, 6152.630842149485, 6181.629102253879, 6202.503799696014, 6205.5345849060595, 6218.036204388327, 6110.847228819315, 6146.815595532141, 6148.815535533941, 6158.599691020159, 6204.689765511706, 4074.7758873261664, 4887.266909963463, 4900.411950565955, 4903.411590609078, 4908.9263661045115, 3528.8941331759574, 4366.628836548865, 4396.670249731283, 4399.5820397062225, 4449.087936972913, 5610.971945140248, 5629.211910332557, 5634.014047541664, 5643.40744221859, 5646.350669672958, 6090.147379366892, 6175.104609831549, 6193.504519638418, 6194.473469755031, 6295.937040629627, 5610.186522954149, 5669.43305669438, 5679.204911312419, 5703.914441283384, 5709.486146246858, 5323.0, 5325.7337133143965, 5330.946690533123, 5345.465453454701, 5349.144136938071, 6223.253209614694, 6287.1512345832725, 6324.367563243639, 6327.493800495858, 6349.619022858736, 6114.113453549299, 6146.432659671755, 6186.845328866814, 6204.720787564661, 6208.658523781235, 6337.683115844282, 6345.397187267202, 6346.07981842621, 6346.587471814318, 6358.872822543431, 6066.939330606638, 6126.884121540821, 6131.816045518642, 6143.600665956698, 6166.075088736726, 6192.071189321638, 6192.442680158807, 6215.627062376091, 6224.284207316216, 6228.56400051992, 5983.581149319506, 6000.789972350947, 6020.187274718032, 6026.548008899263, 6047.334793172836, 5950.821475355746, 5987.670678112746, 6022.45797878193, 6046.334903160561, 6089.238845144357, 5893.086571581412, 5920.851978700567, 5925.466707996301, 5935.2877654681715, 5950.434708702666, 6033.336333003278, 6041.0, 6051.697415129314, 6116.816495505142, 6117.663528505975, 5769.68266745333, 5853.882922341614, 5872.618279811799, 5898.616589921641, 5905.261842269716], "value": 5655.979771770652, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.34746135101665, 510.2219115848331, 527.3671594087097, 527.7387693091918, 578.5892016668165, 23145.537089258225, 30119.84940075302, 30131.69868301319, 37509.81245093771, 38547.0, 42060.57939420605, 42151.78924105375, 42156.367654485206, 42370.57629423705, 42408.0, 9433.103855133768, 9711.174550163245, 9713.660021899235, 9713.95143024284, 9715.125638692516, 8402.831943361129, 8690.478571285743, 9480.0, 11367.658970230865, 11708.121890858178, 11395.202335836495, 11517.654470365902, 11529.711757206094, 11540.769184616303, 11547.191696581243, 8408.285295749869, 11199.496022678999, 11328.207025508218, 11353.659390218265, 11358.0, 8488.0, 8622.827543449159, 8643.178898004742, 11114.499847506882, 11491.42542872853, 37842.43236351457, 38119.0, 38322.233555328734, 38323.041923951845, 38332.0, 3050.527168288919, 3254.7233485153793, 3484.362349695639, 3504.2465869838106, 3896.875959852183, 27618.37512058783, 27833.304167395774, 27950.44099118006, 28048.719512804815, 28066.15801525937, 2642.3129986203535, 2694.5553983592686, 2700.6354142190944, 2708.3906121122786, 2710.186943916817, 479678.0, 479855.0, 480146.0, 480469.0, 483838.0, 59684.0, 61022.694886525285, 61103.69448152731, 61118.0, 61162.38837611567, 64018.67990660017, 64313.03530447047, 64411.67794160999, 64429.67785161044, 64441.0, 16060.839391605934, 16588.75116873248, 16592.336306547844, 16612.750808737877, 16613.58466038359, 11678.708032299091, 12008.979236764973, 12900.548480803127, 12993.0, 13003.544875929298, 14121.152730835976, 14326.49857254991, 14352.842374677553, 16032.438864639915, 16675.166241687868, 6845.623490708059, 6958.0, 6964.930350696428, 6999.930000700029, 7028.929710702828, 848.3001523742813, 960.8174446855076, 964.8118616869643, 1028.7073009366766, 1053.757635743783, 29021.56467652987, 29097.418051639273, 29157.7084229155, 29774.851125744666, 30110.247243819078, 1082.4154956323498, 1091.0671375973586, 1130.6099395708468, 1190.7261329894172, 1200.783858905388, 14894.255287235595, 15049.097054176784, 15485.535433937, 15541.611459713371, 15696.450624228097, 598610.0, 602988.0, 606929.0, 607054.0, 607520.0, 59380.109298360556, 59710.20869373926, 59730.0, 59735.0, 59813.40186598165, 1451.586297905092, 1491.179851081879, 1503.098141115322, 1503.8571335723088, 1609.7102521546235, 28896.0, 29334.85332573409, 29338.0, 30138.397232055675, 30474.695253047186, 49581.752091239316, 49921.500784993135, 50466.73833154201, 50523.74738126286, 50611.0, 546833.0, 550092.2495387497, 550130.0, 551437.0, 551447.0, 22477.43806404853, 23816.285511434686, 24212.636810447504, 24624.753752462246, 25620.103296384535, 40815.48990886192, 41069.794651026554, 41139.588604113575, 41869.581304187785, 42382.1523569533, 29898.85050574733, 34228.82885585556, 34331.4850277251, 35012.82493587516, 35488.29023419569, 35405.937821864354, 35666.0, 35937.640623594474, 35950.10124746902, 36349.818250908575, 35620.753273635295, 35847.0, 36085.27829443344, 36409.54361825603, 36601.0, 29274.41451170922, 29820.0, 31229.843850780602, 31237.8438107808, 31245.843770781, 23670.408239793454, 23731.43196672636, 23799.64300535528, 24096.0, 24175.63736543918], "value": 19411.86239505042, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.38871003967955, 387.9127196380814, 388.4910766895367, 395.8970667626418, 408.14697282679197, 18239.361622343222, 19708.014599270016, 20276.188952441902, 20284.594308113847, 20362.287319943804, 17921.731174032368, 19112.61774764504, 20045.498862528446, 20434.591308173865, 20440.875751833642, 5357.892842143175, 5621.650803807098, 5669.09294512877, 5866.266716660418, 5867.325257595388, 5846.269216347957, 5859.384764599719, 5895.469407753301, 5895.793647222348, 5899.380565040673, 5586.0, 5815.796447124351, 5830.300363956331, 5843.298804143508, 5857.121431785245, 4877.463479017305, 5788.942110578903, 5819.418058194189, 5821.6507009579345, 5824.563157763142, 4832.613390928717, 5093.770780314895, 5100.515451032183, 5107.668001579923, 5108.846734597968, 22335.7715325657, 22747.886260568757, 25597.360065998313, 25920.481590368276, 26004.609930851053, 1856.118343786704, 2006.9764420145684, 2151.806337429623, 2159.6220661384195, 2344.6365813298967, 9840.753981150458, 9919.90080099197, 9970.451625160613, 10048.497575121288, 10142.89857101427, 1630.3886042733975, 1746.7030604797087, 1755.0961254953709, 1768.071762324777, 1777.2091419318408, 106825.0, 110188.449057755, 110316.89683103147, 111140.0, 111538.0, 11385.544578216945, 11518.308901465938, 11527.827082593767, 11534.269859521139, 11654.53381864716, 14657.04729192599, 14749.77875331871, 14810.629734256514, 14811.111333320036, 14824.925875370554, 8352.206540378655, 8372.037215720271, 8390.412671112963, 8446.746597602081, 8505.489670619783, 6757.68225196082, 8182.672693092329, 8202.58987050645, 8289.41974061822, 8329.416940814084, 4404.11917616478, 4520.706154099973, 4527.954720452819, 4572.497025327211, 4576.0161565263625, 1561.8754496762313, 1878.5303674081479, 1945.085809669453, 1953.326102494637, 1986.3246496191364, 853.6329378367237, 869.6738722978882, 913.6665117232162, 917.6971599372191, 981.1709105805583, 20085.39743807688, 20755.169793208104, 20855.724576461787, 21163.78836211649, 22303.55392892133, 415.87939497545375, 434.1815677448033, 989.6833013435776, 990.7968866382374, 999.4558407260799, 5634.887302253932, 5927.170196172539, 5936.079907614327, 5973.641581505123, 6004.39956004396, 523152.0, 525291.0, 534794.0, 536541.634583657, 539062.0, 122301.38849305696, 123263.38368308102, 124307.0, 124711.3764431172, 126226.73773262149, 464.4867421499262, 465.5553945981647, 471.24835886760565, 471.48137049245554, 472.07473352230016, 10750.0324970753, 10839.078678312431, 10966.177536684621, 10986.945065274622, 11019.393933333744, 45452.0, 46710.53289467062, 47311.45164112636, 47457.762711186224, 49282.0, 63381.0, 64576.70846583136, 66380.66809665921, 71374.6431267861, 71759.64120179365, 7749.535027898344, 7944.205579442009, 8184.918150818416, 8306.501609903426, 8514.0, 11803.586874459354, 12505.749885002067, 12513.061520385825, 12624.810627840407, 12647.810282845949, 10523.263371563917, 11031.779364412827, 11327.773444531229, 11362.204645674723, 11438.741738408935, 8398.916010839814, 10777.62278320255, 10994.890051099386, 11060.557577696802, 11180.608678696206, 11242.718932026764, 11497.1377146716, 11569.421528923689, 11617.593384231512, 11652.184347095623, 8127.431079824592, 8188.181181881764, 8217.342612591097, 8278.296344810758, 8526.445781024213, 10354.896451035393, 10483.633072842415, 10727.570897164025, 11026.228164028442, 11033.282836615594], "value": 8765.376139583579, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.18511855683, 1591.363454618153, 1610.3719549375742, 1849.5838436351823, 1983.722278880957, 7883.526988380701, 8432.156784321565, 8709.0, 8709.651613935435, 8710.259627931626, 8227.09501954786, 8566.657333706644, 8598.22615964563, 8600.483970961746, 8602.956985215082, 2341.8126549876056, 2392.473655795731, 2393.2461274698503, 2395.760423957599, 2395.784379405853, 2373.5608912351186, 2379.9762002380016, 2419.020296779807, 2425.0542288507495, 2429.4898071405028, 2396.269137912936, 2405.987970060156, 2421.636754486832, 2433.3794882305074, 2439.7438268981678, 2357.1867705641525, 2381.761823817622, 2388.940276493084, 2396.9161079362225, 2398.6162214045844, 2306.688597039395, 2329.94175145621, 2330.673705681206, 2337.6960995070704, 2356.7996720278798, 7721.691132354699, 7976.960115199387, 8573.271271941892, 8653.956730216309, 8689.26141277992, 4263.637590804754, 5285.709285989269, 5286.497782710675, 5310.36275646921, 5315.255864179018, 3357.61387440445, 3401.200717831308, 3455.7235421166497, 3468.618451970281, 3475.51342812004, 989.1246247071322, 1003.5333569890037, 1011.6610935336671, 1015.0103648942296, 1019.7246743379246, 10853.294535855144, 11093.1125509959, 11120.332780033143, 11246.49390777417, 11252.831207531894, 4550.522195169459, 4624.306354046853, 4639.698419602782, 4687.601553867959, 4832.540908613676, 8900.753894454781, 9539.0, 10004.49977501122, 10026.147777438999, 10027.598896044077, 5312.0, 5340.118880384771, 5341.359036915595, 5344.0, 5344.156266088194, 3758.511393518825, 4692.835750748707, 4824.0110777291275, 4835.588974937099, 4840.177169881129, 3317.452620317669, 3725.733250694777, 3758.285925674113, 3861.189150278417, 3885.1258466845297, 1150.3960420779158, 1260.7541529401678, 1284.1652925598248, 1290.6386211860695, 1296.0603562417173, 825.9304201059642, 882.7837179890968, 891.6611687558816, 932.7807965128189, 941.096547314572, 4432.977835110868, 5419.430959749248, 5632.098864181711, 5850.12248162779, 5991.820245392645, 935.5581931159668, 968.2157452463528, 977.3842479238176, 980.9313348065567, 982.0866594067586, 3783.697304215656, 3840.0975770693863, 3911.84380566522, 3916.549596796348, 3985.9636494511055, 10295.897041029644, 10764.515596798163, 10764.784704306026, 10777.0, 10777.191710621579, 10620.0, 10723.517441715141, 10731.463426828628, 10734.57061717538, 10751.40867252293, 7807.531548107132, 8008.27925486709, 8141.755747327471, 8174.959125204336, 8252.298554622925, 5584.776608935759, 5663.292088488939, 5715.714214289185, 5770.653760774367, 5862.12068189775, 9723.65967191145, 9856.753581160528, 9869.901300987185, 9871.111599956039, 10015.248856335658, 8192.877106843283, 9294.442333460014, 10065.949670251603, 10111.24165687591, 10188.235882308709, 6823.727050917908, 6881.483888708267, 6895.586264824126, 6902.447804175755, 7070.0808894845395, 8020.759377218693, 8099.271065604124, 8126.55303958288, 8127.2279133482225, 8150.9184908150155, 7198.6400679964745, 7320.414366850746, 7331.900214967797, 7436.293552112541, 7493.662785174789, 6979.267176946348, 7208.35124838767, 7217.025701530226, 7227.927720722725, 7284.089488813898, 6843.897341539781, 6936.7918962429185, 6938.722451101899, 6951.826204344932, 6961.721531138698, 4108.548059713489, 4622.653301002371, 4684.414448193976, 4729.196036673842, 4913.557779799835, 4380.189664912002, 4521.389612402284, 4530.25250833622, 4560.977195114003, 4632.3977882875015], "value": 4494.32144309592, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.38657726156976, 305.17298122089136, 323.37911210475875, 327.09884268839346, 328.0372107863421, 5265.842024739254, 5830.300363956326, 5851.552819856918, 5863.296404431463, 5951.613145145568, 5624.425160954929, 5789.710514474281, 5812.738426770795, 5880.735366908489, 5884.205632239647, 3715.7956312402875, 3859.7069981556074, 4197.286461301571, 4461.196984542781, 4465.776711164445, 4164.97917510412, 4411.294192929132, 4472.038511719979, 4494.123645889053, 4515.983903621692, 3472.861085556587, 4133.689973252003, 4328.718633288842, 4349.086691794727, 4361.433013708213, 3820.0, 3985.864028751792, 4328.740275583444, 4347.63045141165, 4390.802413891351, 3306.702396784277, 3580.695640870529, 3750.5686846012513, 3751.7748935063983, 3765.604611515806, 5664.2636457260705, 5676.574256930747, 5680.659160450345, 5695.943040569583, 5733.913991290134, 4391.956080439187, 4926.236433352836, 4955.727434991074, 4975.626827987915, 4991.475895031006, 5243.292155558989, 5793.304803423616, 6168.074788781719, 6184.474319682832, 6231.600833679066, 3448.413769659139, 3646.398344273192, 4083.632473077437, 4116.58834116589, 4131.194417088669, 5394.757235924393, 5732.197492351074, 5756.338021127582, 5859.626851125301, 6354.740580528176, 3482.89551313461, 4024.959750402517, 4183.477065366829, 4199.454070970754, 4213.346931225665, 3809.657130858236, 4056.371262454324, 4213.6839737019845, 4262.87211383659, 4275.615194632498, 4750.382450281441, 4973.925391119136, 4984.975075124601, 4987.4015118185325, 5019.347484826949, 5378.408375078739, 5929.911051334234, 5982.341942386334, 6156.569040167235, 6251.6561589112125, 1422.9217393043482, 1463.7072585482947, 1467.4570408948757, 1476.8449312822213, 1483.3473271760606, 938.4702934217319, 950.2777888804559, 959.1463597398182, 966.2221911361421, 974.2449601558849, 4562.749048802348, 5664.150377443334, 5678.488935995781, 5694.4590263924865, 5702.45826646468, 5338.626296159232, 6105.603135796159, 6305.306416294204, 6326.936730632727, 6384.265809431975, 5166.870828229249, 5227.503387178212, 5700.572457065737, 5715.199552219383, 5919.3192782829665, 2982.8508574571183, 3315.6850099240532, 3415.9829200853837, 3458.4466485362723, 3461.2731326421736, 5645.98372292983, 5986.623076692385, 6359.427651511293, 6493.104137517546, 6772.661366931634, 5669.149627555899, 6321.55749097568, 6571.4085732283365, 6697.430718388894, 6702.865942681119, 6783.4573234142135, 6801.353871382211, 6812.4550035997, 6827.6244806536115, 6849.554778939452, 6067.24159480065, 6162.26052873658, 6243.910238793597, 6495.675216239264, 6587.934120658732, 5351.411344751997, 5798.362180160263, 6265.27949285838, 6398.93601064002, 6415.743370265137, 5445.047116754631, 6033.728482218223, 6449.935500644933, 6722.193336799615, 6860.3139686031, 3488.5464889564196, 4126.360414135814, 4187.97906010468, 4212.0, 4221.53563108064, 4824.951750482591, 5057.898842023213, 6416.967915160394, 6534.738610455719, 6587.858945842716, 6187.938120618736, 6285.340039295808, 6350.7459701611415, 6356.396142366468, 6388.584741991755, 5556.666600004012, 5995.95070862606, 6246.968765156145, 6312.684365781784, 6338.746450141943, 5673.149027645886, 6190.50475961931, 6208.130861679459, 6224.190855188796, 6235.563510554399, 5545.694986775605, 6303.9684801575695, 6322.114903913363, 6323.620582765049, 6341.365863413622, 5413.079776437936, 5929.946077770038, 5959.433853783884, 6193.1329613853195, 6211.689415529115], "value": 4465.543116708935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.2972342519195, 721.051816860828, 743.1528058013862, 752.0974830203756, 790.182161462886, 11916.82124768128, 15031.248437578119, 16984.98090114594, 17819.37632182874, 17882.463526094205, 16363.754543681824, 16460.917695411506, 16532.25604847782, 16534.007959522438, 16543.338266469356, 701.5475018612991, 902.1790170944425, 904.0642934562729, 904.615538396179, 904.6833608237097, 737.2516895351223, 740.0157790139102, 740.7185269597545, 743.1750756660103, 874.8162885793959, 936.4053825820619, 940.8823897012874, 942.034414724909, 942.5051847779902, 943.0333907744582, 931.0363773494435, 937.6765016069479, 948.8197242523898, 949.1125797379403, 949.6771097826703, 550.3148580017863, 565.064817726663, 570.2586637371442, 710.8294009437698, 716.3517017099533, 12438.19151755142, 14845.628859278604, 15021.098734075991, 15275.694486110215, 15293.6176595586, 12215.450304736309, 12319.199252048587, 12372.1958072725, 12767.936160319232, 12822.615321540368, 10010.299279050469, 10156.339837910513, 10195.745106372326, 10236.129928956048, 10573.365598064142, 3431.4681224410256, 3513.402721537345, 3528.0, 3588.8923332300074, 3604.6215147409407, 78389.21610783876, 79224.0, 79910.80133797998, 79998.40003199961, 80029.0, 9301.488418136933, 9354.064593540592, 9500.95249523748, 10104.898951010542, 10109.545070471846, 20521.17915283372, 20884.164633414795, 20893.0, 20928.895355523124, 20941.790582094287, 7516.173220945691, 7612.8477430452185, 7647.541147531166, 7693.615319234016, 7866.252705992922, 4138.255114079434, 4148.702594810379, 4193.454850869368, 4198.076423186955, 4450.488193857683, 2962.407518496266, 3378.543896573931, 3426.2633533790354, 3461.6192218855904, 3471.409860323751, 646.809191288571, 677.2448719677524, 678.1387637700192, 689.6172624193521, 692.5740669488229, 446.47316166923343, 482.08163448630415, 485.1074023796232, 519.4805194805194, 540.351578106274, 7389.81525461857, 7575.356094731899, 7808.7657370278985, 7825.726099586601, 7879.527228366202, 528.7911275046336, 543.1852221667499, 551.5256879083985, 560.2716468590816, 569.829051284613, 3417.1969587147, 3720.6837418819705, 3726.4410338448906, 3775.0751065989007, 3906.8632597858937, 87669.56165219261, 89260.21479570372, 92498.07501925029, 92538.0, 92760.0, 64012.039819402744, 67467.32532674709, 69892.30107698959, 75271.0, 77219.61390193013, 60120.69939650361, 60565.394346056855, 60646.69676651677, 61182.63495507701, 63102.053469198, 5789.797357092481, 7555.962220188864, 7723.995880535719, 7784.377249820114, 7868.72459463916, 42001.0, 42334.36498452587, 42721.78639106784, 43324.0, 43510.0, 57060.714696427916, 59087.40912590991, 59666.40333596608, 59687.0, 59823.401765981784, 10041.196704263788, 10103.797924041624, 10215.846762298721, 10251.897481025095, 10402.219833512365, 10979.121670266519, 11105.944470277596, 11164.832527512257, 11604.593839215588, 12368.75262494763, 10572.312799667998, 10798.67603971882, 10856.0, 10924.403288895946, 11036.227464077438, 10308.12380947628, 10440.42577658236, 10445.485241259086, 10514.631987880388, 11358.204925655455, 10332.70841144857, 10402.219833512365, 10466.110380617429, 10500.527476263434, 10770.569177233136, 7280.817979550554, 7945.721899733481, 8770.517621530877, 9151.496667683341, 9205.309601780027, 8567.443116197428, 8637.827243455222, 8706.306593483261, 9068.138526839939, 9174.128457796498], "value": 6608.406490160515, "unit": "score"}], "name": "dromaeo_css", "value": 7095.83717772607, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 113.0, 111.0, 114.0, 114.0, 118.0, 113.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 142.0, 169.0, 139.0, 176.0, 180.0, 118.0, 170.0, 119.0], "value": 149.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 186.0, 189.0, 187.0, 183.0, 182.0, 182.0, 185.0, 184.0, 196.0], "value": 186.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 85.0, 95.0, 73.0, 85.0, 84.0, 106.0, 87.0, 55.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 129.0, 76.0, 78.0, 84.0, 124.0, 79.0, 76.0, 125.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 89.0, 86.0, 88.0, 85.0, 90.0, 129.0, 87.0, 86.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 92.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 136.0, 85.0, 85.0, 85.0, 87.0, 88.0, 85.0, 85.0, 85.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 58.0, 60.0, 60.0, 59.0, 78.0, 59.0, 57.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 73.0, 86.0, 74.0, 71.0, 67.0, 68.0, 67.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 83.0, 84.0, 85.0, 84.0, 87.0, 87.0, 73.0, 99.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 145.0, 138.0, 142.0, 124.0, 162.0, 149.0, 175.0, 178.0], "value": 150.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 179.0, 167.0, 169.0, 170.0, 172.0, 169.0, 170.0, 168.0, 168.0], "value": 170.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 69.0, 68.0, 69.0, 70.0, 70.0, 69.0, 67.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1512.0, "alertThreshold": 2.0}]} 03:03:03 INFO - Return code: 0 03:03:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:03:03 ERROR - # TBPL SUCCESS # 03:03:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:03:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:03:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:03:03 INFO - 2016-04-15 03:03:03.849 screenresolution[1943:11208] starting screenresolution argv=screenresolution get 03:03:03 INFO - 2016-04-15 03:03:03.851 screenresolution[1943:11208] Display 0: 1600x1200x32@60 03:03:03 INFO - 2016-04-15 03:03:03.857 screenresolution[1944:11211] starting screenresolution argv=screenresolution list 03:03:03 INFO - Available Modes on Display 0 03:03:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:03:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:03:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:03:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:03:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:03:04 INFO - Intel Iris: 03:03:04 INFO - Chipset Model: Intel Iris 03:03:04 INFO - Type: GPU 03:03:04 INFO - Bus: Built-In 03:03:04 INFO - VRAM (Dynamic, Max): 1536 MB 03:03:04 INFO - Vendor: Intel (0x8086) 03:03:04 INFO - Device ID: 0x0a2e 03:03:04 INFO - Revision ID: 0x0009 03:03:04 INFO - Displays: 03:03:04 INFO - Display: 03:03:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:03:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:03:04 INFO - Display Serial Number: 1600x1200 60 03:03:04 INFO - Main Display: Yes 03:03:04 INFO - Mirror: Off 03:03:04 INFO - Online: Yes 03:03:04 INFO - Rotation: Supported 03:03:04 INFO - Return code: 0 03:03:04 INFO - Running post-action listener: _resource_record_post_action 03:03:04 INFO - Running post-run listener: _resource_record_post_run 03:03:05 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 1789952; Write bytes: 690965504; Read time: 19; Write time: 1858 03:03:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 372967936; Write bytes: 367101952; Read time: 28025; Write time: 709 03:03:05 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1789952; Write bytes: 294568960; Read time: 19; Write time: 1098 03:03:05 INFO - Running post-run listener: _upload_blobber_files 03:03:05 INFO - Blob upload gear active. 03:03:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:03:05 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:03:05 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'] 03:03:05 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 03:03:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:03:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:03:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:03:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:06 INFO - (blobuploader) - INFO - Done attempting. 03:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:03:07 INFO - (blobuploader) - INFO - Done attempting. 03:03:07 INFO - (blobuploader) - INFO - Iteration through files over. 03:03:07 INFO - Return code: 0 03:03:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:03:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:03:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e41058553fdaf67b0913548e17b0c8c7fac5e3aecb9d549554b82ac0ac132686c6ce0b27b2dac7299fb79c19e955d379f6d5b6c4c646e9a271828293d000bd3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b9c88ff55bcc872a1bedfaaefa8c5d80d91a79c2a66e776653a163fa9af23ea76395fd12dd2c708e7225da7c0c3662ebf0c0fbb48140e081128d9e012693b62"} 03:03:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:03:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:03:07 INFO - Contents: 03:03:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e41058553fdaf67b0913548e17b0c8c7fac5e3aecb9d549554b82ac0ac132686c6ce0b27b2dac7299fb79c19e955d379f6d5b6c4c646e9a271828293d000bd3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b9c88ff55bcc872a1bedfaaefa8c5d80d91a79c2a66e776653a163fa9af23ea76395fd12dd2c708e7225da7c0c3662ebf0c0fbb48140e081128d9e012693b62"} 03:03:07 INFO - Running post-run listener: copy_logs_to_upload_dir 03:03:07 INFO - Copying logs to upload dir... 03:03:07 INFO - mkdir: /builds/slave/test/build/upload/logs 03:03:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.797221 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-04-15 03:03:07.565879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:03:07.571057) ========= 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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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/e41058553fdaf67b0913548e17b0c8c7fac5e3aecb9d549554b82ac0ac132686c6ce0b27b2dac7299fb79c19e955d379f6d5b6c4c646e9a271828293d000bd3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b9c88ff55bcc872a1bedfaaefa8c5d80d91a79c2a66e776653a163fa9af23ea76395fd12dd2c708e7225da7c0c3662ebf0c0fbb48140e081128d9e012693b62"} build_url:https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/aUs-LlRdT4Wn7NOg8-PNZQ/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/e41058553fdaf67b0913548e17b0c8c7fac5e3aecb9d549554b82ac0ac132686c6ce0b27b2dac7299fb79c19e955d379f6d5b6c4c646e9a271828293d000bd3b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b9c88ff55bcc872a1bedfaaefa8c5d80d91a79c2a66e776653a163fa9af23ea76395fd12dd2c708e7225da7c0c3662ebf0c0fbb48140e081128d9e012693b62"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-15 03:03:07.598779) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:03:07.599125) ========= 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.CgDVeWTLA8/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.6oW4X6QdFg/Listeners TMPDIR=/var/folders/3_/7trspq7n5235lqw2h9mfsq5800000w/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.005250 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-15 03:03:07.647510) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:03:07.647845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-15 03:03:07.648216) ========= ========= Total master_lag: 0.16 =========